1453984 - Intermittent PID 1838 | TEST-UNEXPECTED-FAIL | damp | webconsole/complicated.js: Test timed out

Status: RESOLVED INCOMPLETE

(Testing :: Talos, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: aiakab [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=173509394&repo=mozilla-inbound

https://queue.taskcluster.net/v1/task/ENFdSHytQZanMO6CVTb1Nw/runs/0/artifacts/public/logs/live_backing.log

TEST-INFO | started process 1838 (/Users/cltbld/tasks/task_1523627387/build/application/Firefox Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/mfqch3t508nb4xstw1yfgl_h00000w/T/tmpiMBfSm/profile)
07:05:30     INFO -  PID 1838 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
07:05:31     INFO -  PID 1838 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
07:05:31     INFO -  PID 1838 | 2018-04-13 07:05:31.478 plugin-container[1839:29463] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9353, name = 'com.apple.tsm.portname'
07:05:31     INFO -  PID 1838 | See /usr/include/servers/bootstrap_defs.h for the error codes.
07:05:31     INFO -  PID 1838 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
07:05:31     INFO -  PID 1838 | Initialize the head file with a reference to this DAMP instance
07:05:31     INFO -  PID 1838 | Garbage collect
07:05:31     INFO -  PID 1838 | 2018-04-13 07:05:31.991 plugin-container[1840:29538] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9553, name = 'com.apple.tsm.portname'
07:05:31     INFO -  PID 1838 | See /usr/include/servers/bootstrap_defs.h for the error codes.
07:05:32     INFO -  PID 1838 | Loading test 'inspector/cold-open.js'
07:05:32     INFO -  PID 1838 | Executing test 'inspector/cold-open.js'
07:05:32     INFO -  PID 1838 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
07:05:32     INFO -  PID 1838 | 2018-04-13 07:05:32.994 plugin-container[1841:29601] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9353, name = 'com.apple.tsm.portname'
07:05:32     INFO -  PID 1838 | See /usr/include/servers/bootstrap_defs.h for the error codes.
07:05:33     INFO -  PID 1838 | Garbage collect
07:05:34     INFO -  PID 1838 | Garbage collect
07:05:34     INFO -  PID 1838 | inspector/cold-open.js took 2360ms.
07:05:34     INFO -  PID 1838 | Loading test 'webconsole/simple.js'
07:05:34     INFO -  PID 1838 | Executing test 'webconsole/simple.js'
07:05:35     INFO -  PID 1838 | Garbage collect
07:05:35     INFO -  PID 1838 | Reload page on 'simple.webconsole'
07:05:36     INFO -  PID 1838 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
07:05:36     INFO -  PID 1838 | Wait for pending paints on 'simple.webconsole'
07:05:36     INFO -  PID 1838 | Close toolbox on 'simple.webconsole'
07:05:36     INFO -  PID 1838 | Garbage collect
07:05:36     INFO -  PID 1838 | 2018-04-13 07:05:36.260 plugin-container[1842:29658] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x953b, name = 'com.apple.tsm.portname'
07:05:36     INFO -  PID 1838 | See /usr/include/servers/bootstrap_defs.h for the error codes.
07:05:36     INFO -  PID 1838 | webconsole/simple.js took 2099ms.
07:05:36     INFO -  PID 1838 | Loading test 'inspector/simple.js'
07:05:36     INFO -  PID 1838 | Executing test 'inspector/simple.js'
07:05:37     INFO -  PID 1838 | Garbage collect
07:05:38     INFO -  PID 1838 | Reload page on 'simple.inspector'
07:05:38     INFO -  PID 1838 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
07:05:38     INFO -  PID 1838 | Wait for pending paints on 'simple.inspector'
07:05:38     INFO -  PID 1838 | Close toolbox on 'simple.inspector'
07:05:38     INFO -  PID 1838 | 2018-04-13 07:05:38.719 plugin-container[1843:29701] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9257, name = 'com.apple.tsm.portname'
07:05:38     INFO -  PID 1838 | See /usr/include/servers/bootstrap_defs.h for the error codes.
07:05:38     INFO -  PID 1838 | Garbage collect
07:05:39     INFO -  PID 1838 | inspector/simple.js took 2522ms.
07:05:39     INFO -  PID 1838 | Loading test 'debugger/simple.js'
07:05:39     INFO -  PID 1838 | Executing test 'debugger/simple.js'
07:05:40     INFO -  PID 1838 | Waiting for state change: count sources
07:05:40     INFO -  PID 1838 | Finished waiting for state change: count sources
07:05:40     INFO -  PID 1838 | Selecting source: simple.html
07:05:40     INFO -  PID 1838 | Waiting for state change: selected source
07:05:40     INFO -  PID 1838 | Finished waiting for state change: selected source
07:05:40     INFO -  PID 1838 | Waiting until: text is visible
07:05:40     INFO -  PID 1838 | Finished Waiting until: text is visible
07:05:40     INFO -  PID 1838 | Waiting until: has file metadata
07:05:41     INFO -  PID 1838 | Finished Waiting until: has file metadata
07:05:41     INFO -  PID 1838 | Garbage collect
07:05:41     INFO -  PID 1838 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
07:05:41     INFO -  PID 1838 | 2018-04-13 07:05:41.249 plugin-container[1844:29755] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x935b, name = 'com.apple.tsm.portname'
07:05:41     INFO -  PID 1838 | See /usr/include/servers/bootstrap_defs.h for the error codes.
07:05:41     INFO -  PID 1838 | Reload page on 'simple.jsdebugger'
07:05:41     INFO -  PID 1838 | Waiting for state change: count sources
07:05:41     INFO -  PID 1838 | Finished waiting for state change: count sources
07:05:42     INFO -  PID 1838 | Waiting until: text is visible
07:05:42     INFO -  PID 1838 | Finished Waiting until: text is visible
07:05:42     INFO -  PID 1838 | Waiting until: has file metadata
07:05:42     INFO -  PID 1838 | Finished Waiting until: has file metadata
07:05:42     INFO -  PID 1838 | Wait for pending paints on 'simple.jsdebugger'
07:05:42     INFO -  PID 1838 | Close toolbox on 'simple.jsdebugger'
07:05:42     INFO -  PID 1838 | Garbage collect
07:05:42     INFO -  PID 1838 | debugger/simple.js took 3643ms.
07:05:42     INFO -  PID 1838 | Loading test 'styleeditor/simple.js'
07:05:42     INFO -  PID 1838 | Executing test 'styleeditor/simple.js'
07:05:43     INFO -  PID 1838 | Garbage collect
07:05:44     INFO -  PID 1838 | Reload page on 'simple.styleeditor'
07:05:44     INFO -  PID 1838 | Wait for pending paints on 'simple.styleeditor'
07:05:44     INFO -  PID 1838 | Close toolbox on 'simple.styleeditor'
07:05:44     INFO -  PID 1838 | Garbage collect
07:05:44     INFO -  PID 1838 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
07:05:44     INFO -  PID 1838 | 2018-04-13 07:05:44.439 plugin-container[1845:29801] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x944f, name = 'com.apple.tsm.portname'
07:05:44     INFO -  PID 1838 | See /usr/include/servers/bootstrap_defs.h for the error codes.
07:05:44     INFO -  PID 1838 | styleeditor/simple.js took 1792ms.
07:05:44     INFO -  PID 1838 | Loading test 'performance/simple.js'
07:05:44     INFO -  PID 1838 | Executing test 'performance/simple.js'
07:05:45     INFO -  PID 1838 | Garbage collect
07:05:46     INFO -  PID 1838 | Reload page on 'simple.performance'
07:05:46     INFO -  PID 1838 | Wait for pending paints on 'simple.performance'
07:05:46     INFO -  PID 1838 | Close toolbox on 'simple.performance'
07:05:46     INFO -  PID 1838 | Garbage collect
07:05:46     INFO -  PID 1838 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
07:05:46     INFO -  PID 1838 | 2018-04-13 07:05:46.449 plugin-container[1846:29843] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x935b, name = 'com.apple.tsm.portname'
07:05:46     INFO -  PID 1838 | See /usr/include/servers/bootstrap_defs.h for the error codes.
07:05:46     INFO -  PID 1838 | performance/simple.js took 1977ms.
07:05:46     INFO -  PID 1838 | Loading test 'netmonitor/simple.js'
07:05:46     INFO -  PID 1838 | Executing test 'netmonitor/simple.js'
07:05:47     INFO -  PID 1838 | Garbage collect
07:05:47     INFO -  PID 1838 | Reload page on 'simple.netmonitor'
07:05:47     INFO -  PID 1838 | Wait for pending paints on 'simple.netmonitor'
07:05:48     INFO -  PID 1838 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
07:05:48     INFO -  PID 1838 | 2018-04-13 07:05:48.209 plugin-container[1847:29891] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9457, name = 'com.apple.tsm.portname'
07:05:48     INFO -  PID 1838 | See /usr/include/servers/bootstrap_defs.h for the error codes.
07:05:48     INFO -  PID 1838 | Close toolbox on 'simple.netmonitor'
07:05:48     INFO -  PID 1838 | console.error: "Task cancelled"
07:05:48     INFO -  PID 1838 | Garbage collect
07:05:48     INFO -  PID 1838 | netmonitor/simple.js took 2246ms.
07:05:48     INFO -  PID 1838 | Loading test 'memory/simple.js'
07:05:48     INFO -  PID 1838 | Executing test 'memory/simple.js'
07:05:49     INFO -  PID 1838 | Garbage collect
07:05:50     INFO -  PID 1838 | Reload page on 'simple.memory'
07:05:50     INFO -  PID 1838 | Wait for pending paints on 'simple.memory'
07:05:50     INFO -  PID 1838 | Close toolbox on 'simple.memory'
07:05:50     INFO -  PID 1838 | Garbage collect
07:05:50     INFO -  PID 1838 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
07:05:50     INFO -  PID 1838 | 2018-04-13 07:05:50.491 plugin-container[1848:29938] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9253, name = 'com.apple.tsm.portname'
07:05:50     INFO -  PID 1838 | See /usr/include/servers/bootstrap_defs.h for the error codes.
07:05:51     INFO -  PID 1838 | memory/simple.js took 2043ms.
07:05:51     INFO -  PID 1838 | Loading test 'webconsole/complicated.js'
07:05:51     INFO -  PID 1838 | Executing test 'webconsole/complicated.js'
07:05:52     INFO -  PID 1838 | Unable to read VR Path Registry from /Users/cltbld/Library/Application Support/OpenVR/.openvr/openvrpaths.vrpath
07:05:52     INFO -  PID 1838 | 2018-04-13 07:05:52.505 plugin-container[1849:29982] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9247, name = 'com.apple.tsm.portname'
07:05:52     INFO -  PID 1838 | See /usr/include/servers/bootstrap_defs.h for the error codes.
07:05:53     INFO -  PID 1838 | 2018-04-13 07:05:53.657 firefox[1838:29405] Persistent UI failed to open file file:///Users/cltbld/Library/Saved%20Application%20State/org.mozilla.nightly.savedState/window_1.data: No such file or directory (2)
07:10:51     INFO -  PID 1838 | TEST-UNEXPECTED-FAIL | damp | webconsole/complicated.js: Test timed out
07:10:51     INFO -  Terminating psutil.Process(pid=1838, name='firefox', started='07:05:30')
07:10:51     INFO -  PID 1838 | [GFX1-]: Receive IPC close with reason=AbnormalShutdown
07:10:51     INFO -  PID 1838 | [Child 1849, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 709
07:10:51     INFO -  PID 1838 | ** Unknown exception behavior: -2147483647
07:10:51     INFO -  PID 1838 | ** Unknown exception behavior: -2147483647
07:10:51     INFO -  PID 1838 | ** Unknown exception behavior: -2147483647
07:10:51     INFO -  PID 1838 | ** Unknown exception behavior: -2147483647
07:10:51     INFO -  TEST-UNEXPECTED-ERROR | damp | unexpected error
07:10:51    ERROR -  Traceback (most recent call last):
07:10:51     INFO -    File "/Users/cltbld/tasks/task_1523627387/build/tests/talos/talos/run_tests.py", line 296, in run_tests
07:10:51     INFO -      talos_results.add(mytest.runTest(browser_config, test))
07:10:51     INFO -    File "/Users/cltbld/tasks/task_1523627387/build/tests/talos/talos/ttest.py", line 63, in runTest
07:10:51     INFO -      return self._runTest(browser_config, test_config, setup)
07:10:51     INFO -    File "/Users/cltbld/tasks/task_1523627387/build/tests/talos/talos/ttest.py", line 207, in _runTest
07:10:51     INFO -      debugger_args=browser_config['debugger_args']
07:10:51     INFO -    File "/Users/cltbld/tasks/task_1523627387/build/tests/talos/talos/talos_process.py", line 156, in run_browser
07:10:51     INFO -      raise TalosError("unexpected error")
07:10:51     INFO -  TalosError: unexpected error
07:10:51     INFO -  TEST-INFO took 1134925ms
07:10:51     INFO -  SUITE-END | took 1134s
07:10:51    ERROR - Return code: 2
07:10:51  WARNING - setting return code to 2
07:10:51    ERROR - # TBPL FAILURE #

Comment 1

[Arthur Iakab [arthur_iakab]]

Also please see Bug 1453007, Bug 1452378,

Comment 2

[Intermittent Failures Robot]

1 failures in 792 pushes (0.001 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* osx-10-10: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1453984&startday=2018-04-09&endday=2018-04-15&tree=trunk

Comment 3

[Intermittent Failures Robot]

2 failures in 782 pushes (0.003 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-central: 1
* autoland: 1

Platform breakdown:
* osx-10-10: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1453984&startday=2018-04-16&endday=2018-04-22&tree=trunk

Comment 4

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup