Closed
Bug 1831231
Opened 2 years ago
Closed 2 years ago
Perma Linux Shippable Btime sp/sp3 [tier 2] raptor-browsertime Critical: [chrome] Exception [Errno 2] No such file or directory: '/<path>/Default/user.js' while removing mozprofile delimiters - no version 113 for chromedriver
Categories
(Testing :: Raptor, defect, P5)
Testing
Raptor
Tracking
(Not tracked)
RESOLVED
WORKSFORME
People
(Reporter: intermittent-bug-filer, Unassigned)
References
Details
(Keywords: intermittent-failure)
Filed by: imoraru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=414577783&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/C37U6XmXRjmEg6G3CoFlig/runs/0/artifacts/public/logs/live_backing.log
[task 2023-05-04T01:30:05.276Z] 01:30:05 INFO - Calling ['/home/cltbld/tasks/task_168316370417743/build/venv/bin/python', '/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/raptor.py', '--browsertime-node', '/home/cltbld/tasks/task_168316370417743/fetches/node/bin/node', '--browsertime-browsertimejs', '/home/cltbld/tasks/task_168316370417743/fetches/browsertime/node_modules/browsertime/bin/browsertime.js', '--browsertime-chromedriver', '/home/cltbld/tasks/task_168316370417743/fetches/{}chromedriver', '--browsertime-ffmpeg', '/home/cltbld/tasks/task_168316370417743/fetches/ffmpeg-4.4.1-i686-static/ffmpeg', '--browsertime-geckodriver', '/home/cltbld/tasks/task_168316370417743/fetches/geckodriver', '--browsertime', '--app', 'chrome', '--binary', '/usr/bin/google-chrome', '--test', 'speedometer', '--symbolsPath', 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/KWiZiFblQ5C3NheDWE0oTw/artifacts/public/build/target.crashreporter-symbols.zip', '--conditioned-profile', 'settled', '--host', '127.0.0.1', '--log-tbpl-level=info'] with output_timeout 3600
[task 2023-05-04T01:30:05.919Z] 01:30:05 INFO - Fission enabled through browser preferences
[task 2023-05-04T01:30:05.919Z] 01:30:05 INFO - raptor-main Info: Python version: 3.9.15 (main, Oct 12 2022, 19:15:11)
[task 2023-05-04T01:30:05.919Z] 01:30:05 INFO - [GCC 7.5.0]
[task 2023-05-04T01:30:05.920Z] 01:30:05 INFO - raptor-main Info: raptor-start
[task 2023-05-04T01:30:05.923Z] 01:30:05 INFO - raptor-main Info: received command line arguments: Namespace(test='speedometer', app='chrome', binary='/usr/bin/google-chrome', activity=None, intent=None, host='127.0.0.1', power_test=False, memory_test=False, cpu_test=False, live_sites=False, chimera=False, is_release_build=False, gecko_profile=False, gecko_profile_interval=None, gecko_profile_entries=None, gecko_profile_extra_threads=[], gecko_profile_threads=None, gecko_profile_features=None, extra_profiler_run=False, symbols_path='https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/KWiZiFblQ5C3NheDWE0oTw/artifacts/public/build/target.crashreporter-symbols.zip', page_cycles=None, page_timeout=None, post_startup_delay=30000, browser_cycles=None, project='mozilla-central', test_url_params=None, debug_mode=False, e10s=True, device_name=None, fission=True, fission_mobile=False, extra_prefs={'fission.autostart': True}, environment={}, run_local=False, obj_path=None, mozbuild_path=None, noinstall=False, installerpath=None, disable_perf_tuning=False, conditioned_profile='settled', webext=False, test_bytecode_cache=False, cold=False, browsertime=True, browsertime_user_args=[], browsertime_node='/home/cltbld/tasks/task_168316370417743/fetches/node/bin/node', browsertime_browsertimejs='/home/cltbld/tasks/task_168316370417743/fetches/browsertime/node_modules/browsertime/bin/browsertime.js', browsertime_vismet_script=None, browsertime_chromedriver='/home/cltbld/tasks/task_168316370417743/fetches/{}chromedriver', browsertime_video=False, browsertime_visualmetrics=False, browsertime_no_ffwindowrecorder=False, browsertime_ffmpeg='/home/cltbld/tasks/task_168316370417743/fetches/ffmpeg-4.4.1-i686-static/ffmpeg', browsertime_geckodriver='/home/cltbld/tasks/task_168316370417743/fetches/geckodriver', browsertime_existing_results=None, verbose=False, enable_marionette_trace=False, clean=False, collect_perfstats=False, extra_summary_methods=[], log_raw=None, log_unittest=None, log_xunit=None, log_html=None, log_mach=None, log_tbpl=None, log_grouped=None, log_errorsummary=None, log_raw_level=None, log_mach_verbose=None, log_mach_level=None, log_mach_buffer=None, log_mach_screenshot=None, log_tbpl_compact=None, log_tbpl_level='info', log_tbpl_buffer=None)
[task 2023-05-04T01:30:05.924Z] 01:30:05 INFO - raptor-manifest Info: /home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/raptor.ini
[task 2023-05-04T01:30:05.930Z] 01:30:05 INFO - raptor-manifest Info: configuring settings for test speedometer
[task 2023-05-04T01:30:05.931Z] 01:30:05 INFO - raptor-manifest Info: extra-profiler-run disabled
[task 2023-05-04T01:30:05.931Z] 01:30:05 INFO - raptor-main Info: raptor tests scheduled to run:
[task 2023-05-04T01:30:05.931Z] 01:30:05 INFO - raptor-main Info: speedometer
[task 2023-05-04T01:30:05.931Z] 01:30:05 INFO - raptor-perftest Info: Using a conditioned profile.
[task 2023-05-04T01:30:05.932Z] 01:30:05 INFO - raptor-perftest Warning: [chrome] Failed to get browser meta data through mozversion: LocalAppNotFoundError-Application not found at: /opt/google/chrome
[task 2023-05-04T01:30:05.932Z] 01:30:05 INFO - raptor-perftest Info: Attempting to get version through fallback method...
[task 2023-05-04T01:30:05.992Z] 01:30:05 INFO - Google Chrome 113.0.5672.63
[task 2023-05-04T01:30:06.014Z] 01:30:06 INFO - raptor-perftest Info: Browser name: chrome
[task 2023-05-04T01:30:06.014Z] 01:30:06 INFO - raptor-perftest Info: Browser version: 113.0.5672.63
[task 2023-05-04T01:30:06.015Z] 01:30:06 INFO - raptor-perftest Warning: [chrome] Failed to get browser meta data through mozversion: LocalAppNotFoundError-Application not found at: /opt/google/chrome
[task 2023-05-04T01:30:06.015Z] 01:30:06 INFO - raptor-perftest Info: Attempting to get version through fallback method...
[task 2023-05-04T01:30:06.071Z] 01:30:06 INFO - Google Chrome 113.0.5672.63
[task 2023-05-04T01:30:06.091Z] 01:30:06 INFO - raptor-perftest Info: Browser name: chrome
[task 2023-05-04T01:30:06.091Z] 01:30:06 INFO - raptor-perftest Info: Browser version: 113.0.5672.63
[task 2023-05-04T01:30:06.092Z] 01:30:06 INFO - raptor-perftest Info: Post startup delay set to 1000 ms
[task 2023-05-04T01:30:06.093Z] 01:30:06 INFO - raptor-perftest Info: main raptor init, config is: {'app': 'chrome', 'binary': '/usr/bin/google-chrome', 'platform': 'linux', 'processor': 'x86_64', 'run_local': False, 'obj_path': None, 'gecko_profile': False, 'gecko_profile_interval': None, 'gecko_profile_entries': None, 'gecko_profile_extra_threads': [], 'gecko_profile_threads': None, 'gecko_profile_features': None, 'extra_profiler_run': False, 'symbols_path': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/KWiZiFblQ5C3NheDWE0oTw/artifacts/public/build/target.crashreporter-symbols.zip', 'host': '127.0.0.1', 'power_test': False, 'memory_test': False, 'cpu_test': False, 'cold': False, 'live_sites': False, 'is_release_build': False, 'enable_control_server_wait': False, 'e10s': True, 'device_name': None, 'fission': True, 'disable_perf_tuning': False, 'conditioned_profile': 'settled', 'test_bytecode_cache': False, 'chimera': False, 'extra_prefs': {'fission.autostart': True}, 'environment': {}, 'project': 'mozilla-central', 'verbose': False, 'extra_summary_methods': []}
[task 2023-05-04T01:30:06.094Z] 01:30:06 INFO - raptor-perftest Info: Merging profile: /home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/profile_data/base
[task 2023-05-04T01:30:06.094Z] 01:30:06 INFO - raptor-perftest Info: Merging profile: /home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/profile_data/common
[task 2023-05-04T01:30:06.095Z] 01:30:06 INFO - raptor-perftest Info: Merging profile: /home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/profile_data/perf
[task 2023-05-04T01:30:06.095Z] 01:30:06 INFO - raptor-perftest Info: Merging profile: /home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/profile_data/raptor
[task 2023-05-04T01:30:06.095Z] 01:30:06 INFO - raptor-perftest Info: Browser preferences: {'fission.autostart': True}
[task 2023-05-04T01:30:06.095Z] 01:30:06 INFO - raptor-perftest Info: Local browser profile: /tmp/tmpcbqysnh5.mozrunner/Default
[task 2023-05-04T01:30:06.096Z] 01:30:06 INFO - raptor-browsertime Info: Removing mozprofile delimiters from browser profile
[task 2023-05-04T01:30:06.096Z] 01:30:06 CRITICAL - raptor-browsertime Critical: [chrome] Exception [Errno 2] No such file or directory: '/tmp/tmpcbqysnh5.mozrunner/Default/user.js' while removing mozprofile delimiters
[task 2023-05-04T01:30:06.096Z] 01:30:06 INFO - raptor-browsertime Info: cwd: '/home/cltbld/tasks/task_168316370417743/build'
[task 2023-05-04T01:30:06.097Z] 01:30:06 INFO - raptor-browsertime Info: browsertime_node: /home/cltbld/tasks/task_168316370417743/fetches/node/bin/node
[task 2023-05-04T01:30:06.097Z] 01:30:06 INFO - raptor-browsertime Info: browsertime_node: os.stat_result(st_mode=33261, st_ino=7296819, st_dev=64768, st_nlink=1, st_uid=1006, st_gid=1007, st_size=82792464, st_atime=1683163707, st_mtime=1670917451, st_ctime=1683163707)
[task 2023-05-04T01:30:06.098Z] 01:30:06 INFO - raptor-browsertime Info: browsertime_browsertimejs: /home/cltbld/tasks/task_168316370417743/fetches/browsertime/node_modules/browsertime/bin/browsertime.js
[task 2023-05-04T01:30:06.098Z] 01:30:06 INFO - raptor-browsertime Info: browsertime_browsertimejs: os.stat_result(st_mode=33261, st_ino=7749455, st_dev=64768, st_nlink=1, st_uid=1006, st_gid=1007, st_size=6287, st_atime=1683163707, st_mtime=1677004066, st_ctime=1683163707)
[task 2023-05-04T01:30:06.098Z] 01:30:06 INFO - raptor-browsertime Info: browsertime_geckodriver: /home/cltbld/tasks/task_168316370417743/fetches/geckodriver
[task 2023-05-04T01:30:06.099Z] 01:30:06 INFO - raptor-browsertime Info: browsertime_geckodriver: os.stat_result(st_mode=33261, st_ino=5506348, st_dev=64768, st_nlink=1, st_uid=1006, st_gid=1007, st_size=9631992, st_atime=1683163706, st_mtime=1682112131, st_ctime=1683163706)
[task 2023-05-04T01:30:06.099Z] 01:30:06 INFO - raptor-browsertime Info: browsertime_chromedriver: /home/cltbld/tasks/task_168316370417743/fetches/{}chromedriver
[task 2023-05-04T01:30:06.100Z] 01:30:06 INFO - raptor-browsertime Info: browsertime_chromedriver: [Errno 2] No such file or directory: '/home/cltbld/tasks/task_168316370417743/fetches/{}chromedriver'
[task 2023-05-04T01:30:06.100Z] 01:30:06 INFO - raptor-browsertime Info: browsertime_user_args: []
[task 2023-05-04T01:30:06.100Z] 01:30:06 INFO - raptor-browsertime Info: browsertime_user_args: stat: path should be string, bytes, os.PathLike or integer, not list
[task 2023-05-04T01:30:06.100Z] 01:30:06 INFO - raptor-perftest Info: starting test: speedometer
[task 2023-05-04T01:30:06.101Z] 01:30:06 INFO - raptor-benchmark Info: bench_dir: /home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/tests/webkit/PerformanceTests
[task 2023-05-04T01:30:06.101Z] 01:30:06 INFO - raptor-benchmark Info: bench_dir contains:
[task 2023-05-04T01:30:06.103Z] 01:30:06 INFO - raptor-benchmark Info: [PosixPath('/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/tests/webkit/PerformanceTests/SunSpider'), PosixPath('/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/tests/webkit/PerformanceTests/resources'), PosixPath('/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/tests/webkit/PerformanceTests/Speedometer'), PosixPath('/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/tests/webkit/PerformanceTests/MotionMark'), PosixPath('/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/tests/webkit/PerformanceTests/ARES-6'), PosixPath('/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/tests/webkit/PerformanceTests/six-speed'), PosixPath('/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/tests/webkit/PerformanceTests/wasm-godot'), PosixPath('/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/tests/webkit/PerformanceTests/StyleBench'), PosixPath('/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/tests/webkit/PerformanceTests/webaudio')]
[task 2023-05-04T01:30:06.103Z] 01:30:06 INFO - raptor-benchmark Info: writing wptserve headers file
[task 2023-05-04T01:30:06.103Z] 01:30:06 INFO - raptor-benchmark Info: wrote wpt headers file: /home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/tests/webkit/PerformanceTests/__dir__.headers
[task 2023-05-04T01:30:06.104Z] 01:30:06 INFO - raptor-benchmark Info: starting webserver on '127.0.0.1:39825'
[task 2023-05-04T01:30:06.104Z] 01:30:06 INFO - raptor-benchmark Info: serving benchmarks from here: /home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/tests/webkit/PerformanceTests
[task 2023-05-04T01:30:06.104Z] 01:30:06 ERROR - Traceback (most recent call last):
[task 2023-05-04T01:30:06.105Z] 01:30:06 INFO - File "/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/raptor.py", line 204, in <module>
[task 2023-05-04T01:30:06.105Z] 01:30:06 INFO - main()
[task 2023-05-04T01:30:06.105Z] 01:30:06 INFO - File "/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/raptor.py", line 150, in main
[task 2023-05-04T01:30:06.105Z] 01:30:06 INFO - success = raptor.run_tests(raptor_test_list, raptor_test_names)
[task 2023-05-04T01:30:06.105Z] 01:30:06 INFO - File "/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/perftest.py", line 472, in run_tests
[task 2023-05-04T01:30:06.106Z] 01:30:06 INFO - self.run_test(test, timeout=int(test.get("page_timeout")))
[task 2023-05-04T01:30:06.106Z] 01:30:06 INFO - File "/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/browsertime/base.py", line 687, in run_test
[task 2023-05-04T01:30:06.106Z] 01:30:06 INFO - self.run_test_setup(test)
[task 2023-05-04T01:30:06.106Z] 01:30:06 INFO - File "/home/cltbld/tasks/task_168316370417743/build/tests/raptor/raptor/browsertime/base.py", line 155, in run_test_setup
[task 2023-05-04T01:30:06.107Z] 01:30:06 INFO - raise Exception(
[task 2023-05-04T01:30:06.107Z] 01:30:06 INFO - Exception: Cannot find the chromedriver for the chrome version being tested: /home/cltbld/tasks/task_168316370417743/fetches/113chromedriver
[task 2023-05-04T01:30:06.168Z] 01:30:06 INFO - Return code: 1
[task 2023-05-04T01:30:06.168Z] 01:30:06 WARNING - setting return code to 1
[task 2023-05-04T01:30:06.168Z] 01:30:06 INFO - Copying Raptor results to upload dir:
[task 2023-05-04T01:30:06.168Z] 01:30:06 INFO - /home/cltbld/tasks/task_168316370417743/build/blobber_upload_dir/perfherder-data.json
[task 2023-05-04T01:30:06.168Z] 01:30:06 INFO - Copying raptor results from /home/cltbld/tasks/task_168316370417743/build/raptor.json to /home/cltbld/tasks/task_168316370417743/build/blobber_upload_dir/perfherder-data.json
[task 2023-05-04T01:30:06.168Z] 01:30:06 CRITICAL - Error copying results /home/cltbld/tasks/task_168316370417743/build/raptor.json to upload dir /home/cltbld/tasks/task_168316370417743/build/blobber_upload_dir/perfherder-data.json
[task 2023-05-04T01:30:06.168Z] 01:30:06 INFO - [Errno 2] No such file or directory: '/home/cltbld/tasks/task_168316370417743/build/raptor.json'
[task 2023-05-04T01:30:06.169Z] 01:30:06 INFO - Running post-action listener: _package_coverage_data
[task 2023-05-04T01:30:06.169Z] 01:30:06 INFO - Running post-action listener: _resource_record_post_action
[task 2023-05-04T01:30:06.169Z] 01:30:06 INFO - Running post-action listener: process_java_coverage_data
[task 2023-05-04T01:30:06.169Z] 01:30:06 INFO - Running post-action listener: stop_device
[task 2023-05-04T01:30:06.169Z] 01:30:06 INFO - [mozharness: 2023-05-04 01:30:06.169546Z] Finished run-tests step (success)
[task 2023-05-04T01:30:06.169Z] 01:30:06 INFO - Running post-run listener: _resource_record_post_run
[task 2023-05-04T01:30:06.239Z] 01:30:06 INFO - Total resource usage - Wall time: 12s; CPU: 13%; Read bytes: 663552; Write bytes: 21118976; Read time: 8; Write time: 164
[task 2023-05-04T01:30:06.240Z] 01:30:06 INFO - TinderboxPrint: CPU usage<br/>12.5%
[task 2023-05-04T01:30:06.240Z] 01:30:06 INFO - TinderboxPrint: I/O read bytes / time<br/>663,552 / 8
[task 2023-05-04T01:30:06.240Z] 01:30:06 INFO - TinderboxPrint: I/O write bytes / time<br/>21,118,976 / 164
[task 2023-05-04T01:30:06.240Z] 01:30:06 INFO - TinderboxPrint: CPU idle<br/>84.0 (87.5%)
[task 2023-05-04T01:30:06.240Z] 01:30:06 INFO - TinderboxPrint: CPU user<br/>11.7 (12.2%)
[task 2023-05-04T01:30:06.240Z] 01:30:06 INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2023-05-04T01:30:06.240Z] 01:30:06 INFO - install-chromium-distribution - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2023-05-04T01:30:06.241Z] 01:30:06 INFO - install - Wall time: 11s; CPU: 13%; Read bytes: 0; Write bytes: 19341312; Read time: 0; Write time: 164
[task 2023-05-04T01:30:06.241Z] 01:30:06 INFO - run-tests - Wall time: 1s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2023-05-04T01:30:06.249Z] 01:30:06 WARNING - returning nonzero exit status 1
[taskcluster 2023-05-04T01:30:06.285Z] Exit Code: 1
[taskcluster 2023-05-04T01:30:06.285Z] User Time: 1m30.228715s
[taskcluster 2023-05-04T01:30:06.285Z] Kernel Time: 7.087879s
[taskcluster 2023-05-04T01:30:06.285Z] Wall Time: 1m39.968128694s
[taskcluster 2023-05-04T01:30:06.285Z] Result: FAILED
[taskcluster 2023-05-04T01:30:06.285Z] === Task Finished ===
[taskcluster 2023-05-04T01:30:06.285Z] Task Duration: 1m39.971613539s
[taskcluster 2023-05-04T01:30:06.412Z] Uploading artifact public/logs/localconfig.json from file logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2023-08-02T00:03:57.553Z
[taskcluster 2023-05-04T01:30:06.700Z] Uploading artifact public/test_info/resource-usage.json from file build/blobber_upload_dir/resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2023-08-02T00:03:57.553Z
[taskcluster 2023-05-04T01:30:06.810Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2023-08-02T00:03:57.553Z
[taskcluster:error] exit status 1
|
||
Updated•2 years ago
|
Summary: Perma Linux Shippable Btime sp/sp3 [tier 2] raptor-browsertime Critical: [chrome] Exception [Errno 2] No such file or directory: '/tmp/tmpcbqysnh5.mozrunner/Default/user.js' while removing mozprofile delimiters → Perma Linux Shippable Btime sp/sp3 [tier 2] raptor-browsertime Critical: [chrome] Exception [Errno 2] No such file or directory: '/<path>/Default/user.js' while removing mozprofile delimiters - no version 113 for chromedriver
|
|
||
Comment 1•2 years ago
|
||
Hi Greg! Can you please take a look at this?
This only affects sp and sp3 on Linux shippable as seen here.
And, could this be something regressed by Bug 1830299?
Thank you!
Flags: needinfo?(gmierz2)
|
||
Comment 2•2 years ago
|
||
Thanks for the ping Iulian! This seems to be caused by a missing chromedriver for version 113.
Depends on: 1825736
Flags: needinfo?(gmierz2)
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 4•2 years ago
|
||
This hasn't failed since May 10th. It's no longer reproducing on trees.
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → WORKSFORME
| Comment hidden (Intermittent Failures Robot) |
You need to log in
before you can comment on or make changes to this bug.
Description
•