Back to build
Raw log | Switch to full mode | Login

cat .debug.log in dir /b/s/w/ir/cache/builder/sdk: allow_subannotations: False cmd: ['cat', '.debug.log'] cwd: '/b/s/w/ir/cache/builder/sdk' env: {} env_prefixes: {} env_suffixes: {} infra_step: False name_tokens: ('debug log',) ok_ret: ALL_OK trigger_specs: () full environment: BOTO_CONFIG: /b/s/w/ir/tmp/gsutil_task/.boto BUILDBUCKET_EXPERIMENTAL: FALSE CIPD_CACHE_DIR: /b/s/cipd_cache/cache CIPD_PROTOCOL: v2 DEVSHELL_CLIENT_PORT: 40422 DOCKER_CONFIG: /b/s/w/ir/tmp/docker_cfg_task DOCKER_TMPDIR: /b/s/w/ir/tmp/docker_tmp_task GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOME: /home/chrome-bot INFRA_GIT_WRAPPER_HOME: /b/s/w/ir/tmp/git_home_task LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8918170109808821392 LOGDOG_STREAM_PROJECT: dart LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/itKr7UnO/luci_context.208743825 MAC_CHROMIUM_TMPDIR: /b/s/w/ir/tmp/t MAIL: /var/mail/chrome-bot NO_GCE_CHECK: False PATH: /b/s/w/ir/cipd_bin_packages:/b/s/w/ir/cipd_bin_packages/bin:/b/s/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/snap/bin PWD: /b/s/w/ir/k PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 SHELL: /bin/bash SHLVL: 1 SUDO_COMMAND: /usr/bin/python /b/s/swarming_bot.zip start_bot SUDO_GID: 0 SUDO_UID: 0 SUDO_USER: root SWARMING_BOT_ID: trusty-dart-68765ebb-us-central1-b-nkmm SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 43c4b89326614611 TEMP: /b/s/w/ir/tmp/t TEMPDIR: /b/s/w/ir/tmp/t TERM: linux TMP: /b/s/w/ir/tmp/t TMPDIR: /b/s/w/ir/tmp/t USER: chrome-bot USERNAME: chrome-bot VPYTHON_VIRTUALENV_ROOT: /b/s/w/ir/cache/vpython _: /b/s/w/ir/cipd_bin_packages/vpython 2019-03-23 12:01:21.524827 Warning: Double reporting tests: 2019-03-23 12:01:21.527440 Warning: http://127.0.0.1:39261/root_build/generated_tests/dart2js-chrome-minified-sdk/runtime_observatory_tests_observatory_ui_heap_snapshot_element_test/test.html?crossOriginPort=37761, output: 2019-03-23 12:01:21.527472 Warning: [{"type":"debug","value":"test_controller.js started","timestamp":0},{"type":"debug","value":"Sending events to driver page (isFirstMessage = true, isStatusUpdate = true, isDone = false)","timestamp":0},{"type":"print","value":"dart-calling-main","timestamp":0.225},{"type":"print","value":"dart-main-done","timestamp":0.326},{"type":"print","value":"00:00 \u001b[32m+0\u001b[0m: instantiation\u001b[0m","timestamp":0.437},{"type":"message_received","value":"dart-calling-main","timestamp":0.446},{"type":"message_received","value":"dart-main-done","timestamp":0.446},{"type":"debug","value":"Sending events to driver page (isFirstMessage = false, isStatusUpdate = false, isDone = true)","timestamp":0.446},{"type":"print","value":"00:00 \u001b[32m+1\u001b[0m: elements created\u001b[0m","timestamp":0.48},{"type":"print","value":"00:00 \u001b[32m+1\u001b[0m\u001b[31m -1\u001b[0m: elements created \u001b[1m\u001b[31m[E]\u001b[0m\u001b[0m","timestamp":0.568},{"type":"print","value":" Expected: false\n Actual: <true>\n ","timestamp":0.578},{"type":"print","value":" element_test.js 422:3 Object.b\n element_test.js 428:23 Object.K\n element_test.js 4066:25 Object.xk\n element_test.js 4065:36 Object.wJ\n element_test.js 4055:22 Object.cP\n element_test.js 12667:3 oo.$2\n element_test.js 12684:21 f5.hh\n element_test.js 10031:13 <fn>\n element_test.js 1314:72 o7.a\n element_test.js 5857:23 o7.$2\n ===== asynchronous gap ===========================\n element_test.js 6064:7 dt.b8\n element_test.js 5848:24 mu.$0\n element_test.js 11556:9 cl.dV\n element_test.js 11576:12 lh.$0\n element_test.js 1541:18 lm.o3\n ===== asynchronous gap ===========================\n element_test.js 6791:92 mF.bt\n element_test.js 6750:42 mF.cZ\n element_test.js 1496:8 Object.dB\n element_test.js 5842:8 fG.b8\n element_test.js 1301:32 Object.ag\n element_test.js 10029:52 <fn>\n ===== asynchronous gap ===========================\n element_test.js 6803:122 mF.de\n element_test.js 1317:12 Object.ak\n element_test.js 10029:17 w.bB\n element_test.js 9969:6 w.J\n element_test.js 1197:30 Object.tS\n element_test.js 3096:25 lm.wz\n ===== asynchronous gap ===========================\n element_test.js 6803:122 mF.de\n element_test.js 1317:12 Object.ak\n element_test.js 12624:17 oq.$0\n element_test.js 11709:16 <fn>\n element_test.js 1314:72 o7.a\n element_test.js 5857:23 o7.$2\n ===== asynchronous gap ===========================\n element_test.js 6803:122 mF.de\n element_test.js 1317:12 Object.ak\n element_test.js 11705:17 i6.$0\n element_test.js 11854:16 <fn>\n element_test.js 1314:72 o7.a\n element_test.js 5857:23 o7.$2\n ===== asynchronous gap ===========================\n element_test.js 6803:122 mF.de\n element_test.js 1317:12 Object.ak\n element_test.js 11849:17 jI.$0\n element_test.js 1544:9 lm.o3\n element_test.js 6770:79 mF.aD\n element_test.js 1655:20 Object.rp\n ===== asynchronous gap ===========================\n element_test.js 6803:122 mF.de\n element_test.js 1317:12 Object.ak\n element_test.js 11684:17 i8.$0\n element_test.js 11927:24 <fn>\n element_test.js 1314:72 o7.a\n element_test.js 5857:23 o7.$2\n ===== asynchronous gap ===========================\n element_test.js 6803:122 mF.de\n element_test.js 1317:12 Object.ak\n element_test.js 11924:17 jz.$0\n element_test.js 6002:22 iW.$0\n element_test.js 11556:9 cl.dV\n element_test.js 11576:12 lh.$0\n ===== asynchronous gap ===========================\n element_test.js 6791:92 mF.bt\n element_test.js 6750:42 mF.cZ\n element_test.js 1528:17 Object.qL\n element_test.js 1321:3 Object.qc\n element_test.js 11903:3 <fn>\n element_test.js 1314:72 o7.a\n ===== asynchronous gap ===========================\n element_test.js 6803:122 mF.de\n element_test.js 1317:12 Object.ak\n element_test.js 11898:17 jA.$0\n element_test.js 1544:9 lm.o3\n element_test.js 6770:79 mF.aD\n element_test.js 1655:20 Object.rp\n ","timestamp":1.034},{"type":"print","value":"00:00 \u001b[32m+1\u001b[0m\u001b[31m -1\u001b[0m: \u001b[31mSome tests failed.\u001b[0m","timestamp":1.131},{"type":"print","value":"","timestamp":1.133},{"type":"window_onerror","value":"window.onerror called: \n\nhttp://127.0.0.1:39261/root_build/generated_tests/dart2js-chrome-minified-sdk/runtime_observatory_tests_observatory_ui_heap_snapshot_element_test/element_test.js:6871:\nUncaught \n\n","timestamp":1.134},{"type":"debug","value":"Sending events to driver page (isFirstMessage = false, isStatusUpdate = false, isDone = true)","timestamp":1.135},{"type":"dom","value":"<head>\n <meta http-equiv=\"X-UA-Compatible\" content=\"IE=edge\">\n <meta name=\"dart.unittest\" content=\"full-stack-traces\">\n <style>\n .unittest-table { font-family:monospace; border:1px; }\n .unittest-pass { background: #6b3;}\n .unittest-fail { background: #d55;}\n .unittest-error { background: #a11;}\n </style>\n</head>\n<body>\n <script type=\"text/javascript\" src=\"/root_dart/tools/testing/dart/test_controller.js\"></script>\n <script src=\"element_test.js\"></script>\n\n\n<heap-snapshot><nav class=\"nav-bar\"><ul><nav-top-menu><li class=\"nav-menu\"><span class=\"nav-menu_label\"><a href=\"#/vm\">Observatory</a><ul><nav-menu-item><li class=\"nav-menu-item\"><a href=\"#/vm-connect\">Connect to a VM</a><ul></ul></li></nav-menu-item></ul></span></li></nav-top-menu><nav-vm-menu><li class=\"nav-menu\"><span class=\"nav-menu_label\"><a href=\"#/vm\">vm-display-name</a><ul></ul></span></li></nav-vm-menu><nav-isolate-menu><li class=\"nav-menu\"><span class=\"nav-menu_label\"><a href=\"#/inspect?isolateId=i-id\">i-name</a><ul><nav-menu-item><li class=\"nav-menu-item\"><a href=\"#/debugger?isolateId=i-id\">debugger</a><ul></ul></li></nav-menu-item><nav-menu-item><li class=\"nav-menu-item\"><a href=\"#/class-tree?isolateId=i-id\">class hierarchy</a><ul></ul></li></nav-menu-item><nav-menu-item><li class=\"nav-menu-item\"><a href=\"#/profiler?isolateId=i-id\">cpu profile</a><ul></ul></li></nav-menu-item><nav-menu-item><li class=\"nav-menu-item\"><a href=\"#/profiler-table?isolateId=i-id\">cpu profile (table)</a><ul></ul></li></nav-menu-item><nav-menu-item><li class=\"nav-menu-item\"><a href=\"#/allocation-profiler?isolateId=i-id\">allocation profile</a><ul></ul></li></nav-menu-item><nav-menu-item><li class=\"nav-menu-item\"><a href=\"#/heap-snapshot?isolateId=i-id\">heap snapshot</a><ul></ul></li></nav-menu-item><nav-menu-item><li class=\"nav-menu-item\"><a href=\"#/heap-map?isolateId=i-id\">heap map</a><ul></ul></li></nav-menu-item><nav-menu-item><li class=\"nav-menu-item\"><a href=\"#/metrics?isolateId=i-id\">metrics</a><ul></ul></li></nav-menu-item><nav-menu-item><li class=\"nav-menu-item\"><a href=\"#/persistent-handles?isolateId=i-id\">persistent handles</a><ul></ul></li></nav-menu-item><nav-menu-item><li class=\"nav-menu-item\"><a href=\"#/ports?isolateId=i-id\">ports</a><ul></ul></li></nav-menu-item><nav-menu-item><li class=\"nav-menu-item\"><a href=\"#/logging?isolateId=i-id\">logging</a><ul></ul></li></nav-menu-item></ul></span></li></nav-isolate-menu><li class=\"nav-menu\"><span class=\"nav-menu_label\"><a>heap snapshot</a><ul></ul></span></li><nav-refresh><li><button>Refresh</button></li></nav-refresh><nav-notify><div><div></div></div></nav-notify></ul></nav></heap-snapshot></body>","timestamp":1.136}] 2019-03-23 12:01:21.527508 Warning: 2019-03-23 12:01:21.527516 Warning: 2019-03-23 12:01:21.527525 Warning: http://127.0.0.1:39261/root_build/generated_tests/dart2js-chrome-minified-sdk/runtime_observatory_tests_observatory_ui_class_tree_element_test/test.html?crossOriginPort=37761, output: 2019-03-23 12:01:21.527534 Warning: [{"type":"debug","value":"test_controller.js started","timestamp":0},{"type":"debug","value":"Sending events to driver page (isFirstMessage = true, isStatusUpdate = true, isDone = false)","timestamp":0.001},{"type":"print","value":"dart-calling-main","timestamp":0.134},{"type":"print","value":"dart-main-done","timestamp":0.178},{"type":"print","value":"00:00 \u001b[32m+0\u001b[0m: instantiation default\u001b[0m","timestamp":0.218},{"type":"message_received","value":"dart-calling-main","timestamp":0.23},{"type":"message_received","value":"dart-main-done","timestamp":0.231},{"type":"debug","value":"Sending events to driver page (isFirstMessage = false, isStatusUpdate = false, isDone = true)","timestamp":0.231},{"type":"print","value":"00:00 \u001b[32m+1\u001b[0m: elements created after attachment\u001b[0m","timestamp":0.275},{"type":"print","value":"00:00 \u001b[32m+1\u001b[0m\u001b[31m -1\u001b[0m: elements created after attachment \u001b[1m\u001b[31m[E]\u001b[0m\u001b[0m","timestamp":0.31},{"type":"print","value":" TypeError: Instance of 'minified:iS': type 'minified:iS' is not a subtype of type 'minified:bu'","timestamp":0.311},{"type":"print","value":" element_test.js 328:3 Object.c\n element_test.js 495:26 Object.oN\n element_test.js 499:3 Object.f\n element_test.js 11585:36 hc.h8\n element_test.js 9015:16 <fn>\n element_test.js 1218:72 nk.a\n element_test.js 5377:23 nk.$2\n element_test.js 10357:16 kq.$0\n element_test.js 10318:9 c8.dM\n element_test.js 10351:12 kr.$2\n ===== asynchronous gap ===========================\n element_test.js 5592:7 di.b2\n element_test.js 5364:24 lC.$0\n element_test.js 10318:9 c8.dM\n element_test.js 10338:12 ks.$0\n element_test.js 1445:18 kx.nf\n ===== asynchronous gap ===========================\n element_test.js 6329:92 lN.bn\n element_test.js 6288:42 lN.cN\n element_test.js 1400:8 Object.dq\n element_test.js 5356:8 f5.b2\n element_test.js 1205:32 Object.aa\n element_test.js 9007:52 <fn>\n ===== asynchronous gap ===========================\n element_test.js 6341:122 lN.d_\n element_test.js 1221:12 Object.ae\n element_test.js 9007:17 u.bV\n element_test.js 8951:6 u.ac\n element_test.js 1108:30 Object.rM\n element_test.js 2976:25 kx.uU\n ===== asynchronous gap ===========================\n element_test.js 6341:122 lN.d_\n element_test.js 1221:12 Object.ae\n element_test.js 11517:17 nB.h5\n element_test.js 11515:27 nB.$0\n element_test.js 10512:16 <fn>\n element_test.js 1218:72 nk.a\n ===== asynchronous gap ===========================\n element_test.js 6341:122 lN.d_\n element_test.js 1221:12 Object.ae\n element_test.js 10508:17 hy.$0\n element_test.js 10672:16 <fn>\n element_test.js 1218:72 nk.a\n element_test.js 5377:23 nk.$2\n ===== asynchronous gap ===========================\n element_test.js 6341:122 lN.d_\n element_test.js 1221:12 Object.ae\n element_test.js 10667:17 iP.$0\n element_test.js 1448:9 kx.nf\n element_test.js 6308:79 lN.ax\n element_test.js 1559:20 Object.ql\n ===== asynchronous gap ===========================\n element_test.js 6341:122 lN.d_\n element_test.js 1221:12 Object.ae\n element_test.js 10483:17 hA.$0\n element_test.js 10761:24 <fn>\n element_test.js 1218:72 nk.a\n element_test.js 5377:23 nk.$2\n ===== asynchronous gap ===========================\n element_test.js 6341:122 lN.d_\n element_test.js 1221:12 Object.ae\n element_test.js 10758:17 iG.$0\n element_test.js 5524:22 io.$0\n element_test.js 10318:9 c8.dM\n element_test.js 10338:12 ks.$0\n ===== asynchronous gap ===========================\n element_test.js 6329:92 lN.bn\n element_test.js 6288:42 lN.cN\n element_test.js 1432:17 Object.pG\n element_test.js 1225:3 Object.pf\n element_test.js 10735:3 <fn>\n element_test.js 1218:72 nk.a\n ===== asynchronous gap ===========================\n element_test.js 6341:122 lN.d_\n element_test.js 1221:12 Object.ae\n element_test.js 10730:17 iH.$0\n element_test.js 1448:9 kx.nf\n element_test.js 6308:79 lN.ax\n element_test.js 1559:20 Object.ql\n ","timestamp":0.642},{"type":"print","value":"00:00 \u001b[32m+1\u001b[0m\u001b[31m -1\u001b[0m: \u001b[31mSome tests failed.\u001b[0m","timestamp":0.683},{"type":"print","value":"","timestamp":0.685},{"type":"window_onerror","value":"window.onerror called: \n\nhttp://127.0.0.1:39261/root_build/generated_tests/dart2js-chrome-minified-sdk/runtime_observatory_tests_observatory_ui_class_tree_element_test/element_test.js:6411:\nUncaught \n\n","timestamp":0.686},{"type":"debug","value":"Sending events to driver page (isFirstMessage = false, isStatusUpdate = false, isDone = true)","timestamp":0.686},{"type":"dom","value":"<head>\n <meta http-equiv=\"X-UA-Compatible\" content=\"IE=edge\">\n <meta name=\"dart.unittest\" content=\"full-stack-traces\">\n <style>\n .unittest-table { font-family:monospace; border:1px; }\n .unittest-pass { background: #6b3;}\n .unittest-fail { background: #d55;}\n .unittest-error { background: #a11;}\n class-tree virtual-tree .class-tree-item {\n line-height: 25px;\n height: 25px;\n padding-left: 10%;\n padding-right: 10%;\n }\n </style>\n</head>\n<body>\n <script type=\"text/javascript\" src=\"/root_dart/tools/testing/dart/test_controller.js\"></script>\n <script src=\"element_test.js\"></script>\n\n\n</body>","timestamp":0.686}] 2019-03-23 12:01:21.527562 Warning: 2019-03-23 12:01:21.527569 Warning: