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

cmd.exe /c type .debug.log in dir C:\b\s\w\ir\cache\builder\sdk: allow_subannotations: False cmd: ['cmd.exe', '/c', 'type', '.debug.log'] cwd: 'C:\\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: ALLUSERSPROFILE: C:\ProgramData APPDATA: C:\Users\chrome-bot\AppData\Roaming BOTO_CONFIG: C:\b\s\w\ir\tmp\gsutil_task\.boto BUILDBUCKET_EXPERIMENTAL: FALSE CIPD_CACHE_DIR: C:\b\s\cipd_cache\cache CIPD_EXE_SHIM: "C:\b\s\w\ir\cipd_bin_packages\vpython.exe" CIPD_PROTOCOL: v2 COMMONPROGRAMFILES: C:\Program Files\Common Files COMMONPROGRAMFILES(X86): C:\Program Files (x86)\Common Files COMMONPROGRAMW6432: C:\Program Files\Common Files COMPUTERNAME: WIN10-DART-FEDC COMSPEC: C:\Windows\system32\cmd.exe DOCKER_CONFIG: C:\b\s\w\ir\tmp\docker_cfg_task DOCKER_TMPDIR: C:\b\s\w\ir\tmp\docker_tmp_task FPS_BROWSER_APP_PROFILE_STRING: Internet Explorer FPS_BROWSER_USER_PROFILE_STRING: Default GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOMEDRIVE: C: HOMEPATH: \Users\chrome-bot INFRA_GIT_WRAPPER_HOME: C:\b\s\w\ir\tmp\git_home_task LC_ALL: English_United States.UTF-8 LC_COLLATE: English_United States.UTF-8 LC_CTYPE: English_United States.UTF-8 LC_MONETARY: English_United States.UTF-8 LC_NUMERIC: English_United States.UTF-8 LC_TIME: English_United States.UTF-8 LOCALAPPDATA: C:\Users\chrome-bot\AppData\Local LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8917984717170154704 LOGDOG_STREAM_PROJECT: dart LOGDOG_STREAM_SERVER_PATH: net.pipe:LUCILogDogKitchen_1580 LOGONSERVER: \\WIN10-DART-FEDC LUCI_CONTEXT: C:\b\s\w\itq8w6ol\luci_context.203255986 MAC_CHROMIUM_TMPDIR: C:\b\s\w\ir\tmp\t NO_GCE_CHECK: False NUMBER_OF_PROCESSORS: 8 ONEDRIVE: C:\Users\chrome-bot\OneDrive OS: Windows_NT PATH: C:\b\s\w\ir\cipd_bin_packages;C:\b\s\w\ir\cipd_bin_packages\bin;C:\b\s\cipd_cache\bin;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Program Files\Puppet Labs\Puppet\bin PATHEXT: .COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE: AMD64 PROCESSOR_IDENTIFIER: Intel64 Family 6 Model 63 Stepping 0, GenuineIntel PROCESSOR_LEVEL: 6 PROCESSOR_REVISION: 3f00 PROGRAMDATA: C:\ProgramData PROGRAMFILES: C:\Program Files PROGRAMFILES(X86): C:\Program Files (x86) PROGRAMW6432: C:\Program Files PROMPT: $P$G PSMODULEPATH: C:\Program Files\WindowsPowerShell\Modules;C:\Windows\system32\WindowsPowerShell\v1.0\Modules PUBLIC: C:\Users\Public PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 SESSIONNAME: Console SWARMING_BOT_ID: win10-dart-fedce810-us-central1-c-85t9 SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 43cf427365a10011 SYSTEMDRIVE: C: SYSTEMROOT: C:\Windows TEMP: C:\b\s\w\ir\tmp\t TEMPDIR: C:\b\s\w\ir\tmp\t TMP: C:\b\s\w\ir\tmp\t TMPDIR: C:\b\s\w\ir\tmp\t USERDOMAIN: WIN10-DART-FEDC USERDOMAIN_ROAMINGPROFILE: WIN10-DART-FEDC USERNAME: chrome-bot USERPROFILE: C:\Users\chrome-bot VPYTHON_VIRTUALENV_ROOT: C:\b\s\w\ir\cache\vpython WINDIR: C:\Windows 2019-03-25 14:05:33.255983 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:06:03.287236 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:06:33.318573 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:09:36.193671 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:10:06.240633 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:10:36.271886 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:11:06.303188 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:11:36.334443 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:12:06.365682 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:12:36.397033 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:13:06.428233 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:13:06.428233 Warning: Double reporting tests: 2019-03-25 14:13:06.428233 Warning: http://127.0.0.1:50423/root_build/generated_tests/dart2js-chrome-sdk/short1_llocation_profile_element_test/test.html?crossOriginPort=50424, output: 2019-03-25 14:13:06.428233 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.308},{"type":"print","value":"dart-main-done","timestamp":0.363},{"type":"print","value":"00:00 \u001b[32m+0\u001b[0m: instantiation\u001b[0m","timestamp":0.431},{"type":"message_received","value":"dart-calling-main","timestamp":0.459},{"type":"message_received","value":"dart-main-done","timestamp":0.459},{"type":"debug","value":"Sending events to driver page (isFirstMessage = false, isStatusUpdate = false, isDone = true)","timestamp":0.459},{"type":"print","value":"00:00 \u001b[32m+1\u001b[0m: elements created\u001b[0m","timestamp":0.477},{"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.546},{"type":"print","value":" TypeError: Instance of 'IsolateRefMock': type 'IsolateRefMock' is not a subtype of type 'Isolate'","timestamp":0.546},{"type":"print","value":" element_test.js 1050:17 Object.wrapException\n element_test.js 1561:15 Object.propertyTypeError\n element_test.js 1571:9 Object.interceptedTypeCheck\n element_test.js 27626:28 AllocationProfileRepositoryMock.$get$3$gc$reset\n element_test.js 22676:84 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 12564:12 _wrapJsFunctionForAsync_closure.call$2\n element_test.js 24999:51 StackZoneSpecification__registerBinaryCallback__closure.call$0\n element_test.js 24918:16 StackZoneSpecification._stack_zone_specification$_run$1$2\n element_test.js 24988:26 StackZoneSpecification__registerBinaryCallback_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 12982:37 _SyncCompleter.completeError$2\n element_test.js 12542:29 _AsyncAwaitCompleter_completeError_closure.call$0\n element_test.js 24918:16 StackZoneSpecification._stack_zone_specification$_run$1$2\n element_test.js 24958:26 StackZoneSpecification__registerCallback_closure.call$0\n element_test.js 3723:18 StaticClosure._rootRun\n ===== asynchronous gap ===========================\n element_test.js 14389:174 _CustomZone.registerCallback$1$1\n element_test.js 14326:71 _CustomZone.bindCallbackGuarded$1\n element_test.js 3638:33 Object.scheduleMicrotask\n element_test.js 12528:11 _AsyncAwaitCompleter.completeError$2\n element_test.js 3272:57 Object._asyncRethrow\n element_test.js 22666:20 <fn>\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 22664:62 HtmlElement._allocation_profile$_refresh$2$gc$reset\n element_test.js 22688:19 HtmlElement._allocation_profile$_refresh$0\n element_test.js 22282:12 HtmlElement.attached$0\n element_test.js 3069:43 Object.attached$0$x\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 27198:29 main_closure0.call$0\n element_test.js 25315:53 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 12564:12 _wrapJsFunctionForAsync_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25303:29 Declarer_test___closure.call$0\n element_test.js 25643:51 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 12564:12 _wrapJsFunctionForAsync_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25632:29 Invoker_waitForOutstandingCallbacks_closure.call$0\n element_test.js 3727:16 StaticClosure._rootRun\n element_test.js 14362:158 _CustomZone.run$1$1\n element_test.js 3898:89 Object._runZoned\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25245:29 Declarer_test_closure.call$0\n element_test.js 25804:116 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 12564:12 _wrapJsFunctionForAsync_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25795:29 Invoker__onRun____closure.call$0\n element_test.js 12848:50 Future_Future_closure.call$0\n element_test.js 24918:16 StackZoneSpecification._stack_zone_specification$_run$1$2\n element_test.js 24958:26 StackZoneSpecification__registerCallback_closure.call$0\n ===== asynchronous gap ===========================\n element_test.js 14389:174 _CustomZone.registerCallback$1$1\n element_test.js 14326:71 _CustomZone.bindCallbackGuarded$1\n element_test.js 3700:44 Object.Timer_Timer\n element_test.js 3311:9 Object.Future_Future\n element_test.js 25753:17 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25742:29 Invoker__onRun___closure.call$0\n element_test.js 3727:16 StaticClosure._rootRun\n element_test.js 14362:158 _CustomZone.run$1$1\n element_test.js 3898:89 Object._runZoned\n ","timestamp":0.857},{"type":"print","value":"00:01 \u001b[32m+1\u001b[0m\u001b[31m -1\u001b[0m: reacts to refresh\u001b[0m","timestamp":2.1},{"type":"print","value":"00:01 \u001b[32m+1\u001b[0m\u001b[31m -2\u001b[0m: reacts to refresh \u001b[1m\u001b[31m[E]\u001b[0m\u001b[0m","timestamp":2.125},{"type":"print","value":" TypeError: Instance of 'IsolateRefMock': type 'IsolateRefMock' is not a subtype of type 'Isolate'","timestamp":2.125},{"type":"print","value":" element_test.js 1050:17 Object.wrapException\n element_test.js 1561:15 Object.propertyTypeError\n element_test.js 1571:9 Object.interceptedTypeCheck\n element_test.js 27626:28 AllocationProfileRepositoryMock.$get$3$gc$reset\n element_test.js 22676:84 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 12564:12 _wrapJsFunctionForAsync_closure.call$2\n element_test.js 24999:51 StackZoneSpecification__registerBinaryCallback__closure.call$0\n element_test.js 24918:16 StackZoneSpecification._stack_zone_specification$_run$1$2\n element_test.js 24988:26 StackZoneSpecification__registerBinaryCallback_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 12982:37 _SyncCompleter.completeError$2\n element_test.js 12542:29 _AsyncAwaitCompleter_completeError_closure.call$0\n element_test.js 24918:16 StackZoneSpecification._stack_zone_specification$_run$1$2\n element_test.js 24958:26 StackZoneSpecification__registerCallback_closure.call$0\n element_test.js 3723:18 StaticClosure._rootRun\n ===== asynchronous gap ===========================\n element_test.js 14389:174 _CustomZone.registerCallback$1$1\n element_test.js 14326:71 _CustomZone.bindCallbackGuarded$1\n element_test.js 3638:33 Object.scheduleMicrotask\n element_test.js 12528:11 _AsyncAwaitCompleter.completeError$2\n element_test.js 3272:57 Object._asyncRethrow\n element_test.js 22666:20 <fn>\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 22664:62 HtmlElement._allocation_profile$_refresh$2$gc$reset\n element_test.js 22688:19 HtmlElement._allocation_profile$_refresh$0\n element_test.js 22282:12 HtmlElement.attached$0\n element_test.js 3069:43 Object.attached$0$x\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 27286:29 main__closure.$call$body$main__closure0\n element_test.js 27280:19 main__closure.call$0\n element_test.js 25315:53 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25303:29 Declarer_test___closure.call$0\n element_test.js 25643:51 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 12564:12 _wrapJsFunctionForAsync_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25632:29 Invoker_waitForOutstandingCallbacks_closure.call$0\n element_test.js 3727:16 StaticClosure._rootRun\n element_test.js 14362:158 _CustomZone.run$1$1\n element_test.js 3898:89 Object._runZoned\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25245:29 Declarer_test_closure.call$0\n element_test.js 25804:116 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 12564:12 _wrapJsFunctionForAsync_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25795:29 Invoker__onRun____closure.call$0\n element_test.js 12848:50 Future_Future_closure.call$0\n element_test.js 24918:16 StackZoneSpecification._stack_zone_specification$_run$1$2\n element_test.js 24958:26 StackZoneSpecification__registerCallback_closure.call$0\n ===== asynchronous gap ===========================\n element_test.js 14389:174 _CustomZone.registerCallback$1$1\n element_test.js 14326:71 _CustomZone.bindCallbackGuarded$1\n element_test.js 3700:44 Object.Timer_Timer\n element_test.js 3311:9 Object.Future_Future\n element_test.js 25753:17 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25742:29 Invoker__onRun___closure.call$0\n element_test.js 3727:16 StaticClosure._rootRun\n element_test.js 14362:158 _CustomZone.run$1$1\n element_test.js 3898:89 Object._runZoned\n ","timestamp":2.342},{"type":"print","value":"00:01 \u001b[32m+1\u001b[0m\u001b[31m -2\u001b[0m: reacts to gc\u001b[0m","timestamp":2.359},{"type":"print","value":"00:01 \u001b[32m+1\u001b[0m\u001b[31m -3\u001b[0m: reacts to gc \u001b[1m\u001b[31m[E]\u001b[0m\u001b[0m","timestamp":2.386},{"type":"print","value":" TypeError: Instance of 'IsolateRefMock': type 'IsolateRefMock' is not a subtype of type 'Isolate'","timestamp":2.387},{"type":"print","value":" element_test.js 1050:17 Object.wrapException\n element_test.js 1561:15 Object.propertyTypeError\n element_test.js 1571:9 Object.interceptedTypeCheck\n element_test.js 27626:28 AllocationProfileRepositoryMock.$get$3$gc$reset\n element_test.js 22676:84 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 12564:12 _wrapJsFunctionForAsync_closure.call$2\n element_test.js 24999:51 StackZoneSpecification__registerBinaryCallback__closure.call$0\n element_test.js 24918:16 StackZoneSpecification._stack_zone_specification$_run$1$2\n element_test.js 24988:26 StackZoneSpecification__registerBinaryCallback_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 12982:37 _SyncCompleter.completeError$2\n element_test.js 12542:29 _AsyncAwaitCompleter_completeError_closure.call$0\n element_test.js 24918:16 StackZoneSpecification._stack_zone_specification$_run$1$2\n element_test.js 24958:26 StackZoneSpecification__registerCallback_closure.call$0\n element_test.js 3723:18 StaticClosure._rootRun\n ===== asynchronous gap ===========================\n element_test.js 14389:174 _CustomZone.registerCallback$1$1\n element_test.js 14326:71 _CustomZone.bindCallbackGuarded$1\n element_test.js 3638:33 Object.scheduleMicrotask\n element_test.js 12528:11 _AsyncAwaitCompleter.completeError$2\n element_test.js 3272:57 Object._asyncRethrow\n element_test.js 22666:20 <fn>\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 22664:62 HtmlElement._allocation_profile$_refresh$2$gc$reset\n element_test.js 22688:19 HtmlElement._allocation_profile$_refresh$0\n element_test.js 22282:12 HtmlElement.attached$0\n element_test.js 3069:43 Object.attached$0$x\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 27383:29 main__closure0.$call$body$main__closure\n element_test.js 27377:19 main__closure0.call$0\n element_test.js 25315:53 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25303:29 Declarer_test___closure.call$0\n element_test.js 25643:51 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 12564:12 _wrapJsFunctionForAsync_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25632:29 Invoker_waitForOutstandingCallbacks_closure.call$0\n element_test.js 3727:16 StaticClosure._rootRun\n element_test.js 14362:158 _CustomZone.run$1$1\n element_test.js 3898:89 Object._runZoned\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25245:29 Declarer_test_closure.call$0\n element_test.js 25804:116 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 12564:12 _wrapJsFunctionForAsync_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25795:29 Invoker__onRun____closure.call$0\n element_test.js 12848:50 Future_Future_closure.call$0\n element_test.js 24918:16 StackZoneSpecification._stack_zone_specification$_run$1$2\n element_test.js 24958:26 StackZoneSpecification__registerCallback_closure.call$0\n ===== asynchronous gap ===========================\n element_test.js 14389:174 _CustomZone.registerCallback$1$1\n element_test.js 14326:71 _CustomZone.bindCallbackGuarded$1\n element_test.js 3700:44 Object.Timer_Timer\n element_test.js 3311:9 Object.Future_Future\n element_test.js 25753:17 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25742:29 Invoker__onRun___closure.call$0\n element_test.js 3727:16 StaticClosure._rootRun\n element_test.js 14362:158 _CustomZone.run$1$1\n element_test.js 3898:89 Object._runZoned\n ","timestamp":2.585},{"type":"print","value":"00:02 \u001b[32m+1\u001b[0m\u001b[31m -3\u001b[0m: reacts to sort change\u001b[0m","timestamp":2.595},{"type":"print","value":"00:02 \u001b[32m+1\u001b[0m\u001b[31m -4\u001b[0m: reacts to sort change \u001b[1m\u001b[31m[E]\u001b[0m\u001b[0m","timestamp":2.615},{"type":"print","value":" TypeError: Instance of 'IsolateRefMock': type 'IsolateRefMock' is not a subtype of type 'Isolate'","timestamp":2.616},{"type":"print","value":" element_test.js 1050:17 Object.wrapException\n element_test.js 1561:15 Object.propertyTypeError\n element_test.js 1571:9 Object.interceptedTypeCheck\n element_test.js 27626:28 AllocationProfileRepositoryMock.$get$3$gc$reset\n element_test.js 22676:84 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 12564:12 _wrapJsFunctionForAsync_closure.call$2\n element_test.js 24999:51 StackZoneSpecification__registerBinaryCallback__closure.call$0\n element_test.js 24918:16 StackZoneSpecification._stack_zone_specification$_run$1$2\n element_test.js 24988:26 StackZoneSpecification__registerBinaryCallback_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 12982:37 _SyncCompleter.completeError$2\n element_test.js 12542:29 _AsyncAwaitCompleter_completeError_closure.call$0\n element_test.js 24918:16 StackZoneSpecification._stack_zone_specification$_run$1$2\n element_test.js 24958:26 StackZoneSpecification__registerCallback_closure.call$0\n element_test.js 3723:18 StaticClosure._rootRun\n ===== asynchronous gap ===========================\n element_test.js 14389:174 _CustomZone.registerCallback$1$1\n element_test.js 14326:71 _CustomZone.bindCallbackGuarded$1\n element_test.js 3638:33 Object.scheduleMicrotask\n element_test.js 12528:11 _AsyncAwaitCompleter.completeError$2\n element_test.js 3272:57 Object._asyncRethrow\n element_test.js 22666:20 <fn>\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 22664:62 HtmlElement._allocation_profile$_refresh$2$gc$reset\n element_test.js 22688:19 HtmlElement._allocation_profile$_refresh$0\n element_test.js 22282:12 HtmlElement.attached$0\n element_test.js 3069:43 Object.attached$0$x\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 27512:29 main__closure1.call$0\n element_test.js 25315:53 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 12564:12 _wrapJsFunctionForAsync_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25303:29 Declarer_test___closure.call$0\n element_test.js 25643:51 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 12564:12 _wrapJsFunctionForAsync_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25632:29 Invoker_waitForOutstandingCallbacks_closure.call$0\n element_test.js 3727:16 StaticClosure._rootRun\n element_test.js 14362:158 _CustomZone.run$1$1\n element_test.js 3898:89 Object._runZoned\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25245:29 Declarer_test_closure.call$0\n element_test.js 25804:116 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 12564:12 _wrapJsFunctionForAsync_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25795:29 Invoker__onRun____closure.call$0\n element_test.js 12848:50 Future_Future_closure.call$0\n element_test.js 24918:16 StackZoneSpecification._stack_zone_specification$_run$1$2\n element_test.js 24958:26 StackZoneSpecification__registerCallback_closure.call$0\n ===== asynchronous gap ===========================\n element_test.js 14389:174 _CustomZone.registerCallback$1$1\n element_test.js 14326:71 _CustomZone.bindCallbackGuarded$1\n element_test.js 3700:44 Object.Timer_Timer\n element_test.js 3311:9 Object.Future_Future\n element_test.js 25753:17 <fn>\n element_test.js 3297:15 _wrapJsFunctionForAsync_closure.$protected\n ===== asynchronous gap ===========================\n element_test.js 14405:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3305:30 Object._wrapJsFunctionForAsync\n element_test.js 25742:29 Invoker__onRun___closure.call$0\n element_test.js 3727:16 StaticClosure._rootRun\n element_test.js 14362:158 _CustomZone.run$1$1\n element_test.js 3898:89 Object._runZoned\n ","timestamp":2.768},{"type":"print","value":"00:02 \u001b[32m+1\u001b[0m\u001b[31m -4\u001b[0m: \u001b[31mSome tests failed.\u001b[0m","timestamp":2.786},{"type":"print","value":"","timestamp":2.787},{"type":"window_onerror","value":"window.onerror called: \n\nhttp://127.0.0.1:50423/root_build/generated_tests/dart2js-chrome-sdk/short1_llocation_profile_element_test/element_test.js:14567:\nUncaught \n\n","timestamp":2.789},{"type":"debug","value":"Sending events to driver page (isFirstMessage = false, isStatusUpdate = false, isDone = true)","timestamp":2.789},{"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<allocation-profile><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>allocation profile</a><ul></ul></span></li><nav-refresh><li><button disabled=\"\">Download</button></li></nav-refresh><nav-refresh><li><button>Reset Accumulator</button></li></nav-refresh><nav-refresh><li><button>GC</button></li></nav-refresh><nav-refresh><li><button>Refresh</button></li></nav-refresh><div class=\"nav-option\"><input type=\"checkbox\" id=\"allocation-profile-auto-refresh\"><label for=\"allocation-profile-auto-refresh\">Auto-refresh on GC</label></div><nav-notify><div><div></div></div></nav-notify></ul></nav><div class=\"content-centered-big\"><h2>Allocation Profile</h2><hr></div><div class=\"content-centered-big\"><h2>Loading...</h2></div></allocation-profile><allocation-profile><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>allocation profile</a><ul></ul></span></li><nav-refresh><li><button disabled=\"\">Download</button></li></nav-refresh><nav-refresh><li><button>Reset Accumulator</button></li></nav-refresh><nav-refresh><li><button>GC</button></li></nav-refresh><nav-refresh><li><button>Refresh</button></li></nav-refresh><div class=\"nav-option\"><input type=\"checkbox\" id=\"allocation-profile-auto-refresh\"><label for=\"allocation-profile-auto-refresh\">Auto-refresh on GC</label></div><nav-notify><div><div></div></div></nav-notify></ul></nav><div class=\"content-centered-big\"><h2>Allocation Profile</h2><hr></div><div class=\"content-centered-big\"><h2>Loading...</h2></div></allocation-profile><allocation-profile><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>allocation profile</a><ul></ul></span></li><nav-refresh><li><button disabled=\"\">Download</button></li></nav-refresh><nav-refresh><li><button>Reset Accumulator</button></li></nav-refresh><nav-refresh><li><button>GC</button></li></nav-refresh><nav-refresh><li><button>Refresh</button></li></nav-refresh><div class=\"nav-option\"><input type=\"checkbox\" id=\"allocation-profile-auto-refresh\"><label for=\"allocation-profile-auto-refresh\">Auto-refresh on GC</label></div><nav-notify><div><div></div></div></nav-notify></ul></nav><div class=\"content-centered-big\"><h2>Allocation Profile</h2><hr></div><div class=\"content-centered-big\"><h2>Loading...</h2></div></allocation-profile><allocation-profile><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>allocation profile</a><ul></ul></span></li><nav-refresh><li><button disabled=\"\">Download</button></li></nav-refresh><nav-refresh><li><button>Reset Accumulator</button></li></nav-refresh><nav-refresh><li><button>GC</button></li></nav-refresh><nav-refresh><li><button>Refresh</button></li></nav-refresh><div class=\"nav-option\"><input type=\"checkbox\" id=\"allocation-profile-auto-refresh\"><label for=\"allocation-profile-auto-refresh\">Auto-refresh on GC</label></div><nav-notify><div><div></div></div></nav-notify></ul></nav><div class=\"content-centered-big\"><h2>Allocation Profile</h2><hr></div><div class=\"content-centered-big\"><h2>Loading...</h2></div></allocation-profile></body>","timestamp":2.79}] 2019-03-25 14:13:06.428233 Warning: 2019-03-25 14:13:06.428233 Warning: 2019-03-25 14:13:06.428233 Warning: http://127.0.0.1:50423/root_build/generated_tests/dart2js-chrome-sdk/short33__ui_heap_snapshot_element_test/test.html?crossOriginPort=50424, output: 2019-03-25 14:13:06.428233 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.584},{"type":"print","value":"dart-main-done","timestamp":0.623},{"type":"print","value":"00:00 \u001b[32m+0\u001b[0m: instantiation\u001b[0m","timestamp":0.686},{"type":"message_received","value":"dart-calling-main","timestamp":0.7},{"type":"message_received","value":"dart-main-done","timestamp":0.701},{"type":"debug","value":"Sending events to driver page (isFirstMessage = false, isStatusUpdate = false, isDone = true)","timestamp":0.701},{"type":"print","value":"00:00 \u001b[32m+1\u001b[0m: elements created\u001b[0m","timestamp":0.721},{"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.783},{"type":"print","value":" Expected: false\n Actual: <true>\n ","timestamp":0.784},{"type":"print","value":" element_test.js 959:17 Object.wrapException\n element_test.js 972:15 Object.throwExpression\n element_test.js 8280:16 Object.fail\n element_test.js 8277:9 Object._expect\n element_test.js 8255:9 Object.expect\n element_test.js 24988:9 main__closure.call$2\n element_test.js 25021:19 HeapSnapshotRepositoryMock.$get$3$gc$roots\n element_test.js 20166:99 <fn>\n element_test.js 3108:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 11799:12 _wrapJsFunctionForAsync_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 12209:37 _SyncCompleter.completeError$2\n element_test.js 11781:29 _AsyncAwaitCompleter_completeError_closure.call$0\n element_test.js 22825:16 StackZoneSpecification._stack_zone_specification$_run$1$2\n element_test.js 22865:26 StackZoneSpecification__registerCallback_closure.call$0\n element_test.js 3534:18 StaticClosure._rootRun\n ===== asynchronous gap ===========================\n element_test.js 13620:174 _CustomZone.registerCallback$1$1\n element_test.js 13557:71 _CustomZone.bindCallbackGuarded$1\n element_test.js 3449:33 Object.scheduleMicrotask\n element_test.js 11769:11 _AsyncAwaitCompleter.completeError$2\n element_test.js 3083:57 Object._asyncRethrow\n element_test.js 20160:20 <fn>\n ===== asynchronous gap ===========================\n element_test.js 13636:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3116:30 Object._wrapJsFunctionForAsync\n element_test.js 20158:48 HtmlElement._heap_snapshot$_refresh$0\n element_test.js 20078:12 HtmlElement.attached$0\n element_test.js 2895:43 Object.attached$0$x\n element_test.js 6541:16 StaticClosure._callAttached\n ===== asynchronous gap ===========================\n element_test.js 13636:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3116:30 Object._wrapJsFunctionForAsync\n element_test.js 24925:29 main_closure0.call$0\n element_test.js 23171:53 <fn>\n element_test.js 3108:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 11799:12 _wrapJsFunctionForAsync_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 13636:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3116:30 Object._wrapJsFunctionForAsync\n element_test.js 23159:29 Declarer_test___closure.call$0\n element_test.js 23478:51 <fn>\n element_test.js 3108:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 11799:12 _wrapJsFunctionForAsync_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 13636:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3116:30 Object._wrapJsFunctionForAsync\n element_test.js 23467:29 Invoker_waitForOutstandingCallbacks_closure.call$0\n element_test.js 3538:16 StaticClosure._rootRun\n element_test.js 13593:158 _CustomZone.run$1$1\n element_test.js 3709:89 Object._runZoned\n ===== asynchronous gap ===========================\n element_test.js 13636:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3116:30 Object._wrapJsFunctionForAsync\n element_test.js 23105:29 Declarer_test_closure.call$0\n element_test.js 23623:116 <fn>\n element_test.js 3108:15 _wrapJsFunctionForAsync_closure.$protected\n element_test.js 11799:12 _wrapJsFunctionForAsync_closure.call$2\n ===== asynchronous gap ===========================\n element_test.js 13636:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3116:30 Object._wrapJsFunctionForAsync\n element_test.js 23614:29 Invoker__onRun____closure.call$0\n element_test.js 12081:50 Future_Future_closure.call$0\n element_test.js 22825:16 StackZoneSpecification._stack_zone_specification$_run$1$2\n element_test.js 22865:26 StackZoneSpecification__registerCallback_closure.call$0\n ===== asynchronous gap ===========================\n element_test.js 13620:174 _CustomZone.registerCallback$1$1\n element_test.js 13557:71 _CustomZone.bindCallbackGuarded$1\n element_test.js 3511:44 Object.Timer_Timer\n element_test.js 3122:9 Object.Future_Future\n element_test.js 23574:17 <fn>\n element_test.js 3108:15 _wrapJsFunctionForAsync_closure.$protected\n ===== asynchronous gap ===========================\n element_test.js 13636:222 _CustomZone.registerBinaryCallback$3$1\n element_test.js 3116:30 Object._wrapJsFunctionForAsync\n element_test.js 23563:29 Invoker__onRun___closure.call$0\n element_test.js 3538:16 StaticClosure._rootRun\n element_test.js 13593:158 _CustomZone.run$1$1\n element_test.js 3709:89 Object._runZoned\n ","timestamp":1.027},{"type":"print","value":"00:00 \u001b[32m+1\u001b[0m\u001b[31m -1\u001b[0m: \u001b[31mSome tests failed.\u001b[0m","timestamp":1.07},{"type":"print","value":"","timestamp":1.071},{"type":"window_onerror","value":"window.onerror called: \n\nhttp://127.0.0.1:50423/root_build/generated_tests/dart2js-chrome-sdk/short33__ui_heap_snapshot_element_test/element_test.js:13796:\nUncaught \n\n","timestamp":1.072},{"type":"debug","value":"Sending events to driver page (isFirstMessage = false, isStatusUpdate = false, isDone = true)","timestamp":1.072},{"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.072}] 2019-03-25 14:13:06.428233 Warning: 2019-03-25 14:13:06.428233 Warning: 2019-03-25 14:14:41.442748 Warning: HttpServer: could not find file for request path: "/root_build/generated_tests/dart2js-chrome-sdk/tests_compiler_dart2js_extra_deferred_fail_and_retry_test/non_existing.js" 2019-03-25 14:16:24.162770 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:16:54.209662 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:17:24.240948 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:17:54.272245 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:18:24.303513 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:18:54.350447 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:19:24.381685 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome) 2019-03-25 14:19:54.412990 Warning: Not waiting for stdout/stderr from subprocess anymore (0:00:30.000000 passed). Please note that this could be an indicator that there is a hanging process which we were unable to kill. (browser: Chrome)