Closed Bug 1594534 Opened 6 years ago Closed 6 years ago

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

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)

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

[task 2019-11-06T17:37:00.536Z] 17:37:00 INFO - PID 5604 | Values: 107.0
[task 2019-11-06T17:37:00.536Z] 17:37:00 INFO - PID 5604 |
[task 2019-11-06T17:37:00.536Z] 17:37:00 INFO - PID 5604 | [#98] youtube.com/www.youtube.com/music.html Cycles:1 Average:520.00 Median:520.00 stddev:0.00 (0.0%)
[task 2019-11-06T17:37:00.536Z] 17:37:00 INFO - PID 5604 | Values: 520.0
[task 2019-11-06T17:37:00.536Z] 17:37:00 INFO - PID 5604 |
[task 2019-11-06T17:37:00.536Z] 17:37:00 INFO - PID 5604 | [#99] people.com.cn/people.com.cn/index.html Cycles:1 Average:1155.00 Median:1155.00 stddev:0.00 (0.0%)
[task 2019-11-06T17:37:00.536Z] 17:37:00 INFO - PID 5604 | Values: 1155.0
[task 2019-11-06T17:37:00.537Z] 17:37:00 INFO - PID 5604 | -------- Summary: end --------
[task 2019-11-06T17:37:00.537Z] 17:37:00 INFO - PID 5604 |
[task 2019-11-06T17:37:00.537Z] 17:37:00 INFO - PID 5604 | [Child 1880, Chrome_ChildThread] WARNING: pipe error: 109: file z:/task_1573052117/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-11-06T17:37:00.537Z] 17:37:00 INFO - PID 5604 | [Child 1880, Chrome_ChildThread] WARNING: pip[Parent 5492, Gecko_IOThread] WARNING: pipe error: 109: file z:/task_1573052117/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-11-06T17:37:00.537Z] 17:37:00 INFO - PID 5604 | [Child 5888, Chrome_ChildThread] WARNING: pipe error: 109: file z:/task_1573052117/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-11-06T17:37:00.538Z] 17:37:00 INFO - PID 5604 | [Child 5888, Chrome_ChildThread] WARNING: pipe error: 109: file z:/task_1573052117/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-11-06T17:37:00.538Z] 17:37:00 INFO - PID 5604 | [Parent 5492, Gecko_IOThread] WARNING: pipe error: 109: file z:/task_1573052117/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-11-06T17:37:00.541Z] 17:37:00 INFO - PID 5604 | [Ch
[task 2019-11-06T17:37:00.541Z] 17:37:00 INFO - PID 5604 | ###!!! [Child][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-11-06T17:37:00.541Z] 17:37:00 INFO - PID 5604 |
[task 2019-11-06T17:37:00.541Z] 17:37:00 INFO - PID 5604 | ild 5320, Chrome_ChildThread] WARNING: pipe error: 109: file z:/task_1573052117/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
[task 2019-11-06T17:37:00.768Z] 17:37:00 INFO - PID 5604 | [Child 5320, Chrome_ChildThread] WARNING: pipe error: 109: file z:/task_1573052117/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line
[task 2019-11-06T17:37:00.803Z] 17:37:00 INFO - TEST-INFO | 5604: exit 0
[task 2019-11-06T17:37:02.018Z] 17:37:02 INFO - The trace you have just captured "Z:\task_1573059231\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-11-06T17:37:02.018Z] 17:37:02 INFO - The trace you have just captured "Z:\task_1573059231\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-11-06T17:37:10.805Z] 17:37:10 INFO - Merged Etl: test.etl
[task 2019-11-06T17:39:01.559Z] 17:39:01 INFO - c:/Program Files/Microsoft Windows Performance Toolkit/xperf: warning: applying restriction of access for trace processing
[task 2019-11-06T17:39:59.215Z] 17:39:59 INFO - reading etl filename: test.etl
[task 2019-11-06T17:39:59.215Z] 17:39:59 INFO - etlparser: in readfile: test.etl.csv
[task 2019-11-06T17:39:59.215Z] 17:39:59 INFO - TEST-UNEXPECTED-FAIL : xperf: File 'c:\windows\system32\wldap32.dll' (normalized from 'C:\windows\system32\Wldap32.dll') was accessed and we were not expecting it. DiskReadCount: 2, DiskWriteCount: 0, DiskReadBytes: 65536, DiskWriteBytes: 0
[task 2019-11-06T17:40:02.043Z] 17:40:02 INFO - extending with xperf!
[task 2019-11-06T17:40:02.043Z] 17:40:02 INFO - Detected a regression for tp5n
[task 2019-11-06T17:40:02.043Z] 17:40:02 INFO - TEST-UNEXPECTED-FAIL | tp5n | Talos has found a regression, if you have questions ask for help in irc on #perf
[task 2019-11-06T17:40:02.043Z] 17:40:02 ERROR - Traceback (most recent call last):
[task 2019-11-06T17:40:02.043Z] 17:40:02 INFO - File "Z:\task_1573059231\build\tests\talos\talos\run_tests.py", line 281, in run_tests
[task 2019-11-06T17:40:02.043Z] 17:40:02 INFO - talos_results.add(mytest.runTest(browser_config, test))
[task 2019-11-06T17:40:02.044Z] 17:40:02 INFO - File "Z:\task_1573059231\build\tests\talos\talos\ttest.py", line 64, in runTest
[task 2019-11-06T17:40:02.044Z] 17:40:02 INFO - return self._runTest(browser_config, test_config, setup)
[task 2019-11-06T17:40:02.044Z] 17:40:02 INFO - File "Z:\task_1573059231\build\tests\talos\talos\ttest.py", line 269, in _runTest
[task 2019-11-06T17:40:02.044Z] 17:40:02 INFO - 'Talos has found a regression, if you have questions'
[task 2019-11-06T17:40:02.044Z] 17:40:02 INFO - TalosRegression: Talos has found a regression, if you have questions ask for help in irc on #perf
[task 2019-11-06T17:40:02.044Z] 17:40:02 INFO - TEST-INFO took 292995ms
[task 2019-11-06T17:40:02.044Z] 17:40:02 INFO - SUITE-END | took 292s
[task 2019-11-06T17:40:02.428Z] 17:40:02 ERROR - Return code: 1

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

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