Closed Bug 1571728 Opened 6 years ago Closed 6 years ago

Intermittent TEST-UNEXPECTED-FAIL : xperf: File 'c:\windows\system32\cfgmgr32.dll' (normalized from 'C:\Windows\System32\cfgmgr32.dll') was accessed and we were not expecting it. DiskReadCount: 2, DiskWriteCount: 0, DiskReadBytes: 22528, DiskWriteBytes

Categories

(Testing :: Talos, defect, P5)

Product:
Testing
Component:
Talos
Version:
Version 3
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, regression)

Filed by: ccoroiu [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=260124309&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/XNaaZCBiQDWGt9BhiuDndw/runs/0/artifacts/public/logs/live_backing.log

[task 2019-08-06T14:21:04.379Z] 14:21:04 INFO - PID 8412 | -------- Summary: end --------
[task 2019-08-06T14:21:04.379Z] 14:21:04 INFO - PID 8412 |
[task 2019-08-06T14:21:04.379Z] 14:21:04 INFO - PID 8412 | [Parent 9652, Gecko_IOThread] WARNING: pipe error: 109: file z:/task_1565091350/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-08-06T14:21:04.401Z] 14:21:04 INFO - PID 8412 | [Child 3572, Chrome_ChildThread] WARNING: pipe error: 109: file z:/task_1565091350/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-08-06T14:21:04.441Z] 14:21:04 INFO - PID 8412 | [Child 3572, C[Parent 9652, Gecko_IOThread] WARNING: pipe error: 109: file z:/task_1565091350/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-08-06T14:21:04.441Z] 14:21:04 INFO - PID 8412 | [Child 2880, Chrome_ChildThread] WARNING: pipe error: 109: file z:/task_1565091350/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-08-06T14:21:04.442Z] 14:21:04 INFO - PID 8412 | [Child 2880, Chrome_ChildThread] WARNING: pip[Parent 9652, Gecko_IOThread] WARNING: pipe error: 109: file z:/task_1565091350/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-08-06T14:21:04.459Z] 14:21:04 INFO - PID 8412 | [Parent 9652, Gecko_IOThread] WARNING: pipe error: 109: file z:/task_1565091350/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-08-06T14:21:05.704Z] 14:21:05 INFO - TEST-INFO | 8412: exit 0
[task 2019-08-06T14:21:08.317Z] 14:21:08 INFO - The trace you have just captured "Z:\task_1565098456\build\test.etl.kernel" may contain personally identifiable information, including but not necessarily limited to paths to files accessed, paths to registry accessed and process names. Exact information depends on the events that were logged. Please be aware of this when sharing out this trace with other people.
[task 2019-08-06T14:21:08.317Z] 14:21:08 INFO - The trace you have just captured "Z:\task_1565098456\build\test.etl.user" may contain personally identifiable information, including but not necessarily limited to paths to files accessed, paths to registry accessed and process names. Exact information depends on the events that were logged. Please be aware of this when sharing out this trace with other people.
[task 2019-08-06T14:21:18.464Z] 14:21:18 INFO - Merged Etl: test.etl
[task 2019-08-06T14:23:18.668Z] 14:23:18 INFO - reading etl filename: test.etl
[task 2019-08-06T14:23:18.668Z] 14:23:18 INFO - etlparser: in readfile: test.etl.csv
[task 2019-08-06T14:23:18.668Z] 14:23:18 INFO - TEST-UNEXPECTED-FAIL : xperf: File 'c:\windows\system32\cfgmgr32.dll' (normalized from 'C:\Windows\System32\cfgmgr32.dll') was accessed and we were not expecting it. DiskReadCount: 2, DiskWriteCount: 0, DiskReadBytes: 22528, DiskWriteBytes: 0
[task 2019-08-06T14:23:18.668Z] 14:23:18 INFO - TEST-UNEXPECTED-FAIL : xperf: File 'c:\windows\system32\mmdevapi.dll' (normalized from 'C:\Windows\System32\MMDevAPI.dll') was accessed and we were not expecting it. DiskReadCount: 2, DiskWriteCount: 0, DiskReadBytes: 8192, DiskWriteBytes: 0
[task 2019-08-06T14:23:20.030Z] 14:23:20 INFO - extending with xperf!
[task 2019-08-06T14:23:20.030Z] 14:23:20 INFO - Detected a regression for tp5n
[task 2019-08-06T14:23:20.032Z] 14:23:20 INFO - TEST-UNEXPECTED-FAIL | tp5n | Talos has found a regression, if you have questions ask for help in irc on #perf
[task 2019-08-06T14:23:20.032Z] 14:23:20 ERROR - Traceback (most recent call last):
[task 2019-08-06T14:23:20.032Z] 14:23:20 INFO - File "Z:\task_1565098456\build\tests\talos\talos\run_tests.py", line 276, in run_tests
[task 2019-08-06T14:23:20.032Z] 14:23:20 INFO - talos_results.add(mytest.runTest(browser_config, test))
[task 2019-08-06T14:23:20.032Z] 14:23:20 INFO - File "Z:\task_1565098456\build\tests\talos\talos\ttest.py", line 64, in runTest
[task 2019-08-06T14:23:20.032Z] 14:23:20 INFO - return self._runTest(browser_config, test_config, setup)
[task 2019-08-06T14:23:20.032Z] 14:23:20 INFO - File "Z:\task_1565098456\build\tests\talos\talos\ttest.py", line 269, in _runTest
[task 2019-08-06T14:23:20.032Z] 14:23:20 INFO - 'Talos has found a regression, if you have questions'
[task 2019-08-06T14:23:20.032Z] 14:23:20 INFO - TalosRegression: Talos has found a regression, if you have questions ask for help in irc on #perf
[task 2019-08-06T14:23:20.032Z] 14:23:20 INFO - TEST-INFO took 253686ms
[task 2019-08-06T14:23:20.032Z] 14:23:20 INFO - SUITE-END | took 253s
[task 2019-08-06T14:23:20.191Z] 14:23:20 ERROR - Return code: 1
[task 2019-08-06T14:23:20.191Z] 14:23:20 WARNING - setting return code to 1
[task 2019-08-06T14:23:20.191Z] 14:23:20 ERROR - # TBPL WARNING #

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

Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=266477536&repo=autoland&lineNumber=1691

