builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1501756316.47 results: success (0) revision: 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.472405) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.472897) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.473181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.496281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.496705) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-03 03:31:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.2M=0s 2017-08-03 03:31:57 (42.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128851 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.646497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.646835) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019786 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.714303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 mins, 57 secs) (at 2017-08-03 03:31:56.714687) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-03 03:31:57,766 truncating revision to first 12 chars 2017-08-03 03:31:57,766 Setting DEBUG logging. 2017-08-03 03:31:57,766 attempt 1/10 2017-08-03 03:31:57,766 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/63e261ce8cb0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-03 03:31:58,158 attempt 1/10 2017-08-03 03:31:58,737 current task status: no status available at this point. state: PENDING 2017-08-03 03:31:58,738 sleeping for 9.00s (attempt 1/10) 2017-08-03 03:32:07,747 attempt 2/10 2017-08-03 03:32:08,308 current task status: no status available at this point. state: PENDING 2017-08-03 03:32:08,308 sleeping for 12.50s (attempt 2/10) 2017-08-03 03:32:20,821 attempt 3/10 2017-08-03 03:32:21,358 current task status: no status available at this point. state: PENDING 2017-08-03 03:32:21,359 sleeping for 19.75s (attempt 3/10) 2017-08-03 03:32:41,129 attempt 4/10 2017-08-03 03:32:41,698 current task status: no status available at this point. state: PENDING 2017-08-03 03:32:41,699 sleeping for 28.62s (attempt 4/10) 2017-08-03 03:33:10,353 attempt 5/10 2017-08-03 03:33:10,884 current task status: no status available at this point. state: PENDING 2017-08-03 03:33:10,884 sleeping for 42.94s (attempt 5/10) 2017-08-03 03:33:53,865 attempt 6/10 2017-08-03 03:33:54,205 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-03 03:33:54,465 unpacking tar archive at: mozilla-central-63e261ce8cb0/testing/mozharness/ program finished with exit code 0 elapsedTime=117.010466 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 mins, 57 secs) (at 2017-08-03 03:33:53.767375) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 03:33:53.770703) ========= script_repo_revision: 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 03:33:53.771105) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 03:33:53.771367) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 03:33:53.780549) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-03 03:33:53.780901) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:33:54 INFO - MultiFileLogger online at 20170803 03:33:54 in /builds/slave/test 03:33:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:33:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:33:54 INFO - {'append_to_log': False, 03:33:54 INFO - 'base_work_dir': '/builds/slave/test', 03:33:54 INFO - 'blob_upload_branch': 'Firefox', 03:33:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:33:54 INFO - 'branch': 'Firefox', 03:33:54 INFO - 'buildbot_json_path': 'buildprops.json', 03:33:54 INFO - 'code_coverage': False, 03:33:54 INFO - 'config_files': ('talos/linux_config.py',), 03:33:54 INFO - 'default_actions': ('clobber', 03:33:54 INFO - 'read-buildbot-config', 03:33:54 INFO - 'download-and-extract', 03:33:54 INFO - 'populate-webroot', 03:33:54 INFO - 'create-virtualenv', 03:33:54 INFO - 'install', 03:33:54 INFO - 'setup-mitmproxy', 03:33:54 INFO - 'run-tests'), 03:33:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:33:54 INFO - 'disable_ccov_upload': False, 03:33:54 INFO - 'download_minidump_stackwalk': True, 03:33:54 INFO - 'download_symbols': 'ondemand', 03:33:54 INFO - 'enable_stylo': False, 03:33:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:33:54 INFO - 'tooltool.py': '/tools/tooltool.py', 03:33:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:33:54 INFO - '/tools/misc-python/virtualenv.py')}, 03:33:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:33:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:33:54 INFO - 'gecko_profile': False, 03:33:54 INFO - 'gecko_profile_interval': 0, 03:33:54 INFO - 'installer_path': 'installer.exe', 03:33:54 INFO - 'log_level': 'info', 03:33:54 INFO - 'log_name': 'talos', 03:33:54 INFO - 'log_to_console': True, 03:33:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:33:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:33:54 INFO - 'opt_config_files': (), 03:33:54 INFO - 'pip_index': False, 03:33:54 INFO - 'suite': 'dromaeojs-e10s', 03:33:54 INFO - 'system_bits': '32', 03:33:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:33:54 INFO - 'title': 'talos-linux64-ix-041', 03:33:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:33:54 INFO - 'use_talos_json': True, 03:33:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:33:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:33:54 INFO - 'work_dir': 'build'} 03:33:54 INFO - [mozharness: 2017-08-03 10:33:54.903578Z] Running clobber step. 03:33:54 INFO - Running pre-action listener: _resource_record_pre_action 03:33:54 INFO - Running main action method: clobber 03:33:54 INFO - rmtree: /builds/slave/test/build 03:33:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:33:55 INFO - Running post-action listener: _resource_record_post_action 03:33:55 INFO - [mozharness: 2017-08-03 10:33:55.941462Z] Finished clobber step (success) 03:33:55 INFO - [mozharness: 2017-08-03 10:33:55.941566Z] Running read-buildbot-config step. 03:33:55 INFO - Running pre-action listener: _resource_record_pre_action 03:33:55 INFO - Running main action method: read_buildbot_config 03:33:55 INFO - Using buildbot properties: 03:33:55 INFO - { 03:33:55 INFO - "project": "", 03:33:55 INFO - "product": "firefox", 03:33:55 INFO - "who": "archaeopteryx@coole-files.de", 03:33:55 INFO - "installer_path": "public/build/target.tar.bz2", 03:33:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:33:55 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:33:55 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:33:55 INFO - "stage_platform": "linux64-stylo", 03:33:55 INFO - "basedir": "/builds/slave/test", 03:33:55 INFO - "buildnumber": 64, 03:33:55 INFO - "platform": "ubuntu64_hw_stylo", 03:33:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:33:55 INFO - "slavebuilddir": "test", 03:33:55 INFO - "taskId": "YlBv4jgqR5qecHBuiaLNDg", 03:33:55 INFO - "branch": "mozilla-central", 03:33:55 INFO - "script_repo_revision": "production", 03:33:55 INFO - "revision": "63e261ce8cb04c913d2e6b19ea451b7078d24dc1", 03:33:55 INFO - "slavename": "talos-linux64-ix-041", 03:33:55 INFO - "repo_path": "mozilla-central" 03:33:55 INFO - } 03:33:55 INFO - Finding installer, test and symbols from parent task. 03:33:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YlBv4jgqR5qecHBuiaLNDg'}, attempt #1 03:33:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YlBv4jgqR5qecHBuiaLNDg'}, attempt #1 03:33:56 INFO - Task dependencies: L44bNG-6R8C_EpcBDQJUNA 03:33:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA'}, attempt #1 03:33:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 03:33:57 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.test_packages.json 03:33:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.crashreporter-symbols.zip 03:33:57 INFO - Running post-action listener: _resource_record_post_action 03:33:57 INFO - [mozharness: 2017-08-03 10:33:57.359023Z] Finished read-buildbot-config step (success) 03:33:57 INFO - [mozharness: 2017-08-03 10:33:57.359244Z] Running download-and-extract step. 03:33:57 INFO - Running pre-action listener: _resource_record_pre_action 03:33:57 INFO - Running main action method: download_and_extract 03:33:57 INFO - mkdir: /builds/slave/test/build/tests 03:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:57 INFO - trying https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.test_packages.json 03:33:57 INFO - Downloading https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:33:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:33:57 INFO - Downloaded 989 bytes. 03:33:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:33:57 INFO - Using the following test package requirements: 03:33:57 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:33:57 INFO - u'common': [u'target.common.tests.zip'], 03:33:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:33:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:33:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:33:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:33:57 INFO - u'mozbase': [u'target.common.tests.zip'], 03:33:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:33:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:33:57 INFO - u'web-platform': [u'target.common.tests.zip', 03:33:57 INFO - u'target.web-platform.tests.tar.gz'], 03:33:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:33:57 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:33:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip 03:33:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:33:57 INFO - Fetch https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip into memory 03:33:59 INFO - Content-Length response header: 54278281 03:33:59 INFO - Bytes received: 54278281 03:34:10 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:34:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip 03:34:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:34:10 INFO - Fetch https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip into memory 03:34:11 INFO - Content-Length response header: 54278281 03:34:11 INFO - Bytes received: 54278281 03:34:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.talos.tests.zip 03:34:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:34:23 INFO - Fetch https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.talos.tests.zip into memory 03:34:24 INFO - Content-Length response header: 14496464 03:34:24 INFO - Bytes received: 14496464 03:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:24 INFO - trying https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 03:34:24 INFO - Downloading https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:34:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:34:26 INFO - Downloaded 62211648 bytes. 03:34:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 03:34:26 INFO - mkdir: /builds/slave/test/properties 03:34:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:34:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:34:26 INFO - Contents: 03:34:26 INFO - build_url:https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 03:34:26 INFO - Running post-action listener: _resource_record_post_action 03:34:26 INFO - Running post-action listener: set_extra_try_arguments 03:34:26 INFO - [mozharness: 2017-08-03 10:34:26.201854Z] Finished download-and-extract step (success) 03:34:26 INFO - [mozharness: 2017-08-03 10:34:26.201953Z] Running populate-webroot step. 03:34:26 INFO - Running pre-action listener: _resource_record_pre_action 03:34:26 INFO - Running main action method: populate_webroot 03:34:26 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:34:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:34:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:34:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:34:26 INFO - 'tests': ['damp', 'tps']}, 03:34:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:34:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:34:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:34:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:34:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:34:26 INFO - 'ts_paint', 03:34:26 INFO - 'tpaint', 03:34:26 INFO - 'sessionrestore', 03:34:26 INFO - 'sessionrestore_many_windows', 03:34:26 INFO - 'sessionrestore_no_auto_restore', 03:34:26 INFO - 'tabpaint']}, 03:34:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:34:26 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:34:26 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:26 INFO - 'talos_options': ['--mitmproxy', 03:34:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:26 INFO - '--firstNonBlankPaint'], 03:34:26 INFO - 'tests': ['quantum_pageload_google', 03:34:26 INFO - 'quantum_pageload_youtube', 03:34:26 INFO - 'quantum_pageload_amazon', 03:34:26 INFO - 'quantum_pageload_facebook']}, 03:34:26 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:26 INFO - 'talos_options': ['--stylo', 03:34:26 INFO - '--mitmproxy', 03:34:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:26 INFO - '--firstNonBlankPaint'], 03:34:26 INFO - 'tests': ['quantum_pageload_google', 03:34:26 INFO - 'quantum_pageload_youtube', 03:34:26 INFO - 'quantum_pageload_amazon', 03:34:26 INFO - 'quantum_pageload_facebook']}, 03:34:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:34:26 INFO - 'tsvgr_opacity', 03:34:26 INFO - 'tart', 03:34:26 INFO - 'tscrollx', 03:34:26 INFO - 'cart', 03:34:26 INFO - 'tsvg_static']}, 03:34:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:34:26 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:26 INFO - 'talos_options': ['--stylo', 03:34:26 INFO - '--stylo-threads=1', 03:34:26 INFO - '--mitmproxy', 03:34:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:26 INFO - '--firstNonBlankPaint'], 03:34:26 INFO - 'tests': ['tp6_google', 03:34:26 INFO - 'tp6_youtube', 03:34:26 INFO - 'tp6_amazon', 03:34:26 INFO - 'tp6_facebook']}, 03:34:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:34:26 INFO - 'talos_options': ['--xperf_path', 03:34:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:26 INFO - 'tests': ['tp5n']}}} 03:34:26 INFO - Running post-action listener: _resource_record_post_action 03:34:26 INFO - [mozharness: 2017-08-03 10:34:26.210585Z] Finished populate-webroot step (success) 03:34:26 INFO - [mozharness: 2017-08-03 10:34:26.210674Z] Running create-virtualenv step. 03:34:26 INFO - Running pre-action listener: _resource_record_pre_action 03:34:26 INFO - Running main action method: create_virtualenv 03:34:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:34:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:34:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:34:26 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:34:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:34:26 INFO - Using real prefix '/usr' 03:34:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:34:26 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:28 INFO - Installing pip.................done. 03:34:28 INFO - Return code: 0 03:34:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:34:28 INFO - Reading from file tmpfile_stdout 03:34:28 INFO - Output received: 03:34:28 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:34:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179aeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:34:29 INFO - Using env: {'DISPLAY': ':0', 03:34:29 INFO - 'HOME': '/home/cltbld', 03:34:29 INFO - 'LANG': 'en_US.UTF-8', 03:34:29 INFO - 'LANGUAGE': 'en_US:en', 03:34:29 INFO - 'LOGNAME': 'cltbld', 03:34:29 INFO - 'MAIL': '/var/mail/cltbld', 03:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:29 INFO - 'MOZ_NO_REMOTE': '1', 03:34:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:29 INFO - 'NO_EM_RESTART': '1', 03:34:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:29 INFO - 'PWD': '/builds/slave/test', 03:34:29 INFO - 'SHELL': '/bin/bash', 03:34:29 INFO - 'SHLVL': '1', 03:34:29 INFO - 'TERM': 'linux', 03:34:29 INFO - 'TMOUT': '86400', 03:34:29 INFO - 'USER': 'cltbld', 03:34:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 03:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:29 INFO - '_': '/tools/buildbot/bin/python'} 03:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:34:29 INFO - Cleaning up... 03:34:29 INFO - Return code: 0 03:34:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179aeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:34:29 INFO - Using env: {'DISPLAY': ':0', 03:34:29 INFO - 'HOME': '/home/cltbld', 03:34:29 INFO - 'LANG': 'en_US.UTF-8', 03:34:29 INFO - 'LANGUAGE': 'en_US:en', 03:34:29 INFO - 'LOGNAME': 'cltbld', 03:34:29 INFO - 'MAIL': '/var/mail/cltbld', 03:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:29 INFO - 'MOZ_NO_REMOTE': '1', 03:34:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:29 INFO - 'NO_EM_RESTART': '1', 03:34:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:29 INFO - 'PWD': '/builds/slave/test', 03:34:29 INFO - 'SHELL': '/bin/bash', 03:34:29 INFO - 'SHLVL': '1', 03:34:29 INFO - 'TERM': 'linux', 03:34:29 INFO - 'TMOUT': '86400', 03:34:29 INFO - 'USER': 'cltbld', 03:34:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 03:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:29 INFO - '_': '/tools/buildbot/bin/python'} 03:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:29 INFO - Downloading/unpacking psutil>=3.1.1 03:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:30 INFO - Installing collected packages: psutil 03:34:30 INFO - Running setup.py install for psutil 03:34:30 INFO - building 'psutil._psutil_linux' extension 03:34:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:34:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:34:30 INFO - building 'psutil._psutil_posix' extension 03:34:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:34:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:34:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:31 INFO - Successfully installed psutil 03:34:31 INFO - Cleaning up... 03:34:31 INFO - Return code: 0 03:34:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179aeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:34:31 INFO - Using env: {'DISPLAY': ':0', 03:34:31 INFO - 'HOME': '/home/cltbld', 03:34:31 INFO - 'LANG': 'en_US.UTF-8', 03:34:31 INFO - 'LANGUAGE': 'en_US:en', 03:34:31 INFO - 'LOGNAME': 'cltbld', 03:34:31 INFO - 'MAIL': '/var/mail/cltbld', 03:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:31 INFO - 'MOZ_NO_REMOTE': '1', 03:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:31 INFO - 'NO_EM_RESTART': '1', 03:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:31 INFO - 'PWD': '/builds/slave/test', 03:34:31 INFO - 'SHELL': '/bin/bash', 03:34:31 INFO - 'SHLVL': '1', 03:34:31 INFO - 'TERM': 'linux', 03:34:31 INFO - 'TMOUT': '86400', 03:34:31 INFO - 'USER': 'cltbld', 03:34:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 03:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:31 INFO - '_': '/tools/buildbot/bin/python'} 03:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:34:32 INFO - Installing collected packages: mozsystemmonitor 03:34:32 INFO - Running setup.py install for mozsystemmonitor 03:34:32 INFO - Successfully installed mozsystemmonitor 03:34:32 INFO - Cleaning up... 03:34:32 INFO - Return code: 0 03:34:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179aeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:34:32 INFO - Using env: {'DISPLAY': ':0', 03:34:32 INFO - 'HOME': '/home/cltbld', 03:34:32 INFO - 'LANG': 'en_US.UTF-8', 03:34:32 INFO - 'LANGUAGE': 'en_US:en', 03:34:32 INFO - 'LOGNAME': 'cltbld', 03:34:32 INFO - 'MAIL': '/var/mail/cltbld', 03:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:32 INFO - 'MOZ_NO_REMOTE': '1', 03:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:32 INFO - 'NO_EM_RESTART': '1', 03:34:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:32 INFO - 'PWD': '/builds/slave/test', 03:34:32 INFO - 'SHELL': '/bin/bash', 03:34:32 INFO - 'SHLVL': '1', 03:34:32 INFO - 'TERM': 'linux', 03:34:32 INFO - 'TMOUT': '86400', 03:34:32 INFO - 'USER': 'cltbld', 03:34:32 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 03:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:32 INFO - '_': '/tools/buildbot/bin/python'} 03:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:32 INFO - Downloading/unpacking jsonschema==2.5.1 03:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:34 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:34 INFO - warning: no files found matching '*.txt' 03:34:34 INFO - no previously-included directories found matching 'build' 03:34:34 INFO - no previously-included directories found matching 'dist' 03:34:34 INFO - no previously-included directories found matching '.git*' 03:34:34 INFO - Installing collected packages: jsonschema, functools32 03:34:34 INFO - Running setup.py install for functools32 03:34:34 INFO - warning: no files found matching '*.txt' 03:34:34 INFO - no previously-included directories found matching 'build' 03:34:34 INFO - no previously-included directories found matching 'dist' 03:34:34 INFO - no previously-included directories found matching '.git*' 03:34:34 INFO - Successfully installed jsonschema functools32 03:34:34 INFO - Cleaning up... 03:34:34 INFO - Return code: 0 03:34:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179aeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:34:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:34:34 INFO - Using env: {'DISPLAY': ':0', 03:34:34 INFO - 'HOME': '/home/cltbld', 03:34:34 INFO - 'LANG': 'en_US.UTF-8', 03:34:34 INFO - 'LANGUAGE': 'en_US:en', 03:34:34 INFO - 'LOGNAME': 'cltbld', 03:34:34 INFO - 'MAIL': '/var/mail/cltbld', 03:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:34 INFO - 'MOZ_NO_REMOTE': '1', 03:34:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:34 INFO - 'NO_EM_RESTART': '1', 03:34:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:34 INFO - 'PWD': '/builds/slave/test', 03:34:34 INFO - 'SHELL': '/bin/bash', 03:34:34 INFO - 'SHLVL': '1', 03:34:34 INFO - 'TERM': 'linux', 03:34:34 INFO - 'TMOUT': '86400', 03:34:34 INFO - 'USER': 'cltbld', 03:34:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 03:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:34 INFO - '_': '/tools/buildbot/bin/python'} 03:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:34:34 INFO - Cleaning up... 03:34:34 INFO - Return code: 0 03:34:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179aeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:34:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:34:34 INFO - Using env: {'DISPLAY': ':0', 03:34:34 INFO - 'HOME': '/home/cltbld', 03:34:34 INFO - 'LANG': 'en_US.UTF-8', 03:34:34 INFO - 'LANGUAGE': 'en_US:en', 03:34:34 INFO - 'LOGNAME': 'cltbld', 03:34:34 INFO - 'MAIL': '/var/mail/cltbld', 03:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:34 INFO - 'MOZ_NO_REMOTE': '1', 03:34:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:34 INFO - 'NO_EM_RESTART': '1', 03:34:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:34 INFO - 'PWD': '/builds/slave/test', 03:34:34 INFO - 'SHELL': '/bin/bash', 03:34:34 INFO - 'SHLVL': '1', 03:34:34 INFO - 'TERM': 'linux', 03:34:34 INFO - 'TMOUT': '86400', 03:34:34 INFO - 'USER': 'cltbld', 03:34:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 03:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:34 INFO - '_': '/tools/buildbot/bin/python'} 03:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:34 INFO - Downloading/unpacking blobuploader==1.2.4 03:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:35 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:36 INFO - Downloading docopt-0.6.1.tar.gz 03:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:36 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:36 INFO - Running setup.py install for blobuploader 03:34:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:36 INFO - Running setup.py install for requests 03:34:36 INFO - Running setup.py install for docopt 03:34:37 INFO - Successfully installed blobuploader requests docopt 03:34:37 INFO - Cleaning up... 03:34:37 INFO - Return code: 0 03:34:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179aeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:37 INFO - Using env: {'DISPLAY': ':0', 03:34:37 INFO - 'HOME': '/home/cltbld', 03:34:37 INFO - 'LANG': 'en_US.UTF-8', 03:34:37 INFO - 'LANGUAGE': 'en_US:en', 03:34:37 INFO - 'LOGNAME': 'cltbld', 03:34:37 INFO - 'MAIL': '/var/mail/cltbld', 03:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:37 INFO - 'MOZ_NO_REMOTE': '1', 03:34:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:37 INFO - 'NO_EM_RESTART': '1', 03:34:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:37 INFO - 'PWD': '/builds/slave/test', 03:34:37 INFO - 'SHELL': '/bin/bash', 03:34:37 INFO - 'SHLVL': '1', 03:34:37 INFO - 'TERM': 'linux', 03:34:37 INFO - 'TMOUT': '86400', 03:34:37 INFO - 'USER': 'cltbld', 03:34:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 03:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:37 INFO - '_': '/tools/buildbot/bin/python'} 03:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:37 INFO - Running setup.py (path:/tmp/pip-cHdTq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:37 INFO - Running setup.py (path:/tmp/pip-ZCQrKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:37 INFO - Running setup.py (path:/tmp/pip-OoihFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:37 INFO - Running setup.py (path:/tmp/pip-Em8aF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:37 INFO - Running setup.py (path:/tmp/pip-J2Krhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:37 INFO - Running setup.py (path:/tmp/pip-KS9htU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:37 INFO - Running setup.py (path:/tmp/pip-GlnfeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:37 INFO - Running setup.py (path:/tmp/pip-o5MKs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:37 INFO - Running setup.py (path:/tmp/pip-0H5QZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:37 INFO - Running setup.py (path:/tmp/pip-l3GNDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:38 INFO - Running setup.py (path:/tmp/pip-fqjbJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:38 INFO - Running setup.py (path:/tmp/pip-089uyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:38 INFO - Running setup.py (path:/tmp/pip-fMaWB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:38 INFO - Running setup.py (path:/tmp/pip-lH6tLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:38 INFO - Running setup.py (path:/tmp/pip-Lnu_eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:38 INFO - Running setup.py (path:/tmp/pip-vwhRfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:38 INFO - Running setup.py (path:/tmp/pip-peCEgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:38 INFO - Running setup.py install for manifestparser 03:34:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:38 INFO - Running setup.py install for mozcrash 03:34:38 INFO - Running setup.py install for mozdebug 03:34:38 INFO - Running setup.py install for mozdevice 03:34:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:38 INFO - Running setup.py install for mozfile 03:34:39 INFO - Running setup.py install for mozhttpd 03:34:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:39 INFO - Running setup.py install for mozinfo 03:34:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:39 INFO - Running setup.py install for mozInstall 03:34:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:39 INFO - Running setup.py install for mozleak 03:34:39 INFO - Running setup.py install for mozlog 03:34:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:39 INFO - Running setup.py install for moznetwork 03:34:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:39 INFO - Running setup.py install for mozprocess 03:34:39 INFO - Running setup.py install for mozprofile 03:34:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:39 INFO - Running setup.py install for mozrunner 03:34:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:34:39 INFO - Running setup.py install for mozscreenshot 03:34:40 INFO - Running setup.py install for moztest 03:34:40 INFO - Running setup.py install for mozversion 03:34:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:34:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:34:40 INFO - Cleaning up... 03:34:40 INFO - Return code: 0 03:34:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179aeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:40 INFO - Using env: {'DISPLAY': ':0', 03:34:40 INFO - 'HOME': '/home/cltbld', 03:34:40 INFO - 'LANG': 'en_US.UTF-8', 03:34:40 INFO - 'LANGUAGE': 'en_US:en', 03:34:40 INFO - 'LOGNAME': 'cltbld', 03:34:40 INFO - 'MAIL': '/var/mail/cltbld', 03:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:40 INFO - 'MOZ_NO_REMOTE': '1', 03:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:40 INFO - 'NO_EM_RESTART': '1', 03:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:40 INFO - 'PWD': '/builds/slave/test', 03:34:40 INFO - 'SHELL': '/bin/bash', 03:34:40 INFO - 'SHLVL': '1', 03:34:40 INFO - 'TERM': 'linux', 03:34:40 INFO - 'TMOUT': '86400', 03:34:40 INFO - 'USER': 'cltbld', 03:34:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 03:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:40 INFO - '_': '/tools/buildbot/bin/python'} 03:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:40 INFO - Running setup.py (path:/tmp/pip-tlcncO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:40 INFO - Running setup.py (path:/tmp/pip-hhU1Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:40 INFO - Running setup.py (path:/tmp/pip-8hSqsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:40 INFO - Running setup.py (path:/tmp/pip-dRyU8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:40 INFO - Running setup.py (path:/tmp/pip-jHlu1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:40 INFO - Running setup.py (path:/tmp/pip-uanfUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:40 INFO - Running setup.py (path:/tmp/pip-8qhLro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:41 INFO - Running setup.py (path:/tmp/pip-pBHvxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:41 INFO - Running setup.py (path:/tmp/pip-nGzqp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:41 INFO - Running setup.py (path:/tmp/pip-NbikH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:41 INFO - Running setup.py (path:/tmp/pip-6sVPsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:41 INFO - Running setup.py (path:/tmp/pip-NgQJ5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:41 INFO - Running setup.py (path:/tmp/pip-2W1Hmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:41 INFO - Running setup.py (path:/tmp/pip-B1ukQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:41 INFO - Running setup.py (path:/tmp/pip-jiV6pV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:41 INFO - Running setup.py (path:/tmp/pip-J2jI8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:41 INFO - Running setup.py (path:/tmp/pip-lwlgWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:34:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:42 INFO - Downloading blessings-1.6.tar.gz 03:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:42 INFO - Installing collected packages: blessings 03:34:42 INFO - Running setup.py install for blessings 03:34:43 INFO - Successfully installed blessings 03:34:43 INFO - Cleaning up... 03:34:43 INFO - Return code: 0 03:34:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:43 INFO - Reading from file tmpfile_stdout 03:34:43 INFO - Current package versions: 03:34:43 INFO - argparse == 1.2.1 03:34:43 INFO - blessings == 1.6 03:34:43 INFO - blobuploader == 1.2.4 03:34:43 INFO - docopt == 0.6.1 03:34:43 INFO - functools32 == 3.2.3-2 03:34:43 INFO - jsonschema == 2.5.1 03:34:43 INFO - manifestparser == 1.1 03:34:43 INFO - mozInstall == 1.13 03:34:43 INFO - mozcrash == 1.0 03:34:43 INFO - mozdebug == 0.1 03:34:43 INFO - mozdevice == 0.51 03:34:43 INFO - mozfile == 1.2 03:34:43 INFO - mozhttpd == 0.7 03:34:43 INFO - mozinfo == 0.10 03:34:43 INFO - mozleak == 0.1 03:34:43 INFO - mozlog == 3.5 03:34:43 INFO - moznetwork == 0.27 03:34:43 INFO - mozprocess == 0.25 03:34:43 INFO - mozprofile == 0.28 03:34:43 INFO - mozrunner == 6.13 03:34:43 INFO - mozscreenshot == 0.1 03:34:43 INFO - mozsystemmonitor == 0.3 03:34:43 INFO - moztest == 0.8 03:34:43 INFO - mozversion == 1.4 03:34:43 INFO - psutil == 3.1.1 03:34:43 INFO - requests == 1.2.3 03:34:43 INFO - wsgiref == 0.1.2 03:34:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179aeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:43 INFO - Using env: {'DISPLAY': ':0', 03:34:43 INFO - 'HOME': '/home/cltbld', 03:34:43 INFO - 'LANG': 'en_US.UTF-8', 03:34:43 INFO - 'LANGUAGE': 'en_US:en', 03:34:43 INFO - 'LOGNAME': 'cltbld', 03:34:43 INFO - 'MAIL': '/var/mail/cltbld', 03:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:43 INFO - 'MOZ_NO_REMOTE': '1', 03:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:43 INFO - 'NO_EM_RESTART': '1', 03:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:43 INFO - 'PWD': '/builds/slave/test', 03:34:43 INFO - 'SHELL': '/bin/bash', 03:34:43 INFO - 'SHLVL': '1', 03:34:43 INFO - 'TERM': 'linux', 03:34:43 INFO - 'TMOUT': '86400', 03:34:43 INFO - 'USER': 'cltbld', 03:34:43 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 03:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:43 INFO - '_': '/tools/buildbot/bin/python'} 03:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:34:43 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:34:44 INFO - Installing collected packages: simplejson 03:34:44 INFO - Running setup.py install for simplejson 03:34:44 INFO - building 'simplejson._speedups' extension 03:34:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:34:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:34:45 INFO - Successfully installed simplejson 03:34:45 INFO - Cleaning up... 03:34:45 INFO - Return code: 0 03:34:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15faa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179aeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:34:45 INFO - Using env: {'DISPLAY': ':0', 03:34:45 INFO - 'HOME': '/home/cltbld', 03:34:45 INFO - 'LANG': 'en_US.UTF-8', 03:34:45 INFO - 'LANGUAGE': 'en_US:en', 03:34:45 INFO - 'LOGNAME': 'cltbld', 03:34:45 INFO - 'MAIL': '/var/mail/cltbld', 03:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:45 INFO - 'MOZ_NO_REMOTE': '1', 03:34:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:45 INFO - 'NO_EM_RESTART': '1', 03:34:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:45 INFO - 'PWD': '/builds/slave/test', 03:34:45 INFO - 'SHELL': '/bin/bash', 03:34:45 INFO - 'SHLVL': '1', 03:34:45 INFO - 'TERM': 'linux', 03:34:45 INFO - 'TMOUT': '86400', 03:34:45 INFO - 'USER': 'cltbld', 03:34:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 03:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:45 INFO - '_': '/tools/buildbot/bin/python'} 03:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:34:45 INFO - Cleaning up... 03:34:45 INFO - Return code: 0 03:34:45 INFO - Running post-action listener: _resource_record_post_action 03:34:45 INFO - Running post-action listener: _start_resource_monitoring 03:34:45 INFO - Starting resource monitoring. 03:34:45 INFO - [mozharness: 2017-08-03 10:34:45.964199Z] Finished create-virtualenv step (success) 03:34:45 INFO - [mozharness: 2017-08-03 10:34:45.964721Z] Running install step. 03:34:45 INFO - Running pre-action listener: _resource_record_pre_action 03:34:45 INFO - Running main action method: install 03:34:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:46 INFO - Reading from file tmpfile_stdout 03:34:46 INFO - Detecting whether we're running mozinstall >=1.0... 03:34:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:34:46 INFO - Reading from file tmpfile_stdout 03:34:46 INFO - Output received: 03:34:46 INFO - Usage: mozinstall [options] installer 03:34:46 INFO - Options: 03:34:46 INFO - -h, --help show this help message and exit 03:34:46 INFO - -d DEST, --destination=DEST 03:34:46 INFO - Directory to install application into. [default: 03:34:46 INFO - "/builds/slave/test"] 03:34:46 INFO - --app=APP Application being installed. [default: firefox] 03:34:46 INFO - mkdir: /builds/slave/test/build/application 03:34:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:35:04 INFO - Reading from file tmpfile_stdout 03:35:04 INFO - Output received: 03:35:04 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:04 INFO - Running post-action listener: _resource_record_post_action 03:35:04 INFO - [mozharness: 2017-08-03 10:35:04.286807Z] Finished install step (success) 03:35:04 INFO - [mozharness: 2017-08-03 10:35:04.287086Z] Running setup-mitmproxy step. 03:35:04 INFO - Running pre-action listener: _resource_record_pre_action 03:35:04 INFO - Running main action method: setup_mitmproxy 03:35:04 INFO - Skipping: mitmproxy is not required 03:35:04 INFO - Running post-action listener: _resource_record_post_action 03:35:04 INFO - [mozharness: 2017-08-03 10:35:04.288222Z] Finished setup-mitmproxy step (success) 03:35:04 INFO - [mozharness: 2017-08-03 10:35:04.288441Z] Running run-tests step. 03:35:04 INFO - Running pre-action listener: _resource_record_pre_action 03:35:04 INFO - Running pre-action listener: _set_gcov_prefix 03:35:04 INFO - Running main action method: run_tests 03:35:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:04 INFO - Python 2.7.3 03:35:04 INFO - Return code: 0 03:35:04 INFO - grabbing minidump binary from tooltool 03:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179aeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179c240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:35:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:35:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:35:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:04 INFO - Return code: 0 03:35:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:04 INFO - ENV: RUST_BACKTRACE is now 1 03:35:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:35:04 INFO - Using env: {'DISPLAY': ':0', 03:35:04 INFO - 'HOME': '/home/cltbld', 03:35:04 INFO - 'LANG': 'en_US.UTF-8', 03:35:04 INFO - 'LANGUAGE': 'en_US:en', 03:35:04 INFO - 'LOGNAME': 'cltbld', 03:35:04 INFO - 'MAIL': '/var/mail/cltbld', 03:35:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:04 INFO - 'MOZ_NO_REMOTE': '1', 03:35:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:04 INFO - 'NO_EM_RESTART': '1', 03:35:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:04 INFO - 'PWD': '/builds/slave/test', 03:35:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:04 INFO - 'RUST_BACKTRACE': '1', 03:35:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:35:04 INFO - 'SHELL': '/bin/bash', 03:35:04 INFO - 'SHLVL': '1', 03:35:04 INFO - 'STYLO_FORCE_ENABLED': '1', 03:35:04 INFO - 'TERM': 'linux', 03:35:04 INFO - 'TMOUT': '86400', 03:35:04 INFO - 'USER': 'cltbld', 03:35:04 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291', 03:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:04 INFO - '_': '/tools/buildbot/bin/python'} 03:35:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:35:04 INFO - mozversion application_buildid: 20170803094619 03:35:04 INFO - mozversion application_changeset: 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 03:35:04 INFO - mozversion application_display_name: Nightly 03:35:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:04 INFO - mozversion application_name: Firefox 03:35:04 INFO - mozversion application_remotingname: firefox 03:35:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:35:04 INFO - mozversion application_vendor: Mozilla 03:35:04 INFO - mozversion application_version: 57.0a1 03:35:04 INFO - mozversion platform_buildid: 20170803094619 03:35:04 INFO - mozversion platform_changeset: 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 03:35:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:35:04 INFO - mozversion platform_version: 57.0a1 03:35:04 INFO - using testdate: 1501756504 03:35:04 INFO - actual date: 1501756504 03:35:04 INFO - starting webserver on 'localhost:53906' 03:35:04 INFO - SUITE-START | Running 2 tests 03:35:04 INFO - TEST-START | dromaeo_css 03:35:04 INFO - Initialising browser for dromaeo_css test... 03:35:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53906/getInfo.html -profile /tmp/tmpaNORZw/profile 03:35:04 INFO - TEST-INFO | started process 16201 (/builds/slave/test/build/application/firefox/firefox http://localhost:53906/getInfo.html) 03:35:11 INFO - TEST-INFO | 16201: exit 0 03:35:11 INFO - Browser initialized. 03:35:11 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:11 INFO - TEST-INFO | started process 16426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaNORZw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:12 INFO - PID 16426 | 03:35:12 INFO - PID 16426 | (/builds/slave/test/build/application/firefox/firefox:16480): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:35:12 INFO - PID 16426 | 03:35:22 INFO - PID 16426 | RSS: Main: 173916160 03:35:22 INFO - PID 16426 | 03:38:22 INFO - PID 16426 | Cycle 1(1): loaded http://localhost:53906/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53906/tests/dromaeo/cssquery-ext.html) 03:38:23 INFO - PID 16426 | RSS: Main: 174170112 03:38:23 INFO - PID 16426 | 03:41:25 INFO - PID 16426 | Cycle 1(1): loaded http://localhost:53906/tests/dromaeo/cssquery-ext.html (next: http://localhost:53906/tests/dromaeo/cssquery-jquery.html) 03:41:26 INFO - PID 16426 | RSS: Main: 171958272 03:41:26 INFO - PID 16426 | 03:44:27 INFO - PID 16426 | Cycle 1(1): loaded http://localhost:53906/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53906/tests/dromaeo/cssquery-mootools.html) 03:44:28 INFO - PID 16426 | RSS: Main: 173658112 03:44:28 INFO - PID 16426 | 03:47:30 INFO - PID 16426 | Cycle 1(1): loaded http://localhost:53906/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53906/tests/dromaeo/cssquery-prototype.html) 03:47:31 INFO - PID 16426 | RSS: Main: 173907968 03:47:31 INFO - PID 16426 | 03:50:34 INFO - PID 16426 | Cycle 1(1): loaded http://localhost:53906/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53906/tests/dromaeo/cssquery-yui.html) 03:50:35 INFO - PID 16426 | RSS: Main: 177053696 03:50:35 INFO - PID 16426 | 03:53:37 INFO - PID 16426 | Cycle 1(1): loaded http://localhost:53906/tests/dromaeo/cssquery-yui.html (next: http://localhost:53906/tests/dromaeo/cssquery-dojo.html) 03:53:37 INFO - PID 16426 | RSS: Main: 177750016 03:53:37 INFO - PID 16426 | 03:53:37 INFO - PID 16426 | __start_tp_report 03:53:37 INFO - PID 16426 | _x_x_mozilla_page_load 03:53:37 INFO - PID 16426 | _x_x_mozilla_page_load_details 03:53:37 INFO - PID 16426 | |i|pagename|runs| 03:53:37 INFO - PID 16426 | |0;dojo.html;3153.0540837748654;3164.556962025317;3170.2866854957624;3179.205198700325;3240.8217548034863;6187.721552530135;6193.690315484225;6311.558190926637;6319.115323854652;6354.68226588671;6177.66022868742;6214.84462888428;6288.968555157229;6289.654069026202;6311.589746666475;5475.233467314579;5725.942740572604;5790.71046447676;5800.274965629296;5814.883702325951;5658.830235092953;5722.313322401297;5736.139579063153;5743.942560574383;5784.2480477537865;5655.971720141414;5740.138979153139;5740.9712951435395;5761.827145185651;5821.155932389822;5568.443155684439;5669.149627555858;5695.7152142392715;5763.279590051244;5778.451047150514;5640.8871822563315;5648.54811615074;5668.31980162379;5695.1741997410145;5703.7148142592705;6126.264848218198;6189.566730328879;6196.349383314732;6220;6224.377562243784;6640.966795165993;6710.16122984627;6751.594904305708;6795.082663840417;6796.524243302971;6743.696533655997;6782.220044694874;6795.524313298021;6853.657317134123;6856.040154378391;6131.816045518642;6157.96921015392;6219.222597175353;6227.19046523949;6237.906431403532;6882.8967565486555;7020.403265722369;7022.789316320519;7023.92976070243;7040.401565866959;6582.473402127818;6584.045313429526;6586.967065164644;6601.900971485432;6608.471322294205;6586.835329116715;6619.073329733841;6694.9665251674405;6707.832304192337;6737;6544.607323560602;6553.8361540960905;6566.376194261537;6658.400743933069;6710.261871194165;6650.53446258767;6769.898451523231;6772.255051944282;6774.830629234309;6780.830479238059;5428.185772134132;5440.347158341025;5442.537384322298;5445.618806683573;5445.673259604437;4670.673052886265;4697.177993851063;4724.574788269072;4730.314104454904;4741.5258474153;5817.592768506164;5836.124581312837;5890.322612899486;5908.704564771744;5916.970415147896;6668.233153187349;6718.764843230463;6738.056672065914;6824.249332573413;6836.077129587541;5792.160136780143;5828.417158284223;5829.358770535237;5855.238818953509;5869.4717475427415;5959.0763431668165;5975.312839023568;5977.163197152402;5986.431289027535;5995.61028533144;6570.342965703487;6628.337166283333;6645.734170633217;6650.800475985729;6658.3674550917585;6788.59268443895;6798.4221341184575;6880.5527640704195;6898.793036208922;6899.89650155238;6469.547131700736;6481.092647029325;6521.380468855451;6525.8694826104165;6534.640594767334;6539.215294164731;6612.570182938093;6636.2368327642935;6648.202215734143;6654.4676425884845;6757.628330441873;6810.046593476818;6810.284920083518;6811.93188068113;6819.624920629413;5485.232067510631;6444.387783160592;6551.246606640107;6597.1423714916755;6606.405423511907;6466.708998095003;6483.675816209265;6506.25178104524;6575.243846957661;6589.769358072636;6331.9366806331345;6396.584222025554;6409.583377080475;6498.64257465825;6513;6517.511186661114;6591.703373348115;6618.040384144176;6629.834254143685;6632.668366581555;6378.394052564999;6389.520785941166;6411.198600174978;6412.1023056771155;6421.197350331208 03:53:37 INFO - PID 16426 | |1;ext.html;821.6918655504186;838.9328853691705;850.9149085091491;894.5884892949243;904.6336233825301;42174;43101.56898431015;43115;43155.78422107893;43281.78359108204;39061.414078788766;39108.608913910924;39208;39246.8037659812;39343.80328098363;6980.476464265188;7140.214576396618;7141.071660684104;7143.535670181447;7147.964260178692;7007.509474336798;7104.254053324404;7705.653245603933;7939.206079392073;7939.245771651684;7914.089879663826;7942.205779422041;7962.5620590867475;7966.482178658398;7969.9203007970045;7704.845903081963;7842.960785196066;7856.292933635971;7886.487378320391;7908.169642187602;7727.65225564851;7785.844283114306;7794.571298578576;7801.609919504002;7802.180771019075;39315.41026884599;39344.60655393467;39370.40944385836;39374.21251574981;39734;3571.232185080194;3617.746757726934;3628.8911332660064;3639.890803275906;3640.2719456108885;31474.213144671336;32102.197445063826;32208;32244.193895152574;32259.6774032259;4940.407151141886;4963.553280204763;4995.700257984533;5011.774470148852;5033.194688849767;231881;236402;237195;238495;239089;52136;53075.73462132742;53111.46888531065;53146.73426632842;53164.20253696197;54395.45604543983;54621;54624.45375546273;54656.72671636696;54670;17254.137293135293;17382.478525644252;17410.21654025572;17432.477025689248;17442.47672569825;14070.085444446284;14147.85852141486;14151.504697335544;14172.433102675777;14176.929115354356;15015;15096.16971066602;15102.924485377722;15124.924375378272;15192.848071519364;5732.484076433141;5834.824955251349;5885.6468611882565;5889.352171261158;5920.703964801743;985.6845809341086;995.2436148527026;1019.9694009179588;1025.3027941000043;1041.6979076068008;22748.65877011846;23342.7665723344;23534.176303829285;28860;29845.85077074601;1096.13405409727;1099.934003959765;1104.3042882983668;1109.8612673415823;1117.754094099297;12550.560730374576;12656.43046062911;12742.554010609585;12747.362631868555;12886.742265154831;248426;249460;251158;251742;252150;55269.723651381486;55816.44183558112;56378.154327685115;58692.7065364679;61372.38627613667;1495.229956572366;1500.9699806003819;1506.1716056169282;1507.6155580326947;1522.5812901451968;27849.860750696116;28182.718172818008;28417.289567760145;28494;28610.713892860804;39529.20941581095;39591;39655.40516892307;39728.404073938334;39841;213507;213730;214465;215634;215948;35951;36181.457278140326;36588.451173232956;36713.632863671024;39040.41439378468;49500.25749613831;50201.24698129604;50553.988920222124;50881.491185087674;51053.74473127611;35736.106597335274;35898.46152307665;35947.10132246715;36001.63998359983;36016.27967440584;35368.11579710528;35436.645633544365;35584.82207588945;35587;36264;39332.2133557333;39503.60496394999;39523.20953580855;39599.60400395959;39620.801895990335;34240.828795855865;34251;34733.47899781556;34902.30195396027;35438.64561354354;24789.50420991534;24916.01651217704;25108.497830042932;25213.747862521876;25573.48853022892 03:53:37 INFO - PID 16426 | |2;jquery.html;585.2771826793906;585.3122580967362;592.1975722895477;601.4166258729034;612.8008397270887;22906.083756649736;23004.76995230047;23422.76577234227;23428.531429371404;23428.88285558574;25257.74742252577;27181.18456446305;27250;27304.726952730467;27407.451850962967;6607.075009498662;6769.898451523231;6772.085768421274;6772.085768421274;6785.728570857184;4126.195391898581;5959.374265702104;6018.909716354258;6603.405693487585;6717.664116794165;4116.58834116589;6610.768623098193;6612.867742645144;6616.404523592876;6624.701888415008;6586.440152587012;6613.801585952429;6614.404703576702;6614.570052946543;6615.834604134887;6111.449969502766;6148.508119350441;6166.352532984062;6181.320054793969;6194.845128871769;30233;30573.847130764203;30638.54042189369;31118.688813111807;31133;1909.4653497020856;1952.1020330647777;1954.7067939809;1955.0420294055953;1956.4521933858543;18451.723224151647;18890.43328700141;19351.709724354147;19916.601667966705;19919.402417927486;2335.8364914455997;2336.906523739048;2381.9761802381927;2400.603900356439;2402.2072716003677;147464.262678687;152431;153722.23138884234;153820.2308988459;158041;15148.848511514743;15599;15728.213589320718;15996.440124595583;16060.598485037968;24395.634065489034;24436.755632443448;24592.508149836904;24604.753952460604;24650;10072.136654718754;10732.195085368628;10752.784944301227;10795.83806242907;10865.619703310504;9969.102780749767;9970.853351864629;10103.54534045955;10129.848052279222;10144.492775361203;9335.90664093364;9421.481818499911;9432.669856555125;9724.416535007922;9828.017198280259;2783.860806959644;2792.9301767455568;2816.9154377524505;2835.3478699899138;2908.69458706837;971.3006635222629;976.8814707160403;980.789130336981;982.1357205658975;993.5231089077283;19572.763551546446;19961.401157965283;20101.19595216175;20362.898185508977;20453.48866278355;1009.5154325923597;1040.5265604150093;1077.830553849067;1085.0722632149557;1086.1745073744012;10929.453527323602;11165.330080195214;11253.71865703364;11298.887011129947;11310.321380717183;550626;572088;582452;588822;595314;113276;119546;125753;128556.35721821518;128711;1284.094713227154;1284.389914790467;1314.1523717202351;1321.722438287951;1321.9801702974464;20505.89747051255;20622.793772062687;20793;20830.1667933281;20913.477163071046;54827.17759233694;55516.167257490364;56360;56432.71783641056;56894.7155264221;69826.65086674535;70145.29854701592;70461.64769176122;70908;71296;14666.41334346657;14946.626334341294;15123.924380378028;15124.470643527424;15129.697406052037;23131.190408335628;23231;23482.76517234874;23573.17493887706;23626;17206.31174753046;17358;18446.26214951387;18681.43955681332;18749.250029998646;17003.23485443133;17093;17477.38829140974;17502.387416440364;17509.124543773014;18826.905865470584;18995.525111872314;18997;19100.426987190407;19311.130999105357;14783.704325913637;14784.260786960394;14810.62973425673;14846.77729834075;14864.777028344799;18513;18565.35021274249;18587.814121859148;18659.626807464047;18673.253069877053 03:53:37 INFO - PID 16426 | |3;mootools.html;1375.6560859785054;1427.8072460217868;1437.274176540847;1439.1437094928515;1442.4951267056538;13816.378262978165;14319.713605727879;14354.354054067553;14364.353604087815;14425.990180687342;13911.234882081482;14439.711205775879;14798.630034249149;14834.368219495847;14854.480093196713;2704.418550011747;2777.5555911054234;2781.1517487166407;2787.7351651593167;2790.539560972437;2625.566781481053;2636.5913283441;2736;2742.9725702742917;2786.512360336943;2778.6387769589924;2807.6490438695164;2807.7332653397893;2810.367667274857;2811.6485439320086;2621.986890065547;2644.7223041580646;2655.2830735701446;2658.2158263312176;2659.9999999999905;2623.7113917469064;2634.499445105424;2647.113217072283;2651;2653.827501212415;13776.793348099787;14197.290135493287;14206.289685515683;14208.715825683428;14222.644433889132;7690.653920573588;7950.880736788953;7957.60211989404;7970.840583188304;8008.239217274349;5172.534471897509;5259.132243179909;5329.626926115174;5461.5357694596005;5527.474889885454;1785.2234278088943;1805.1876655505075;1831.0844577711143;1839.7884243312058;1852.8054554271741;22496.775032249632;22724.772752272595;22768.43078923007;22769.886150569306;22771.658425123638;6428.678566071678;6530.118434011442;6618.742438936587;6718.865622687519;6756.614893946729;15902.284397202153;16000.359985600679;16013.839861601467;16068.43760468378;16101.758473622906;7512.0985481741445;7762.534247945141;7764.534127952341;7769.53382797034;7774.727884524014;6955.7217711292;7098.432125429953;7158.141023077264;7183.245759195209;7195.89206161908;5142.485751424828;5149;5233.973830130901;5252.763625636855;5397.73011349431;1415.7380884536394;1444.9885080443732;1526.3513006971993;1565.2565031610122;1574.189292514356;869.0874581689201;879.1120967822545;882.969096081634;892.7411050795326;897.8159477307137;8382.790430239293;8466.153384661484;8589.398742088119;8614.138586141336;8654.956725216334;990.9009099090177;993.5231089077283;1004.5981607357115;1007.3804610164696;1009.5764971390452;4669.533046695304;4958.727270000112;4970.826021089245;5057.291979122926;5110.361204849394;18440.35458758937;18792.436226913214;19497.707534386995;19851.205951761767;19882.304119355755;17870.374536891406;17960.101994900204;17989.370372037178;18069.096545172688;18160.455186344432;10375.792484150275;10761.085307748772;10915.945420272848;11008.504617292241;11099.056580190612;7794.571298578632;7890.9605451972375;8021.438499305226;8067;8251.587420628824;16447.83552164463;16467.83532164663;16574.337026519286;16793.41223057236;17059.658806823547;16794.244259008618;16873.07198104067;16912.74630880513;16945.576360591083;17246.396376126777;10952.452377381258;11155.330680159217;11224.66326010221;11263;11343.48954297075;12275.93862030684;12420.565280215149;12442.191257568229;12454.501819927102;12468.438920248429;8856.778580535538;10388.636397726346;11015.504302306575;11025.17311201647;11090.334579925231;10176.694699159038;10234.846477302697;10281.074703276441;10459;10490;9571.90428095738;9611.759706007406;9677.129058384498;9684.467354295299;9687.612495500383;6561.573497722633;6700.564463309869;6705.698243578953;6720.630365329758;6747.730090796509;7028.226895041644;7071.222165561681;7099.325564071405;7116.50184487081;7160.462965277729 03:53:37 INFO - PID 16426 | |4;prototype.html;493.92676699349147;498.18049308886873;518.2899427783937;523.5052875033094;529.6557237795432;6220.751169953202;6241.843953901149;6264.404881536252;6295.748170073191;6351.618902865831;5925.644461332312;6128;6179.3202747697715;6210.130581718563;6213.658248796314;4897.730624815652;4922.68002579833;4967.602591792648;5006.299118123466;5040;4974.900501989958;4993.176125939234;4997.675151115184;5002.674826136289;5025.120603894322;4785.377900872882;4883.4628190898975;4969.875753106183;4977.328060711794;4989.57588604969;4937.284493528563;4950.059488697136;4966.081274964107;4980.77586508608;4986.950130498685;4422.204003279408;4453.332000199964;4458.8439404620685;4465.486469056068;4468.620167285784;6015.879682406327;6065.452509945833;6074.058520929263;6083.148359229712;6125.111858780497;5682.801101961411;5708.71456427177;5754.367019627837;5765.1928729977835;5776.9422305776825;6489.059086432441;6529.444997175246;6530.902036469457;6542.738290468375;6599.736010559572;4850.733209673466;4857.708537487762;4858.1983972644475;4869.318295438641;4903.730294833783;6914.239433662293;6976.825579360506;6989.82525436863;6993.930060699429;7017.543859649107;5039.823606173766;5045.495450454925;5045.571126454219;5056.949430505648;5083.38999320084;5099.388073431212;5105.157648987875;5108;5114.33513643224;5150.665206761549;5709.22925405065;5744.856378590485;5749.9425005750245;5768.7692492300675;5813.360530341659;6544.345565443513;6580.63806490638;6583.506237032242;6630.5027122965;6646.2356828965285;1703.4498606268485;1731.1257814803696;1746.6157445362;1768.9292428302724;1797.4158398520533;1147.3345459633392;1227.7483115961206;1231.2550906701497;1239.6343078791779;1259.3514340114848;5701.857453563694;5758.395368486333;5758.769649213985;5790.652560846363;5806.738696758656;6533.281339052701;6553.934460655428;6565.540412171103;6577.86844263112;6641.734330626818;5593.272874526286;5796.739146738407;5819.679917604488;5874.383189765099;5907.556933230025;3633.4004889193516;3637.727170462173;3638.909027274339;3660.9450858237146;3668.1196512836727;6509.251436084911;6561.573497722633;6570.277269500351;6574.276829548746;6614.900776488356;6967.895481567781;7047.295270473014;7052.118485189351;7052.294770522906;7064.576125432491;6595;6604.801855944425;6636.601803891782;6640.468762498988;6649.803035453568;6682.599044057372;6727.2263689674355;6731.697073631601;6760.93239067603;6808.38724514796;6520.902186467301;6529.804105876831;6596.60420374779;6617.966910165418;6727.293634168342;6642.734290628321;6658.234303055211;6660.933390666225;6670.933290667225;6690.130283063365;4910.410750709938;4959.13215187348;4960.900781984412;4986.850394488171;4988.755060222842;6727.798166055026;6737;6769.221539523018;6821.226481114847;6830.394857208651;6467.967660161669;6505.381988711065;6560.409563139149;6604.174478190226;6609.570377925419;6437.678116094083;6441.355864413521;6486.805395838132;6537.444317233088;6578.8355291118105;6237.349126621259;6403.96798016007;6431.356864313531;6500.447461965786;6509.7396104155305;6471.546991710535;6516.478681705357;6528;6566.785144748237;6624.271330153776;6189.84525386869;6313.05304204373;6368.745250190126;6389.904151437825;6405.295417504164 03:53:37 INFO - PID 16426 | |5;yui.html;900.9144131307526;906.3791302957475;924.7364501117179;926.9768255793608;927.9907200927993;17549.736753948684;18569.350072747457;18573.814261857377;18590.34933777318;18605.348812791555;17211.569710757238;18489.630207395843;21558.784412155874;21591.56816863662;21678.34964951054;1008.7074748322977;1034.105498743585;1043.4626167523693;1044.1438020822927;1045.513836066229;762.744480599;786.3041208530464;1055.4775386183849;1058.2433560004595;1062.9468526573678;1076.1552181537495;1114.4260705736551;1128.3399211461306;1129.4183495499824;1130.5534313945986;1115.314081839671;1116.5198964445326;1118.2619471149044;1119.7256672115302;1120.6918097523205;817.382875928676;819.4345901328064;821.2690705272313;823.0493779684474;823.7528741377623;18964.5258868528;19263.325783597647;19546.218151273933;19580.80419195804;19633.31283405074;20191.495212619655;20325.593488130155;20746;20774.169033238653;20888.791112088835;15882.523524294289;16444.506664800076;16504.25730842115;16545.338186472527;16644.33422663092;3540.964590354089;3572.4105522588743;3588.2823435313044;3593.2993066352074;3597.1366871950545;129295;130219;130572;131663.6833631661;132756;15113.773293400607;15240.923795380952;15689.529314120595;15854.207289635702;15883;30477;30781;30899.382012359627;30990.22524436907;31037.379252414827;8351.958240208882;8457.53483558398;8468.576571171418;8491.363147763943;8499.74500764978;3970.900727481836;4002.199560087994;4046.2312160689376;4075.612816782401;4079.796010199478;5129.666571672829;5191.610629202825;5202.453742356998;5242;5246.23929530216;897.6947837735071;926.4904302633524;938.6855403439788;941.1717688434134;942.1144124522926;673.1148539670415;687.3161204601354;695.5687473766297;698.2807708060706;699.1959246866043;10363.32638378503;10373.792524149474;10952.561897524169;11112.499937502671;11123.777524449466;678.25053316086;689.975850845218;691.405391363427;693.3240090911321;697.7034760226883;4744.24092145262;4769.046190761862;4843.07981483517;4901.975490122527;4947.752612369439;102288;102526.48736756269;105436.47281763695;105715.4714226424;106509.46745266224;90647.54676226576;93415;94100;98532;98880;80638.5968070156;82789;83522;85589;86231.5688421554;11130.276532025393;11383.203175777948;11536.884631153582;11868.703282418008;11931.105167112328;33885.32229355448;34021.65978340185;34716.30567388688;35216.47175292424;35401.468977965866;43602.78198608987;44354.334684979105;44572.33141502815;44638.3304250443;45187.09625807531;16970.660586788443;17259.309627614755;17265.82734172642;17393.82606173922;17475;18277.908610456863;18280.45158645243;18325.816741832412;18373;18540.907295463436;15405.537833865003;15471.690566188838;15648.92175539115;15727.135007574694;15871.603209919844;15343.46297879569;15440.922795385952;15482.767758483407;15512.92243538775;16047.839521604634;14783.778243326144;14973.775393368891;15073.547793566211;15100.848991510384;15207.391704331703;12226.510939562673;12694.682632934251;12697.238165710087;12749.808752868528;12806.35968201605;12003.878991462108;12015.399230038638;12086;12128.636140915787;12314.568990085305 03:53:37 INFO - PID 16426 | __end_tp_report 03:53:37 INFO - PID 16426 | __start_cc_report 03:53:37 INFO - PID 16426 | _x_x_mozilla_cycle_collect,382 03:53:37 INFO - PID 16426 | __end_cc_report 03:53:37 INFO - PID 16426 | __startTimestamp1501757617600__endTimestamp 03:53:37 INFO - PID 16426 | 03:53:37 INFO - PID 16426 | ------- Summary: start ------- 03:53:37 INFO - PID 16426 | Number of tests: 6 03:53:37 INFO - PID 16426 | 03:53:37 INFO - PID 16426 | [#0] dojo.html Cycles:165 Average:6185.46 Median:6412.10 stddev:734.88 (11.5%) stddev-sans-first:697.57 03:53:37 INFO - PID 16426 | Values: 3153.1 3164.6 3170.3 3179.2 3240.8 6187.7 6193.7 6311.6 6319.1 6354.7 6177.7 6214.8 6289.0 6289.7 6311.6 5475.2 5725.9 5790.7 5800.3 5814.9 5658.8 5722.3 5736.1 5743.9 5784.2 5656.0 5740.1 5741.0 5761.8 5821.2 5568.4 5669.1 5695.7 5763.3 5778.5 5640.9 5648.5 5668.3 5695.2 5703.7 6126.3 6189.6 6196.3 6220.0 6224.4 6641.0 6710.2 6751.6 6795.1 6796.5 6743.7 6782.2 6795.5 6853.7 6856.0 6131.8 6158.0 6219.2 6227.2 6237.9 6882.9 7020.4 7022.8 7023.9 7040.4 6582.5 6584.0 6587.0 6601.9 6608.5 6586.8 6619.1 6695.0 6707.8 6737.0 6544.6 6553.8 6566.4 6658.4 6710.3 6650.5 6769.9 6772.3 6774.8 6780.8 5428.2 5440.3 5442.5 5445.6 5445.7 4670.7 4697.2 4724.6 4730.3 4741.5 5817.6 5836.1 5890.3 5908.7 5917.0 6668.2 6718.8 6738.1 6824.2 6836.1 5792.2 5828.4 5829.4 5855.2 5869.5 5959.1 5975.3 5977.2 5986.4 5995.6 6570.3 6628.3 6645.7 6650.8 6658.4 6788.6 6798.4 6880.6 6898.8 6899.9 6469.5 6481.1 6521.4 6525.9 6534.6 6539.2 6612.6 6636.2 6648.2 6654.5 6757.6 6810.0 6810.3 6811.9 6819.6 5485.2 6444.4 6551.2 6597.1 6606.4 6466.7 6483.7 6506.3 6575.2 6589.8 6331.9 6396.6 6409.6 6498.6 6513.0 6517.5 6591.7 6618.0 6629.8 6632.7 6378.4 6389.5 6411.2 6412.1 6421.2 03:53:37 INFO - PID 16426 | 03:53:37 INFO - PID 16426 | [#1] ext.html Cycles:180 Average:41359.65 Median:36651.04 stddev:60840.05 (166.0%) stddev-sans-first:60934.58 03:53:37 INFO - PID 16426 | Values: 821.7 838.9 850.9 894.6 904.6 42174.0 43101.6 43115.0 43155.8 43281.8 39061.4 39108.6 39208.0 39246.8 39343.8 6980.5 7140.2 7141.1 7143.5 7148.0 7007.5 7104.3 7705.7 7939.2 7939.2 7914.1 7942.2 7962.6 7966.5 7969.9 7704.8 7843.0 7856.3 7886.5 7908.2 7727.7 7785.8 7794.6 7801.6 7802.2 39315.4 39344.6 39370.4 39374.2 39734.0 3571.2 3617.7 3628.9 3639.9 3640.3 31474.2 32102.2 32208.0 32244.2 32259.7 4940.4 4963.6 4995.7 5011.8 5033.2 231881.0 236402.0 237195.0 238495.0 239089.0 52136.0 53075.7 53111.5 53146.7 53164.2 54395.5 54621.0 54624.5 54656.7 54670.0 17254.1 17382.5 17410.2 17432.5 17442.5 14070.1 14147.9 14151.5 14172.4 14176.9 15015.0 15096.2 15102.9 15124.9 15192.8 5732.5 5834.8 5885.6 5889.4 5920.7 985.7 995.2 1020.0 1025.3 1041.7 22748.7 23342.8 23534.2 28860.0 29845.9 1096.1 1099.9 1104.3 1109.9 1117.8 12550.6 12656.4 12742.6 12747.4 12886.7 248426.0 249460.0 251158.0 251742.0 252150.0 55269.7 55816.4 56378.2 58692.7 61372.4 1495.2 1501.0 1506.2 1507.6 1522.6 27849.9 28182.7 28417.3 28494.0 28610.7 39529.2 39591.0 39655.4 39728.4 39841.0 213507.0 213730.0 214465.0 215634.0 215948.0 35951.0 36181.5 36588.5 36713.6 39040.4 49500.3 50201.2 50554.0 50881.5 51053.7 35736.1 35898.5 35947.1 36001.6 36016.3 35368.1 35436.6 35584.8 35587.0 36264.0 39332.2 39503.6 39523.2 39599.6 39620.8 34240.8 34251.0 34733.5 34902.3 35438.6 24789.5 24916.0 25108.5 25213.7 25573.5 03:53:37 INFO - PID 16426 | 03:53:37 INFO - PID 16426 | [#2] jquery.html Cycles:180 Average:38116.95 Median:23181.10 stddev:96860.80 (417.8%) stddev-sans-first:97091.52 03:53:37 INFO - PID 16426 | Values: 585.3 585.3 592.2 601.4 612.8 22906.1 23004.8 23422.8 23428.5 23428.9 25257.7 27181.2 27250.0 27304.7 27407.5 6607.1 6769.9 6772.1 6772.1 6785.7 4126.2 5959.4 6018.9 6603.4 6717.7 4116.6 6610.8 6612.9 6616.4 6624.7 6586.4 6613.8 6614.4 6614.6 6615.8 6111.4 6148.5 6166.4 6181.3 6194.8 30233.0 30573.8 30638.5 31118.7 31133.0 1909.5 1952.1 1954.7 1955.0 1956.5 18451.7 18890.4 19351.7 19916.6 19919.4 2335.8 2336.9 2382.0 2400.6 2402.2 147464.3 152431.0 153722.2 153820.2 158041.0 15148.8 15599.0 15728.2 15996.4 16060.6 24395.6 24436.8 24592.5 24604.8 24650.0 10072.1 10732.2 10752.8 10795.8 10865.6 9969.1 9970.9 10103.5 10129.8 10144.5 9335.9 9421.5 9432.7 9724.4 9828.0 2783.9 2792.9 2816.9 2835.3 2908.7 971.3 976.9 980.8 982.1 993.5 19572.8 19961.4 20101.2 20362.9 20453.5 1009.5 1040.5 1077.8 1085.1 1086.2 10929.5 11165.3 11253.7 11298.9 11310.3 550626.0 572088.0 582452.0 588822.0 595314.0 113276.0 119546.0 125753.0 128556.4 128711.0 1284.1 1284.4 1314.2 1321.7 1322.0 20505.9 20622.8 20793.0 20830.2 20913.5 54827.2 55516.2 56360.0 56432.7 56894.7 69826.7 70145.3 70461.6 70908.0 71296.0 14666.4 14946.6 15123.9 15124.5 15129.7 23131.2 23231.0 23482.8 23573.2 23626.0 17206.3 17358.0 18446.3 18681.4 18749.3 17003.2 17093.0 17477.4 17502.4 17509.1 18826.9 18995.5 18997.0 19100.4 19311.1 14783.7 14784.3 14810.6 14846.8 14864.8 18513.0 18565.4 18587.8 18659.6 18673.3 03:53:37 INFO - PID 16426 | 03:53:37 INFO - PID 16426 | [#3] mootools.html Cycles:180 Average:8692.00 Median:2635.55 stddev:5818.92 (220.8%) stddev-sans-first:5809.28 03:53:37 INFO - PID 16426 | Values: 1375.7 1427.8 1437.3 1439.1 1442.5 13816.4 14319.7 14354.4 14364.4 14426.0 13911.2 14439.7 14798.6 14834.4 14854.5 2704.4 2777.6 2781.2 2787.7 2790.5 2625.6 2636.6 2736.0 2743.0 2786.5 2778.6 2807.6 2807.7 2810.4 2811.6 2622.0 2644.7 2655.3 2658.2 2660.0 2623.7 2634.5 2647.1 2651.0 2653.8 13776.8 14197.3 14206.3 14208.7 14222.6 7690.7 7950.9 7957.6 7970.8 8008.2 5172.5 5259.1 5329.6 5461.5 5527.5 1785.2 1805.2 1831.1 1839.8 1852.8 22496.8 22724.8 22768.4 22769.9 22771.7 6428.7 6530.1 6618.7 6718.9 6756.6 15902.3 16000.4 16013.8 16068.4 16101.8 7512.1 7762.5 7764.5 7769.5 7774.7 6955.7 7098.4 7158.1 7183.2 7195.9 5142.5 5149.0 5234.0 5252.8 5397.7 1415.7 1445.0 1526.4 1565.3 1574.2 869.1 879.1 883.0 892.7 897.8 8382.8 8466.2 8589.4 8614.1 8655.0 990.9 993.5 1004.6 1007.4 1009.6 4669.5 4958.7 4970.8 5057.3 5110.4 18440.4 18792.4 19497.7 19851.2 19882.3 17870.4 17960.1 17989.4 18069.1 18160.5 10375.8 10761.1 10915.9 11008.5 11099.1 7794.6 7891.0 8021.4 8067.0 8251.6 16447.8 16467.8 16574.3 16793.4 17059.7 16794.2 16873.1 16912.7 16945.6 17246.4 10952.5 11155.3 11224.7 11263.0 11343.5 12275.9 12420.6 12442.2 12454.5 12468.4 8856.8 10388.6 11015.5 11025.2 11090.3 10176.7 10234.8 10281.1 10459.0 10490.0 9571.9 9611.8 9677.1 9684.5 9687.6 6561.6 6700.6 6705.7 6720.6 6747.7 7028.2 7071.2 7099.3 7116.5 7160.5 03:53:37 INFO - PID 16426 | 03:53:37 INFO - PID 16426 | [#4] prototype.html Cycles:180 Average:5527.95 Median:6126.56 stddev:1554.16 (25.4%) stddev-sans-first:1511.89 03:53:37 INFO - PID 16426 | Values: 493.9 498.2 518.3 523.5 529.7 6220.8 6241.8 6264.4 6295.7 6351.6 5925.6 6128.0 6179.3 6210.1 6213.7 4897.7 4922.7 4967.6 5006.3 5040.0 4974.9 4993.2 4997.7 5002.7 5025.1 4785.4 4883.5 4969.9 4977.3 4989.6 4937.3 4950.1 4966.1 4980.8 4987.0 4422.2 4453.3 4458.8 4465.5 4468.6 6015.9 6065.5 6074.1 6083.1 6125.1 5682.8 5708.7 5754.4 5765.2 5776.9 6489.1 6529.4 6530.9 6542.7 6599.7 4850.7 4857.7 4858.2 4869.3 4903.7 6914.2 6976.8 6989.8 6993.9 7017.5 5039.8 5045.5 5045.6 5056.9 5083.4 5099.4 5105.2 5108.0 5114.3 5150.7 5709.2 5744.9 5749.9 5768.8 5813.4 6544.3 6580.6 6583.5 6630.5 6646.2 1703.4 1731.1 1746.6 1768.9 1797.4 1147.3 1227.7 1231.3 1239.6 1259.4 5701.9 5758.4 5758.8 5790.7 5806.7 6533.3 6553.9 6565.5 6577.9 6641.7 5593.3 5796.7 5819.7 5874.4 5907.6 3633.4 3637.7 3638.9 3660.9 3668.1 6509.3 6561.6 6570.3 6574.3 6614.9 6967.9 7047.3 7052.1 7052.3 7064.6 6595.0 6604.8 6636.6 6640.5 6649.8 6682.6 6727.2 6731.7 6760.9 6808.4 6520.9 6529.8 6596.6 6618.0 6727.3 6642.7 6658.2 6660.9 6670.9 6690.1 4910.4 4959.1 4960.9 4986.9 4988.8 6727.8 6737.0 6769.2 6821.2 6830.4 6468.0 6505.4 6560.4 6604.2 6609.6 6437.7 6441.4 6486.8 6537.4 6578.8 6237.3 6404.0 6431.4 6500.4 6509.7 6471.5 6516.5 6528.0 6566.8 6624.3 6189.8 6313.1 6368.7 6389.9 6405.3 03:53:37 INFO - PID 16426 | 03:53:37 INFO - PID 16426 | [#5] yui.html Cycles:180 Average:22165.91 Median:19113.93 stddev:31131.80 (162.9%) stddev-sans-first:31178.19 03:53:37 INFO - PID 16426 | Values: 900.9 906.4 924.7 927.0 928.0 17549.7 18569.4 18573.8 18590.3 18605.3 17211.6 18489.6 21558.8 21591.6 21678.3 1008.7 1034.1 1043.5 1044.1 1045.5 762.7 786.3 1055.5 1058.2 1062.9 1076.2 1114.4 1128.3 1129.4 1130.6 1115.3 1116.5 1118.3 1119.7 1120.7 817.4 819.4 821.3 823.0 823.8 18964.5 19263.3 19546.2 19580.8 19633.3 20191.5 20325.6 20746.0 20774.2 20888.8 15882.5 16444.5 16504.3 16545.3 16644.3 3541.0 3572.4 3588.3 3593.3 3597.1 129295.0 130219.0 130572.0 131663.7 132756.0 15113.8 15240.9 15689.5 15854.2 15883.0 30477.0 30781.0 30899.4 30990.2 31037.4 8352.0 8457.5 8468.6 8491.4 8499.7 3970.9 4002.2 4046.2 4075.6 4079.8 5129.7 5191.6 5202.5 5242.0 5246.2 897.7 926.5 938.7 941.2 942.1 673.1 687.3 695.6 698.3 699.2 10363.3 10373.8 10952.6 11112.5 11123.8 678.3 690.0 691.4 693.3 697.7 4744.2 4769.0 4843.1 4902.0 4947.8 102288.0 102526.5 105436.5 105715.5 106509.5 90647.5 93415.0 94100.0 98532.0 98880.0 80638.6 82789.0 83522.0 85589.0 86231.6 11130.3 11383.2 11536.9 11868.7 11931.1 33885.3 34021.7 34716.3 35216.5 35401.5 43602.8 44354.3 44572.3 44638.3 45187.1 16970.7 17259.3 17265.8 17393.8 17475.0 18277.9 18280.5 18325.8 18373.0 18540.9 15405.5 15471.7 15648.9 15727.1 15871.6 15343.5 15440.9 15482.8 15512.9 16047.8 14783.8 14973.8 15073.5 15100.8 15207.4 12226.5 12694.7 12697.2 12749.8 12806.4 12003.9 12015.4 12086.0 12128.6 12314.6 03:53:37 INFO - PID 16426 | -------- Summary: end -------- 03:53:37 INFO - PID 16426 | 03:53:38 INFO - TEST-INFO | 16426: exit 0 03:53:38 INFO - TEST-OK | dromaeo_css | took 1113558ms 03:53:38 INFO - TEST-START | kraken 03:53:38 INFO - Initialising browser for kraken test... 03:53:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53906/getInfo.html -profile /tmp/tmp4v87jZ/profile 03:53:38 INFO - TEST-INFO | started process 16805 (/builds/slave/test/build/application/firefox/firefox http://localhost:53906/getInfo.html) 03:53:44 INFO - TEST-INFO | 16805: exit 0 03:53:44 INFO - Browser initialized. 03:53:44 INFO - Running cycle 1/1 for kraken test... 03:53:44 INFO - TEST-INFO | started process 17029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4v87jZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:45 INFO - PID 17029 | 03:53:45 INFO - PID 17029 | (/builds/slave/test/build/application/firefox/firefox:17083): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:53:45 INFO - PID 17029 | 03:53:55 INFO - PID 17029 | RSS: Main: 174628864 03:53:55 INFO - PID 17029 | 03:53:58 INFO - PID 17029 | Cycle 1(1): loaded http://localhost:53906/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53906/tests/kraken/driver.html?testName=audio-beat-detection) 03:53:59 INFO - PID 17029 | RSS: Main: 179195904 03:53:59 INFO - PID 17029 | 03:54:02 INFO - PID 17029 | Cycle 1(1): loaded http://localhost:53906/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53906/tests/kraken/driver.html?testName=audio-dft) 03:54:02 INFO - PID 17029 | RSS: Main: 179777536 03:54:02 INFO - PID 17029 | 03:54:05 INFO - PID 17029 | Cycle 1(1): loaded http://localhost:53906/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53906/tests/kraken/driver.html?testName=audio-fft) 03:54:06 INFO - PID 17029 | RSS: Main: 174661632 03:54:06 INFO - PID 17029 | 03:54:08 INFO - PID 17029 | Cycle 1(1): loaded http://localhost:53906/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53906/tests/kraken/driver.html?testName=audio-oscillator) 03:54:09 INFO - PID 17029 | RSS: Main: 175181824 03:54:09 INFO - PID 17029 | 03:54:11 INFO - PID 17029 | Cycle 1(1): loaded http://localhost:53906/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53906/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:12 INFO - PID 17029 | RSS: Main: 175280128 03:54:12 INFO - PID 17029 | 03:54:15 INFO - PID 17029 | Cycle 1(1): loaded http://localhost:53906/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53906/tests/kraken/driver.html?testName=imaging-darkroom) 03:54:15 INFO - PID 17029 | RSS: Main: 178778112 03:54:15 INFO - PID 17029 | 03:54:19 INFO - PID 17029 | Cycle 1(1): loaded http://localhost:53906/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53906/tests/kraken/driver.html?testName=imaging-desaturate) 03:54:20 INFO - PID 17029 | RSS: Main: 177868800 03:54:20 INFO - PID 17029 | 03:54:22 INFO - PID 17029 | Cycle 1(1): loaded http://localhost:53906/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53906/tests/kraken/driver.html?testName=json-parse-financial) 03:54:23 INFO - PID 17029 | RSS: Main: 178835456 03:54:23 INFO - PID 17029 | 03:54:25 INFO - PID 17029 | Cycle 1(1): loaded http://localhost:53906/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53906/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:26 INFO - PID 17029 | RSS: Main: 178675712 03:54:26 INFO - PID 17029 | 03:54:27 INFO - PID 17029 | Cycle 1(1): loaded http://localhost:53906/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53906/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:28 INFO - PID 17029 | RSS: Main: 175788032 03:54:28 INFO - PID 17029 | 03:54:30 INFO - PID 17029 | Cycle 1(1): loaded http://localhost:53906/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53906/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:54:31 INFO - PID 17029 | RSS: Main: 175833088 03:54:31 INFO - PID 17029 | 03:54:34 INFO - PID 17029 | Cycle 1(1): loaded http://localhost:53906/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53906/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:54:34 INFO - PID 17029 | RSS: Main: 176234496 03:54:34 INFO - PID 17029 | 03:54:38 INFO - PID 17029 | Cycle 1(1): loaded http://localhost:53906/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53906/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:38 INFO - PID 17029 | RSS: Main: 176054272 03:54:38 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | Cycle 1(1): loaded http://localhost:53906/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53906/tests/kraken/driver.html?testName=ai-astar) 03:54:40 INFO - PID 17029 | RSS: Main: 177520640 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | __start_tp_report 03:54:40 INFO - PID 17029 | _x_x_mozilla_page_load 03:54:40 INFO - PID 17029 | _x_x_mozilla_page_load_details 03:54:40 INFO - PID 17029 | |i|pagename|runs| 03:54:40 INFO - PID 17029 | |0;ai-astar;115;110;101;108;120;112;111;104;108;110 03:54:40 INFO - PID 17029 | |1;audio-beat-detection;145;122;138;178;119;149;144;118;169;118 03:54:40 INFO - PID 17029 | |2;audio-dft;173;164;163;164;162;163;174;174;160;164 03:54:40 INFO - PID 17029 | |3;audio-fft;76;75;76;167;76;75;74;77;152;78 03:54:40 INFO - PID 17029 | |4;audio-oscillator;77;84;127;79;80;86;125;79;78;135 03:54:40 INFO - PID 17029 | |5;imaging-gaussian-blur;114;114;118;115;114;115;114;117;117;114 03:54:40 INFO - PID 17029 | |6;imaging-darkroom;151;150;151;152;150;153;155;151;156;152 03:54:40 INFO - PID 17029 | |7;imaging-desaturate;95;94;95;94;94;94;95;99;95;94 03:54:40 INFO - PID 17029 | |8;json-parse-financial;57;56;56;56;60;64;58;55;56;56 03:54:40 INFO - PID 17029 | |9;json-stringify-tinderbox;61;58;54;59;58;57;54;55;54;54 03:54:40 INFO - PID 17029 | |10;stanford-crypto-aes;79;89;78;84;80;78;84;101;80;94 03:54:40 INFO - PID 17029 | |11;stanford-crypto-ccm;130;142;140;132;129;134;125;133;125;174 03:54:40 INFO - PID 17029 | |12;stanford-crypto-pbkdf2;177;177;181;175;176;178;176;174;173;174 03:54:40 INFO - PID 17029 | |13;stanford-crypto-sha256-iterative;68;70;68;87;67;65;69;69;68;66 03:54:40 INFO - PID 17029 | __end_tp_report 03:54:40 INFO - PID 17029 | __start_cc_report 03:54:40 INFO - PID 17029 | _x_x_mozilla_cycle_collect,980 03:54:40 INFO - PID 17029 | __end_cc_report 03:54:40 INFO - PID 17029 | __startTimestamp1501757680768__endTimestamp 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | ------- Summary: start ------- 03:54:40 INFO - PID 17029 | Number of tests: 14 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:5.32 (4.8%) stddev-sans-first:5.32 03:54:40 INFO - PID 17029 | Values: 115.0 110.0 101.0 108.0 120.0 112.0 111.0 104.0 108.0 110.0 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:144.50 stddev:21.46 (14.8%) stddev-sans-first:22.68 03:54:40 INFO - PID 17029 | Values: 145.0 122.0 138.0 178.0 119.0 149.0 144.0 118.0 169.0 118.0 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | [#2] audio-dft Cycles:10 Average:166.10 Median:164.00 stddev:5.36 (3.3%) stddev-sans-first:5.07 03:54:40 INFO - PID 17029 | Values: 173.0 164.0 163.0 164.0 162.0 163.0 174.0 174.0 160.0 164.0 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.00 stddev:35.45 (46.6%) stddev-sans-first:37.09 03:54:40 INFO - PID 17029 | Values: 76.0 75.0 76.0 167.0 76.0 75.0 74.0 77.0 152.0 78.0 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:79.00 stddev:23.75 (30.1%) stddev-sans-first:24.28 03:54:40 INFO - PID 17029 | Values: 77.0 84.0 127.0 79.0 80.0 86.0 125.0 79.0 78.0 135.0 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.55 (1.3%) stddev-sans-first:1.58 03:54:40 INFO - PID 17029 | Values: 114.0 114.0 118.0 115.0 114.0 115.0 114.0 117.0 117.0 114.0 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | [#6] imaging-darkroom Cycles:10 Average:152.10 Median:152.00 stddev:2.02 (1.3%) stddev-sans-first:2.11 03:54:40 INFO - PID 17029 | Values: 151.0 150.0 151.0 152.0 150.0 153.0 155.0 151.0 156.0 152.0 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:1.52 (1.6%) stddev-sans-first:1.62 03:54:40 INFO - PID 17029 | Values: 95.0 94.0 95.0 94.0 94.0 94.0 95.0 99.0 95.0 94.0 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:56.50 stddev:2.72 (4.8%) stddev-sans-first:2.88 03:54:40 INFO - PID 17029 | Values: 57.0 56.0 56.0 56.0 60.0 64.0 58.0 55.0 56.0 56.0 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:57.50 stddev:2.55 (4.4%) stddev-sans-first:2.09 03:54:40 INFO - PID 17029 | Values: 61.0 58.0 54.0 59.0 58.0 57.0 54.0 55.0 54.0 54.0 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:82.00 stddev:7.73 (9.4%) stddev-sans-first:7.92 03:54:40 INFO - PID 17029 | Values: 79.0 89.0 78.0 84.0 80.0 78.0 84.0 101.0 80.0 94.0 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:133.50 stddev:14.34 (10.7%) stddev-sans-first:15.02 03:54:40 INFO - PID 17029 | Values: 130.0 142.0 140.0 132.0 129.0 134.0 125.0 133.0 125.0 174.0 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:176.50 stddev:2.33 (1.3%) stddev-sans-first:2.45 03:54:40 INFO - PID 17029 | Values: 177.0 177.0 181.0 175.0 176.0 178.0 176.0 174.0 173.0 174.0 03:54:40 INFO - PID 17029 | 03:54:40 INFO - PID 17029 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:68.50 stddev:6.25 (9.1%) stddev-sans-first:6.60 03:54:40 INFO - PID 17029 | Values: 68.0 70.0 68.0 87.0 67.0 65.0 69.0 69.0 68.0 66.0 03:54:40 INFO - PID 17029 | -------- Summary: end -------- 03:54:40 INFO - PID 17029 | 03:54:41 INFO - PID 17029 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:54:41 INFO - TEST-INFO | 17029: exit 0 03:54:41 INFO - TEST-OK | kraken | took 63241ms 03:54:41 INFO - SUITE-END | took 1176s 03:54:41 INFO - Completed test suite (00:19:37) 03:54:41 INFO - javascript benchmark 03:54:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8527.387088328016, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3153.0540837748654, 3164.556962025317, 3170.2866854957624, 3179.205198700325, 3240.8217548034863, 6187.721552530135, 6193.690315484225, 6311.558190926637, 6319.115323854652, 6354.68226588671, 6177.66022868742, 6214.84462888428, 6288.968555157229, 6289.654069026202, 6311.589746666475, 5475.233467314579, 5725.942740572604, 5790.71046447676, 5800.274965629296, 5814.883702325951, 5658.830235092953, 5722.313322401297, 5736.139579063153, 5743.942560574383, 5784.2480477537865, 5655.971720141414, 5740.138979153139, 5740.9712951435395, 5761.827145185651, 5821.155932389822, 5568.443155684439, 5669.149627555858, 5695.7152142392715, 5763.279590051244, 5778.451047150514, 5640.8871822563315, 5648.54811615074, 5668.31980162379, 5695.1741997410145, 5703.7148142592705, 6126.264848218198, 6189.566730328879, 6196.349383314732, 6220.0, 6224.377562243784, 6640.966795165993, 6710.16122984627, 6751.594904305708, 6795.082663840417, 6796.524243302971, 6743.696533655997, 6782.220044694874, 6795.524313298021, 6853.657317134123, 6856.040154378391, 6131.816045518642, 6157.96921015392, 6219.222597175353, 6227.19046523949, 6237.906431403532, 6882.8967565486555, 7020.403265722369, 7022.789316320519, 7023.92976070243, 7040.401565866959, 6582.473402127818, 6584.045313429526, 6586.967065164644, 6601.900971485432, 6608.471322294205, 6586.835329116715, 6619.073329733841, 6694.9665251674405, 6707.832304192337, 6737.0, 6544.607323560602, 6553.8361540960905, 6566.376194261537, 6658.400743933069, 6710.261871194165, 6650.53446258767, 6769.898451523231, 6772.255051944282, 6774.830629234309, 6780.830479238059, 5428.185772134132, 5440.347158341025, 5442.537384322298, 5445.618806683573, 5445.673259604437, 4670.673052886265, 4697.177993851063, 4724.574788269072, 4730.314104454904, 4741.5258474153, 5817.592768506164, 5836.124581312837, 5890.322612899486, 5908.704564771744, 5916.970415147896, 6668.233153187349, 6718.764843230463, 6738.056672065914, 6824.249332573413, 6836.077129587541, 5792.160136780143, 5828.417158284223, 5829.358770535237, 5855.238818953509, 5869.4717475427415, 5959.0763431668165, 5975.312839023568, 5977.163197152402, 5986.431289027535, 5995.61028533144, 6570.342965703487, 6628.337166283333, 6645.734170633217, 6650.800475985729, 6658.3674550917585, 6788.59268443895, 6798.4221341184575, 6880.5527640704195, 6898.793036208922, 6899.89650155238, 6469.547131700736, 6481.092647029325, 6521.380468855451, 6525.8694826104165, 6534.640594767334, 6539.215294164731, 6612.570182938093, 6636.2368327642935, 6648.202215734143, 6654.4676425884845, 6757.628330441873, 6810.046593476818, 6810.284920083518, 6811.93188068113, 6819.624920629413, 5485.232067510631, 6444.387783160592, 6551.246606640107, 6597.1423714916755, 6606.405423511907, 6466.708998095003, 6483.675816209265, 6506.25178104524, 6575.243846957661, 6589.769358072636, 6331.9366806331345, 6396.584222025554, 6409.583377080475, 6498.64257465825, 6513.0, 6517.511186661114, 6591.703373348115, 6618.040384144176, 6629.834254143685, 6632.668366581555, 6378.394052564999, 6389.520785941166, 6411.198600174978, 6412.1023056771155, 6421.197350331208], "value": 6130.7626820897085, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.6918655504186, 838.9328853691705, 850.9149085091491, 894.5884892949243, 904.6336233825301, 42174.0, 43101.56898431015, 43115.0, 43155.78422107893, 43281.78359108204, 39061.414078788766, 39108.608913910924, 39208.0, 39246.8037659812, 39343.80328098363, 6980.476464265188, 7140.214576396618, 7141.071660684104, 7143.535670181447, 7147.964260178692, 7007.509474336798, 7104.254053324404, 7705.653245603933, 7939.206079392073, 7939.245771651684, 7914.089879663826, 7942.205779422041, 7962.5620590867475, 7966.482178658398, 7969.9203007970045, 7704.845903081963, 7842.960785196066, 7856.292933635971, 7886.487378320391, 7908.169642187602, 7727.65225564851, 7785.844283114306, 7794.571298578576, 7801.609919504002, 7802.180771019075, 39315.41026884599, 39344.60655393467, 39370.40944385836, 39374.21251574981, 39734.0, 3571.232185080194, 3617.746757726934, 3628.8911332660064, 3639.890803275906, 3640.2719456108885, 31474.213144671336, 32102.197445063826, 32208.0, 32244.193895152574, 32259.6774032259, 4940.407151141886, 4963.553280204763, 4995.700257984533, 5011.774470148852, 5033.194688849767, 231881.0, 236402.0, 237195.0, 238495.0, 239089.0, 52136.0, 53075.73462132742, 53111.46888531065, 53146.73426632842, 53164.20253696197, 54395.45604543983, 54621.0, 54624.45375546273, 54656.72671636696, 54670.0, 17254.137293135293, 17382.478525644252, 17410.21654025572, 17432.477025689248, 17442.47672569825, 14070.085444446284, 14147.85852141486, 14151.504697335544, 14172.433102675777, 14176.929115354356, 15015.0, 15096.16971066602, 15102.924485377722, 15124.924375378272, 15192.848071519364, 5732.484076433141, 5834.824955251349, 5885.6468611882565, 5889.352171261158, 5920.703964801743, 985.6845809341086, 995.2436148527026, 1019.9694009179588, 1025.3027941000043, 1041.6979076068008, 22748.65877011846, 23342.7665723344, 23534.176303829285, 28860.0, 29845.85077074601, 1096.13405409727, 1099.934003959765, 1104.3042882983668, 1109.8612673415823, 1117.754094099297, 12550.560730374576, 12656.43046062911, 12742.554010609585, 12747.362631868555, 12886.742265154831, 248426.0, 249460.0, 251158.0, 251742.0, 252150.0, 55269.723651381486, 55816.44183558112, 56378.154327685115, 58692.7065364679, 61372.38627613667, 1495.229956572366, 1500.9699806003819, 1506.1716056169282, 1507.6155580326947, 1522.5812901451968, 27849.860750696116, 28182.718172818008, 28417.289567760145, 28494.0, 28610.713892860804, 39529.20941581095, 39591.0, 39655.40516892307, 39728.404073938334, 39841.0, 213507.0, 213730.0, 214465.0, 215634.0, 215948.0, 35951.0, 36181.457278140326, 36588.451173232956, 36713.632863671024, 39040.41439378468, 49500.25749613831, 50201.24698129604, 50553.988920222124, 50881.491185087674, 51053.74473127611, 35736.106597335274, 35898.46152307665, 35947.10132246715, 36001.63998359983, 36016.27967440584, 35368.11579710528, 35436.645633544365, 35584.82207588945, 35587.0, 36264.0, 39332.2133557333, 39503.60496394999, 39523.20953580855, 39599.60400395959, 39620.801895990335, 34240.828795855865, 34251.0, 34733.47899781556, 34902.30195396027, 35438.64561354354, 24789.50420991534, 24916.01651217704, 25108.497830042932, 25213.747862521876, 25573.48853022892], "value": 18133.685068784802, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.2771826793906, 585.3122580967362, 592.1975722895477, 601.4166258729034, 612.8008397270887, 22906.083756649736, 23004.76995230047, 23422.76577234227, 23428.531429371404, 23428.88285558574, 25257.74742252577, 27181.18456446305, 27250.0, 27304.726952730467, 27407.451850962967, 6607.075009498662, 6769.898451523231, 6772.085768421274, 6772.085768421274, 6785.728570857184, 4126.195391898581, 5959.374265702104, 6018.909716354258, 6603.405693487585, 6717.664116794165, 4116.58834116589, 6610.768623098193, 6612.867742645144, 6616.404523592876, 6624.701888415008, 6586.440152587012, 6613.801585952429, 6614.404703576702, 6614.570052946543, 6615.834604134887, 6111.449969502766, 6148.508119350441, 6166.352532984062, 6181.320054793969, 6194.845128871769, 30233.0, 30573.847130764203, 30638.54042189369, 31118.688813111807, 31133.0, 1909.4653497020856, 1952.1020330647777, 1954.7067939809, 1955.0420294055953, 1956.4521933858543, 18451.723224151647, 18890.43328700141, 19351.709724354147, 19916.601667966705, 19919.402417927486, 2335.8364914455997, 2336.906523739048, 2381.9761802381927, 2400.603900356439, 2402.2072716003677, 147464.262678687, 152431.0, 153722.23138884234, 153820.2308988459, 158041.0, 15148.848511514743, 15599.0, 15728.213589320718, 15996.440124595583, 16060.598485037968, 24395.634065489034, 24436.755632443448, 24592.508149836904, 24604.753952460604, 24650.0, 10072.136654718754, 10732.195085368628, 10752.784944301227, 10795.83806242907, 10865.619703310504, 9969.102780749767, 9970.853351864629, 10103.54534045955, 10129.848052279222, 10144.492775361203, 9335.90664093364, 9421.481818499911, 9432.669856555125, 9724.416535007922, 9828.017198280259, 2783.860806959644, 2792.9301767455568, 2816.9154377524505, 2835.3478699899138, 2908.69458706837, 971.3006635222629, 976.8814707160403, 980.789130336981, 982.1357205658975, 993.5231089077283, 19572.763551546446, 19961.401157965283, 20101.19595216175, 20362.898185508977, 20453.48866278355, 1009.5154325923597, 1040.5265604150093, 1077.830553849067, 1085.0722632149557, 1086.1745073744012, 10929.453527323602, 11165.330080195214, 11253.71865703364, 11298.887011129947, 11310.321380717183, 550626.0, 572088.0, 582452.0, 588822.0, 595314.0, 113276.0, 119546.0, 125753.0, 128556.35721821518, 128711.0, 1284.094713227154, 1284.389914790467, 1314.1523717202351, 1321.722438287951, 1321.9801702974464, 20505.89747051255, 20622.793772062687, 20793.0, 20830.1667933281, 20913.477163071046, 54827.17759233694, 55516.167257490364, 56360.0, 56432.71783641056, 56894.7155264221, 69826.65086674535, 70145.29854701592, 70461.64769176122, 70908.0, 71296.0, 14666.41334346657, 14946.626334341294, 15123.924380378028, 15124.470643527424, 15129.697406052037, 23131.190408335628, 23231.0, 23482.76517234874, 23573.17493887706, 23626.0, 17206.31174753046, 17358.0, 18446.26214951387, 18681.43955681332, 18749.250029998646, 17003.23485443133, 17093.0, 17477.38829140974, 17502.387416440364, 17509.124543773014, 18826.905865470584, 18995.525111872314, 18997.0, 19100.426987190407, 19311.130999105357, 14783.704325913637, 14784.260786960394, 14810.62973425673, 14846.77729834075, 14864.777028344799, 18513.0, 18565.35021274249, 18587.814121859148, 18659.626807464047, 18673.253069877053], "value": 12309.121145955372, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.6560859785054, 1427.8072460217868, 1437.274176540847, 1439.1437094928515, 1442.4951267056538, 13816.378262978165, 14319.713605727879, 14354.354054067553, 14364.353604087815, 14425.990180687342, 13911.234882081482, 14439.711205775879, 14798.630034249149, 14834.368219495847, 14854.480093196713, 2704.418550011747, 2777.5555911054234, 2781.1517487166407, 2787.7351651593167, 2790.539560972437, 2625.566781481053, 2636.5913283441, 2736.0, 2742.9725702742917, 2786.512360336943, 2778.6387769589924, 2807.6490438695164, 2807.7332653397893, 2810.367667274857, 2811.6485439320086, 2621.986890065547, 2644.7223041580646, 2655.2830735701446, 2658.2158263312176, 2659.9999999999905, 2623.7113917469064, 2634.499445105424, 2647.113217072283, 2651.0, 2653.827501212415, 13776.793348099787, 14197.290135493287, 14206.289685515683, 14208.715825683428, 14222.644433889132, 7690.653920573588, 7950.880736788953, 7957.60211989404, 7970.840583188304, 8008.239217274349, 5172.534471897509, 5259.132243179909, 5329.626926115174, 5461.5357694596005, 5527.474889885454, 1785.2234278088943, 1805.1876655505075, 1831.0844577711143, 1839.7884243312058, 1852.8054554271741, 22496.775032249632, 22724.772752272595, 22768.43078923007, 22769.886150569306, 22771.658425123638, 6428.678566071678, 6530.118434011442, 6618.742438936587, 6718.865622687519, 6756.614893946729, 15902.284397202153, 16000.359985600679, 16013.839861601467, 16068.43760468378, 16101.758473622906, 7512.0985481741445, 7762.534247945141, 7764.534127952341, 7769.53382797034, 7774.727884524014, 6955.7217711292, 7098.432125429953, 7158.141023077264, 7183.245759195209, 7195.89206161908, 5142.485751424828, 5149.0, 5233.973830130901, 5252.763625636855, 5397.73011349431, 1415.7380884536394, 1444.9885080443732, 1526.3513006971993, 1565.2565031610122, 1574.189292514356, 869.0874581689201, 879.1120967822545, 882.969096081634, 892.7411050795326, 897.8159477307137, 8382.790430239293, 8466.153384661484, 8589.398742088119, 8614.138586141336, 8654.956725216334, 990.9009099090177, 993.5231089077283, 1004.5981607357115, 1007.3804610164696, 1009.5764971390452, 4669.533046695304, 4958.727270000112, 4970.826021089245, 5057.291979122926, 5110.361204849394, 18440.35458758937, 18792.436226913214, 19497.707534386995, 19851.205951761767, 19882.304119355755, 17870.374536891406, 17960.101994900204, 17989.370372037178, 18069.096545172688, 18160.455186344432, 10375.792484150275, 10761.085307748772, 10915.945420272848, 11008.504617292241, 11099.056580190612, 7794.571298578632, 7890.9605451972375, 8021.438499305226, 8067.0, 8251.587420628824, 16447.83552164463, 16467.83532164663, 16574.337026519286, 16793.41223057236, 17059.658806823547, 16794.244259008618, 16873.07198104067, 16912.74630880513, 16945.576360591083, 17246.396376126777, 10952.452377381258, 11155.330680159217, 11224.66326010221, 11263.0, 11343.48954297075, 12275.93862030684, 12420.565280215149, 12442.191257568229, 12454.501819927102, 12468.438920248429, 8856.778580535538, 10388.636397726346, 11015.504302306575, 11025.17311201647, 11090.334579925231, 10176.694699159038, 10234.846477302697, 10281.074703276441, 10459.0, 10490.0, 9571.90428095738, 9611.759706007406, 9677.129058384498, 9684.467354295299, 9687.612495500383, 6561.573497722633, 6700.564463309869, 6705.698243578953, 6720.630365329758, 6747.730090796509, 7028.226895041644, 7071.222165561681, 7099.325564071405, 7116.50184487081, 7160.462965277729], "value": 6405.247789406359, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.92676699349147, 498.18049308886873, 518.2899427783937, 523.5052875033094, 529.6557237795432, 6220.751169953202, 6241.843953901149, 6264.404881536252, 6295.748170073191, 6351.618902865831, 5925.644461332312, 6128.0, 6179.3202747697715, 6210.130581718563, 6213.658248796314, 4897.730624815652, 4922.68002579833, 4967.602591792648, 5006.299118123466, 5040.0, 4974.900501989958, 4993.176125939234, 4997.675151115184, 5002.674826136289, 5025.120603894322, 4785.377900872882, 4883.4628190898975, 4969.875753106183, 4977.328060711794, 4989.57588604969, 4937.284493528563, 4950.059488697136, 4966.081274964107, 4980.77586508608, 4986.950130498685, 4422.204003279408, 4453.332000199964, 4458.8439404620685, 4465.486469056068, 4468.620167285784, 6015.879682406327, 6065.452509945833, 6074.058520929263, 6083.148359229712, 6125.111858780497, 5682.801101961411, 5708.71456427177, 5754.367019627837, 5765.1928729977835, 5776.9422305776825, 6489.059086432441, 6529.444997175246, 6530.902036469457, 6542.738290468375, 6599.736010559572, 4850.733209673466, 4857.708537487762, 4858.1983972644475, 4869.318295438641, 4903.730294833783, 6914.239433662293, 6976.825579360506, 6989.82525436863, 6993.930060699429, 7017.543859649107, 5039.823606173766, 5045.495450454925, 5045.571126454219, 5056.949430505648, 5083.38999320084, 5099.388073431212, 5105.157648987875, 5108.0, 5114.33513643224, 5150.665206761549, 5709.22925405065, 5744.856378590485, 5749.9425005750245, 5768.7692492300675, 5813.360530341659, 6544.345565443513, 6580.63806490638, 6583.506237032242, 6630.5027122965, 6646.2356828965285, 1703.4498606268485, 1731.1257814803696, 1746.6157445362, 1768.9292428302724, 1797.4158398520533, 1147.3345459633392, 1227.7483115961206, 1231.2550906701497, 1239.6343078791779, 1259.3514340114848, 5701.857453563694, 5758.395368486333, 5758.769649213985, 5790.652560846363, 5806.738696758656, 6533.281339052701, 6553.934460655428, 6565.540412171103, 6577.86844263112, 6641.734330626818, 5593.272874526286, 5796.739146738407, 5819.679917604488, 5874.383189765099, 5907.556933230025, 3633.4004889193516, 3637.727170462173, 3638.909027274339, 3660.9450858237146, 3668.1196512836727, 6509.251436084911, 6561.573497722633, 6570.277269500351, 6574.276829548746, 6614.900776488356, 6967.895481567781, 7047.295270473014, 7052.118485189351, 7052.294770522906, 7064.576125432491, 6595.0, 6604.801855944425, 6636.601803891782, 6640.468762498988, 6649.803035453568, 6682.599044057372, 6727.2263689674355, 6731.697073631601, 6760.93239067603, 6808.38724514796, 6520.902186467301, 6529.804105876831, 6596.60420374779, 6617.966910165418, 6727.293634168342, 6642.734290628321, 6658.234303055211, 6660.933390666225, 6670.933290667225, 6690.130283063365, 4910.410750709938, 4959.13215187348, 4960.900781984412, 4986.850394488171, 4988.755060222842, 6727.798166055026, 6737.0, 6769.221539523018, 6821.226481114847, 6830.394857208651, 6467.967660161669, 6505.381988711065, 6560.409563139149, 6604.174478190226, 6609.570377925419, 6437.678116094083, 6441.355864413521, 6486.805395838132, 6537.444317233088, 6578.8355291118105, 6237.349126621259, 6403.96798016007, 6431.356864313531, 6500.447461965786, 6509.7396104155305, 6471.546991710535, 6516.478681705357, 6528.0, 6566.785144748237, 6624.271330153776, 6189.84525386869, 6313.05304204373, 6368.745250190126, 6389.904151437825, 6405.295417504164], "value": 5069.844873269748, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.9144131307526, 906.3791302957475, 924.7364501117179, 926.9768255793608, 927.9907200927993, 17549.736753948684, 18569.350072747457, 18573.814261857377, 18590.34933777318, 18605.348812791555, 17211.569710757238, 18489.630207395843, 21558.784412155874, 21591.56816863662, 21678.34964951054, 1008.7074748322977, 1034.105498743585, 1043.4626167523693, 1044.1438020822927, 1045.513836066229, 762.744480599, 786.3041208530464, 1055.4775386183849, 1058.2433560004595, 1062.9468526573678, 1076.1552181537495, 1114.4260705736551, 1128.3399211461306, 1129.4183495499824, 1130.5534313945986, 1115.314081839671, 1116.5198964445326, 1118.2619471149044, 1119.7256672115302, 1120.6918097523205, 817.382875928676, 819.4345901328064, 821.2690705272313, 823.0493779684474, 823.7528741377623, 18964.5258868528, 19263.325783597647, 19546.218151273933, 19580.80419195804, 19633.31283405074, 20191.495212619655, 20325.593488130155, 20746.0, 20774.169033238653, 20888.791112088835, 15882.523524294289, 16444.506664800076, 16504.25730842115, 16545.338186472527, 16644.33422663092, 3540.964590354089, 3572.4105522588743, 3588.2823435313044, 3593.2993066352074, 3597.1366871950545, 129295.0, 130219.0, 130572.0, 131663.6833631661, 132756.0, 15113.773293400607, 15240.923795380952, 15689.529314120595, 15854.207289635702, 15883.0, 30477.0, 30781.0, 30899.382012359627, 30990.22524436907, 31037.379252414827, 8351.958240208882, 8457.53483558398, 8468.576571171418, 8491.363147763943, 8499.74500764978, 3970.900727481836, 4002.199560087994, 4046.2312160689376, 4075.612816782401, 4079.796010199478, 5129.666571672829, 5191.610629202825, 5202.453742356998, 5242.0, 5246.23929530216, 897.6947837735071, 926.4904302633524, 938.6855403439788, 941.1717688434134, 942.1144124522926, 673.1148539670415, 687.3161204601354, 695.5687473766297, 698.2807708060706, 699.1959246866043, 10363.32638378503, 10373.792524149474, 10952.561897524169, 11112.499937502671, 11123.777524449466, 678.25053316086, 689.975850845218, 691.405391363427, 693.3240090911321, 697.7034760226883, 4744.24092145262, 4769.046190761862, 4843.07981483517, 4901.975490122527, 4947.752612369439, 102288.0, 102526.48736756269, 105436.47281763695, 105715.4714226424, 106509.46745266224, 90647.54676226576, 93415.0, 94100.0, 98532.0, 98880.0, 80638.5968070156, 82789.0, 83522.0, 85589.0, 86231.5688421554, 11130.276532025393, 11383.203175777948, 11536.884631153582, 11868.703282418008, 11931.105167112328, 33885.32229355448, 34021.65978340185, 34716.30567388688, 35216.47175292424, 35401.468977965866, 43602.78198608987, 44354.334684979105, 44572.33141502815, 44638.3304250443, 45187.09625807531, 16970.660586788443, 17259.309627614755, 17265.82734172642, 17393.82606173922, 17475.0, 18277.908610456863, 18280.45158645243, 18325.816741832412, 18373.0, 18540.907295463436, 15405.537833865003, 15471.690566188838, 15648.92175539115, 15727.135007574694, 15871.603209919844, 15343.46297879569, 15440.922795385952, 15482.767758483407, 15512.92243538775, 16047.839521604634, 14783.778243326144, 14973.775393368891, 15073.547793566211, 15100.848991510384, 15207.391704331703, 12226.510939562673, 12694.682632934251, 12697.238165710087, 12749.808752868528, 12806.35968201605, 12003.878991462108, 12015.399230038638, 12086.0, 12128.636140915787, 12314.568990085305], "value": 8651.860125366657, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 101.0, 108.0, 120.0, 112.0, 111.0, 104.0, 108.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 138.0, 178.0, 119.0, 149.0, 144.0, 118.0, 169.0, 118.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 164.0, 163.0, 164.0, 162.0, 163.0, 174.0, 174.0, 160.0, 164.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 167.0, 76.0, 75.0, 74.0, 77.0, 152.0, 78.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 84.0, 127.0, 79.0, 80.0, 86.0, 125.0, 79.0, 78.0, 135.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 118.0, 115.0, 114.0, 115.0, 114.0, 117.0, 117.0, 114.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 152.0, 150.0, 153.0, 155.0, 151.0, 156.0, 152.0], "value": 152.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 99.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 60.0, 64.0, 58.0, 55.0, 56.0, 56.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 54.0, 59.0, 58.0, 57.0, 54.0, 55.0, 54.0, 54.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 89.0, 78.0, 84.0, 80.0, 78.0, 84.0, 101.0, 80.0, 94.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 142.0, 140.0, 132.0, 129.0, 134.0, 125.0, 133.0, 125.0, 174.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 181.0, 175.0, 176.0, 178.0, 176.0, 174.0, 173.0, 174.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 87.0, 67.0, 65.0, 69.0, 69.0, 68.0, 66.0], "value": 69.7, "unit": "score"}]}]} 03:54:41 INFO - Return code: 0 03:54:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:54:42 INFO - # TBPL SUCCESS # 03:54:42 INFO - Running post-action listener: _package_coverage_data 03:54:42 INFO - Running post-action listener: _resource_record_post_action 03:54:42 INFO - [mozharness: 2017-08-03 10:54:42.017364Z] Finished run-tests step (success) 03:54:42 INFO - Running post-run listener: _resource_record_post_run 03:54:42 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431853568; Read time: 16; Write time: 330316 03:54:42 INFO - TinderboxPrint: CPU usage
13.2% 03:54:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:54:42 INFO - TinderboxPrint: I/O write bytes / time
431,853,568 / 330,316 03:54:42 INFO - TinderboxPrint: CPU idle
8,278.7 (86.8%) 03:54:42 INFO - TinderboxPrint: CPU user
1,204.9 (12.6%) 03:54:42 INFO - TinderboxPrint: Swap in / out
0 / 0 03:54:42 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106573824; Read time: 0; Write time: 94648 03:54:42 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:54:42 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 323604480; Read time: 0; Write time: 235460 03:54:42 INFO - Running post-run listener: _upload_blobber_files 03:54:42 INFO - Blob upload gear active. 03:54:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:54:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:54:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:54:43 INFO - (blobuploader) - INFO - Open directory for files ... 03:54:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:54:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:54:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:49 INFO - (blobuploader) - INFO - Done attempting. 03:54:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:54:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:54:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:50 INFO - (blobuploader) - INFO - Done attempting. 03:54:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:54:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:54:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:50 INFO - (blobuploader) - INFO - Done attempting. 03:54:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:54:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:54:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:51 INFO - (blobuploader) - INFO - Done attempting. 03:54:51 INFO - (blobuploader) - INFO - Iteration through files over. 03:54:51 INFO - Return code: 0 03:54:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:54:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:54:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1403208394096ee8e9e2a68dd4f0dd3454f516293b47306fc6302153e458273dc2c85189dba20964f322c71bb6fab08071cf34e8e6f4cd7a82dc86f571cb85b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9254605735590d9ad9f87bff708ddeabcb3bfe08788919133abd1ce1bcef9ca5bedb005af64b3e253dc279dc49a848884164b76d45ca43d33cf3bebca94f190f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa24ca7c56bd2cfef2422079a4aae69e71848f15e9a3d9cc141513a53644a49ac0decc399974be15b6d9c50902d314c89cb9677e8b207f247520c1010edfa59", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f200fa55baff774f2a0d5116bef72a8c581c6c686c8f4668531b2973d1e9ff9194c75235c2280d700b33b83a9c95e4b79ffbb60065ef56a358a84e8e4a291cda"} 03:54:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:54:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:54:51 INFO - Contents: 03:54:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1403208394096ee8e9e2a68dd4f0dd3454f516293b47306fc6302153e458273dc2c85189dba20964f322c71bb6fab08071cf34e8e6f4cd7a82dc86f571cb85b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9254605735590d9ad9f87bff708ddeabcb3bfe08788919133abd1ce1bcef9ca5bedb005af64b3e253dc279dc49a848884164b76d45ca43d33cf3bebca94f190f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa24ca7c56bd2cfef2422079a4aae69e71848f15e9a3d9cc141513a53644a49ac0decc399974be15b6d9c50902d314c89cb9677e8b207f247520c1010edfa59", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f200fa55baff774f2a0d5116bef72a8c581c6c686c8f4668531b2973d1e9ff9194c75235c2280d700b33b83a9c95e4b79ffbb60065ef56a358a84e8e4a291cda"} 03:54:51 INFO - Running post-run listener: copy_logs_to_upload_dir 03:54:51 INFO - Copying logs to upload dir... 03:54:51 INFO - mkdir: /builds/slave/test/build/upload/logs 03:54:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.992879 ========= master_lag: 0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-03 03:54:51.111781) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 03:54:51.116096) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1403208394096ee8e9e2a68dd4f0dd3454f516293b47306fc6302153e458273dc2c85189dba20964f322c71bb6fab08071cf34e8e6f4cd7a82dc86f571cb85b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9254605735590d9ad9f87bff708ddeabcb3bfe08788919133abd1ce1bcef9ca5bedb005af64b3e253dc279dc49a848884164b76d45ca43d33cf3bebca94f190f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa24ca7c56bd2cfef2422079a4aae69e71848f15e9a3d9cc141513a53644a49ac0decc399974be15b6d9c50902d314c89cb9677e8b207f247520c1010edfa59", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f200fa55baff774f2a0d5116bef72a8c581c6c686c8f4668531b2973d1e9ff9194c75235c2280d700b33b83a9c95e4b79ffbb60065ef56a358a84e8e4a291cda"} build_url:https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1403208394096ee8e9e2a68dd4f0dd3454f516293b47306fc6302153e458273dc2c85189dba20964f322c71bb6fab08071cf34e8e6f4cd7a82dc86f571cb85b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9254605735590d9ad9f87bff708ddeabcb3bfe08788919133abd1ce1bcef9ca5bedb005af64b3e253dc279dc49a848884164b76d45ca43d33cf3bebca94f190f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa24ca7c56bd2cfef2422079a4aae69e71848f15e9a3d9cc141513a53644a49ac0decc399974be15b6d9c50902d314c89cb9677e8b207f247520c1010edfa59", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f200fa55baff774f2a0d5116bef72a8c581c6c686c8f4668531b2973d1e9ff9194c75235c2280d700b33b83a9c95e4b79ffbb60065ef56a358a84e8e4a291cda"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 03:54:51.140355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:54:51.142702) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1501748881.432248-1703450291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:54:51.225654) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 03:54:51.226079) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 03:54:51.226434) ========= ========= Total master_lag: 0.54 =========