builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1466030852.74 results: success (0) buildid: 20160615141625 builduid: 0d353c62ef9a412fa6fa4ae5eda92429 revision: c914e1312fd6cede0da6dcaa1c605eaf07849138 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:32.745141) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:32.745666) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:32.745960) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:32.760188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:32.760456) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 15:47:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 81.5M=0s 2016-06-15 15:47:33 (81.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074814 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:32.848876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:32.849198) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022106 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:32.898777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 15:47:32.899128) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c914e1312fd6cede0da6dcaa1c605eaf07849138 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c914e1312fd6cede0da6dcaa1c605eaf07849138 --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=5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 15:47:33,951 truncating revision to first 12 chars 2016-06-15 15:47:33,951 Setting DEBUG logging. 2016-06-15 15:47:33,951 attempt 1/10 2016-06-15 15:47:33,951 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c914e1312fd6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 15:47:34,257 unpacking tar archive at: fx-team-c914e1312fd6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628761 ========= master_lag: 0.64 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 15:47:34.165676) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:34.165991) ========= script_repo_revision: c914e1312fd6cede0da6dcaa1c605eaf07849138 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:34.166397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:34.169821) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 15:47:34.180644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 10 secs) (at 2016-06-15 15:47:34.180926) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:35 INFO - MultiFileLogger online at 20160615 15:47:35 in /builds/slave/test 15:47:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:47:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:47:35 INFO - {'append_to_log': False, 15:47:35 INFO - 'base_work_dir': '/builds/slave/test', 15:47:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:47:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:47:35 INFO - 'branch': 'Fx-Team-Non-PGO', 15:47:35 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:35 INFO - 'config_files': ('talos/linux_config.py',), 15:47:35 INFO - 'default_actions': ('clobber', 15:47:35 INFO - 'read-buildbot-config', 15:47:35 INFO - 'download-and-extract', 15:47:35 INFO - 'populate-webroot', 15:47:35 INFO - 'create-virtualenv', 15:47:35 INFO - 'install', 15:47:35 INFO - 'run-tests'), 15:47:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:35 INFO - 'download_minidump_stackwalk': True, 15:47:35 INFO - 'download_symbols': 'ondemand', 15:47:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:47:35 INFO - 'tooltool.py': '/tools/tooltool.py', 15:47:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:47:35 INFO - '/tools/misc-python/virtualenv.py')}, 15:47:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:35 INFO - 'installer_path': 'installer.exe', 15:47:35 INFO - 'log_level': 'info', 15:47:35 INFO - 'log_name': 'talos', 15:47:35 INFO - 'log_to_console': True, 15:47:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:35 INFO - 'opt_config_files': (), 15:47:35 INFO - 'pip_index': False, 15:47:35 INFO - 'sps_profile': False, 15:47:35 INFO - 'sps_profile_interval': 0, 15:47:35 INFO - 'suite': 'dromaeojs-e10s', 15:47:35 INFO - 'system_bits': '32', 15:47:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:35 INFO - 'title': 'talos-linux64-ix-051', 15:47:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:35 INFO - 'use_talos_json': True, 15:47:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:47:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:35 INFO - 'work_dir': 'build'} 15:47:35 INFO - ##### 15:47:35 INFO - ##### Running clobber step. 15:47:35 INFO - ##### 15:47:35 INFO - Running pre-action listener: _resource_record_pre_action 15:47:35 INFO - Running main action method: clobber 15:47:35 INFO - rmtree: /builds/slave/test/build 15:47:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:47:35 INFO - Running post-action listener: _resource_record_post_action 15:47:35 INFO - ##### 15:47:35 INFO - ##### Finished clobber step (success) 15:47:35 INFO - ##### 15:47:35 INFO - ##### 15:47:35 INFO - ##### Running read-buildbot-config step. 15:47:35 INFO - ##### 15:47:35 INFO - Running pre-action listener: _resource_record_pre_action 15:47:35 INFO - Running main action method: read_buildbot_config 15:47:35 INFO - Using buildbot properties: 15:47:35 INFO - { 15:47:35 INFO - "project": "", 15:47:35 INFO - "product": "firefox", 15:47:35 INFO - "script_repo_revision": "production", 15:47:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:47:35 INFO - "repository": "", 15:47:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:47:35 INFO - "buildid": "20160615141625", 15:47:35 INFO - "pgo_build": "False", 15:47:35 INFO - "basedir": "/builds/slave/test", 15:47:35 INFO - "buildnumber": 1371, 15:47:35 INFO - "slavename": "talos-linux64-ix-051", 15:47:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:47:35 INFO - "platform": "ubuntu64_hw", 15:47:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:47:35 INFO - "branch": "fx-team", 15:47:35 INFO - "repo_path": "integration/fx-team", 15:47:35 INFO - "revision": "c914e1312fd6cede0da6dcaa1c605eaf07849138", 15:47:35 INFO - "stage_platform": "linux64", 15:47:35 INFO - "builduid": "0d353c62ef9a412fa6fa4ae5eda92429", 15:47:35 INFO - "slavebuilddir": "test" 15:47:35 INFO - } 15:47:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:47:35 INFO - Running post-action listener: _resource_record_post_action 15:47:35 INFO - ##### 15:47:35 INFO - ##### Finished read-buildbot-config step (success) 15:47:35 INFO - ##### 15:47:35 INFO - ##### 15:47:35 INFO - ##### Running download-and-extract step. 15:47:35 INFO - ##### 15:47:35 INFO - Running pre-action listener: _resource_record_pre_action 15:47:35 INFO - Running main action method: download_and_extract 15:47:35 INFO - mkdir: /builds/slave/test/build/tests 15:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:35 INFO - https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:47:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:47:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:47:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:47:36 INFO - Downloaded 1361 bytes. 15:47:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:47:36 INFO - Using the following test package requirements: 15:47:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:47:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:47:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:36 INFO - u'jsshell-linux-x86_64.zip'], 15:47:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:47:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:47:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:47:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:47:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:47:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:36 INFO - https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:47:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:47:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:47:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:47:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:49:32 INFO - Downloaded 22654307 bytes. 15:49:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:49:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:49:33 INFO - Return code: 0 15:49:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:33 INFO - https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:49:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:49:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:49:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:49:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:51:09 INFO - Downloaded 22654307 bytes. 15:51:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:51:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:51:11 INFO - Return code: 0 15:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:11 INFO - https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:51:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:51:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:51:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:51:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:51:12 INFO - Downloaded 14405384 bytes. 15:51:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:51:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:51:13 INFO - Return code: 0 15:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:13 INFO - https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:51:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:51:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:51:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:51:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:51:15 INFO - Downloaded 55438461 bytes. 15:51:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:51:15 INFO - mkdir: /builds/slave/test/properties 15:51:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:15 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:15 INFO - Contents: 15:51:15 INFO - build_url:https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:51:15 INFO - Running post-action listener: _resource_record_post_action 15:51:15 INFO - Running post-action listener: set_extra_try_arguments 15:51:15 INFO - ##### 15:51:15 INFO - ##### Finished download-and-extract step (success) 15:51:15 INFO - ##### 15:51:15 INFO - ##### 15:51:15 INFO - ##### Running populate-webroot step. 15:51:15 INFO - ##### 15:51:15 INFO - Running pre-action listener: _resource_record_pre_action 15:51:15 INFO - Running main action method: populate_webroot 15:51:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:15 INFO - '--tppagecycles', 15:51:15 INFO - '7'], 15:51:15 INFO - 'tests': ['tsvgm']}}, 15:51:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:51:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:51:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:51:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:51:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:15 INFO - 'talos_options': ['--disable-e10s'], 15:51:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:15 INFO - 'talos_options': ['--disable-e10s'], 15:51:15 INFO - 'tests': ['damp', 'tps']}, 15:51:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:15 INFO - 'tests': ['damp', 'tps']}, 15:51:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:51:15 INFO - 'tests': ['dromaeo_dom']}, 15:51:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:51:15 INFO - 'tests': ['basic_compositor_video']}, 15:51:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:51:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:51:15 INFO - 'tests': ['a11yr', 15:51:15 INFO - 'ts_paint', 15:51:15 INFO - 'tpaint', 15:51:15 INFO - 'sessionrestore', 15:51:15 INFO - 'sessionrestore_no_auto_restore', 15:51:15 INFO - 'tabpaint']}, 15:51:15 INFO - 'other-e10s': {'tests': ['a11yr', 15:51:15 INFO - 'ts_paint', 15:51:15 INFO - 'tpaint', 15:51:15 INFO - 'sessionrestore', 15:51:15 INFO - 'sessionrestore_no_auto_restore', 15:51:15 INFO - 'tabpaint']}, 15:51:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:51:15 INFO - 'ts_paint', 15:51:15 INFO - 'tpaint', 15:51:15 INFO - 'sessionrestore', 15:51:15 INFO - 'sessionrestore_no_auto_restore', 15:51:15 INFO - 'tabpaint']}, 15:51:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:51:15 INFO - 'ts_paint', 15:51:15 INFO - 'tpaint', 15:51:15 INFO - 'sessionrestore', 15:51:15 INFO - 'sessionrestore_no_auto_restore', 15:51:15 INFO - 'tabpaint']}, 15:51:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:51:15 INFO - 'tests': ['a11yr', 15:51:15 INFO - 'ts_paint', 15:51:15 INFO - 'tpaint', 15:51:15 INFO - 'sessionrestore', 15:51:15 INFO - 'sessionrestore_no_auto_restore', 15:51:15 INFO - 'tabpaint']}, 15:51:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:51:15 INFO - 'tests': ['a11yr', 15:51:15 INFO - 'ts_paint', 15:51:15 INFO - 'tpaint', 15:51:15 INFO - 'sessionrestore', 15:51:15 INFO - 'sessionrestore_no_auto_restore', 15:51:15 INFO - 'tabpaint']}, 15:51:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:51:15 INFO - 'tests': ['tsvgx', 15:51:15 INFO - 'tsvgr_opacity', 15:51:15 INFO - 'tart', 15:51:15 INFO - 'tscrollx', 15:51:15 INFO - 'cart']}, 15:51:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:51:15 INFO - 'tsvgr_opacity', 15:51:15 INFO - 'tart', 15:51:15 INFO - 'tscrollx', 15:51:15 INFO - 'cart']}, 15:51:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:15 INFO - 'talos_options': ['--disable-e10s'], 15:51:15 INFO - 'tests': ['tp5o']}, 15:51:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:15 INFO - 'tests': ['tp5o']}, 15:51:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:15 INFO - 'talos_options': ['--disable-e10s', 15:51:15 INFO - '--xperf_path', 15:51:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:15 INFO - 'tests': ['tp5n']}, 15:51:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:15 INFO - 'talos_options': ['--xperf_path', 15:51:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:15 INFO - 'tests': ['tp5n']}}, 15:51:15 INFO - 'talos.zip': {'path': '', 15:51:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:15 INFO - Running post-action listener: _resource_record_post_action 15:51:15 INFO - ##### 15:51:15 INFO - ##### Finished populate-webroot step (success) 15:51:15 INFO - ##### 15:51:15 INFO - ##### 15:51:15 INFO - ##### Running create-virtualenv step. 15:51:15 INFO - ##### 15:51:15 INFO - Running pre-action listener: _resource_record_pre_action 15:51:15 INFO - Running main action method: create_virtualenv 15:51:15 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:15 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 15:51:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:16 INFO - Using real prefix '/usr' 15:51:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:16 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:18 INFO - Installing pip.................done. 15:51:18 INFO - Return code: 0 15:51:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:18 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f7aecb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea1c0>, '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 0x16eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eb550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', '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 15:51:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:51:18 INFO - Using env: {'DISPLAY': ':0', 15:51:18 INFO - 'HOME': '/home/cltbld', 15:51:18 INFO - 'LANG': 'en_US.UTF-8', 15:51:18 INFO - 'LANGUAGE': 'en_US:en', 15:51:18 INFO - 'LOGNAME': 'cltbld', 15:51:18 INFO - 'MAIL': '/var/mail/cltbld', 15:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:18 INFO - 'MOZ_NO_REMOTE': '1', 15:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:18 INFO - 'NO_EM_RESTART': '1', 15:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:18 INFO - 'PWD': '/builds/slave/test', 15:51:18 INFO - 'SHELL': '/bin/bash', 15:51:18 INFO - 'SHLVL': '1', 15:51:18 INFO - 'TERM': 'linux', 15:51:18 INFO - 'TMOUT': '86400', 15:51:18 INFO - 'USER': 'cltbld', 15:51:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', 15:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:18 INFO - '_': '/tools/buildbot/bin/python'} 15:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:18 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 15:51:18 INFO - Cleaning up... 15:51:18 INFO - Return code: 0 15:51:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:18 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f7aecb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea1c0>, '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 0x16eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eb550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', '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 15:51:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:51:18 INFO - Using env: {'DISPLAY': ':0', 15:51:18 INFO - 'HOME': '/home/cltbld', 15:51:18 INFO - 'LANG': 'en_US.UTF-8', 15:51:18 INFO - 'LANGUAGE': 'en_US:en', 15:51:18 INFO - 'LOGNAME': 'cltbld', 15:51:18 INFO - 'MAIL': '/var/mail/cltbld', 15:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:18 INFO - 'MOZ_NO_REMOTE': '1', 15:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:18 INFO - 'NO_EM_RESTART': '1', 15:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:18 INFO - 'PWD': '/builds/slave/test', 15:51:18 INFO - 'SHELL': '/bin/bash', 15:51:18 INFO - 'SHLVL': '1', 15:51:18 INFO - 'TERM': 'linux', 15:51:18 INFO - 'TMOUT': '86400', 15:51:18 INFO - 'USER': 'cltbld', 15:51:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', 15:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:18 INFO - '_': '/tools/buildbot/bin/python'} 15:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:18 INFO - Downloading/unpacking psutil>=3.1.1 15:51:18 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 15:51:18 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 15:51:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:18 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 15:51:18 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 15:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:20 INFO - Installing collected packages: psutil 15:51:20 INFO - Running setup.py install for psutil 15:51:21 INFO - building 'psutil._psutil_linux' extension 15:51:21 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 15:51:21 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 15:51:21 INFO - building 'psutil._psutil_posix' extension 15:51:21 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 15:51:21 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 15:51:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:21 INFO - Successfully installed psutil 15:51:21 INFO - Cleaning up... 15:51:21 INFO - Return code: 0 15:51:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:21 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f7aecb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea1c0>, '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 0x16eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eb550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', '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 15:51:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:51:21 INFO - Using env: {'DISPLAY': ':0', 15:51:21 INFO - 'HOME': '/home/cltbld', 15:51:21 INFO - 'LANG': 'en_US.UTF-8', 15:51:21 INFO - 'LANGUAGE': 'en_US:en', 15:51:21 INFO - 'LOGNAME': 'cltbld', 15:51:21 INFO - 'MAIL': '/var/mail/cltbld', 15:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:21 INFO - 'MOZ_NO_REMOTE': '1', 15:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:21 INFO - 'NO_EM_RESTART': '1', 15:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:21 INFO - 'PWD': '/builds/slave/test', 15:51:21 INFO - 'SHELL': '/bin/bash', 15:51:21 INFO - 'SHLVL': '1', 15:51:21 INFO - 'TERM': 'linux', 15:51:21 INFO - 'TMOUT': '86400', 15:51:21 INFO - 'USER': 'cltbld', 15:51:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', 15:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:21 INFO - '_': '/tools/buildbot/bin/python'} 15:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:51:21 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 15:51:21 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 15:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:21 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 15:51:21 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 15:51:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:51:23 INFO - Installing collected packages: mozsystemmonitor 15:51:23 INFO - Running setup.py install for mozsystemmonitor 15:51:23 INFO - Successfully installed mozsystemmonitor 15:51:23 INFO - Cleaning up... 15:51:23 INFO - Return code: 0 15:51:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:23 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f7aecb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea1c0>, '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 0x16eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eb550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', '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 15:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:51:23 INFO - Using env: {'DISPLAY': ':0', 15:51:23 INFO - 'HOME': '/home/cltbld', 15:51:23 INFO - 'LANG': 'en_US.UTF-8', 15:51:23 INFO - 'LANGUAGE': 'en_US:en', 15:51:23 INFO - 'LOGNAME': 'cltbld', 15:51:23 INFO - 'MAIL': '/var/mail/cltbld', 15:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:23 INFO - 'MOZ_NO_REMOTE': '1', 15:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:23 INFO - 'NO_EM_RESTART': '1', 15:51:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:23 INFO - 'PWD': '/builds/slave/test', 15:51:23 INFO - 'SHELL': '/bin/bash', 15:51:23 INFO - 'SHLVL': '1', 15:51:23 INFO - 'TERM': 'linux', 15:51:23 INFO - 'TMOUT': '86400', 15:51:23 INFO - 'USER': 'cltbld', 15:51:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', 15:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:23 INFO - '_': '/tools/buildbot/bin/python'} 15:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:24 INFO - Downloading/unpacking jsonschema==2.5.1 15:51:24 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 15:51:24 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 15:51:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:24 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 15:51:24 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 15:51:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:51:25 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 15:51:25 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 15:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:25 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 15:51:25 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 15:51:26 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:26 INFO - warning: no files found matching '*.txt' 15:51:26 INFO - no previously-included directories found matching 'build' 15:51:26 INFO - no previously-included directories found matching 'dist' 15:51:26 INFO - no previously-included directories found matching '.git*' 15:51:26 INFO - Installing collected packages: jsonschema, functools32 15:51:26 INFO - Running setup.py install for functools32 15:51:26 INFO - warning: no files found matching '*.txt' 15:51:26 INFO - no previously-included directories found matching 'build' 15:51:26 INFO - no previously-included directories found matching 'dist' 15:51:26 INFO - no previously-included directories found matching '.git*' 15:51:26 INFO - Successfully installed jsonschema functools32 15:51:26 INFO - Cleaning up... 15:51:26 INFO - Return code: 0 15:51:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f7aecb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea1c0>, '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 0x16eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eb550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', '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 15:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:51:26 INFO - Using env: {'DISPLAY': ':0', 15:51:26 INFO - 'HOME': '/home/cltbld', 15:51:26 INFO - 'LANG': 'en_US.UTF-8', 15:51:26 INFO - 'LANGUAGE': 'en_US:en', 15:51:26 INFO - 'LOGNAME': 'cltbld', 15:51:26 INFO - 'MAIL': '/var/mail/cltbld', 15:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:26 INFO - 'MOZ_NO_REMOTE': '1', 15:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:26 INFO - 'NO_EM_RESTART': '1', 15:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:26 INFO - 'PWD': '/builds/slave/test', 15:51:26 INFO - 'SHELL': '/bin/bash', 15:51:26 INFO - 'SHLVL': '1', 15:51:26 INFO - 'TERM': 'linux', 15:51:26 INFO - 'TMOUT': '86400', 15:51:26 INFO - 'USER': 'cltbld', 15:51:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', 15:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:26 INFO - '_': '/tools/buildbot/bin/python'} 15:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:26 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:26 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 15:51:26 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 15:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:26 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 15:51:26 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 15:51:28 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51:28 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 15:51:28 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 15:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:28 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 15:51:28 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 15:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51:28 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 15:51:28 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 15:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:28 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 15:51:28 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 15:51:29 INFO - Downloading docopt-0.6.1.tar.gz 15:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:29 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:29 INFO - Running setup.py install for blobuploader 15:51:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:29 INFO - Running setup.py install for requests 15:51:29 INFO - Running setup.py install for docopt 15:51:29 INFO - Successfully installed blobuploader requests docopt 15:51:29 INFO - Cleaning up... 15:51:29 INFO - Return code: 0 15:51:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:29 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f7aecb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea1c0>, '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 0x16eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eb550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', '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 15:51:29 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:51:29 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:51:29 INFO - Using env: {'DISPLAY': ':0', 15:51:29 INFO - 'HOME': '/home/cltbld', 15:51:29 INFO - 'LANG': 'en_US.UTF-8', 15:51:29 INFO - 'LANGUAGE': 'en_US:en', 15:51:29 INFO - 'LOGNAME': 'cltbld', 15:51:29 INFO - 'MAIL': '/var/mail/cltbld', 15:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:29 INFO - 'MOZ_NO_REMOTE': '1', 15:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:29 INFO - 'NO_EM_RESTART': '1', 15:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:29 INFO - 'PWD': '/builds/slave/test', 15:51:29 INFO - 'SHELL': '/bin/bash', 15:51:29 INFO - 'SHLVL': '1', 15:51:29 INFO - 'TERM': 'linux', 15:51:29 INFO - 'TMOUT': '86400', 15:51:29 INFO - 'USER': 'cltbld', 15:51:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', 15:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:29 INFO - '_': '/tools/buildbot/bin/python'} 15:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:30 INFO - Running setup.py (path:/tmp/pip-Rr1oN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:30 INFO - Running setup.py (path:/tmp/pip-Ypoefz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:30 INFO - Running setup.py (path:/tmp/pip-4zhQtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:30 INFO - Running setup.py (path:/tmp/pip-BCKZZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:30 INFO - Running setup.py (path:/tmp/pip-io3MVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:30 INFO - Running setup.py (path:/tmp/pip-oNvMYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:30 INFO - Running setup.py (path:/tmp/pip-3ejpgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:30 INFO - Running setup.py (path:/tmp/pip-bwjIjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:30 INFO - Running setup.py (path:/tmp/pip-3qKLdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:30 INFO - Running setup.py (path:/tmp/pip-AoOYGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:30 INFO - Running setup.py (path:/tmp/pip-YigU71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:30 INFO - Running setup.py (path:/tmp/pip-1nM3vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:30 INFO - Running setup.py (path:/tmp/pip-OZPOyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:31 INFO - Running setup.py (path:/tmp/pip-t24B8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:31 INFO - Running setup.py (path:/tmp/pip-K8T8AU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:31 INFO - Running setup.py (path:/tmp/pip-DrEgqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:31 INFO - Running setup.py (path:/tmp/pip-lgvV_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:31 INFO - Running setup.py install for manifestparser 15:51:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:31 INFO - Running setup.py install for mozcrash 15:51:31 INFO - Running setup.py install for mozdebug 15:51:31 INFO - Running setup.py install for mozdevice 15:51:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:51:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:31 INFO - Running setup.py install for mozfile 15:51:31 INFO - Running setup.py install for mozhttpd 15:51:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:31 INFO - Running setup.py install for mozinfo 15:51:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:32 INFO - Running setup.py install for mozInstall 15:51:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:32 INFO - Running setup.py install for mozleak 15:51:32 INFO - Running setup.py install for mozlog 15:51:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:32 INFO - Running setup.py install for moznetwork 15:51:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:32 INFO - Running setup.py install for mozprocess 15:51:32 INFO - Running setup.py install for mozprofile 15:51:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:32 INFO - Running setup.py install for mozrunner 15:51:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:32 INFO - Running setup.py install for mozscreenshot 15:51:32 INFO - Running setup.py install for moztest 15:51:33 INFO - Running setup.py install for mozversion 15:51:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:33 INFO - Cleaning up... 15:51:33 INFO - Return code: 0 15:51:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:33 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f7aecb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea1c0>, '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 0x16eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eb550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', '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 15:51:33 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:51:33 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:51:33 INFO - Using env: {'DISPLAY': ':0', 15:51:33 INFO - 'HOME': '/home/cltbld', 15:51:33 INFO - 'LANG': 'en_US.UTF-8', 15:51:33 INFO - 'LANGUAGE': 'en_US:en', 15:51:33 INFO - 'LOGNAME': 'cltbld', 15:51:33 INFO - 'MAIL': '/var/mail/cltbld', 15:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:33 INFO - 'MOZ_NO_REMOTE': '1', 15:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:33 INFO - 'NO_EM_RESTART': '1', 15:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:33 INFO - 'PWD': '/builds/slave/test', 15:51:33 INFO - 'SHELL': '/bin/bash', 15:51:33 INFO - 'SHLVL': '1', 15:51:33 INFO - 'TERM': 'linux', 15:51:33 INFO - 'TMOUT': '86400', 15:51:33 INFO - 'USER': 'cltbld', 15:51:33 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', 15:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:33 INFO - '_': '/tools/buildbot/bin/python'} 15:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:33 INFO - Running setup.py (path:/tmp/pip-jpyh3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:33 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)) 15:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:33 INFO - Running setup.py (path:/tmp/pip-JbtwWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 15:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:33 INFO - Running setup.py (path:/tmp/pip-YLl0LG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:33 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)) 15:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:33 INFO - Running setup.py (path:/tmp/pip-yxFzq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 15:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:33 INFO - Running setup.py (path:/tmp/pip-Mhdt64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:33 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)) 15:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:33 INFO - Running setup.py (path:/tmp/pip-osaSPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:33 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)) 15:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:33 INFO - Running setup.py (path:/tmp/pip-IukFgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 15:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:33 INFO - Running setup.py (path:/tmp/pip-rz_oWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 15:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:33 INFO - Running setup.py (path:/tmp/pip-4nVGsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:34 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)) 15:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:34 INFO - Running setup.py (path:/tmp/pip-cY2YDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 15:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:34 INFO - Running setup.py (path:/tmp/pip-C0hWwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:34 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)) 15:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:34 INFO - Running setup.py (path:/tmp/pip-UmPGR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 15:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:34 INFO - Running setup.py (path:/tmp/pip-7Wx70N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:34 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)) 15:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:34 INFO - Running setup.py (path:/tmp/pip-G67TrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 15:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:34 INFO - Running setup.py (path:/tmp/pip-vKxYpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:34 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)) 15:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:34 INFO - Running setup.py (path:/tmp/pip-ddPL8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 15:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:34 INFO - Running setup.py (path:/tmp/pip-AEI0_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:34 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)) 15:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:34 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)) 15:51:34 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:51:34 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:51:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51: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 15:51: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 15:51:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51: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 15:51: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 15:51:36 INFO - Downloading blessings-1.6.tar.gz 15:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:36 INFO - Installing collected packages: blessings 15:51:36 INFO - Running setup.py install for blessings 15:51:36 INFO - Successfully installed blessings 15:51:36 INFO - Cleaning up... 15:51:36 INFO - Return code: 0 15:51:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:36 INFO - Reading from file tmpfile_stdout 15:51:36 INFO - Current package versions: 15:51:36 INFO - argparse == 1.2.1 15:51:36 INFO - blessings == 1.6 15:51:36 INFO - blobuploader == 1.2.4 15:51:36 INFO - docopt == 0.6.1 15:51:36 INFO - functools32 == 3.2.3-2 15:51:36 INFO - jsonschema == 2.5.1 15:51:36 INFO - manifestparser == 1.1 15:51:36 INFO - mozInstall == 1.12 15:51:36 INFO - mozcrash == 0.17 15:51:36 INFO - mozdebug == 0.1 15:51:36 INFO - mozdevice == 0.48 15:51:36 INFO - mozfile == 1.2 15:51:36 INFO - mozhttpd == 0.7 15:51:36 INFO - mozinfo == 0.9 15:51:36 INFO - mozleak == 0.1 15:51:36 INFO - mozlog == 3.2 15:51:36 INFO - moznetwork == 0.27 15:51:36 INFO - mozprocess == 0.22 15:51:36 INFO - mozprofile == 0.28 15:51:36 INFO - mozrunner == 6.11 15:51:36 INFO - mozscreenshot == 0.1 15:51:36 INFO - mozsystemmonitor == 0.3 15:51:36 INFO - moztest == 0.7 15:51:36 INFO - mozversion == 1.4 15:51:36 INFO - psutil == 3.1.1 15:51:36 INFO - requests == 1.2.3 15:51:36 INFO - wsgiref == 0.1.2 15:51:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:36 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f7aecb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea1c0>, '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 0x16eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eb550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', '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 15:51:36 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:51:36 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:51:36 INFO - Using env: {'DISPLAY': ':0', 15:51:36 INFO - 'HOME': '/home/cltbld', 15:51:36 INFO - 'LANG': 'en_US.UTF-8', 15:51:36 INFO - 'LANGUAGE': 'en_US:en', 15:51:36 INFO - 'LOGNAME': 'cltbld', 15:51:36 INFO - 'MAIL': '/var/mail/cltbld', 15:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:36 INFO - 'MOZ_NO_REMOTE': '1', 15:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:36 INFO - 'NO_EM_RESTART': '1', 15:51:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:36 INFO - 'PWD': '/builds/slave/test', 15:51:36 INFO - 'SHELL': '/bin/bash', 15:51:36 INFO - 'SHLVL': '1', 15:51:36 INFO - 'TERM': 'linux', 15:51:36 INFO - 'TMOUT': '86400', 15:51:36 INFO - 'USER': 'cltbld', 15:51:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', 15:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:36 INFO - '_': '/tools/buildbot/bin/python'} 15:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:37 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)) 15:51:37 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)) 15:51:37 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)) 15:51:37 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)) 15:51:37 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)) 15:51:37 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)) 15:51:37 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)) 15:51:37 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)) 15:51:37 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)) 15:51:37 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)) 15:51:37 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)) 15:51:37 INFO - Cleaning up... 15:51:37 INFO - Return code: 0 15:51:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:37 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f7aecb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea1c0>, '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 0x16eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eb550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', '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 15:51:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:51:37 INFO - Using env: {'DISPLAY': ':0', 15:51:37 INFO - 'HOME': '/home/cltbld', 15:51:37 INFO - 'LANG': 'en_US.UTF-8', 15:51:37 INFO - 'LANGUAGE': 'en_US:en', 15:51:37 INFO - 'LOGNAME': 'cltbld', 15:51:37 INFO - 'MAIL': '/var/mail/cltbld', 15:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:37 INFO - 'MOZ_NO_REMOTE': '1', 15:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:37 INFO - 'NO_EM_RESTART': '1', 15:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:37 INFO - 'PWD': '/builds/slave/test', 15:51:37 INFO - 'SHELL': '/bin/bash', 15:51:37 INFO - 'SHLVL': '1', 15:51:37 INFO - 'TERM': 'linux', 15:51:37 INFO - 'TMOUT': '86400', 15:51:37 INFO - 'USER': 'cltbld', 15:51:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', 15:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:37 INFO - '_': '/tools/buildbot/bin/python'} 15:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:51:37 INFO - Cleaning up... 15:51:37 INFO - Return code: 0 15:51:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:37 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7aecb97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ea1c0>, '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 0x16eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eb550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', '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 15:51:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:51:37 INFO - Using env: {'DISPLAY': ':0', 15:51:37 INFO - 'HOME': '/home/cltbld', 15:51:37 INFO - 'LANG': 'en_US.UTF-8', 15:51:37 INFO - 'LANGUAGE': 'en_US:en', 15:51:37 INFO - 'LOGNAME': 'cltbld', 15:51:37 INFO - 'MAIL': '/var/mail/cltbld', 15:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:37 INFO - 'MOZ_NO_REMOTE': '1', 15:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:37 INFO - 'NO_EM_RESTART': '1', 15:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:37 INFO - 'PWD': '/builds/slave/test', 15:51:37 INFO - 'SHELL': '/bin/bash', 15:51:37 INFO - 'SHLVL': '1', 15:51:37 INFO - 'TERM': 'linux', 15:51:37 INFO - 'TMOUT': '86400', 15:51:37 INFO - 'USER': 'cltbld', 15:51:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', 15:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:37 INFO - '_': '/tools/buildbot/bin/python'} 15:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:37 INFO - Downloading/unpacking flake8 15:51:37 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 15:51:37 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 15:51:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:37 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 15:51:37 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 15:51:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:51:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:51:39 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 15:51:39 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 15:51:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:39 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 15:51:39 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 15:51:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:51:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:51:39 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 15:51:39 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 15:51:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:39 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 15:51:39 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 15:51:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:51:39 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 15:51:39 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 15:51:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:39 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 15:51:39 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 15:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:51:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:40 INFO - no previously-included directories found matching 'docs/_build' 15:51:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:51:40 INFO - Running setup.py install for pep8 15:51:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:40 INFO - no previously-included directories found matching 'docs/_build' 15:51:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:51:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:51:40 INFO - Cleaning up... 15:51:40 INFO - Return code: 0 15:51:40 INFO - Running post-action listener: _resource_record_post_action 15:51:40 INFO - Running post-action listener: _start_resource_monitoring 15:51:40 INFO - Starting resource monitoring. 15:51:40 INFO - ##### 15:51:40 INFO - ##### Finished create-virtualenv step (success) 15:51:40 INFO - ##### 15:51:40 INFO - ##### 15:51:40 INFO - ##### Running install step. 15:51:40 INFO - ##### 15:51:40 INFO - Running pre-action listener: _resource_record_pre_action 15:51:40 INFO - Running main action method: install 15:51:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:40 INFO - Reading from file tmpfile_stdout 15:51:40 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:40 INFO - Reading from file tmpfile_stdout 15:51:40 INFO - Output received: 15:51:40 INFO - Usage: mozinstall [options] installer 15:51:40 INFO - Options: 15:51:40 INFO - -h, --help show this help message and exit 15:51:40 INFO - -d DEST, --destination=DEST 15:51:40 INFO - Directory to install application into. [default: 15:51:40 INFO - "/builds/slave/test"] 15:51:40 INFO - --app=APP Application being installed. [default: firefox] 15:51:40 INFO - mkdir: /builds/slave/test/build/application 15:51:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:51:56 INFO - Reading from file tmpfile_stdout 15:51:56 INFO - Output received: 15:51:56 INFO - /builds/slave/test/build/application/firefox/firefox 15:51:56 INFO - Running post-action listener: _resource_record_post_action 15:51:56 INFO - ##### 15:51:56 INFO - ##### Finished install step (success) 15:51:56 INFO - ##### 15:51:56 INFO - ##### 15:51:56 INFO - ##### Running run-tests step. 15:51:56 INFO - ##### 15:51:56 INFO - Running pre-action listener: _resource_record_pre_action 15:51:56 INFO - Running main action method: run_tests 15:51:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:51:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:51:56 INFO - Python 2.7.3 15:51:56 INFO - Return code: 0 15:51:56 INFO - grabbing minidump binary from tooltool 15:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:56 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 0x16ea1c0>, '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 0x16eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eb550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:51:56 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 15:51:56 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 15:51:56 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 15:51:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:51:56 INFO - Return code: 0 15:51:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:51:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:51:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:51:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:51:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:51:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:51:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:51:57 INFO - Return code: 0 15:51:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 15:51:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 15:51:57 INFO - Using env: {'DISPLAY': ':0', 15:51:57 INFO - 'HOME': '/home/cltbld', 15:51:57 INFO - 'LANG': 'en_US.UTF-8', 15:51:57 INFO - 'LANGUAGE': 'en_US:en', 15:51:57 INFO - 'LOGNAME': 'cltbld', 15:51:57 INFO - 'MAIL': '/var/mail/cltbld', 15:51:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:57 INFO - 'MOZ_NO_REMOTE': '1', 15:51:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:57 INFO - 'NO_EM_RESTART': '1', 15:51:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:57 INFO - 'PWD': '/builds/slave/test', 15:51:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:57 INFO - 'SHELL': '/bin/bash', 15:51:57 INFO - 'SHLVL': '1', 15:51:57 INFO - 'TERM': 'linux', 15:51:57 INFO - 'TMOUT': '86400', 15:51:57 INFO - 'USER': 'cltbld', 15:51:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194', 15:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:57 INFO - '_': '/tools/buildbot/bin/python'} 15:51:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 15:51:57 INFO - mozversion application_buildid: 20160615141625 15:51:57 INFO - mozversion application_changeset: c914e1312fd6cede0da6dcaa1c605eaf07849138 15:51:57 INFO - mozversion application_display_name: Nightly 15:51:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:51:57 INFO - mozversion application_name: Firefox 15:51:57 INFO - mozversion application_remotingname: firefox 15:51:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:51:57 INFO - mozversion application_vendor: Mozilla 15:51:57 INFO - mozversion application_version: 50.0a1 15:51:57 INFO - mozversion platform_buildid: 20160615141625 15:51:57 INFO - mozversion platform_changeset: c914e1312fd6cede0da6dcaa1c605eaf07849138 15:51:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:51:57 INFO - mozversion platform_version: 50.0a1 15:51:57 INFO - using testdate: 1466031117 15:51:57 INFO - actual date: 1466031117 15:51:57 INFO - starting webserver on 'localhost:42254' 15:51:57 INFO - SUITE-START | Running 2 tests 15:51:57 INFO - TEST-START | dromaeo_css 15:51:57 INFO - operating with platform_type : linux_ 15:51:57 INFO - Initialising browser for dromaeo_css test... 15:51:57 INFO - TEST-INFO | started process 488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpagJoN4/profile http://localhost:42254/getInfo.html) 15:52:02 INFO - PROCESS | 488 | __metrics Screen width/height:1600/1200 15:52:02 INFO - PROCESS | 488 | colorDepth:24 15:52:02 INFO - PROCESS | 488 | Browser inner width/height: 1024/697 15:52:02 INFO - PROCESS | 488 | __metrics 15:52:03 ERROR - PROCESS | 488 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 15:52:04 INFO - TEST-INFO | 488: exit 0 15:52:04 INFO - Browser initialized. 15:52:04 INFO - Running cycle 1/1 for dromaeo_css test... 15:52:04 INFO - TEST-INFO | started process 610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpagJoN4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:16 INFO - PROCESS | 610 | RSS: Main: 186060800 15:52:16 INFO - PROCESS | 610 | 15:53:06 INFO - PROCESS | 610 | 1466031186246 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:55:18 INFO - PROCESS | 610 | Cycle 1(1): loaded http://localhost:42254/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42254/tests/dromaeo/cssquery-ext.html) 15:55:19 INFO - PROCESS | 610 | RSS: Main: 189034496 15:55:19 INFO - PROCESS | 610 | 15:58:21 INFO - PROCESS | 610 | Cycle 1(1): loaded http://localhost:42254/tests/dromaeo/cssquery-ext.html (next: http://localhost:42254/tests/dromaeo/cssquery-jquery.html) 15:58:22 INFO - PROCESS | 610 | RSS: Main: 187535360 15:58:22 INFO - PROCESS | 610 | 16:01:24 INFO - PROCESS | 610 | Cycle 1(1): loaded http://localhost:42254/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42254/tests/dromaeo/cssquery-mootools.html) 16:01:25 INFO - PROCESS | 610 | RSS: Main: 190074880 16:01:25 INFO - PROCESS | 610 | 16:04:26 INFO - PROCESS | 610 | Cycle 1(1): loaded http://localhost:42254/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42254/tests/dromaeo/cssquery-prototype.html) 16:04:27 INFO - PROCESS | 610 | RSS: Main: 187023360 16:04:27 INFO - PROCESS | 610 | 16:07:30 INFO - PROCESS | 610 | Cycle 1(1): loaded http://localhost:42254/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42254/tests/dromaeo/cssquery-yui.html) 16:07:30 INFO - PROCESS | 610 | RSS: Main: 188555264 16:07:30 INFO - PROCESS | 610 | 16:10:33 INFO - PROCESS | 610 | Cycle 1(1): loaded http://localhost:42254/tests/dromaeo/cssquery-yui.html (next: http://localhost:42254/tests/dromaeo/cssquery-dojo.html) 16:10:33 INFO - PROCESS | 610 | RSS: Main: 189681664 16:10:33 INFO - PROCESS | 610 | 16:10:33 INFO - PROCESS | 610 | __start_tp_report 16:10:33 INFO - PROCESS | 610 | _x_x_mozilla_page_load 16:10:33 INFO - PROCESS | 610 | _x_x_mozilla_page_load_details 16:10:33 INFO - PROCESS | 610 | |i|pagename|runs| 16:10:33 INFO - PROCESS | 610 | |0;dojo.html;2603.479304139172;2652.6153707712383;2662.094887738169;2671.252049426161;2678.624992501049;4642.32686260492;4722.102800467908;4743.264793956938;4820.445648750386;4866.756662166895;4700.083483720668;4800.231962885939;4807.783649735761;4830.686005409646;4915.188993816016;4356.9564304356945;4395.692301538894;4446.444194475691;4515.706479078865;4561.201789686808;4469.982761635899;4494.910101797962;4514.074614703978;4522.660800439964;4564.224081906067;4339.913201735979;4471.262241730111;4491.483479399878;4521.547845215485;4535.138323718499;4369.650427965755;4372.693911426201;4383.517813040563;4388.605025547684;4428.955710442919;4375.25620644488;4416.1167766446515;4416.2713152329825;4417.624501917341;4456.22016147173;4768.3085952536685;4775.761211939423;4780.091782561337;4780.7609619519235;4790.640701947333;5199;5216.347956505437;5216.400113986902;5219.164933610604;5253.553447956928;5234.685918844882;5235.581153507748;5237.921431178535;5259.76331065103;5264.92102618461;4671.089137618166;4765.11845308619;4823.758812059383;4827.8551643450755;4885.682430642032;5315.415304316522;5337.119375303031;5339.759710813023;5354.8661283467445;5355.598330125256;5122.1804511278015;5141.228815677603;5141.820036298786;5146.0479811235045;5186.559142472856;4997.500249975046;5159.200323949719;5183.688978661293;5194.6104042196985;5214.504622060898;5028.195488721787;5080.77136528857;5081.974590127025;5152.845414637567;5171.974140129275;5123.7438128093445;5129.076766182123;5130.358705161855;5139.460356662571;5185.455527169593;4305.289627211538;4353.956460435418;4391.692581519327;4396;4404.07514421975;3817.751846129993;3829.215010922754;3834.1564855731694;3867.3812190049457;3870;4370.584794444522;4463.866084017484;4467.441569803775;4485.798139083749;4503.437070366204;5048.974755126201;5078.771455284521;5099.541041306226;5104.770285337168;5123.2827404163445;4379.1022840317655;4381.298992161239;4401.6478681705385;4416.889577760582;4430.202563538594;4573.428321459817;4574.268117101248;4577.290519969343;4591.334256532784;4608.815647374135;4787.808487660454;4800.207965685623;4814.109389762905;4819.373481447389;4870.050340183701;5154.201098829687;5158.200478925773;5165.147750621106;5166.8966620668125;5206.609504287269;4745.0509898019845;4792.520747925179;4817.325574419514;4855.150348689036;4885.291632713308;5098.847034588968;5105.795768169381;5113.41195762492;5118.206677964921;5156.793728250828;5180.093483640272;5189.636725429184;5194.506521880416;5200.817971371135;5220.399654039682;4879.243717223836;4970.204767237225;5002.374703162105;5032.84901452957;5035.370578677665;4890.779914903766;4905.5094490550655;4918.458969513422;4941.258811178208;4983.451820299837;4808.2787581863;4912.066707325596;4920.261960705922;4921.311016457627;4926.039422312615;4956.207006878882;4994.725290108933;5009.123403404316;5036.6726162799305;5060.443351231435;4923.655344125877;4962.5533701967;4965.354503914468;4970.826021089245;5022.372203474566 16:10:33 INFO - PROCESS | 610 | |1;ext.html;539.3862322144107;564.8249042796733;579.189135210705;601.3445344574413;603.8007457539013;32676.183095422628;37088;37144;37168.62831371686;37306.81346593267;37325.62674373255;37827;38047.809760951226;38065.8096709516;38249.42625860607;7839.0985036720795;7874.173211812763;7898.80252993674;7931.206879312052;7954.562499062549;7888.1323054463965;7896.881546776803;7940.642671079815;7954.443188976774;7978.760637180894;7941.245581669761;7973.720919767809;8007.599620019005;8008.319292860085;8024.839503209932;7920.841583168333;7965.681372745113;7975.641096150687;7987.081485629169;7999.920000800005;7736.34241089508;7791.10402303731;7840.4511684182135;7843.7254696085365;7872.724454644117;29009.56485652717;35990;36025.639743602755;36529.26941461156;36639.450408243894;2916.7229113234207;3146.5122905949383;3155.826429546374;3281.261716113879;3341.3150304187584;26581.867090664422;28849.71150288491;28971.71028289711;29181.56227656587;30032;3241.6596257393107;3310.453775127125;3314.834258287076;3347.313800670857;3397.490376443553;256900;260739;262032;262573.687131565;263848;32578.674213258037;33534.329313414084;33744.66255337415;51148.23277650838;51891;34401.483977740354;34413.65586344105;34432.82783586066;34628.826855866064;34712;13332.5333613325;13477.460901564024;13578.321083945762;13579.728405431835;13580.660483487993;10512.264141510173;10616.150707943347;10674.73313167177;10682.73293167677;10720.678379648623;7977.880331795028;7988.440809143421;7998.48009879356;8046.155153708776;8091.757247282591;3233.110894503983;3267.591551056118;3303.6035675719068;3322.900312990614;3338;885.2652298592153;914.9862752058724;922.8556589828564;945.3902233059638;961.8076384723083;27474;27824.582631260546;27958.3010424741;28005.15984520468;28302.71697283042;961.2598299309632;981.6269817469458;1002.0830939690102;1007.7228762090484;1014.9543270552842;14448.638784030483;14641.414343426357;14774.704505909822;14783.926080369529;15119.54641360761;383882;388600;388728;388965;390832;47660.28509572359;48461.75769121202;48585.27122093172;48619.27071093937;48732;1159.918805683611;1162.8023236049892;1169.128998895811;1189.0012389592785;1204.0668481926402;25554.616680750176;26809.731902681502;26910.461790764468;27269.45461090807;27638.3090422733;42039.36940945827;42321.365179521716;42943.35584966165;42965;43009.784951075046;325464;326155;326352;327410;327765;24034.11590609138;25446.363840904127;25888.482230355665;26011.739882601687;26053.869730651226;41497.58502415058;41579.792101039304;41765.37351939663;41884.79057604692;42304;35948.64051359453;36208.275834482636;36218.4567231497;36219.63780362163;36375.45436818503;35055.47416788699;35161.47257791084;35180.47229291512;35262.47106293459;35437.64562354344;34757.13107172341;34835;35184.29631407409;35380.82309588538;36053.63946360608;32162.19594510156;33292.167695807795;33788.662113379534;33800.323993520484;34246.828765856015;24832.751672483766;25180.622290666022;25257.422773167607;25444.363890902874;25635.23094307099 16:10:33 INFO - PROCESS | 610 | |2;jquery.html;365.9140102076012;366.55646667532284;367.6195138032136;377.475309320045;379.12800558714946;15853.286602102904;16396.59008524786;17112.229949652265;17137.657246855055;17161.313547458103;15703.293351799168;16369.263383147758;16897.91551042243;17002.48992530226;17023;4908.631852611051;5078.59371250301;5101.617378696594;5103.438621751604;5113.872153196163;3648.908777280563;4985.850424487253;5586.10622300432;5947;5947.167396564484;5897.764089436418;5922.792702255422;5950.821475355746;5986.970065149668;6009.909851352233;5832.883342333151;5957.553183511232;5958.731857066442;5977.043673012297;5977.85055373617;4580.175568397687;5074.720890351029;5254.21186821976;5266;5268.736563171826;11637.592684256011;11729.12031597625;11750.941245293805;11805.763884722342;11887.583934562335;1750.9989673595899;1871.7566716326926;1910.8853468791779;1916.7029110487897;1975.861689681723;8254;8805.295576353941;8942.508162051085;9076.727698169065;9196.310276729206;1716.7596536484778;1728.4037007232484;1728.4814555633386;1753.3775509694003;1809.4390738870861;66276;66510.66744666245;69621.3037869625;70031.64984175097;70102.29897701059;9653.1794797443;9664.56509457062;9668.903310966942;9722.319437639297;9735.70792876215;12672.429740661692;12757.744845103047;12812.679683007813;12843;12854.485820567259;6651.73393064272;6712;6778.084958530535;6803.693833777492;6833.931660683429;6373;6414;6427.485801135898;6466.288708242089;6511.576747511492;3882.378819388884;4045.2314060328445;4097.774622395737;4109;4110.23960567296;1672.1973452742752;1675.5057258108886;1752.3428714232164;1771.2914834066219;1795.5256578520605;857.7726902370877;869.9908106596317;889.1419779912416;911.5260064766285;943.7216021273741;16242.269097890623;16477.34090636361;16713.83286167147;16872.83127168737;16913.492595222164;856.9957150214209;880.4937161132375;907.0340087806464;919.3748251189255;938.8826396700413;8988.842677757291;9485.715428537154;9570.425774453555;9625.807483850283;9713.611455541699;377014;377077;378996;380107;382492;74343.62828185824;75360;75748.62125689337;75767;76229.23770762332;872.4808738800403;887.9200871921429;889.5818965086528;894.6466145872344;903.5211337990876;14991.925040374728;15085.39658413695;15346;15419.306131223897;15457.84542154609;35212.29575408529;35496.290074198885;35985.640143599274;36069.63930360768;36397.636023639425;50147.74926125492;50440.495595045046;50833.49166508435;51846.48153518417;51996;7379;7403.259674032553;7447.441441891771;7501.32488076054;7511.32398084175;10953.56185752561;11137;11175.832362514731;11182.832257516306;11359.772804544029;4479.731216127043;9328.673496427593;9379.906200938176;9418.10527999839;9624.085711857362;10047.698569042941;10159.898401015895;10160.898391016291;10205.74485637865;10221;9556.56995435221;9614.71155865325;9828.512417210255;9843.310968232156;10071.496425178566;7042.401395881203;7325.633718313957;7387.372073373824;7606.467547271638;7633.88549171774;8443.324534037385;9376;9435.669751558662;9590.616375344907;9659.71020869375 16:10:33 INFO - PROCESS | 610 | |3;mootools.html;1380.9861901380987;1392.0534036854935;1490.970180596388;1626.235669235459;1669.8330166983296;6578.539502234834;7144.892826607598;7338.3395494405495;7750.224977502247;7751.108622508414;7353.154387245469;7611.885821712679;7634;7705.73029943952;7714.575698336589;2149.301477019967;2191.7698641642637;2194.2539536557647;2195.0232146694725;2195.2536137713173;2136.7970042845905;2173.7826217378292;2186.8250539956766;2192.550527141932;2200.119952019197;2102.211670623516;2103.842211834111;2116.0477784996738;2119.2158901206576;2157.2880949286778;2098.08733201058;2101.485136141647;2111.2505060703384;2113.218109299561;2115.9788402115937;2097.171617211193;2154.53677459347;2159.6544552871624;2160.319499357697;2169.5227050048966;7681.3470854977395;7700.422468314899;7735.419843511703;7763.767086987399;7792;4478.8432404866;4611.331356953223;4618.9076218475775;4625.560571745679;4636.02643444877;2711.2137480130937;2809.452156829419;2823.2659508527727;2825.9717402825913;2830.4763618730394;852.9530875801828;859.7715578004616;898.3711402018613;905.7373361725092;909.6452383570413;10041.849372259348;10054.396736195778;10082.798344033079;10116.696499105039;10149.695509134664;4069.5116586009867;4093.7953102344763;4138.6482149017065;4190;4195.622393984556;8578.399512034097;8737.825243495094;8774.824503509893;8793.428427152343;8843.425177363451;4604.424446944132;4621.792019359137;4630.236011058205;4633.235516139866;4643.117807616542;3676.227992121631;3978.244133614604;4010.057636455431;4126.711130220916;4222.134462435255;3543.486194501783;3623.130448692295;3668.4313931340685;3704.148045949393;3717.9256414872093;1167.1829719196426;1169.923954942926;1214.3503225774168;1219.439058033297;1222.712662524306;677.2211956250352;774.8686917100983;781.7068599275271;810.2343285595056;819.5697258938985;4748.738819364969;4920.237363208708;4926.802927882844;4990.825321113816;4991.401031876126;390.9452676625275;394.0149625935162;404.4701441112094;406.6990427083996;422.2800125785528;3203.6636153204045;3313.1385839681375;3326.2982669956436;3353.5808023997;3358.529805827186;8925.285977121815;9139.63441462334;9281.767955801159;9296.907030929739;9349.813003739888;9227;9250.86123708145;9294.488803115759;9348.20540254086;9358.57886395114;7076.32774886385;7119.967604697394;7168.390686791577;7168.462365322622;7200.1719802223415;4723.102610503994;4857.95142048575;4864.440589332131;4889;4894.681845680019;8471.872921906053;8536.487810731376;8545.359098067545;8666.523341216294;8672.436291641276;8506.489610623383;8541.273991710526;8612.397132200937;8759.518226497348;8979.236764875059;5739.770409183753;6215.223097112861;6431.549791514549;6469;6529.575577587441;7269;7294.416446684359;7301.817454563678;7333.889991650236;7337.046183996046;6136.478399336106;6147.415995480422;6256.593321434092;6515.869682606227;6569.080328754074;6435.871282574416;6478.5141114415665;6523.24982626985;6545.639989800607;6635;5924.407559244213;5951.345352011189;5964.731587078505;5975.940240597713;5998.580099393001;4048.817803198804;4147.7718725469185;4149.066460046465;4255.106427650228;4262.786860656893;4110.568390319093;4153.335466325373;4155.750654960591;4231.28068228408;4237.512686041021 16:10:33 INFO - PROCESS | 610 | |4;prototype.html;288.46345796817917;288.8642338101092;294.19684261964824;294.41117764471056;295.8402462670158;5155.613329000331;5156;5158.845234642967;5182.393458028014;5197.272381866542;4998.925016124761;4999.825076091894;5001.374828146481;5006.924896126561;5065.822696205633;3696.611855755147;3818.217265460588;3925.2738243425056;3936.2127574485075;3947.1908258806875;3919.804009799513;3942.9605703943025;3955.3782948990774;3959.3370784270533;3961.148353104082;3902.434147048676;3912.315344814646;3953.4267531207956;3954.2091581683635;3964.464797252377;3871.490118853621;3904.3167445697172;3919.2945269851416;3961.108750531136;3968.464257325253;3425.2806910548566;3438.793672379665;3443.8622455101768;3447.120984149026;3451.8608859076444;4899.093667671492;4911.533404326583;4964.329815474901;4968.428630707443;4976.328195693607;4335.6965012449145;4469.1508613363685;4503.4145561077175;4509.7970591323465;4521.593056624886;5249.553787928031;5255.5795536357;5269.683818970836;5282.3925248596515;5325.3077099977145;3790.5451345838674;3793.2603142387247;3799.2781371539595;3810.333191691471;3820.102275965146;5394.73026348681;5595.300587426572;5621.8594535136535;5631;5635.295588051494;3843.26977874203;3844.3272427325105;3856.8457261709777;3857.4406711026745;3880.6119388061534;3876.4572959785087;3912.5109361329833;3917.4319723639915;3918.5885482024546;3921.2941670499013;4429.604674527513;4457.465104187519;4481.983107601593;4509.436320459942;4522.191123550606;5093.465186155475;5248.740302327414;5293.253226435344;5315.202719592015;5356.517913387814;1330.7937269723209;1347.723716638087;1359.7552440560596;1360.1838896661923;1361.3805718398303;854.1714536899198;856.6188046319328;860.8579584368634;889.6708217959267;891.2958762577491;4511.481179664381;4619.838305659286;4648.163330600524;4674.345591617176;4704.082703872712;5436.565074794086;5501.532369748536;5522.972385138129;5524.226608274845;5555.8888822224135;4406.184855801687;4563.383943167696;4663.836765713251;4666.580007799246;4701.929471057937;2904.7676185905075;2936.251255929767;2946;2948.6903875092808;2962.2150130215077;5148.2277658350795;5152.252923326097;5166.405863325691;5172.948270517322;5181.35233095863;5316.787328506816;5597.496225339658;5599.524040456526;5604.355499117572;5628.296462942132;5075.3402057732255;5095.31213286209;5106.591472682177;5118.411382690963;5158.948410515997;5413.729313534229;5460.341571147262;5478.506934375766;5483.75323110453;5488.9725551373585;5104.948950510596;5385.434529374516;5404.243405923253;5408.621396502207;5420.159875219189;5141.614378921521;5154.407243167084;5169;5181.404138524118;5212.348456442945;3869.5163104611925;3880.262750077476;3881.359575669983;3887.747296425723;3904.39481880309;5235.633505654568;5482.725863706878;5537.169424586184;5566.721663916707;5609.32688077417;5360.3299587551555;5368.845698174911;5382.30030096085;5393.27190829233;5410.83767486976;5127.79488820443;5328.254044433705;5328.6802791832615;5329.946700532945;5339.813106541408;5241.371035475768;5258.500442458113;5262.710550919583;5279.815206467755;5286.62993590445;5129.512696293846;5243.921341179962;5344.759485823225;5349.234752531733;5355.892882142258;5219.2953951216095;5243.430718947612;5249.816256431007;5262.815801446931;5272.815451459181 16:10:33 INFO - PROCESS | 610 | |5;yui.html;633.4204203154113;642.3736856564847;665.5474277491307;671.6473851228104;727.2400341642982;12722;13210.471581136742;13304.334783260834;13341.266230357327;13356.933215333935;12599.622011339652;13011.219326840395;13061.085723999324;13099.869001310008;13100.803487947689;622.3620788691604;769.5421224371504;784.9873662974755;787.7164220880478;790.6125998260868;767.9001729775122;789.4828887078972;793.3811626931004;795.1412474527497;796.3788245168778;831.7380025292044;833.6582001379436;834.4200780457585;835.2941764209233;839.1063517353998;816.073756286616;825.2737590920012;826.4421515477059;828.1883753921161;829.2868133405267;604.9213602231682;605.2102006881018;606.0364021206303;607.2257871214193;607.8966575682144;13395.86604133956;13402.664933376645;13439.193648381031;13449;13459.057865949388;13023.34883255843;13349.666258343523;13494.52769153075;13558.186508809504;13780.862191378159;10584.68245952615;10626.893731062668;10796.514156862882;10855.565777368896;10986.285891417032;3408.233147541808;3453.6546345365514;3456.6197718250974;3466.7053300469493;3534.469829525566;60095.69952150255;60812;61889.38110618881;61913.046956243394;62205.37794622041;10615.150787936947;10640.989106034915;10648.467576621139;10658.840117398246;10724.946375268073;19368.515787105436;19410.70883936742;19445.805541944683;19504;19523.804761952484;7062.081929349151;7139.071920650283;7182.748603798842;7218.061651985208;7229.2409297024105;3827.770333779982;3870.903227419337;4028.959710402917;4030.1335212928775;4088.34586466164;2902.622659054309;3027.04648035868;3030.9393812123635;3033.059751477005;3033.3781574777117;484.85939077667786;492.32059757535086;493.622378880157;499.840051183625;500.3470471035261;533.2028617217285;599.5353600959291;611.8164550634792;626.3204423200787;629.2731894661673;7936.365090792723;7963.8805417918775;7978.760637180894;8049.919500805034;8130.918690813016;538.2667809652911;620.5066971757464;621.3103455164763;624.2664868779166;625.9248890133122;3864.3430616795213;3932.5477570079806;3944.6449819515806;3973.662238709684;4089.9182016359505;52300.21549676758;53205;53247.20129197988;88026.55986720153;89592.5520372407;76784.23215767882;83655.58172209222;84353.57823210844;84488;85735;70152.6492367535;73150.26849731541;75037;76378.23621763711;76690;7103.9289607103265;7517.210692877388;7578.848423031398;7699.384049275933;7779.494332868572;43311.35032974445;44476.55523444724;44741;45078;45172.77413612911;37867.242655147296;40033.199336012534;59206.703966479894;63318.36681633125;63489.68255158695;9714.174295184706;10005.54975026111;10040.246981476272;10333.121684656588;10495.47522623881;10767.3539587625;10819.837702434312;10828.404437755999;10862.891371086187;10933.289336193122;10645.680629581126;10688.786224275316;10739.119875896231;10759.784804304027;10945.945270273916;10081.596736130472;10116.443595602312;10285.640002599874;10295.742606434898;10301.896981030393;8604.268637165911;8990.730278091667;9695.418274903528;9958.352707074017;9967.900320996987;8280.337572994267;8339.66641334364;8342.749717508485;8363.790905227417;8367.790805229917;8649.221570058726;8841.69054083104;8851.20906976968;9037;9040.042139158588 16:10:33 INFO - PROCESS | 610 | __end_tp_report 16:10:33 INFO - PROCESS | 610 | __start_cc_report 16:10:33 INFO - PROCESS | 610 | _x_x_mozilla_cycle_collect,393 16:10:33 INFO - PROCESS | 610 | __end_cc_report 16:10:33 INFO - PROCESS | 610 | __startTimestamp1466032233687__endTimestamp 16:10:33 INFO - PROCESS | 610 | 16:10:33 INFO - PROCESS | 610 | ------- Summary: start ------- 16:10:33 INFO - PROCESS | 610 | Number of tests: 6 16:10:33 INFO - PROCESS | 610 | 16:10:33 INFO - PROCESS | 610 | [#0] dojo.html Cycles:165 Average:4759.27 Median:4870.05 stddev:505.87 (10.4%) stddev-sans-first:478.32 16:10:33 INFO - PROCESS | 610 | Values: 2603.5 2652.6 2662.1 2671.3 2678.6 4642.3 4722.1 4743.3 4820.4 4866.8 4700.1 4800.2 4807.8 4830.7 4915.2 4357.0 4395.7 4446.4 4515.7 4561.2 4470.0 4494.9 4514.1 4522.7 4564.2 4339.9 4471.3 4491.5 4521.5 4535.1 4369.7 4372.7 4383.5 4388.6 4429.0 4375.3 4416.1 4416.3 4417.6 4456.2 4768.3 4775.8 4780.1 4780.8 4790.6 5199.0 5216.3 5216.4 5219.2 5253.6 5234.7 5235.6 5237.9 5259.8 5264.9 4671.1 4765.1 4823.8 4827.9 4885.7 5315.4 5337.1 5339.8 5354.9 5355.6 5122.2 5141.2 5141.8 5146.0 5186.6 4997.5 5159.2 5183.7 5194.6 5214.5 5028.2 5080.8 5082.0 5152.8 5172.0 5123.7 5129.1 5130.4 5139.5 5185.5 4305.3 4354.0 4391.7 4396.0 4404.1 3817.8 3829.2 3834.2 3867.4 3870.0 4370.6 4463.9 4467.4 4485.8 4503.4 5049.0 5078.8 5099.5 5104.8 5123.3 4379.1 4381.3 4401.6 4416.9 4430.2 4573.4 4574.3 4577.3 4591.3 4608.8 4787.8 4800.2 4814.1 4819.4 4870.1 5154.2 5158.2 5165.1 5166.9 5206.6 4745.1 4792.5 4817.3 4855.2 4885.3 5098.8 5105.8 5113.4 5118.2 5156.8 5180.1 5189.6 5194.5 5200.8 5220.4 4879.2 4970.2 5002.4 5032.8 5035.4 4890.8 4905.5 4918.5 4941.3 4983.5 4808.3 4912.1 4920.3 4921.3 4926.0 4956.2 4994.7 5009.1 5036.7 5060.4 4923.7 4962.6 4965.4 4970.8 5022.4 16:10:33 INFO - PROCESS | 610 | 16:10:33 INFO - PROCESS | 610 | [#1] ext.html Cycles:180 Average:46315.97 Median:35108.47 stddev:86951.85 (247.7%) stddev-sans-first:87127.85 16:10:33 INFO - PROCESS | 610 | Values: 539.4 564.8 579.2 601.3 603.8 32676.2 37088.0 37144.0 37168.6 37306.8 37325.6 37827.0 38047.8 38065.8 38249.4 7839.1 7874.2 7898.8 7931.2 7954.6 7888.1 7896.9 7940.6 7954.4 7978.8 7941.2 7973.7 8007.6 8008.3 8024.8 7920.8 7965.7 7975.6 7987.1 7999.9 7736.3 7791.1 7840.5 7843.7 7872.7 29009.6 35990.0 36025.6 36529.3 36639.5 2916.7 3146.5 3155.8 3281.3 3341.3 26581.9 28849.7 28971.7 29181.6 30032.0 3241.7 3310.5 3314.8 3347.3 3397.5 256900.0 260739.0 262032.0 262573.7 263848.0 32578.7 33534.3 33744.7 51148.2 51891.0 34401.5 34413.7 34432.8 34628.8 34712.0 13332.5 13477.5 13578.3 13579.7 13580.7 10512.3 10616.2 10674.7 10682.7 10720.7 7977.9 7988.4 7998.5 8046.2 8091.8 3233.1 3267.6 3303.6 3322.9 3338.0 885.3 915.0 922.9 945.4 961.8 27474.0 27824.6 27958.3 28005.2 28302.7 961.3 981.6 1002.1 1007.7 1015.0 14448.6 14641.4 14774.7 14783.9 15119.5 383882.0 388600.0 388728.0 388965.0 390832.0 47660.3 48461.8 48585.3 48619.3 48732.0 1159.9 1162.8 1169.1 1189.0 1204.1 25554.6 26809.7 26910.5 27269.5 27638.3 42039.4 42321.4 42943.4 42965.0 43009.8 325464.0 326155.0 326352.0 327410.0 327765.0 24034.1 25446.4 25888.5 26011.7 26053.9 41497.6 41579.8 41765.4 41884.8 42304.0 35948.6 36208.3 36218.5 36219.6 36375.5 35055.5 35161.5 35180.5 35262.5 35437.6 34757.1 34835.0 35184.3 35380.8 36053.6 32162.2 33292.2 33788.7 33800.3 34246.8 24832.8 25180.6 25257.4 25444.4 25635.2 16:10:33 INFO - PROCESS | 610 | 16:10:33 INFO - PROCESS | 610 | [#2] jquery.html Cycles:180 Average:23457.17 Median:28625.11 stddev:62695.33 (219.0%) stddev-sans-first:62847.24 16:10:33 INFO - PROCESS | 610 | Values: 365.9 366.6 367.6 377.5 379.1 15853.3 16396.6 17112.2 17137.7 17161.3 15703.3 16369.3 16897.9 17002.5 17023.0 4908.6 5078.6 5101.6 5103.4 5113.9 3648.9 4985.9 5586.1 5947.0 5947.2 5897.8 5922.8 5950.8 5987.0 6009.9 5832.9 5957.6 5958.7 5977.0 5977.9 4580.2 5074.7 5254.2 5266.0 5268.7 11637.6 11729.1 11750.9 11805.8 11887.6 1751.0 1871.8 1910.9 1916.7 1975.9 8254.0 8805.3 8942.5 9076.7 9196.3 1716.8 1728.4 1728.5 1753.4 1809.4 66276.0 66510.7 69621.3 70031.6 70102.3 9653.2 9664.6 9668.9 9722.3 9735.7 12672.4 12757.7 12812.7 12843.0 12854.5 6651.7 6712.0 6778.1 6803.7 6833.9 6373.0 6414.0 6427.5 6466.3 6511.6 3882.4 4045.2 4097.8 4109.0 4110.2 1672.2 1675.5 1752.3 1771.3 1795.5 857.8 870.0 889.1 911.5 943.7 16242.3 16477.3 16713.8 16872.8 16913.5 857.0 880.5 907.0 919.4 938.9 8988.8 9485.7 9570.4 9625.8 9713.6 377014.0 377077.0 378996.0 380107.0 382492.0 74343.6 75360.0 75748.6 75767.0 76229.2 872.5 887.9 889.6 894.6 903.5 14991.9 15085.4 15346.0 15419.3 15457.8 35212.3 35496.3 35985.6 36069.6 36397.6 50147.7 50440.5 50833.5 51846.5 51996.0 7379.0 7403.3 7447.4 7501.3 7511.3 10953.6 11137.0 11175.8 11182.8 11359.8 4479.7 9328.7 9379.9 9418.1 9624.1 10047.7 10159.9 10160.9 10205.7 10221.0 9556.6 9614.7 9828.5 9843.3 10071.5 7042.4 7325.6 7387.4 7606.5 7633.9 8443.3 9376.0 9435.7 9590.6 9659.7 16:10:33 INFO - PROCESS | 610 | 16:10:33 INFO - PROCESS | 610 | [#3] mootools.html Cycles:180 Average:4931.33 Median:4735.92 stddev:2771.69 (58.5%) stddev-sans-first:2766.62 16:10:33 INFO - PROCESS | 610 | Values: 1381.0 1392.1 1491.0 1626.2 1669.8 6578.5 7144.9 7338.3 7750.2 7751.1 7353.2 7611.9 7634.0 7705.7 7714.6 2149.3 2191.8 2194.3 2195.0 2195.3 2136.8 2173.8 2186.8 2192.6 2200.1 2102.2 2103.8 2116.0 2119.2 2157.3 2098.1 2101.5 2111.3 2113.2 2116.0 2097.2 2154.5 2159.7 2160.3 2169.5 7681.3 7700.4 7735.4 7763.8 7792.0 4478.8 4611.3 4618.9 4625.6 4636.0 2711.2 2809.5 2823.3 2826.0 2830.5 853.0 859.8 898.4 905.7 909.6 10041.8 10054.4 10082.8 10116.7 10149.7 4069.5 4093.8 4138.6 4190.0 4195.6 8578.4 8737.8 8774.8 8793.4 8843.4 4604.4 4621.8 4630.2 4633.2 4643.1 3676.2 3978.2 4010.1 4126.7 4222.1 3543.5 3623.1 3668.4 3704.1 3717.9 1167.2 1169.9 1214.4 1219.4 1222.7 677.2 774.9 781.7 810.2 819.6 4748.7 4920.2 4926.8 4990.8 4991.4 390.9 394.0 404.5 406.7 422.3 3203.7 3313.1 3326.3 3353.6 3358.5 8925.3 9139.6 9281.8 9296.9 9349.8 9227.0 9250.9 9294.5 9348.2 9358.6 7076.3 7120.0 7168.4 7168.5 7200.2 4723.1 4858.0 4864.4 4889.0 4894.7 8471.9 8536.5 8545.4 8666.5 8672.4 8506.5 8541.3 8612.4 8759.5 8979.2 5739.8 6215.2 6431.5 6469.0 6529.6 7269.0 7294.4 7301.8 7333.9 7337.0 6136.5 6147.4 6256.6 6515.9 6569.1 6435.9 6478.5 6523.2 6545.6 6635.0 5924.4 5951.3 5964.7 5975.9 5998.6 4048.8 4147.8 4149.1 4255.1 4262.8 4110.6 4153.3 4155.8 4231.3 4237.5 16:10:33 INFO - PROCESS | 610 | 16:10:33 INFO - PROCESS | 610 | [#4] prototype.html Cycles:180 Average:4408.90 Median:5084.40 stddev:1290.24 (25.4%) stddev-sans-first:1256.24 16:10:33 INFO - PROCESS | 610 | Values: 288.5 288.9 294.2 294.4 295.8 5155.6 5156.0 5158.8 5182.4 5197.3 4998.9 4999.8 5001.4 5006.9 5065.8 3696.6 3818.2 3925.3 3936.2 3947.2 3919.8 3943.0 3955.4 3959.3 3961.1 3902.4 3912.3 3953.4 3954.2 3964.5 3871.5 3904.3 3919.3 3961.1 3968.5 3425.3 3438.8 3443.9 3447.1 3451.9 4899.1 4911.5 4964.3 4968.4 4976.3 4335.7 4469.2 4503.4 4509.8 4521.6 5249.6 5255.6 5269.7 5282.4 5325.3 3790.5 3793.3 3799.3 3810.3 3820.1 5394.7 5595.3 5621.9 5631.0 5635.3 3843.3 3844.3 3856.8 3857.4 3880.6 3876.5 3912.5 3917.4 3918.6 3921.3 4429.6 4457.5 4482.0 4509.4 4522.2 5093.5 5248.7 5293.3 5315.2 5356.5 1330.8 1347.7 1359.8 1360.2 1361.4 854.2 856.6 860.9 889.7 891.3 4511.5 4619.8 4648.2 4674.3 4704.1 5436.6 5501.5 5523.0 5524.2 5555.9 4406.2 4563.4 4663.8 4666.6 4701.9 2904.8 2936.3 2946.0 2948.7 2962.2 5148.2 5152.3 5166.4 5172.9 5181.4 5316.8 5597.5 5599.5 5604.4 5628.3 5075.3 5095.3 5106.6 5118.4 5158.9 5413.7 5460.3 5478.5 5483.8 5489.0 5104.9 5385.4 5404.2 5408.6 5420.2 5141.6 5154.4 5169.0 5181.4 5212.3 3869.5 3880.3 3881.4 3887.7 3904.4 5235.6 5482.7 5537.2 5566.7 5609.3 5360.3 5368.8 5382.3 5393.3 5410.8 5127.8 5328.3 5328.7 5329.9 5339.8 5241.4 5258.5 5262.7 5279.8 5286.6 5129.5 5243.9 5344.8 5349.2 5355.9 5219.3 5243.4 5249.8 5262.8 5272.8 16:10:33 INFO - PROCESS | 610 | 16:10:33 INFO - PROCESS | 610 | [#5] yui.html Cycles:180 Average:16363.26 Median:29872.49 stddev:22737.67 (76.1%) stddev-sans-first:22770.77 16:10:33 INFO - PROCESS | 610 | Values: 633.4 642.4 665.5 671.6 727.2 12722.0 13210.5 13304.3 13341.3 13356.9 12599.6 13011.2 13061.1 13099.9 13100.8 622.4 769.5 785.0 787.7 790.6 767.9 789.5 793.4 795.1 796.4 831.7 833.7 834.4 835.3 839.1 816.1 825.3 826.4 828.2 829.3 604.9 605.2 606.0 607.2 607.9 13395.9 13402.7 13439.2 13449.0 13459.1 13023.3 13349.7 13494.5 13558.2 13780.9 10584.7 10626.9 10796.5 10855.6 10986.3 3408.2 3453.7 3456.6 3466.7 3534.5 60095.7 60812.0 61889.4 61913.0 62205.4 10615.2 10641.0 10648.5 10658.8 10724.9 19368.5 19410.7 19445.8 19504.0 19523.8 7062.1 7139.1 7182.7 7218.1 7229.2 3827.8 3870.9 4029.0 4030.1 4088.3 2902.6 3027.0 3030.9 3033.1 3033.4 484.9 492.3 493.6 499.8 500.3 533.2 599.5 611.8 626.3 629.3 7936.4 7963.9 7978.8 8049.9 8130.9 538.3 620.5 621.3 624.3 625.9 3864.3 3932.5 3944.6 3973.7 4089.9 52300.2 53205.0 53247.2 88026.6 89592.6 76784.2 83655.6 84353.6 84488.0 85735.0 70152.6 73150.3 75037.0 76378.2 76690.0 7103.9 7517.2 7578.8 7699.4 7779.5 43311.4 44476.6 44741.0 45078.0 45172.8 37867.2 40033.2 59206.7 63318.4 63489.7 9714.2 10005.5 10040.2 10333.1 10495.5 10767.4 10819.8 10828.4 10862.9 10933.3 10645.7 10688.8 10739.1 10759.8 10945.9 10081.6 10116.4 10285.6 10295.7 10301.9 8604.3 8990.7 9695.4 9958.4 9967.9 8280.3 8339.7 8342.7 8363.8 8367.8 8649.2 8841.7 8851.2 9037.0 9040.0 16:10:33 INFO - PROCESS | 610 | -------- Summary: end -------- 16:10:33 INFO - PROCESS | 610 | 16:10:34 INFO - TEST-INFO | 610: exit 0 16:10:34 INFO - TEST-OK | dromaeo_css | took 1116567ms 16:10:34 INFO - TEST-START | kraken 16:10:34 INFO - operating with platform_type : linux_ 16:10:34 INFO - Initialising browser for kraken test... 16:10:34 INFO - TEST-INFO | started process 857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGKJsfu/profile http://localhost:42254/getInfo.html) 16:10:39 INFO - PROCESS | 857 | __metrics Screen width/height:1600/1200 16:10:39 INFO - PROCESS | 857 | colorDepth:24 16:10:39 INFO - PROCESS | 857 | Browser inner width/height: 1024/697 16:10:39 INFO - PROCESS | 857 | __metrics 16:10:39 ERROR - PROCESS | 857 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 16:10:40 INFO - TEST-INFO | 857: exit 0 16:10:40 INFO - Browser initialized. 16:10:40 INFO - Running cycle 1/1 for kraken test... 16:10:40 INFO - TEST-INFO | started process 978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGKJsfu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:52 INFO - PROCESS | 978 | RSS: Main: 185995264 16:10:52 INFO - PROCESS | 978 | 16:10:55 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:42254/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42254/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:56 INFO - PROCESS | 978 | RSS: Main: 190492672 16:10:56 INFO - PROCESS | 978 | 16:10:59 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:42254/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42254/tests/kraken/driver.html?testName=audio-dft) 16:10:59 INFO - PROCESS | 978 | RSS: Main: 190660608 16:10:59 INFO - PROCESS | 978 | 16:11:02 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:42254/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42254/tests/kraken/driver.html?testName=audio-fft) 16:11:03 INFO - PROCESS | 978 | RSS: Main: 186449920 16:11:03 INFO - PROCESS | 978 | 16:11:05 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:42254/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42254/tests/kraken/driver.html?testName=audio-oscillator) 16:11:06 INFO - PROCESS | 978 | RSS: Main: 186757120 16:11:06 INFO - PROCESS | 978 | 16:11:08 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:42254/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42254/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:11:09 INFO - PROCESS | 978 | RSS: Main: 187207680 16:11:09 INFO - PROCESS | 978 | 16:11:12 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:42254/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42254/tests/kraken/driver.html?testName=imaging-darkroom) 16:11:13 INFO - PROCESS | 978 | RSS: Main: 187092992 16:11:13 INFO - PROCESS | 978 | 16:11:16 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:42254/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42254/tests/kraken/driver.html?testName=imaging-desaturate) 16:11:17 INFO - PROCESS | 978 | RSS: Main: 184356864 16:11:17 INFO - PROCESS | 978 | 16:11:20 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:42254/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42254/tests/kraken/driver.html?testName=json-parse-financial) 16:11:20 INFO - PROCESS | 978 | RSS: Main: 185454592 16:11:20 INFO - PROCESS | 978 | 16:11:22 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:42254/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42254/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:23 INFO - PROCESS | 978 | RSS: Main: 186322944 16:11:23 INFO - PROCESS | 978 | 16:11:24 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:42254/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42254/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:25 INFO - PROCESS | 978 | RSS: Main: 186880000 16:11:25 INFO - PROCESS | 978 | 16:11:27 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:42254/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42254/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:28 INFO - PROCESS | 978 | RSS: Main: 187080704 16:11:28 INFO - PROCESS | 978 | 16:11:31 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:42254/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:31 INFO - PROCESS | 978 | RSS: Main: 187478016 16:11:31 INFO - PROCESS | 978 | 16:11:34 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:42254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:35 INFO - PROCESS | 978 | RSS: Main: 187109376 16:11:35 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | Cycle 1(1): loaded http://localhost:42254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42254/tests/kraken/driver.html?testName=ai-astar) 16:11:37 INFO - PROCESS | 978 | RSS: Main: 188223488 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | __start_tp_report 16:11:37 INFO - PROCESS | 978 | _x_x_mozilla_page_load 16:11:37 INFO - PROCESS | 978 | _x_x_mozilla_page_load_details 16:11:37 INFO - PROCESS | 978 | |i|pagename|runs| 16:11:37 INFO - PROCESS | 978 | |0;ai-astar;115;110;114;114;116;115;113;115;115;113 16:11:37 INFO - PROCESS | 978 | |1;audio-beat-detection;161;136;160;190;140;160;153;135;197;135 16:11:37 INFO - PROCESS | 978 | |2;audio-dft;164;168;172;164;163;162;165;165;164;163 16:11:37 INFO - PROCESS | 978 | |3;audio-fft;77;77;78;170;77;80;76;76;181;77 16:11:37 INFO - PROCESS | 978 | |4;audio-oscillator;87;86;148;88;88;88;127;86;86;154 16:11:37 INFO - PROCESS | 978 | |5;imaging-gaussian-blur;119;119;118;118;118;117;120;119;118;118 16:11:37 INFO - PROCESS | 978 | |6;imaging-darkroom;147;148;148;148;147;158;148;147;148;148 16:11:37 INFO - PROCESS | 978 | |7;imaging-desaturate;95;95;96;95;95;96;95;97;97;97 16:11:37 INFO - PROCESS | 978 | |8;json-parse-financial;64;64;65;64;63;71;63;63;64;63 16:11:37 INFO - PROCESS | 978 | |9;json-stringify-tinderbox;64;65;65;65;65;65;65;64;66;65 16:11:37 INFO - PROCESS | 978 | |10;stanford-crypto-aes;84;83;89;87;86;84;85;85;110;83 16:11:37 INFO - PROCESS | 978 | |11;stanford-crypto-ccm;139;136;133;130;133;150;151;139;137;138 16:11:37 INFO - PROCESS | 978 | |12;stanford-crypto-pbkdf2;171;173;172;172;170;169;166;171;169;167 16:11:37 INFO - PROCESS | 978 | |13;stanford-crypto-sha256-iterative;70;69;70;68;68;68;71;66;67;67 16:11:37 INFO - PROCESS | 978 | __end_tp_report 16:11:37 INFO - PROCESS | 978 | __start_cc_report 16:11:37 INFO - PROCESS | 978 | _x_x_mozilla_cycle_collect,990 16:11:37 INFO - PROCESS | 978 | __end_cc_report 16:11:37 INFO - PROCESS | 978 | __startTimestamp1466032297522__endTimestamp 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | ------- Summary: start ------- 16:11:37 INFO - PROCESS | 978 | Number of tests: 14 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:1.70 (1.5%) stddev-sans-first:1.76 16:11:37 INFO - PROCESS | 978 | Values: 115.0 110.0 114.0 114.0 116.0 115.0 113.0 115.0 115.0 113.0 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | [#1] audio-beat-detection Cycles:10 Average:156.70 Median:160.00 stddev:22.20 (13.9%) stddev-sans-first:23.49 16:11:37 INFO - PROCESS | 978 | Values: 161.0 136.0 160.0 190.0 140.0 160.0 153.0 135.0 197.0 135.0 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:2.94 (1.8%) stddev-sans-first:3.10 16:11:37 INFO - PROCESS | 978 | Values: 164.0 168.0 172.0 164.0 163.0 162.0 165.0 165.0 164.0 163.0 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | [#3] audio-fft Cycles:10 Average:96.90 Median:77.00 stddev:41.52 (53.9%) stddev-sans-first:43.41 16:11:37 INFO - PROCESS | 978 | Values: 77.0 77.0 78.0 170.0 77.0 80.0 76.0 76.0 181.0 77.0 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:86.50 stddev:27.88 (32.2%) stddev-sans-first:28.90 16:11:37 INFO - PROCESS | 978 | Values: 87.0 86.0 148.0 88.0 88.0 88.0 127.0 86.0 86.0 154.0 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 16:11:37 INFO - PROCESS | 978 | Values: 119.0 119.0 118.0 118.0 118.0 117.0 120.0 119.0 118.0 118.0 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.00 stddev:3.30 (2.2%) stddev-sans-first:3.44 16:11:37 INFO - PROCESS | 978 | Values: 147.0 148.0 148.0 148.0 147.0 158.0 148.0 147.0 148.0 148.0 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 16:11:37 INFO - PROCESS | 978 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 95.0 97.0 97.0 97.0 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.00 stddev:2.41 (3.8%) stddev-sans-first:2.55 16:11:37 INFO - PROCESS | 978 | Values: 64.0 64.0 65.0 64.0 63.0 71.0 63.0 63.0 64.0 63.0 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 16:11:37 INFO - PROCESS | 978 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 66.0 65.0 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:85.00 stddev:8.09 (9.5%) stddev-sans-first:8.47 16:11:37 INFO - PROCESS | 978 | Values: 84.0 83.0 89.0 87.0 86.0 84.0 85.0 85.0 110.0 83.0 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:138.50 stddev:6.92 (5.0%) stddev-sans-first:7.33 16:11:37 INFO - PROCESS | 978 | Values: 139.0 136.0 133.0 130.0 133.0 150.0 151.0 139.0 137.0 138.0 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:171.00 stddev:2.26 (1.3%) stddev-sans-first:2.37 16:11:37 INFO - PROCESS | 978 | Values: 171.0 173.0 172.0 172.0 170.0 169.0 166.0 171.0 169.0 167.0 16:11:37 INFO - PROCESS | 978 | 16:11:37 INFO - PROCESS | 978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.58 (2.3%) stddev-sans-first:1.56 16:11:37 INFO - PROCESS | 978 | Values: 70.0 69.0 70.0 68.0 68.0 68.0 71.0 66.0 67.0 67.0 16:11:37 INFO - PROCESS | 978 | -------- Summary: end -------- 16:11:37 INFO - PROCESS | 978 | 16:11:38 INFO - TEST-INFO | 978: exit 0 16:11:38 INFO - TEST-OK | kraken | took 64074ms 16:11:38 INFO - SUITE-END | took 1180s 16:11:38 INFO - Completed test suite (00:19:40) 16:11:38 INFO - javascript benchmark 16:11:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6261.24587077352, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.479304139172, 2652.6153707712383, 2662.094887738169, 2671.252049426161, 2678.624992501049, 4642.32686260492, 4722.102800467908, 4743.264793956938, 4820.445648750386, 4866.756662166895, 4700.083483720668, 4800.231962885939, 4807.783649735761, 4830.686005409646, 4915.188993816016, 4356.9564304356945, 4395.692301538894, 4446.444194475691, 4515.706479078865, 4561.201789686808, 4469.982761635899, 4494.910101797962, 4514.074614703978, 4522.660800439964, 4564.224081906067, 4339.913201735979, 4471.262241730111, 4491.483479399878, 4521.547845215485, 4535.138323718499, 4369.650427965755, 4372.693911426201, 4383.517813040563, 4388.605025547684, 4428.955710442919, 4375.25620644488, 4416.1167766446515, 4416.2713152329825, 4417.624501917341, 4456.22016147173, 4768.3085952536685, 4775.761211939423, 4780.091782561337, 4780.7609619519235, 4790.640701947333, 5199.0, 5216.347956505437, 5216.400113986902, 5219.164933610604, 5253.553447956928, 5234.685918844882, 5235.581153507748, 5237.921431178535, 5259.76331065103, 5264.92102618461, 4671.089137618166, 4765.11845308619, 4823.758812059383, 4827.8551643450755, 4885.682430642032, 5315.415304316522, 5337.119375303031, 5339.759710813023, 5354.8661283467445, 5355.598330125256, 5122.1804511278015, 5141.228815677603, 5141.820036298786, 5146.0479811235045, 5186.559142472856, 4997.500249975046, 5159.200323949719, 5183.688978661293, 5194.6104042196985, 5214.504622060898, 5028.195488721787, 5080.77136528857, 5081.974590127025, 5152.845414637567, 5171.974140129275, 5123.7438128093445, 5129.076766182123, 5130.358705161855, 5139.460356662571, 5185.455527169593, 4305.289627211538, 4353.956460435418, 4391.692581519327, 4396.0, 4404.07514421975, 3817.751846129993, 3829.215010922754, 3834.1564855731694, 3867.3812190049457, 3870.0, 4370.584794444522, 4463.866084017484, 4467.441569803775, 4485.798139083749, 4503.437070366204, 5048.974755126201, 5078.771455284521, 5099.541041306226, 5104.770285337168, 5123.2827404163445, 4379.1022840317655, 4381.298992161239, 4401.6478681705385, 4416.889577760582, 4430.202563538594, 4573.428321459817, 4574.268117101248, 4577.290519969343, 4591.334256532784, 4608.815647374135, 4787.808487660454, 4800.207965685623, 4814.109389762905, 4819.373481447389, 4870.050340183701, 5154.201098829687, 5158.200478925773, 5165.147750621106, 5166.8966620668125, 5206.609504287269, 4745.0509898019845, 4792.520747925179, 4817.325574419514, 4855.150348689036, 4885.291632713308, 5098.847034588968, 5105.795768169381, 5113.41195762492, 5118.206677964921, 5156.793728250828, 5180.093483640272, 5189.636725429184, 5194.506521880416, 5200.817971371135, 5220.399654039682, 4879.243717223836, 4970.204767237225, 5002.374703162105, 5032.84901452957, 5035.370578677665, 4890.779914903766, 4905.5094490550655, 4918.458969513422, 4941.258811178208, 4983.451820299837, 4808.2787581863, 4912.066707325596, 4920.261960705922, 4921.311016457627, 4926.039422312615, 4956.207006878882, 4994.725290108933, 5009.123403404316, 5036.6726162799305, 5060.443351231435, 4923.655344125877, 4962.5533701967, 4965.354503914468, 4970.826021089245, 5022.372203474566], "value": 4726.367178145942, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.3862322144107, 564.8249042796733, 579.189135210705, 601.3445344574413, 603.8007457539013, 32676.183095422628, 37088.0, 37144.0, 37168.62831371686, 37306.81346593267, 37325.62674373255, 37827.0, 38047.809760951226, 38065.8096709516, 38249.42625860607, 7839.0985036720795, 7874.173211812763, 7898.80252993674, 7931.206879312052, 7954.562499062549, 7888.1323054463965, 7896.881546776803, 7940.642671079815, 7954.443188976774, 7978.760637180894, 7941.245581669761, 7973.720919767809, 8007.599620019005, 8008.319292860085, 8024.839503209932, 7920.841583168333, 7965.681372745113, 7975.641096150687, 7987.081485629169, 7999.920000800005, 7736.34241089508, 7791.10402303731, 7840.4511684182135, 7843.7254696085365, 7872.724454644117, 29009.56485652717, 35990.0, 36025.639743602755, 36529.26941461156, 36639.450408243894, 2916.7229113234207, 3146.5122905949383, 3155.826429546374, 3281.261716113879, 3341.3150304187584, 26581.867090664422, 28849.71150288491, 28971.71028289711, 29181.56227656587, 30032.0, 3241.6596257393107, 3310.453775127125, 3314.834258287076, 3347.313800670857, 3397.490376443553, 256900.0, 260739.0, 262032.0, 262573.687131565, 263848.0, 32578.674213258037, 33534.329313414084, 33744.66255337415, 51148.23277650838, 51891.0, 34401.483977740354, 34413.65586344105, 34432.82783586066, 34628.826855866064, 34712.0, 13332.5333613325, 13477.460901564024, 13578.321083945762, 13579.728405431835, 13580.660483487993, 10512.264141510173, 10616.150707943347, 10674.73313167177, 10682.73293167677, 10720.678379648623, 7977.880331795028, 7988.440809143421, 7998.48009879356, 8046.155153708776, 8091.757247282591, 3233.110894503983, 3267.591551056118, 3303.6035675719068, 3322.900312990614, 3338.0, 885.2652298592153, 914.9862752058724, 922.8556589828564, 945.3902233059638, 961.8076384723083, 27474.0, 27824.582631260546, 27958.3010424741, 28005.15984520468, 28302.71697283042, 961.2598299309632, 981.6269817469458, 1002.0830939690102, 1007.7228762090484, 1014.9543270552842, 14448.638784030483, 14641.414343426357, 14774.704505909822, 14783.926080369529, 15119.54641360761, 383882.0, 388600.0, 388728.0, 388965.0, 390832.0, 47660.28509572359, 48461.75769121202, 48585.27122093172, 48619.27071093937, 48732.0, 1159.918805683611, 1162.8023236049892, 1169.128998895811, 1189.0012389592785, 1204.0668481926402, 25554.616680750176, 26809.731902681502, 26910.461790764468, 27269.45461090807, 27638.3090422733, 42039.36940945827, 42321.365179521716, 42943.35584966165, 42965.0, 43009.784951075046, 325464.0, 326155.0, 326352.0, 327410.0, 327765.0, 24034.11590609138, 25446.363840904127, 25888.482230355665, 26011.739882601687, 26053.869730651226, 41497.58502415058, 41579.792101039304, 41765.37351939663, 41884.79057604692, 42304.0, 35948.64051359453, 36208.275834482636, 36218.4567231497, 36219.63780362163, 36375.45436818503, 35055.47416788699, 35161.47257791084, 35180.47229291512, 35262.47106293459, 35437.64562354344, 34757.13107172341, 34835.0, 35184.29631407409, 35380.82309588538, 36053.63946360608, 32162.19594510156, 33292.167695807795, 33788.662113379534, 33800.323993520484, 34246.828765856015, 24832.751672483766, 25180.622290666022, 25257.422773167607, 25444.363890902874, 25635.23094307099], "value": 16327.156713510887, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.9140102076012, 366.55646667532284, 367.6195138032136, 377.475309320045, 379.12800558714946, 15853.286602102904, 16396.59008524786, 17112.229949652265, 17137.657246855055, 17161.313547458103, 15703.293351799168, 16369.263383147758, 16897.91551042243, 17002.48992530226, 17023.0, 4908.631852611051, 5078.59371250301, 5101.617378696594, 5103.438621751604, 5113.872153196163, 3648.908777280563, 4985.850424487253, 5586.10622300432, 5947.0, 5947.167396564484, 5897.764089436418, 5922.792702255422, 5950.821475355746, 5986.970065149668, 6009.909851352233, 5832.883342333151, 5957.553183511232, 5958.731857066442, 5977.043673012297, 5977.85055373617, 4580.175568397687, 5074.720890351029, 5254.21186821976, 5266.0, 5268.736563171826, 11637.592684256011, 11729.12031597625, 11750.941245293805, 11805.763884722342, 11887.583934562335, 1750.9989673595899, 1871.7566716326926, 1910.8853468791779, 1916.7029110487897, 1975.861689681723, 8254.0, 8805.295576353941, 8942.508162051085, 9076.727698169065, 9196.310276729206, 1716.7596536484778, 1728.4037007232484, 1728.4814555633386, 1753.3775509694003, 1809.4390738870861, 66276.0, 66510.66744666245, 69621.3037869625, 70031.64984175097, 70102.29897701059, 9653.1794797443, 9664.56509457062, 9668.903310966942, 9722.319437639297, 9735.70792876215, 12672.429740661692, 12757.744845103047, 12812.679683007813, 12843.0, 12854.485820567259, 6651.73393064272, 6712.0, 6778.084958530535, 6803.693833777492, 6833.931660683429, 6373.0, 6414.0, 6427.485801135898, 6466.288708242089, 6511.576747511492, 3882.378819388884, 4045.2314060328445, 4097.774622395737, 4109.0, 4110.23960567296, 1672.1973452742752, 1675.5057258108886, 1752.3428714232164, 1771.2914834066219, 1795.5256578520605, 857.7726902370877, 869.9908106596317, 889.1419779912416, 911.5260064766285, 943.7216021273741, 16242.269097890623, 16477.34090636361, 16713.83286167147, 16872.83127168737, 16913.492595222164, 856.9957150214209, 880.4937161132375, 907.0340087806464, 919.3748251189255, 938.8826396700413, 8988.842677757291, 9485.715428537154, 9570.425774453555, 9625.807483850283, 9713.611455541699, 377014.0, 377077.0, 378996.0, 380107.0, 382492.0, 74343.62828185824, 75360.0, 75748.62125689337, 75767.0, 76229.23770762332, 872.4808738800403, 887.9200871921429, 889.5818965086528, 894.6466145872344, 903.5211337990876, 14991.925040374728, 15085.39658413695, 15346.0, 15419.306131223897, 15457.84542154609, 35212.29575408529, 35496.290074198885, 35985.640143599274, 36069.63930360768, 36397.636023639425, 50147.74926125492, 50440.495595045046, 50833.49166508435, 51846.48153518417, 51996.0, 7379.0, 7403.259674032553, 7447.441441891771, 7501.32488076054, 7511.32398084175, 10953.56185752561, 11137.0, 11175.832362514731, 11182.832257516306, 11359.772804544029, 4479.731216127043, 9328.673496427593, 9379.906200938176, 9418.10527999839, 9624.085711857362, 10047.698569042941, 10159.898401015895, 10160.898391016291, 10205.74485637865, 10221.0, 9556.56995435221, 9614.71155865325, 9828.512417210255, 9843.310968232156, 10071.496425178566, 7042.401395881203, 7325.633718313957, 7387.372073373824, 7606.467547271638, 7633.88549171774, 8443.324534037385, 9376.0, 9435.669751558662, 9590.616375344907, 9659.71020869375], "value": 7882.38638280114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.9861901380987, 1392.0534036854935, 1490.970180596388, 1626.235669235459, 1669.8330166983296, 6578.539502234834, 7144.892826607598, 7338.3395494405495, 7750.224977502247, 7751.108622508414, 7353.154387245469, 7611.885821712679, 7634.0, 7705.73029943952, 7714.575698336589, 2149.301477019967, 2191.7698641642637, 2194.2539536557647, 2195.0232146694725, 2195.2536137713173, 2136.7970042845905, 2173.7826217378292, 2186.8250539956766, 2192.550527141932, 2200.119952019197, 2102.211670623516, 2103.842211834111, 2116.0477784996738, 2119.2158901206576, 2157.2880949286778, 2098.08733201058, 2101.485136141647, 2111.2505060703384, 2113.218109299561, 2115.9788402115937, 2097.171617211193, 2154.53677459347, 2159.6544552871624, 2160.319499357697, 2169.5227050048966, 7681.3470854977395, 7700.422468314899, 7735.419843511703, 7763.767086987399, 7792.0, 4478.8432404866, 4611.331356953223, 4618.9076218475775, 4625.560571745679, 4636.02643444877, 2711.2137480130937, 2809.452156829419, 2823.2659508527727, 2825.9717402825913, 2830.4763618730394, 852.9530875801828, 859.7715578004616, 898.3711402018613, 905.7373361725092, 909.6452383570413, 10041.849372259348, 10054.396736195778, 10082.798344033079, 10116.696499105039, 10149.695509134664, 4069.5116586009867, 4093.7953102344763, 4138.6482149017065, 4190.0, 4195.622393984556, 8578.399512034097, 8737.825243495094, 8774.824503509893, 8793.428427152343, 8843.425177363451, 4604.424446944132, 4621.792019359137, 4630.236011058205, 4633.235516139866, 4643.117807616542, 3676.227992121631, 3978.244133614604, 4010.057636455431, 4126.711130220916, 4222.134462435255, 3543.486194501783, 3623.130448692295, 3668.4313931340685, 3704.148045949393, 3717.9256414872093, 1167.1829719196426, 1169.923954942926, 1214.3503225774168, 1219.439058033297, 1222.712662524306, 677.2211956250352, 774.8686917100983, 781.7068599275271, 810.2343285595056, 819.5697258938985, 4748.738819364969, 4920.237363208708, 4926.802927882844, 4990.825321113816, 4991.401031876126, 390.9452676625275, 394.0149625935162, 404.4701441112094, 406.6990427083996, 422.2800125785528, 3203.6636153204045, 3313.1385839681375, 3326.2982669956436, 3353.5808023997, 3358.529805827186, 8925.285977121815, 9139.63441462334, 9281.767955801159, 9296.907030929739, 9349.813003739888, 9227.0, 9250.86123708145, 9294.488803115759, 9348.20540254086, 9358.57886395114, 7076.32774886385, 7119.967604697394, 7168.390686791577, 7168.462365322622, 7200.1719802223415, 4723.102610503994, 4857.95142048575, 4864.440589332131, 4889.0, 4894.681845680019, 8471.872921906053, 8536.487810731376, 8545.359098067545, 8666.523341216294, 8672.436291641276, 8506.489610623383, 8541.273991710526, 8612.397132200937, 8759.518226497348, 8979.236764875059, 5739.770409183753, 6215.223097112861, 6431.549791514549, 6469.0, 6529.575577587441, 7269.0, 7294.416446684359, 7301.817454563678, 7333.889991650236, 7337.046183996046, 6136.478399336106, 6147.415995480422, 6256.593321434092, 6515.869682606227, 6569.080328754074, 6435.871282574416, 6478.5141114415665, 6523.24982626985, 6545.639989800607, 6635.0, 5924.407559244213, 5951.345352011189, 5964.731587078505, 5975.940240597713, 5998.580099393001, 4048.817803198804, 4147.7718725469185, 4149.066460046465, 4255.106427650228, 4262.786860656893, 4110.568390319093, 4153.335466325373, 4155.750654960591, 4231.28068228408, 4237.512686041021], "value": 3916.727774159151, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.46345796817917, 288.8642338101092, 294.19684261964824, 294.41117764471056, 295.8402462670158, 5155.613329000331, 5156.0, 5158.845234642967, 5182.393458028014, 5197.272381866542, 4998.925016124761, 4999.825076091894, 5001.374828146481, 5006.924896126561, 5065.822696205633, 3696.611855755147, 3818.217265460588, 3925.2738243425056, 3936.2127574485075, 3947.1908258806875, 3919.804009799513, 3942.9605703943025, 3955.3782948990774, 3959.3370784270533, 3961.148353104082, 3902.434147048676, 3912.315344814646, 3953.4267531207956, 3954.2091581683635, 3964.464797252377, 3871.490118853621, 3904.3167445697172, 3919.2945269851416, 3961.108750531136, 3968.464257325253, 3425.2806910548566, 3438.793672379665, 3443.8622455101768, 3447.120984149026, 3451.8608859076444, 4899.093667671492, 4911.533404326583, 4964.329815474901, 4968.428630707443, 4976.328195693607, 4335.6965012449145, 4469.1508613363685, 4503.4145561077175, 4509.7970591323465, 4521.593056624886, 5249.553787928031, 5255.5795536357, 5269.683818970836, 5282.3925248596515, 5325.3077099977145, 3790.5451345838674, 3793.2603142387247, 3799.2781371539595, 3810.333191691471, 3820.102275965146, 5394.73026348681, 5595.300587426572, 5621.8594535136535, 5631.0, 5635.295588051494, 3843.26977874203, 3844.3272427325105, 3856.8457261709777, 3857.4406711026745, 3880.6119388061534, 3876.4572959785087, 3912.5109361329833, 3917.4319723639915, 3918.5885482024546, 3921.2941670499013, 4429.604674527513, 4457.465104187519, 4481.983107601593, 4509.436320459942, 4522.191123550606, 5093.465186155475, 5248.740302327414, 5293.253226435344, 5315.202719592015, 5356.517913387814, 1330.7937269723209, 1347.723716638087, 1359.7552440560596, 1360.1838896661923, 1361.3805718398303, 854.1714536899198, 856.6188046319328, 860.8579584368634, 889.6708217959267, 891.2958762577491, 4511.481179664381, 4619.838305659286, 4648.163330600524, 4674.345591617176, 4704.082703872712, 5436.565074794086, 5501.532369748536, 5522.972385138129, 5524.226608274845, 5555.8888822224135, 4406.184855801687, 4563.383943167696, 4663.836765713251, 4666.580007799246, 4701.929471057937, 2904.7676185905075, 2936.251255929767, 2946.0, 2948.6903875092808, 2962.2150130215077, 5148.2277658350795, 5152.252923326097, 5166.405863325691, 5172.948270517322, 5181.35233095863, 5316.787328506816, 5597.496225339658, 5599.524040456526, 5604.355499117572, 5628.296462942132, 5075.3402057732255, 5095.31213286209, 5106.591472682177, 5118.411382690963, 5158.948410515997, 5413.729313534229, 5460.341571147262, 5478.506934375766, 5483.75323110453, 5488.9725551373585, 5104.948950510596, 5385.434529374516, 5404.243405923253, 5408.621396502207, 5420.159875219189, 5141.614378921521, 5154.407243167084, 5169.0, 5181.404138524118, 5212.348456442945, 3869.5163104611925, 3880.262750077476, 3881.359575669983, 3887.747296425723, 3904.39481880309, 5235.633505654568, 5482.725863706878, 5537.169424586184, 5566.721663916707, 5609.32688077417, 5360.3299587551555, 5368.845698174911, 5382.30030096085, 5393.27190829233, 5410.83767486976, 5127.79488820443, 5328.254044433705, 5328.6802791832615, 5329.946700532945, 5339.813106541408, 5241.371035475768, 5258.500442458113, 5262.710550919583, 5279.815206467755, 5286.62993590445, 5129.512696293846, 5243.921341179962, 5344.759485823225, 5349.234752531733, 5355.892882142258, 5219.2953951216095, 5243.430718947612, 5249.816256431007, 5262.815801446931, 5272.815451459181], "value": 3990.054366351713, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.4204203154113, 642.3736856564847, 665.5474277491307, 671.6473851228104, 727.2400341642982, 12722.0, 13210.471581136742, 13304.334783260834, 13341.266230357327, 13356.933215333935, 12599.622011339652, 13011.219326840395, 13061.085723999324, 13099.869001310008, 13100.803487947689, 622.3620788691604, 769.5421224371504, 784.9873662974755, 787.7164220880478, 790.6125998260868, 767.9001729775122, 789.4828887078972, 793.3811626931004, 795.1412474527497, 796.3788245168778, 831.7380025292044, 833.6582001379436, 834.4200780457585, 835.2941764209233, 839.1063517353998, 816.073756286616, 825.2737590920012, 826.4421515477059, 828.1883753921161, 829.2868133405267, 604.9213602231682, 605.2102006881018, 606.0364021206303, 607.2257871214193, 607.8966575682144, 13395.86604133956, 13402.664933376645, 13439.193648381031, 13449.0, 13459.057865949388, 13023.34883255843, 13349.666258343523, 13494.52769153075, 13558.186508809504, 13780.862191378159, 10584.68245952615, 10626.893731062668, 10796.514156862882, 10855.565777368896, 10986.285891417032, 3408.233147541808, 3453.6546345365514, 3456.6197718250974, 3466.7053300469493, 3534.469829525566, 60095.69952150255, 60812.0, 61889.38110618881, 61913.046956243394, 62205.37794622041, 10615.150787936947, 10640.989106034915, 10648.467576621139, 10658.840117398246, 10724.946375268073, 19368.515787105436, 19410.70883936742, 19445.805541944683, 19504.0, 19523.804761952484, 7062.081929349151, 7139.071920650283, 7182.748603798842, 7218.061651985208, 7229.2409297024105, 3827.770333779982, 3870.903227419337, 4028.959710402917, 4030.1335212928775, 4088.34586466164, 2902.622659054309, 3027.04648035868, 3030.9393812123635, 3033.059751477005, 3033.3781574777117, 484.85939077667786, 492.32059757535086, 493.622378880157, 499.840051183625, 500.3470471035261, 533.2028617217285, 599.5353600959291, 611.8164550634792, 626.3204423200787, 629.2731894661673, 7936.365090792723, 7963.8805417918775, 7978.760637180894, 8049.919500805034, 8130.918690813016, 538.2667809652911, 620.5066971757464, 621.3103455164763, 624.2664868779166, 625.9248890133122, 3864.3430616795213, 3932.5477570079806, 3944.6449819515806, 3973.662238709684, 4089.9182016359505, 52300.21549676758, 53205.0, 53247.20129197988, 88026.55986720153, 89592.5520372407, 76784.23215767882, 83655.58172209222, 84353.57823210844, 84488.0, 85735.0, 70152.6492367535, 73150.26849731541, 75037.0, 76378.23621763711, 76690.0, 7103.9289607103265, 7517.210692877388, 7578.848423031398, 7699.384049275933, 7779.494332868572, 43311.35032974445, 44476.55523444724, 44741.0, 45078.0, 45172.77413612911, 37867.242655147296, 40033.199336012534, 59206.703966479894, 63318.36681633125, 63489.68255158695, 9714.174295184706, 10005.54975026111, 10040.246981476272, 10333.121684656588, 10495.47522623881, 10767.3539587625, 10819.837702434312, 10828.404437755999, 10862.891371086187, 10933.289336193122, 10645.680629581126, 10688.786224275316, 10739.119875896231, 10759.784804304027, 10945.945270273916, 10081.596736130472, 10116.443595602312, 10285.640002599874, 10295.742606434898, 10301.896981030393, 8604.268637165911, 8990.730278091667, 9695.418274903528, 9958.352707074017, 9967.900320996987, 8280.337572994267, 8339.66641334364, 8342.749717508485, 8363.790905227417, 8367.790805229917, 8649.221570058726, 8841.69054083104, 8851.20906976968, 9037.0, 9040.042139158588], "value": 6337.543609536409, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 114.0, 114.0, 116.0, 115.0, 113.0, 115.0, 115.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 136.0, 160.0, 190.0, 140.0, 160.0, 153.0, 135.0, 197.0, 135.0], "value": 156.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 172.0, 164.0, 163.0, 162.0, 165.0, 165.0, 164.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 170.0, 77.0, 80.0, 76.0, 76.0, 181.0, 77.0], "value": 96.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 148.0, 88.0, 88.0, 88.0, 127.0, 86.0, 86.0, 154.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 118.0, 118.0, 117.0, 120.0, 119.0, 118.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 147.0, 158.0, 148.0, 147.0, 148.0, 148.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 97.0, 97.0, 97.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 63.0, 71.0, 63.0, 63.0, 64.0, 63.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 89.0, 87.0, 86.0, 84.0, 85.0, 85.0, 110.0, 83.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 133.0, 130.0, 133.0, 150.0, 151.0, 139.0, 137.0, 138.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 172.0, 172.0, 170.0, 169.0, 166.0, 171.0, 169.0, 167.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 68.0, 68.0, 68.0, 71.0, 66.0, 67.0, 67.0], "value": 68.4, "unit": "score"}]}]} 16:11:38 INFO - Return code: 0 16:11:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:11:38 ERROR - # TBPL SUCCESS # 16:11:38 INFO - Running post-action listener: _resource_record_post_action 16:11:38 INFO - ##### 16:11:38 INFO - ##### Finished run-tests step (success) 16:11:38 INFO - ##### 16:11:38 INFO - Running post-run listener: _resource_record_post_run 16:11:38 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 550797312; Read time: 0; Write time: 427816 16:11:38 INFO - TinderboxPrint: CPU usage
13.4% 16:11:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:11:38 INFO - TinderboxPrint: I/O write bytes / time
550,797,312 / 427,816 16:11:38 INFO - TinderboxPrint: CPU idle
8,271.7 (86.6%) 16:11:38 INFO - TinderboxPrint: CPU user
1,230.2 (12.9%) 16:11:38 INFO - TinderboxPrint: Swap in / out
0 / 0 16:11:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 256458752; Read time: 0; Write time: 227196 16:11:38 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 294338560; Read time: 0; Write time: 200620 16:11:39 INFO - Running post-run listener: _upload_blobber_files 16:11:39 INFO - Blob upload gear active. 16:11:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:11:39 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 16:11:39 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:11:39 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:11:39 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:11:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:11:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:40 INFO - (blobuploader) - INFO - Done attempting. 16:11:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:11:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:11:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:44 INFO - (blobuploader) - INFO - Done attempting. 16:11:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:11:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:11:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:45 INFO - (blobuploader) - INFO - Done attempting. 16:11:45 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:45 INFO - Return code: 0 16:11:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c61ce1164b336de474dfa0f2b9d5a4ccb0fd403cc744b295ff672adca1971b2487cd0487df73e1f0b0b70f4d0d91f583cecd5a7ff1cc64e212fffd57be06679c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/956c60d3fb3e0211d409f192edfc839bfc1ea6ebc767f215aab42fb2723eb1ce09831f44da9614a340662271558ce9dedcba0990d202992a5324b5bc4d289529", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec9e214f51c665966219769691d3271193d57fca633bb719aef6fba7385b6f8077df49731ae85c989726167771b0fdeaeb2f127f9d03ff67d7cdd0341ab2a4cf"} 16:11:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:45 INFO - Contents: 16:11:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c61ce1164b336de474dfa0f2b9d5a4ccb0fd403cc744b295ff672adca1971b2487cd0487df73e1f0b0b70f4d0d91f583cecd5a7ff1cc64e212fffd57be06679c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/956c60d3fb3e0211d409f192edfc839bfc1ea6ebc767f215aab42fb2723eb1ce09831f44da9614a340662271558ce9dedcba0990d202992a5324b5bc4d289529", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec9e214f51c665966219769691d3271193d57fca633bb719aef6fba7385b6f8077df49731ae85c989726167771b0fdeaeb2f127f9d03ff67d7cdd0341ab2a4cf"} 16:11:45 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:45 INFO - Copying logs to upload dir... 16:11:45 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1450.525355 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 10 secs) (at 2016-06-15 16:11:44.713335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 16:11:44.716985) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194 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/Fx-Team-Non-PGO/sha512/c61ce1164b336de474dfa0f2b9d5a4ccb0fd403cc744b295ff672adca1971b2487cd0487df73e1f0b0b70f4d0d91f583cecd5a7ff1cc64e212fffd57be06679c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/956c60d3fb3e0211d409f192edfc839bfc1ea6ebc767f215aab42fb2723eb1ce09831f44da9614a340662271558ce9dedcba0990d202992a5324b5bc4d289529", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec9e214f51c665966219769691d3271193d57fca633bb719aef6fba7385b6f8077df49731ae85c989726167771b0fdeaeb2f127f9d03ff67d7cdd0341ab2a4cf"} build_url:https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/JQUesOpcSwy3WWzNMZsmlg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c61ce1164b336de474dfa0f2b9d5a4ccb0fd403cc744b295ff672adca1971b2487cd0487df73e1f0b0b70f4d0d91f583cecd5a7ff1cc64e212fffd57be06679c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/956c60d3fb3e0211d409f192edfc839bfc1ea6ebc767f215aab42fb2723eb1ce09831f44da9614a340662271558ce9dedcba0990d202992a5324b5bc4d289529", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec9e214f51c665966219769691d3271193d57fca633bb719aef6fba7385b6f8077df49731ae85c989726167771b0fdeaeb2f127f9d03ff67d7cdd0341ab2a4cf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 16:11:44.742921) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 16:11:44.743277) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466030853.124835-1599455194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 16:11:44.826706) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 16:11:44.827065) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 16:11:44.827393) ========= ========= Total master_lag: 0.78 =========