[task 2019-09-13T05:14:26.341Z] 05:14:26 INFO - PID 8120 | [Child 1912, Chrome_ChildThread] WARNING: pipe error: 109: file z:/task_1568343737/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-09-13T05:14:26.594Z] 05:14:26 INFO - TEST-INFO | 8120: exit 0
[task 2019-09-13T05:14:29.316Z] 05:14:29 INFO - The trace you have just captured "Z:\task_1568347460\build\test.etl.kernel" may contain personally identifiable information, including but not necessarily limited to paths to files accessed, paths to registry accessed and process names. Exact information depends on the events that were logged. Please be aware of this when sharing out this trace with other people.
[task 2019-09-13T05:14:29.316Z] 05:14:29 INFO - The trace you have just captured "Z:\task_1568347460\build\test.etl.user" may contain personally identifiable information, including but not necessarily limited to paths to files accessed, paths to registry accessed and process names. Exact information depends on the events that were logged. Please be aware of this when sharing out this trace with other people.
[task 2019-09-13T05:14:40.612Z] 05:14:40 INFO - Merged Etl: test.etl
[task 2019-09-13T05:17:12.272Z] 05:17:12 INFO - reading etl filename: test.etl
[task 2019-09-13T05:17:12.272Z] 05:17:12 INFO - etlparser: in readfile: test.etl.csv
[task 2019-09-13T05:17:12.272Z] 05:17:12 INFO - TEST-UNEXPECTED-FAIL : xperf: File 'c:\windows\system32\cfgmgr32.dll' (normalized from 'C:\Windows\System32\cfgmgr32.dll') was accessed and we were not expecting it. DiskReadCount: 2, DiskWriteCount: 0, DiskReadBytes: 22528, DiskWriteBytes: 0
[task 2019-09-13T05:17:13.693Z] 05:17:13 INFO - extending with xperf!
[task 2019-09-13T05:17:13.693Z] 05:17:13 INFO - Detected a regression for tp5n
[task 2019-09-13T05:17:13.693Z] 05:17:13 INFO - TEST-UNEXPECTED-FAIL | tp5n | Talos has found a regression, if you have questions ask for help in irc on #perf
[task 2019-09-13T05:17:13.693Z] 05:17:13 ERROR - Traceback (most recent call last):
[task 2019-09-13T05:17:13.693Z] 05:17:13 INFO - File "Z:\task_1568347460\build\tests\talos\talos\run_tests.py", line 276, in run_tests
[task 2019-09-13T05:17:13.693Z] 05:17:13 INFO - talos_results.add(mytest.runTest(browser_config, test))
[task 2019-09-13T05:17:13.693Z] 05:17:13 INFO - File "Z:\task_1568347460\build\tests\talos\talos\ttest.py", line 64, in runTest
[task 2019-09-13T05:17:13.693Z] 05:17:13 INFO - return self._runTest(browser_config, test_config, setup)
[task 2019-09-13T05:17:13.693Z] 05:17:13 INFO - File "Z:\task_1568347460\build\tests\talos\talos\ttest.py", line 269, in _runTest
[task 2019-09-13T05:17:13.693Z] 05:17:13 INFO - 'Talos has found a regression, if you have questions'
[task 2019-09-13T05:17:13.693Z] 05:17:13 INFO - TalosRegression: Talos has found a regression, if you have questions ask for help in irc on #perf
[task 2019-09-13T05:17:13.693Z] 05:17:13 INFO - TEST-INFO took 284040ms
[task 2019-09-13T05:17:13.694Z] 05:17:13 INFO - SUITE-END | took 284s
[task 2019-09-13T05:17:14.175Z] 05:17:14 ERROR - Return code: 1
[task 2019-09-13T05:17:14.175Z] 05:17:14 WARNING - setting return code to 1
[task 2019-09-13T05:17:14.175Z] 05:17:14 ERROR - # TBPL WARNING #
[task 2019-09-13T05:17:14.175Z] 05:17:14 INFO - Running post-action listener: _package_coverage_data
[task 2019-09-13T05:17:14.175Z] 05:17:14 INFO - Running post-action listener: _resource_record_post_action
[task 2019-09-13T05:17:14.175Z] 05:17:14 INFO - Running post-action listener: process_java_coverage_data
[task 2019-09-13T05:17:14.175Z] 05:17:14 INFO - [mozharness: 2019-09-13 05:17:14.175000Z] Finished run-tests step (success)

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: REOPENED → RESOLVED
Closed: 6 years ago → 6 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.