builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1465389385.58 results: success (0) buildid: 20160608045729 builduid: 9f3866678c824a3397dd1f5d96838da8 revision: 71d424246fe1149948c8054a4392feea87dfd0ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 05:36:25.578992) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 05:36:25.579396) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 05:36:25.579692) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 05:36:25.600136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:36:25.600390) ========= 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=df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 05:36:25-- 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% 25.4M=0s 2016-06-08 05:36:26 (25.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146014 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:36:25.774067) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:36:25.774408) ========= 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=df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014046 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:36:25.825883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:36:25.826279) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 71d424246fe1149948c8054a4392feea87dfd0ad --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 71d424246fe1149948c8054a4392feea87dfd0ad --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=df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 05:36:26,245 truncating revision to first 12 chars 2016-06-08 05:36:26,245 Setting DEBUG logging. 2016-06-08 05:36:26,245 attempt 1/10 2016-06-08 05:36:26,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/71d424246fe1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 05:36:26,557 unpacking tar archive at: fx-team-71d424246fe1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657323 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:36:26.500056) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 05:36:26.500437) ========= script_repo_revision: 71d424246fe1149948c8054a4392feea87dfd0ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 05:36:26.500928) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 05:36:26.501211) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 05:36:26.519204) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-06-08 05:36:26.519471) ========= /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=df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:36:27 INFO - MultiFileLogger online at 20160608 05:36:27 in /builds/slave/test 05:36:27 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 05:36:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:36:27 INFO - {'append_to_log': False, 05:36:27 INFO - 'base_work_dir': '/builds/slave/test', 05:36:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:36:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:36:27 INFO - 'branch': 'Fx-Team-Non-PGO', 05:36:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:36:27 INFO - 'config_files': ('talos/linux_config.py',), 05:36:27 INFO - 'default_actions': ('clobber', 05:36:27 INFO - 'read-buildbot-config', 05:36:27 INFO - 'download-and-extract', 05:36:27 INFO - 'populate-webroot', 05:36:27 INFO - 'create-virtualenv', 05:36:27 INFO - 'install', 05:36:27 INFO - 'run-tests'), 05:36:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:36:27 INFO - 'download_minidump_stackwalk': True, 05:36:27 INFO - 'download_symbols': 'ondemand', 05:36:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:36:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:36:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:36:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:36:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:36:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:36:27 INFO - 'installer_path': 'installer.exe', 05:36:27 INFO - 'log_level': 'info', 05:36:27 INFO - 'log_name': 'talos', 05:36:27 INFO - 'log_to_console': True, 05:36:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:36:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:36:27 INFO - 'opt_config_files': (), 05:36:27 INFO - 'pip_index': False, 05:36:27 INFO - 'sps_profile': False, 05:36:27 INFO - 'sps_profile_interval': 0, 05:36:27 INFO - 'suite': 'dromaeojs-e10s', 05:36:27 INFO - 'system_bits': '32', 05:36:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:36:27 INFO - 'title': 'talos-linux64-ix-021', 05:36:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:36:27 INFO - 'use_talos_json': True, 05:36:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:36:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:36:27 INFO - 'work_dir': 'build'} 05:36:27 INFO - ##### 05:36:27 INFO - ##### Running clobber step. 05:36:27 INFO - ##### 05:36:27 INFO - Running pre-action listener: _resource_record_pre_action 05:36:27 INFO - Running main action method: clobber 05:36:27 INFO - rmtree: /builds/slave/test/build 05:36:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:36:28 INFO - Running post-action listener: _resource_record_post_action 05:36:28 INFO - ##### 05:36:28 INFO - ##### Finished clobber step (success) 05:36:28 INFO - ##### 05:36:28 INFO - ##### 05:36:28 INFO - ##### Running read-buildbot-config step. 05:36:28 INFO - ##### 05:36:28 INFO - Running pre-action listener: _resource_record_pre_action 05:36:28 INFO - Running main action method: read_buildbot_config 05:36:28 INFO - Using buildbot properties: 05:36:28 INFO - { 05:36:28 INFO - "project": "", 05:36:28 INFO - "product": "firefox", 05:36:28 INFO - "script_repo_revision": "production", 05:36:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:36:28 INFO - "repository": "", 05:36:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:36:28 INFO - "buildid": "20160608045729", 05:36:28 INFO - "pgo_build": "False", 05:36:28 INFO - "basedir": "/builds/slave/test", 05:36:28 INFO - "buildnumber": 1357, 05:36:28 INFO - "slavename": "talos-linux64-ix-021", 05:36:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:36:28 INFO - "platform": "ubuntu64_hw", 05:36:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:36:28 INFO - "branch": "fx-team", 05:36:28 INFO - "repo_path": "integration/fx-team", 05:36:28 INFO - "revision": "71d424246fe1149948c8054a4392feea87dfd0ad", 05:36:28 INFO - "stage_platform": "linux64", 05:36:28 INFO - "builduid": "9f3866678c824a3397dd1f5d96838da8", 05:36:28 INFO - "slavebuilddir": "test" 05:36:28 INFO - } 05:36:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:36:28 INFO - Running post-action listener: _resource_record_post_action 05:36:28 INFO - ##### 05:36:28 INFO - ##### Finished read-buildbot-config step (success) 05:36:28 INFO - ##### 05:36:28 INFO - ##### 05:36:28 INFO - ##### Running download-and-extract step. 05:36:28 INFO - ##### 05:36:28 INFO - Running pre-action listener: _resource_record_pre_action 05:36:28 INFO - Running main action method: download_and_extract 05:36:28 INFO - mkdir: /builds/slave/test/build/tests 05:36:28 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')]} 05:36:28 INFO - https://queue.taskcluster.net/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:36:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:36:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:36:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/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 05:36:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/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 05:36:32 INFO - Downloaded 1361 bytes. 05:36:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:36:32 INFO - Using the following test package requirements: 05:36:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:36:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:36:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:36:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:32 INFO - u'jsshell-linux-x86_64.zip'], 05:36:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:36:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:36:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:36:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:36:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:36:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:36:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:36:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:36:32 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')]} 05:36:32 INFO - https://queue.taskcluster.net/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:36:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:36:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:36:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/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 05:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/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 05:36:39 INFO - Downloaded 22878197 bytes. 05:36:39 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'] 05:36:39 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 05:36:40 INFO - Return code: 0 05:36:40 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 05:36:40 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')]} 05:36:40 INFO - https://queue.taskcluster.net/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:36:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:36:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:36:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/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 05:36:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/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 05:36:43 INFO - Downloaded 22878197 bytes. 05:36:43 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'] 05:36:43 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 05:36:44 INFO - Return code: 0 05:36:44 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')]} 05:36:44 INFO - https://queue.taskcluster.net/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:36:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:36:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:36:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/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 05:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/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 05:36:46 INFO - Downloaded 10833369 bytes. 05:36:46 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'] 05:36:46 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 05:36:47 INFO - Return code: 0 05:36:47 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')]} 05:36:47 INFO - https://queue.taskcluster.net/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:36:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:36:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:36:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/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 05:36:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdmWkLNAQnSQYtvnT3m6aA/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 05:36:54 INFO - Downloaded 55336807 bytes. 05:36:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:36:54 INFO - mkdir: /builds/slave/test/properties 05:36:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:36:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:36:54 INFO - Contents: 05:36:54 INFO - build_url:https://queue.taskcluster.net/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:36:55 INFO - Running post-action listener: _resource_record_post_action 05:36:55 INFO - Running post-action listener: set_extra_try_arguments 05:36:55 INFO - ##### 05:36:55 INFO - ##### Finished download-and-extract step (success) 05:36:55 INFO - ##### 05:36:55 INFO - ##### 05:36:55 INFO - ##### Running populate-webroot step. 05:36:55 INFO - ##### 05:36:55 INFO - Running pre-action listener: _resource_record_pre_action 05:36:55 INFO - Running main action method: populate_webroot 05:36:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:36:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:36:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:36:55 INFO - '--tppagecycles', 05:36:55 INFO - '7'], 05:36:55 INFO - 'tests': ['tsvgm']}}, 05:36:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:36:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:36:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:36:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:36:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:36:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:36:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:55 INFO - 'talos_options': ['--disable-e10s'], 05:36:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:55 INFO - 'talos_options': ['--disable-e10s'], 05:36:55 INFO - 'tests': ['damp', 'tps']}, 05:36:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:55 INFO - 'tests': ['damp', 'tps']}, 05:36:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:36:55 INFO - 'tests': ['dromaeo_dom']}, 05:36:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:36:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:36:55 INFO - 'tests': ['a11yr', 05:36:55 INFO - 'ts_paint', 05:36:55 INFO - 'tpaint', 05:36:55 INFO - 'sessionrestore', 05:36:55 INFO - 'sessionrestore_no_auto_restore', 05:36:55 INFO - 'tabpaint']}, 05:36:55 INFO - 'other-e10s': {'tests': ['a11yr', 05:36:55 INFO - 'ts_paint', 05:36:55 INFO - 'tpaint', 05:36:55 INFO - 'sessionrestore', 05:36:55 INFO - 'sessionrestore_no_auto_restore', 05:36:55 INFO - 'tabpaint']}, 05:36:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:36:55 INFO - 'ts_paint', 05:36:55 INFO - 'tpaint', 05:36:55 INFO - 'sessionrestore', 05:36:55 INFO - 'sessionrestore_no_auto_restore', 05:36:55 INFO - 'tabpaint']}, 05:36:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:36:55 INFO - 'ts_paint', 05:36:55 INFO - 'tpaint', 05:36:55 INFO - 'sessionrestore', 05:36:55 INFO - 'sessionrestore_no_auto_restore', 05:36:55 INFO - 'tabpaint']}, 05:36:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:36:55 INFO - 'tests': ['a11yr', 05:36:55 INFO - 'ts_paint', 05:36:55 INFO - 'tpaint', 05:36:55 INFO - 'sessionrestore', 05:36:55 INFO - 'sessionrestore_no_auto_restore', 05:36:55 INFO - 'tabpaint']}, 05:36:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:36:55 INFO - 'tests': ['a11yr', 05:36:55 INFO - 'ts_paint', 05:36:55 INFO - 'tpaint', 05:36:55 INFO - 'sessionrestore', 05:36:55 INFO - 'sessionrestore_no_auto_restore', 05:36:55 INFO - 'tabpaint']}, 05:36:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:36:55 INFO - 'tests': ['tsvgx', 05:36:55 INFO - 'tsvgr_opacity', 05:36:55 INFO - 'tart', 05:36:55 INFO - 'tscrollx', 05:36:55 INFO - 'cart']}, 05:36:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:36:55 INFO - 'tsvgr_opacity', 05:36:55 INFO - 'tart', 05:36:55 INFO - 'tscrollx', 05:36:55 INFO - 'cart']}, 05:36:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:55 INFO - 'talos_options': ['--disable-e10s'], 05:36:55 INFO - 'tests': ['tp5o']}, 05:36:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:55 INFO - 'tests': ['tp5o']}, 05:36:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:55 INFO - 'talos_options': ['--disable-e10s', 05:36:55 INFO - '--xperf_path', 05:36:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:55 INFO - 'tests': ['tp5n']}, 05:36:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:55 INFO - 'talos_options': ['--xperf_path', 05:36:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:55 INFO - 'tests': ['tp5n']}}, 05:36:55 INFO - 'talos.zip': {'path': '', 05:36:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:36:55 INFO - Running post-action listener: _resource_record_post_action 05:36:55 INFO - ##### 05:36:55 INFO - ##### Finished populate-webroot step (success) 05:36:55 INFO - ##### 05:36:55 INFO - ##### 05:36:55 INFO - ##### Running create-virtualenv step. 05:36:55 INFO - ##### 05:36:55 INFO - Running pre-action listener: _resource_record_pre_action 05:36:55 INFO - Running main action method: create_virtualenv 05:36:55 INFO - Creating virtualenv /builds/slave/test/build/venv 05:36:55 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 05:36:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:36:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:36:55 INFO - Using real prefix '/usr' 05:36:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:36:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:36:58 INFO - Installing pip.................done. 05:36:58 INFO - Return code: 0 05:36:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:36:58 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')]} 05:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:58 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')]} 05:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:58 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 0x7f8ee5700f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a62e0>, '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 0x1212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12125d0>, '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': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', '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 05:36:58 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 05:36:58 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 05:36:58 INFO - Using env: {'DISPLAY': ':0', 05:36:58 INFO - 'HOME': '/home/cltbld', 05:36:58 INFO - 'LANG': 'en_US.UTF-8', 05:36:58 INFO - 'LANGUAGE': 'en_US:en', 05:36:58 INFO - 'LOGNAME': 'cltbld', 05:36:58 INFO - 'MAIL': '/var/mail/cltbld', 05:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:58 INFO - 'MOZ_NO_REMOTE': '1', 05:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:58 INFO - 'NO_EM_RESTART': '1', 05:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:58 INFO - 'PWD': '/builds/slave/test', 05:36:58 INFO - 'SHELL': '/bin/bash', 05:36:58 INFO - 'SHLVL': '1', 05:36:58 INFO - 'TERM': 'linux', 05:36:58 INFO - 'TMOUT': '86400', 05:36:58 INFO - 'USER': 'cltbld', 05:36:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', 05:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:58 INFO - '_': '/tools/buildbot/bin/python'} 05:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:58 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 05:36:58 INFO - Cleaning up... 05:36:58 INFO - Return code: 0 05:36:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:36:58 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')]} 05:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:58 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')]} 05:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:58 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 0x7f8ee5700f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a62e0>, '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 0x1212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12125d0>, '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': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', '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 05:36:58 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 05:36:58 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 05:36:58 INFO - Using env: {'DISPLAY': ':0', 05:36:58 INFO - 'HOME': '/home/cltbld', 05:36:58 INFO - 'LANG': 'en_US.UTF-8', 05:36:58 INFO - 'LANGUAGE': 'en_US:en', 05:36:58 INFO - 'LOGNAME': 'cltbld', 05:36:58 INFO - 'MAIL': '/var/mail/cltbld', 05:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:58 INFO - 'MOZ_NO_REMOTE': '1', 05:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:58 INFO - 'NO_EM_RESTART': '1', 05:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:58 INFO - 'PWD': '/builds/slave/test', 05:36:58 INFO - 'SHELL': '/bin/bash', 05:36:58 INFO - 'SHLVL': '1', 05:36:58 INFO - 'TERM': 'linux', 05:36:58 INFO - 'TMOUT': '86400', 05:36:58 INFO - 'USER': 'cltbld', 05:36:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', 05:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:58 INFO - '_': '/tools/buildbot/bin/python'} 05:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:58 INFO - Downloading/unpacking psutil>=3.1.1 05:36:58 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 05:36:58 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 05:36:58 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 05:36:58 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 05:36:58 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 05:36:58 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 05:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:37:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:00 INFO - Installing collected packages: psutil 05:37:00 INFO - Running setup.py install for psutil 05:37:00 INFO - building 'psutil._psutil_linux' extension 05:37:00 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 05:37:00 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 05:37:00 INFO - building 'psutil._psutil_posix' extension 05:37:00 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 05:37:00 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 05:37:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:01 INFO - Successfully installed psutil 05:37:01 INFO - Cleaning up... 05:37:01 INFO - Return code: 0 05:37:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:37:01 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')]} 05:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:01 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')]} 05:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:01 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 0x7f8ee5700f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a62e0>, '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 0x1212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12125d0>, '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': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', '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 05:37:01 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 05:37:01 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 05:37:01 INFO - Using env: {'DISPLAY': ':0', 05:37:01 INFO - 'HOME': '/home/cltbld', 05:37:01 INFO - 'LANG': 'en_US.UTF-8', 05:37:01 INFO - 'LANGUAGE': 'en_US:en', 05:37:01 INFO - 'LOGNAME': 'cltbld', 05:37:01 INFO - 'MAIL': '/var/mail/cltbld', 05:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:01 INFO - 'MOZ_NO_REMOTE': '1', 05:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:01 INFO - 'NO_EM_RESTART': '1', 05:37:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:01 INFO - 'PWD': '/builds/slave/test', 05:37:01 INFO - 'SHELL': '/bin/bash', 05:37:01 INFO - 'SHLVL': '1', 05:37:01 INFO - 'TERM': 'linux', 05:37:01 INFO - 'TMOUT': '86400', 05:37:01 INFO - 'USER': 'cltbld', 05:37:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', 05:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:01 INFO - '_': '/tools/buildbot/bin/python'} 05:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:37:01 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 05:37:01 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 05:37:01 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 05:37:01 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 05:37:01 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 05:37:01 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 05:37:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:37:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:37:03 INFO - Installing collected packages: mozsystemmonitor 05:37:03 INFO - Running setup.py install for mozsystemmonitor 05:37:03 INFO - Successfully installed mozsystemmonitor 05:37:03 INFO - Cleaning up... 05:37:03 INFO - Return code: 0 05:37:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:37:03 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')]} 05:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:03 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')]} 05:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:03 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 0x7f8ee5700f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a62e0>, '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 0x1212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12125d0>, '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': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', '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 05:37:03 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 05:37:03 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 05:37:03 INFO - Using env: {'DISPLAY': ':0', 05:37:03 INFO - 'HOME': '/home/cltbld', 05:37:03 INFO - 'LANG': 'en_US.UTF-8', 05:37:03 INFO - 'LANGUAGE': 'en_US:en', 05:37:03 INFO - 'LOGNAME': 'cltbld', 05:37:03 INFO - 'MAIL': '/var/mail/cltbld', 05:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:03 INFO - 'MOZ_NO_REMOTE': '1', 05:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:03 INFO - 'NO_EM_RESTART': '1', 05:37:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:03 INFO - 'PWD': '/builds/slave/test', 05:37:03 INFO - 'SHELL': '/bin/bash', 05:37:03 INFO - 'SHLVL': '1', 05:37:03 INFO - 'TERM': 'linux', 05:37:03 INFO - 'TMOUT': '86400', 05:37:03 INFO - 'USER': 'cltbld', 05:37:03 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', 05:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:03 INFO - '_': '/tools/buildbot/bin/python'} 05:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:03 INFO - Downloading/unpacking jsonschema==2.5.1 05:37:03 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 05:37:03 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 05:37:03 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 05:37:03 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 05:37:03 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 05:37:03 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 05:37:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:37:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:37:05 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 05:37:05 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 05:37:05 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 05:37:05 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 05:37:05 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 05:37:05 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 05:37:05 INFO - Downloading functools32-3.2.3-2.tar.gz 05:37:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:37:05 INFO - warning: no files found matching '*.txt' 05:37:05 INFO - no previously-included directories found matching 'build' 05:37:05 INFO - no previously-included directories found matching 'dist' 05:37:05 INFO - no previously-included directories found matching '.git*' 05:37:05 INFO - Installing collected packages: jsonschema, functools32 05:37:05 INFO - Running setup.py install for functools32 05:37:06 INFO - warning: no files found matching '*.txt' 05:37:06 INFO - no previously-included directories found matching 'build' 05:37:06 INFO - no previously-included directories found matching 'dist' 05:37:06 INFO - no previously-included directories found matching '.git*' 05:37:06 INFO - Successfully installed jsonschema functools32 05:37:06 INFO - Cleaning up... 05:37:06 INFO - Return code: 0 05:37:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:37:06 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')]} 05:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:06 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')]} 05:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:06 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 0x7f8ee5700f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a62e0>, '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 0x1212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12125d0>, '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': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', '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 05:37:06 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 05:37:06 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 05:37:06 INFO - Using env: {'DISPLAY': ':0', 05:37:06 INFO - 'HOME': '/home/cltbld', 05:37:06 INFO - 'LANG': 'en_US.UTF-8', 05:37:06 INFO - 'LANGUAGE': 'en_US:en', 05:37:06 INFO - 'LOGNAME': 'cltbld', 05:37:06 INFO - 'MAIL': '/var/mail/cltbld', 05:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:06 INFO - 'MOZ_NO_REMOTE': '1', 05:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:06 INFO - 'NO_EM_RESTART': '1', 05:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:06 INFO - 'PWD': '/builds/slave/test', 05:37:06 INFO - 'SHELL': '/bin/bash', 05:37:06 INFO - 'SHLVL': '1', 05:37:06 INFO - 'TERM': 'linux', 05:37:06 INFO - 'TMOUT': '86400', 05:37:06 INFO - 'USER': 'cltbld', 05:37:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', 05:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:06 INFO - '_': '/tools/buildbot/bin/python'} 05:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:06 INFO - Downloading/unpacking blobuploader==1.2.4 05:37:06 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 05:37:06 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 05:37:06 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 05:37:06 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 05:37:06 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 05:37:06 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 05:37:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:37:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:37:08 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 05:37:08 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 05:37:08 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 05:37:08 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 05:37:08 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 05:37:08 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 05:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:37:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:37:08 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 05:37:08 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 05:37:08 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 05:37:08 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 05:37:08 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 05:37:08 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 05:37:09 INFO - Downloading docopt-0.6.1.tar.gz 05:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:37:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:37:09 INFO - Running setup.py install for blobuploader 05:37:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:37:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:37:09 INFO - Running setup.py install for requests 05:37:09 INFO - Running setup.py install for docopt 05:37:09 INFO - Successfully installed blobuploader requests docopt 05:37:09 INFO - Cleaning up... 05:37:09 INFO - Return code: 0 05:37:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:09 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')]} 05:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:09 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')]} 05:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:09 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 0x7f8ee5700f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a62e0>, '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 0x1212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12125d0>, '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': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', '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 05:37:09 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 05:37:09 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 05:37:09 INFO - Using env: {'DISPLAY': ':0', 05:37:09 INFO - 'HOME': '/home/cltbld', 05:37:09 INFO - 'LANG': 'en_US.UTF-8', 05:37:09 INFO - 'LANGUAGE': 'en_US:en', 05:37:09 INFO - 'LOGNAME': 'cltbld', 05:37:09 INFO - 'MAIL': '/var/mail/cltbld', 05:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:09 INFO - 'MOZ_NO_REMOTE': '1', 05:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:09 INFO - 'NO_EM_RESTART': '1', 05:37:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:09 INFO - 'PWD': '/builds/slave/test', 05:37:09 INFO - 'SHELL': '/bin/bash', 05:37:09 INFO - 'SHLVL': '1', 05:37:09 INFO - 'TERM': 'linux', 05:37:09 INFO - 'TMOUT': '86400', 05:37:09 INFO - 'USER': 'cltbld', 05:37:09 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', 05:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:09 INFO - '_': '/tools/buildbot/bin/python'} 05:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:09 INFO - Running setup.py (path:/tmp/pip-CTamAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:10 INFO - Running setup.py (path:/tmp/pip-SeiReF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:10 INFO - Running setup.py (path:/tmp/pip-CyBupU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:37:10 INFO - Running setup.py (path:/tmp/pip-_pu_PV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:37:10 INFO - Running setup.py (path:/tmp/pip-55jugk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:37:10 INFO - Running setup.py (path:/tmp/pip-8d2Z1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:37:10 INFO - Running setup.py (path:/tmp/pip-elJzmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:37:10 INFO - Running setup.py (path:/tmp/pip-nnSRcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:37:10 INFO - Running setup.py (path:/tmp/pip-nLNtA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:37:10 INFO - Running setup.py (path:/tmp/pip-rZhL34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:37:10 INFO - Running setup.py (path:/tmp/pip-5Ke7LV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:37:10 INFO - Running setup.py (path:/tmp/pip-uLERBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:37:10 INFO - Running setup.py (path:/tmp/pip-VJGVw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:37:10 INFO - Running setup.py (path:/tmp/pip-KlLsKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:10 INFO - Running setup.py (path:/tmp/pip-ag4X0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:37:11 INFO - Running setup.py (path:/tmp/pip-B6IrqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:37:11 INFO - Running setup.py (path:/tmp/pip-I9NsOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:37:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:37:11 INFO - Running setup.py install for manifestparser 05:37:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:37:11 INFO - Running setup.py install for mozcrash 05:37:11 INFO - Running setup.py install for mozdebug 05:37:11 INFO - Running setup.py install for mozdevice 05:37:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:37:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:37:11 INFO - Running setup.py install for mozfile 05:37:11 INFO - Running setup.py install for mozhttpd 05:37:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:37:11 INFO - Running setup.py install for mozinfo 05:37:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:37:11 INFO - Running setup.py install for mozInstall 05:37:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:37:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:37:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:37:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:37:11 INFO - Running setup.py install for mozleak 05:37:12 INFO - Running setup.py install for mozlog 05:37:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Running setup.py install for moznetwork 05:37:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Running setup.py install for mozprocess 05:37:12 INFO - Running setup.py install for mozprofile 05:37:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Running setup.py install for mozrunner 05:37:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Running setup.py install for mozscreenshot 05:37:12 INFO - Running setup.py install for moztest 05:37:12 INFO - Running setup.py install for mozversion 05:37:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:37:12 INFO - Cleaning up... 05:37:12 INFO - Return code: 0 05:37:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:12 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')]} 05:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:12 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')]} 05:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:12 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 0x7f8ee5700f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a62e0>, '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 0x1212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12125d0>, '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': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', '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 05:37:12 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 05:37:12 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 05:37:12 INFO - Using env: {'DISPLAY': ':0', 05:37:12 INFO - 'HOME': '/home/cltbld', 05:37:12 INFO - 'LANG': 'en_US.UTF-8', 05:37:12 INFO - 'LANGUAGE': 'en_US:en', 05:37:12 INFO - 'LOGNAME': 'cltbld', 05:37:12 INFO - 'MAIL': '/var/mail/cltbld', 05:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:12 INFO - 'MOZ_NO_REMOTE': '1', 05:37:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:12 INFO - 'NO_EM_RESTART': '1', 05:37:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:12 INFO - 'PWD': '/builds/slave/test', 05:37:12 INFO - 'SHELL': '/bin/bash', 05:37:12 INFO - 'SHLVL': '1', 05:37:12 INFO - 'TERM': 'linux', 05:37:12 INFO - 'TMOUT': '86400', 05:37:12 INFO - 'USER': 'cltbld', 05:37:12 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', 05:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:12 INFO - '_': '/tools/buildbot/bin/python'} 05:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:13 INFO - Running setup.py (path:/tmp/pip-Rvg5CC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:13 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)) 05:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:13 INFO - Running setup.py (path:/tmp/pip-qpnjGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:13 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)) 05:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:13 INFO - Running setup.py (path:/tmp/pip-bad_jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:13 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)) 05:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:37:13 INFO - Running setup.py (path:/tmp/pip-v3bN71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:37:13 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)) 05:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:37:13 INFO - Running setup.py (path:/tmp/pip-Lm8rbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:37:13 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)) 05:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:37:13 INFO - Running setup.py (path:/tmp/pip-0FwFVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:37:13 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)) 05:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:37:13 INFO - Running setup.py (path:/tmp/pip-e8g1Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:37:13 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)) 05:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:37:13 INFO - Running setup.py (path:/tmp/pip-tsKKSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:37:13 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)) 05:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:37:13 INFO - Running setup.py (path:/tmp/pip-P7xO5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:37:13 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)) 05:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:37:13 INFO - Running setup.py (path:/tmp/pip-SM0T7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:37:13 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)) 05:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:37:13 INFO - Running setup.py (path:/tmp/pip-fAra2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:37:13 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)) 05:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:37:14 INFO - Running setup.py (path:/tmp/pip-Q1XSTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:37:14 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)) 05:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:37:14 INFO - Running setup.py (path:/tmp/pip-2aZXmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:37:14 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)) 05:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:37:14 INFO - Running setup.py (path:/tmp/pip-cnOebr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:37:14 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)) 05:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:14 INFO - Running setup.py (path:/tmp/pip-h7FuA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:14 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)) 05:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:37:14 INFO - Running setup.py (path:/tmp/pip-OJewez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:37:14 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)) 05:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:37:14 INFO - Running setup.py (path:/tmp/pip-CHQGDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:37:14 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)) 05:37:14 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)) 05:37:14 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)) 05:37:14 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)) 05:37:14 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)) 05:37:14 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)) 05:37:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:37:14 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 05:37:14 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 05:37:14 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 05:37:14 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 05:37:14 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 05:37:14 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 05:37:16 INFO - Downloading blessings-1.6.tar.gz 05:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:37:16 INFO - Installing collected packages: blessings 05:37:16 INFO - Running setup.py install for blessings 05:37:16 INFO - Successfully installed blessings 05:37:16 INFO - Cleaning up... 05:37:18 INFO - Return code: 0 05:37:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:37:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:37:18 INFO - Reading from file tmpfile_stdout 05:37:18 INFO - Current package versions: 05:37:18 INFO - argparse == 1.2.1 05:37:18 INFO - blessings == 1.6 05:37:18 INFO - blobuploader == 1.2.4 05:37:18 INFO - docopt == 0.6.1 05:37:18 INFO - functools32 == 3.2.3-2 05:37:18 INFO - jsonschema == 2.5.1 05:37:18 INFO - manifestparser == 1.1 05:37:18 INFO - mozInstall == 1.12 05:37:18 INFO - mozcrash == 0.17 05:37:18 INFO - mozdebug == 0.1 05:37:18 INFO - mozdevice == 0.48 05:37:18 INFO - mozfile == 1.2 05:37:18 INFO - mozhttpd == 0.7 05:37:18 INFO - mozinfo == 0.9 05:37:18 INFO - mozleak == 0.1 05:37:18 INFO - mozlog == 3.2 05:37:18 INFO - moznetwork == 0.27 05:37:18 INFO - mozprocess == 0.22 05:37:18 INFO - mozprofile == 0.28 05:37:18 INFO - mozrunner == 6.11 05:37:18 INFO - mozscreenshot == 0.1 05:37:18 INFO - mozsystemmonitor == 0.3 05:37:18 INFO - moztest == 0.7 05:37:18 INFO - mozversion == 1.4 05:37:18 INFO - psutil == 3.1.1 05:37:18 INFO - requests == 1.2.3 05:37:18 INFO - wsgiref == 0.1.2 05:37:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37: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')]} 05:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:18 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 0x7f8ee5700f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a62e0>, '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 0x1212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12125d0>, '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': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', '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 05:37:18 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 05:37:18 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 05:37:18 INFO - Using env: {'DISPLAY': ':0', 05:37:18 INFO - 'HOME': '/home/cltbld', 05:37:18 INFO - 'LANG': 'en_US.UTF-8', 05:37:18 INFO - 'LANGUAGE': 'en_US:en', 05:37:18 INFO - 'LOGNAME': 'cltbld', 05:37:18 INFO - 'MAIL': '/var/mail/cltbld', 05:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:18 INFO - 'MOZ_NO_REMOTE': '1', 05:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:18 INFO - 'NO_EM_RESTART': '1', 05:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:18 INFO - 'PWD': '/builds/slave/test', 05:37:18 INFO - 'SHELL': '/bin/bash', 05:37:18 INFO - 'SHLVL': '1', 05:37:18 INFO - 'TERM': 'linux', 05:37:18 INFO - 'TMOUT': '86400', 05:37:18 INFO - 'USER': 'cltbld', 05:37:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', 05:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:18 INFO - '_': '/tools/buildbot/bin/python'} 05:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:18 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)) 05:37:18 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)) 05:37:18 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)) 05:37:18 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)) 05:37:18 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)) 05:37:18 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)) 05:37:18 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)) 05:37:18 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)) 05:37:18 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)) 05:37:18 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)) 05:37:18 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)) 05:37:18 INFO - Cleaning up... 05:37:18 INFO - Return code: 0 05:37:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:37: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')]} 05:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee5700f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a62e0>, '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 0x1212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12125d0>, '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': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', '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 05:37: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', 'jsonschema'] in /builds/slave/test/build 05:37: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 jsonschema 05:37:18 INFO - Using env: {'DISPLAY': ':0', 05:37:18 INFO - 'HOME': '/home/cltbld', 05:37:18 INFO - 'LANG': 'en_US.UTF-8', 05:37:18 INFO - 'LANGUAGE': 'en_US:en', 05:37:18 INFO - 'LOGNAME': 'cltbld', 05:37:18 INFO - 'MAIL': '/var/mail/cltbld', 05:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:18 INFO - 'MOZ_NO_REMOTE': '1', 05:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:18 INFO - 'NO_EM_RESTART': '1', 05:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:18 INFO - 'PWD': '/builds/slave/test', 05:37:18 INFO - 'SHELL': '/bin/bash', 05:37:18 INFO - 'SHLVL': '1', 05:37:18 INFO - 'TERM': 'linux', 05:37:18 INFO - 'TMOUT': '86400', 05:37:18 INFO - 'USER': 'cltbld', 05:37:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', 05:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:18 INFO - '_': '/tools/buildbot/bin/python'} 05:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:37:18 INFO - Cleaning up... 05:37:18 INFO - Return code: 0 05:37:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:37: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')]} 05:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee5700f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a62e0>, '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 0x1212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12125d0>, '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': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', '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 05:37: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', 'flake8'] in /builds/slave/test/build 05:37: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 flake8 05:37:18 INFO - Using env: {'DISPLAY': ':0', 05:37:18 INFO - 'HOME': '/home/cltbld', 05:37:18 INFO - 'LANG': 'en_US.UTF-8', 05:37:18 INFO - 'LANGUAGE': 'en_US:en', 05:37:18 INFO - 'LOGNAME': 'cltbld', 05:37:18 INFO - 'MAIL': '/var/mail/cltbld', 05:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:18 INFO - 'MOZ_NO_REMOTE': '1', 05:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:18 INFO - 'NO_EM_RESTART': '1', 05:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:18 INFO - 'PWD': '/builds/slave/test', 05:37:18 INFO - 'SHELL': '/bin/bash', 05:37:18 INFO - 'SHLVL': '1', 05:37:18 INFO - 'TERM': 'linux', 05:37:18 INFO - 'TMOUT': '86400', 05:37:18 INFO - 'USER': 'cltbld', 05:37:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', 05:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:18 INFO - '_': '/tools/buildbot/bin/python'} 05:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:19 INFO - Downloading/unpacking flake8 05:37:19 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 05:37:19 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 05:37:19 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 05:37:19 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 05:37:19 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 05:37:19 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 05:37:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:37:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:37:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:37:22 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 05:37:22 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 05:37:22 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 05:37:22 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 05:37:22 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 05:37:22 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 05:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:37:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:37:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:37:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:37:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:37:22 INFO - no previously-included directories found matching 'docs/_build' 05:37:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:37:22 INFO - Running setup.py install for pep8 05:37:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:37:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:37:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:37:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:37:22 INFO - no previously-included directories found matching 'docs/_build' 05:37:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:37:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:37:22 INFO - Cleaning up... 05:37:23 INFO - Return code: 0 05:37:23 INFO - Running post-action listener: _resource_record_post_action 05:37:23 INFO - Running post-action listener: _start_resource_monitoring 05:37:23 INFO - Starting resource monitoring. 05:37:23 INFO - ##### 05:37:23 INFO - ##### Finished create-virtualenv step (success) 05:37:23 INFO - ##### 05:37:23 INFO - ##### 05:37:23 INFO - ##### Running install step. 05:37:23 INFO - ##### 05:37:23 INFO - Running pre-action listener: _resource_record_pre_action 05:37:23 INFO - Running main action method: install 05:37:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:37:23 INFO - Reading from file tmpfile_stdout 05:37:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:37:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:37:24 INFO - Reading from file tmpfile_stdout 05:37:24 INFO - Output received: 05:37:24 INFO - Usage: mozinstall [options] installer 05:37:24 INFO - Options: 05:37:24 INFO - -h, --help show this help message and exit 05:37:24 INFO - -d DEST, --destination=DEST 05:37:24 INFO - Directory to install application into. [default: 05:37:24 INFO - "/builds/slave/test"] 05:37:24 INFO - --app=APP Application being installed. [default: firefox] 05:37:24 INFO - mkdir: /builds/slave/test/build/application 05:37:24 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'] 05:37:24 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 05:37:40 INFO - Reading from file tmpfile_stdout 05:37:40 INFO - Output received: 05:37:40 INFO - /builds/slave/test/build/application/firefox/firefox 05:37:40 INFO - Running post-action listener: _resource_record_post_action 05:37:40 INFO - ##### 05:37:40 INFO - ##### Finished install step (success) 05:37:40 INFO - ##### 05:37:40 INFO - ##### 05:37:40 INFO - ##### Running run-tests step. 05:37:40 INFO - ##### 05:37:40 INFO - Running pre-action listener: _resource_record_pre_action 05:37:40 INFO - Running main action method: run_tests 05:37:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:37:40 INFO - Python 2.7.3 05:37:40 INFO - Return code: 0 05:37:40 INFO - grabbing minidump binary from tooltool 05:37:40 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')]} 05:37:40 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 0x12a62e0>, '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 0x1212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12125d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:37:40 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 05:37:40 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 05:37:40 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 05:37:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:37:40 INFO - Return code: 0 05:37:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:37:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:37:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:37:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:37:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:37:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:37:41 INFO - Return code: 0 05:37:41 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/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 05:37:41 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/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 05:37:41 INFO - Using env: {'DISPLAY': ':0', 05:37:41 INFO - 'HOME': '/home/cltbld', 05:37:41 INFO - 'LANG': 'en_US.UTF-8', 05:37:41 INFO - 'LANGUAGE': 'en_US:en', 05:37:41 INFO - 'LOGNAME': 'cltbld', 05:37:41 INFO - 'MAIL': '/var/mail/cltbld', 05:37:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:37:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:41 INFO - 'MOZ_NO_REMOTE': '1', 05:37:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:37:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:41 INFO - 'NO_EM_RESTART': '1', 05:37:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:41 INFO - 'PWD': '/builds/slave/test', 05:37:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:37:41 INFO - 'SHELL': '/bin/bash', 05:37:41 INFO - 'SHLVL': '1', 05:37:41 INFO - 'TERM': 'linux', 05:37:41 INFO - 'TMOUT': '86400', 05:37:41 INFO - 'USER': 'cltbld', 05:37:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698', 05:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:41 INFO - '_': '/tools/buildbot/bin/python'} 05:37:41 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/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 05:37:41 INFO - mozversion application_buildid: 20160608045729 05:37:41 INFO - mozversion application_changeset: 71d424246fe1149948c8054a4392feea87dfd0ad 05:37:41 INFO - mozversion application_display_name: Nightly 05:37:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:37:41 INFO - mozversion application_name: Firefox 05:37:41 INFO - mozversion application_remotingname: firefox 05:37:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:37:41 INFO - mozversion application_vendor: Mozilla 05:37:41 INFO - mozversion application_version: 50.0a1 05:37:41 INFO - mozversion platform_buildid: 20160608045729 05:37:41 INFO - mozversion platform_changeset: 71d424246fe1149948c8054a4392feea87dfd0ad 05:37:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:37:41 INFO - mozversion platform_version: 50.0a1 05:37:41 INFO - using testdate: 1465389461 05:37:41 INFO - actual date: 1465389461 05:37:41 INFO - starting webserver on 'localhost:34319' 05:37:41 INFO - SUITE-START | Running 2 tests 05:37:41 INFO - TEST-START | dromaeo_css 05:37:41 INFO - operating with platform_type : linux_ 05:37:41 INFO - Initialising browser for dromaeo_css test... 05:37:41 INFO - TEST-INFO | started process 9794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjxcY94/profile http://localhost:34319/getInfo.html) 05:37:48 INFO - PROCESS | 9794 | __metrics Screen width/height:1600/1200 05:37:48 INFO - PROCESS | 9794 | colorDepth:24 05:37:48 INFO - PROCESS | 9794 | Browser inner width/height: 1024/697 05:37:48 INFO - PROCESS | 9794 | __metrics 05:37:48 ERROR - PROCESS | 9794 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:37:49 INFO - TEST-INFO | 9794: exit 0 05:37:49 INFO - Browser initialized. 05:37:49 INFO - Running cycle 1/1 for dromaeo_css test... 05:37:49 INFO - TEST-INFO | started process 9912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjxcY94/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:01 INFO - PROCESS | 9912 | RSS: Main: 168030208 05:38:01 INFO - PROCESS | 9912 | 05:38:51 INFO - PROCESS | 9912 | 1465389531203 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] 05:41:04 INFO - PROCESS | 9912 | Cycle 1(1): loaded http://localhost:34319/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34319/tests/dromaeo/cssquery-ext.html) 05:41:05 INFO - PROCESS | 9912 | RSS: Main: 168939520 05:41:05 INFO - PROCESS | 9912 | 05:44:07 INFO - PROCESS | 9912 | Cycle 1(1): loaded http://localhost:34319/tests/dromaeo/cssquery-ext.html (next: http://localhost:34319/tests/dromaeo/cssquery-jquery.html) 05:44:08 INFO - PROCESS | 9912 | RSS: Main: 170496000 05:44:08 INFO - PROCESS | 9912 | 05:47:10 INFO - PROCESS | 9912 | Cycle 1(1): loaded http://localhost:34319/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34319/tests/dromaeo/cssquery-mootools.html) 05:47:10 INFO - PROCESS | 9912 | RSS: Main: 172048384 05:47:10 INFO - PROCESS | 9912 | 05:50:12 INFO - PROCESS | 9912 | Cycle 1(1): loaded http://localhost:34319/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34319/tests/dromaeo/cssquery-prototype.html) 05:50:13 INFO - PROCESS | 9912 | RSS: Main: 169418752 05:50:13 INFO - PROCESS | 9912 | 05:53:16 INFO - PROCESS | 9912 | Cycle 1(1): loaded http://localhost:34319/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34319/tests/dromaeo/cssquery-yui.html) 05:53:16 INFO - PROCESS | 9912 | RSS: Main: 171991040 05:53:16 INFO - PROCESS | 9912 | 05:56:19 INFO - PROCESS | 9912 | Cycle 1(1): loaded http://localhost:34319/tests/dromaeo/cssquery-yui.html (next: http://localhost:34319/tests/dromaeo/cssquery-dojo.html) 05:56:19 INFO - PROCESS | 9912 | RSS: Main: 172777472 05:56:19 INFO - PROCESS | 9912 | 05:56:19 INFO - PROCESS | 9912 | __start_tp_report 05:56:19 INFO - PROCESS | 9912 | _x_x_mozilla_page_load 05:56:19 INFO - PROCESS | 9912 | _x_x_mozilla_page_load_details 05:56:19 INFO - PROCESS | 9912 | |i|pagename|runs| 05:56:19 INFO - PROCESS | 9912 | |0;dojo.html;2686.9731302686973;2743.8765255563503;2761.4201017786263;2765.6128142060115;2778.8054836161464;4767.737774422401;4810.1582223110945;4849.9515004849945;4893.29047288143;4942.703437793726;4712.5758681718635;4819.3734814474155;4825.951740482594;4847.975760121203;4851.563359297663;4392.582704643054;4413.0732546165345;4486.080353527535;4519.52544982777;4528.252838281696;4224.894377640569;4524.6380289576755;4548.613367863719;4614.284785858181;4621.514740952202;4353.41228934093;4390.100029493946;4397.31841564558;4419.204543182258;4496.348029535699;4357.346398040288;4358.8910277243;4420.447444069491;4425.424694789689;4445.555444455528;4428.3578881062385;4431.2466880630045;4439.75581343026;4443;4465.263231566788;4704.811807527695;4747.501512341223;4751.192297309466;4777.904441911177;4790.329353890458;5171.793128274864;5175.223716442526;5180.119379705459;5199.1161502544655;5242.501962313574;5048.444671086178;5214.6871187728475;5215.426303106655;5215.660982036194;5219.921701174486;4873.269009648581;4885.755712214375;4905.484924082992;4906.779194936236;4957.355543779286;5397.10947693634;5400.1899715043055;5407.459254074561;5420;5453.863653408617;4952.281919121707;5067.265246539231;5078.695278283315;5161.329027226437;5164.0188364211435;5010.223415370623;5167.302414174038;5185.222216667455;5211.218317252443;5237.057329680694;5159;5185.196294574347;5201.947980520222;5205.349331333583;5207.1668533034535;4974.253861920669;5069.543741063322;5112.3865136183895;5142.537171654494;5212.4266330703595;4375.912481750347;4396.384506169139;4397.142557201315;4442.089371678862;4457.754823484739;3801.4297855321925;3807.5240594925635;3835.6547910688173;3846.4999550058874;3894.6494815466745;4373.475182978063;4433.246348120762;4466.57567531084;4478.910421791546;4479.59683628475;5167.302414174038;5209.645492171987;5213.348331458567;5225.477452254744;5256.500632439988;4457.375967364572;4468.731876087445;4476.26141686618;4499;4524.660650451229;4549.067441174618;4668.929966050512;4710.199266124767;4713.033828065307;4720.197566413718;4915.8033678652455;4917.139500587455;4930.950690493192;4950.851474455772;4970.155073637418;5123.974380128076;5260.815871444481;5281.577473802164;5283.524482796567;5334.599905007062;4779.641526885428;4805;4805.831795887128;4809.062232864558;4828.179209534458;5041.269015992734;5041.395032596112;5046.419661738947;5046.674301124884;5092.490750924878;5054.873628159178;5113;5126.154184559506;5150.948490515047;5172.19830926207;4943.555080042814;5009.273655319886;5022.045811295842;5047.848564543069;5057.974710126573;5003.424606170337;5077.111505486599;5079.593632509464;5111.488851114858;5116.667416617908;4886.267059941038;4977.427595826526;4981.402231732215;4988.975055124701;4998.100341938486;5113.233015047773;5136.332276803992;5140.537351638221;5140.794368225379;5198.038362902875;4973.602111831117;5019.573336266459;5029.74851257443;5038.672486288379;5086.669366491166 05:56:19 INFO - PROCESS | 9912 | |1;ext.html;549.1301389833802;582.5485248932077;586.2466730251627;589.7994681808187;596.9493691103658;40311.19377612446;41613.375799363035;42000.57999420009;45544.54455455444;45683.31475027869;41637.58362416375;42757.7862110689;42798;42853.78573107138;42868.785656071756;7761.689532418696;7900.446968712193;7983.201679831999;7987.201279871995;8002.759917202464;7751.069871615386;7837;7876.763697089068;7892.842143157133;7894.4868583542175;7876.803079923019;7895.763127106196;7923.484973476734;7934.087579928324;7949.284564389204;7871.5277083374895;7909.050913890313;7935.603219839014;7943.364530837519;7968.362530997506;7750.651220695082;7774.105977812511;7842.137364889858;7866.370690344758;7876.72431464896;39363.212735745125;39524.20951580981;39570.20859582821;39682.20635587301;39931.40102898459;2876.798624096314;2890.132960111958;3051.6948305169526;3059.632844058705;3141.748660107186;28590.428191436054;28791.424171516453;29327.12018639444;29709.851450742608;30231.395372092655;3477.7043951264172;3479.5128681984543;3540.6105328413855;3600.981995090008;3602.3155600435834;252729;254533.727331364;254786;255114;255849;32189.678103219136;55826.441735582936;55918.720406397704;56316.43683563194;56332.43667563272;32758.344833103205;34393.140171495914;34504.65495345065;34555.65444345574;34790.47814282788;14038.649033774238;14212;14262.714745705029;14266.42934282617;14331.498397556245;11706.473208705629;11828.526858925547;11839.644810655695;11845.289282643069;11915.582954596548;7927.762167134995;7979.4813337134065;8039.557824319719;8072.717454889051;8094.595270236465;3146.575212346304;3150.684931506831;3197.8560964756643;3197.888073917402;3220.6457289698114;896.4397251717677;918.1919910478736;929.9860502092474;998.3610489286863;1069.8288273876142;27614;28078.71921280761;28376;28623.856880715462;28734.856325718236;946.5503885654397;977.8728765260613;984.1241295247236;985.4333758088984;996.3623281100101;14386.712265754835;14769.409223630935;14833.332500037524;15122.697546049018;15150.621234469227;389247;389649;393657;393719;395348;51079.48920510821;51112.74443627832;51133.23300150501;51437.48562514402;51647.225291620656;1172.6775136837268;1242.9813552796716;1260.7352455984162;1268.7081971146504;1276.2087505746497;25765.613515797653;27252;27669.86165069162;27807.860960695067;28031.159065228076;42788;42865.78567107145;43496;43558.346624801285;43653.56346436495;338712;340855;340996;342159;342584;25767.742322577284;25982.610260845726;26073.73926260713;26226.344341391617;26377.472450550496;43049.139017218855;43101.78449107734;43755.78122109496;44099;44433.77783111064;37328.62671373251;37496;37600.43599345957;37647.81176094102;37712.81143594265;36874.44688329731;36880;37079.25841483101;37361.25277494489;37842.81078594589;31486.842565787025;36273.637263627024;36330.455043173846;36833.71082012117;36985;28851.7114828849;33173.66826331706;33347.33305333831;33352.49971250482;33495.665043349254;24758.752412475646;25374.492510150063;25607.359816004748;25784;25969 05:56:19 INFO - PROCESS | 9912 | |2;jquery.html;369.4071016019289;370.327854943278;381.30221694299416;390.7011136480591;392.8153767729168;15946.681066378665;16225.756613650805;16960.83039169608;17073.317067317294;17110.058946757923;15941.601459963507;16004.439844605442;16629.584260393498;16756.916215418936;17737.733933991;4374.825006999724;4556.270996640522;4592.517785632511;4592.931106033412;4596.931046034296;3344.7825891317107;6713.731450741989;7119.9288007119785;7130.2513236110235;7136.036635054254;6885.001674757183;6963.303669633046;6995.510314278003;7080.362767350937;7091.85816283674;6696.125084976215;6947.2358040615745;6958.478114141409;6994.0907682001525;7000.124984376953;6868.862622747567;6895.896561551581;6904.240533541307;6911.343422374866;6930.20302665195;21918.23286184992;22632.547349053093;22851;23884.16405425819;24044.639330410057;1922.7884932657396;2015.4860510569858;2045.2841505473114;2108.1883474862134;2136.2629892686996;13297.069205155643;14146.434142634282;14206.644833879132;14791.40834366624;14982.850171498254;1713.7258038713746;1904.4857888370063;1922.5866438715602;1924.0956750327323;1941.7378653881685;48949;49657.255141172915;49707.75146124282;62545.68727156381;83985.58007209985;8344.332453403713;8682.956585217033;8868;9242.491662958468;9337.719868403823;12121.757564848655;12160.14878958482;12202.633920982385;12206.023518118707;12222.694432639255;7215.206327303992;7295.270472952662;7323.670434830446;7431.071116110486;7460.664270107858;7181.8922716159295;7230.421566274686;7410.888836667346;7528.811779705442;7531.3598344141365;3743.1577894973957;3797.240551889633;3810.657040866335;3892.4355968384425;4049.91900162001;1749.2041121289783;1807.1325763633267;1843.271907596492;1880.2103116691023;1900.5058684741791;812.8861959325699;866.4021824940771;878.4026861733954;945.4421891084294;952.8613307097951;15302.923485382724;16134.273957671932;16592.917035414746;16842.663146736995;16877.66244675124;844.7212419901418;879.2702057292432;908.2189317187214;918.008550765172;930.5161316115717;9283.58223879927;9357.20463760588;9559.569819358006;9657;9674.686546933277;377511;379583;387585;396758;402647;75654;82044;87076.56461717651;87605.561972191;88615.55692221498;940.8024314893812;966.2801213096288;979.4319294808994;979.7305740921161;988.4464699768153;15492.380304787683;15781.921090394475;15837.287322070764;16006.279717412977;16131.596710081873;35559.64440355667;36830.263394732494;37364.94492802922;38069.23861522698;38154.375334343196;50015.749921250164;50224.497755021985;51172.232416514526;51254.487455124974;52039.219411708094;7105.57888422328;7137.321954414322;7169;7494.6252687366505;7552.169261381134;11006.449677516252;11552.82670759956;12215.144939854124;12259.448324825225;12278.631641050782;10083.747906302402;10188.184945204217;10319.277650564389;10343.18994176001;10460.47697615101;10597.89402106;10601.098906593026;10665.840012399975;10783.137349011904;10934.289271197347;9886.653967111117;10184.439855807705;10265.486725663837;10353.63762268317;10525.9473702631;7517.511361761468;7605.125410577633;7659.157492675913;7780.455368124177;7837.568933708701;9581.520923953914;9667.70996870095;9820.950895245478;9915.702528924145;9928.503574821374 05:56:19 INFO - PROCESS | 9912 | |3;mootools.html;1416.079548293609;1446.07451231212;1585.3500064973357;1782.2870851659343;1797.7393277974686;6914.101166848315;7672.079350477943;7830.138684744674;8185.549794761286;8207.097219305871;7920.16838231986;8099.311558517518;8124.634391452384;8198.139195384474;8207.261346478816;2161.5136594266323;2192.013593882751;2208.116753298685;2212.4468882779306;2214.2250212425683;2177;2180.4548862784304;2240.9215677451293;2257.3679369776487;2261.525079733258;2190.156789635994;2193.2104442400723;2216.612092883739;2220.2673117871145;2225.9888700556476;2153.8384621153477;2177.7495588007423;2179.4660308224506;2182.68351089092;2197.6703494475796;1971.5465442948203;1980.9108590113478;1990.1939714415685;2165.2962787094098;2184.377452426051;8097.35221182304;8121.106678265386;8124.86251924731;8133.146019667909;8133.511989280662;4638.907221855544;4751.097291514636;4755.2153894607345;4760.404949381327;4761.4524329701835;2855.728705772948;2949.174231215242;3023.183740390082;3029.8182109073527;3039.6200474940633;904.2449554621899;946.9384490008197;947.5783276441986;949.4588084791671;1008.037324355239;11301.547938082467;11326.660200194008;11326.943365283121;11336.999999999918;11364.374959377232;4140.792960351971;4252.043290259667;4287.849925252601;4316.697831151852;4355.956440435555;9511.66709165176;9532.332736708364;9534.713958581253;9536.380135291183;9590.568424420917;4760.690555113906;4835;4836.637252206098;4837.250226214942;4848.0788650156355;3586.103474131467;4115.176964607091;4234.745915245096;4407.140607581491;4409.184300904343;3645.5625324960643;3651.123730304761;3736.551613806361;3747.3442147624055;3765.077555998798;1175.2595864605244;1176.858776946772;1205.5539450403407;1211.715246916974;1216.227695413401;687.8830598798216;858.5878778186506;862.6376921692904;865.260202526843;889;5310.309659744208;5495.175723641486;5500.339959204841;5517.310336207974;5558.221848941152;407.5333742864463;409.29192496979795;411.37676420223386;416.2133567557319;422.23364593263744;3485.0938755923135;3498.930021399558;3522.8238588070494;3522.876699315512;3525.94711079334;9522.428654280766;9742.902570974342;9818.95090524557;9971.252156088321;9991.050850169222;9864.950675246579;9868.80262394748;9917;9922.156616687518;9978.700638980843;7508.211637777955;7518.436117291225;7586.468947173756;7698.923010769932;7705.383569314441;5277.102892508359;5379.1662292344745;5414.810481633124;5483.2323474712775;5547.41752116022;8826.470411775314;9155.450672959643;9158.084191581054;9251.953740231256;9389.248860091313;9283.442993420416;9356.345055846026;9380.20268277204;9389.201917837061;9438.716838494582;5989.431004054608;6621.437177839937;6656.068150458843;6759.425448836707;6815.795526134224;7851;7863.960680196562;7881.802954925944;7884.132745398117;7895.960520197592;6898.896516552155;7011.859762804817;7072.3634872861685;7091.11361079865;7167.175774785758;6930.064441300561;6952.687129079102;6987.266337034538;6991.755288564876;7047.471439641945;6395.968020159869;6406.263279722705;6439.388258115471;6446.226452825691;6456.096146539582;4561.749103799323;4621.468531118964;4656.254999200111;4690.061987602425;4733.952660473351;4690.202665546797;4742.170120229015;4746.050789841976;4759.1671457495495;4760.833370832004 05:56:19 INFO - PROCESS | 9912 | |4;prototype.html;285.4633289415898;289.7088426131737;293.3692560993863;299.9130252226854;299.9565063065854;5060.822871199509;5073.7209453480045;5091.669041512299;5106.6935983840995;5128.9230661540105;4999.500049994998;5015.7492125393765;5036.420811606667;5043.067032598962;5055.9747201263945;3644.81775911204;3771.9819896355457;3873.825677844504;3882.8835134946;3885.417187421881;3857.9035524111982;3884.5726970033274;3884.59211782763;3893.299206142893;3900.8049597520153;3803.5055442792536;3807.7905715185652;3823.808809559525;3877.1276462795927;3878.146807702301;3747.3629482987685;3782.8486860525823;3845.788481633509;3855.47951026612;3897.279003384355;3335.616404113534;3336.516205150264;3342.782719123249;3345.1637090727318;3374.8312584370683;4782.234842425195;4785.66500344976;4788.3056956741075;4804.471508134103;4856.858638220016;4381.518033016366;4394.802233899451;4435.534268901783;4436.489803672586;4477.440319960005;5019.222020586778;5231.424543300234;5232.7122008289525;5247.86880327991;5269.841904742864;3651.2879988402005;3660.432632941898;3666.661668490982;3671.9265614687824;3681.9263614727556;5519.558435325164;5538.169274608801;5543.722813859331;5556.833295001197;5561.138023606348;3514.876979305712;3720.6651401374006;3735.495708079429;3740.775553466801;3748.3627783276906;3745.962540374616;3759;3762.1159027628487;3775.414810704345;3781.7541859779026;4264.914701705949;4299.720518166309;4334.783260836945;4355.259605866947;4359.648508962168;5068.16375298079;5193.272941788153;5246.501582349671;5250.97374513125;5260.28986086881;1301.4208677138583;1314.2574445438297;1319.9142055766345;1320.6962398648366;1323.0011341437153;798.2616080125977;816.3673153306116;827.2182787265975;837.1712005115014;846.9407141500159;4485.865424037219;4580.954190458119;4585.747783871919;4597.8965048388145;4610.101030299126;5394.622376433612;5477.342718873681;5489.6980666062955;5510.8071217507995;5514.255575497336;4531.43357080365;4588.403507543998;4621.60716339115;4636.076028448157;4651.2557990722;2871.9712802872123;2872.5116730155924;2916.6500019997734;2917.1831887071653;2925.254060214632;5123.8719032023755;5145.9485405146215;5155.175171972542;5167.844964651066;5184.714840683799;5467.343918729778;5598.188262701886;5606.6916319602;5612.270404847343;5629.4652008059165;5134.717590532482;5145.45972672864;5151.278820965068;5154.123798954111;5154.8969020620125;5424.891502169856;5454.536364409069;5477.1510415885605;5484.753186106555;5513.8345849624575;5182.6113041521285;5353.54494867925;5429.40276569585;5446.591505637172;5456.127019676833;5122.769475373691;5148.58811295103;5172.094883395466;5233.476652334736;5236.978789136082;3913.7887093791915;3924.1955399143676;3928.8035598220545;3943.093088589583;3954.6440820326306;5453.182022696627;5489.11821293824;5491.807786727445;5500.9273191727225;5508.834734957958;5318.627696061239;5321.148616221386;5335.626506144533;5339.572834173179;5372.811951581676;5071.974640126776;5267.894642107213;5285.260063591178;5332.440093790251;5336.759845807026;5150.871228219175;5187.429382767968;5191.76637051326;5207.3230480037355;5267.499587539178;5126.84698910175;5144.710603781281;5329.600279979095;5350.143976963823;5370.892582148414;5230.137027390438;5232.502912223333;5256.526912577886;5271.288376069181;5283.603729720363 05:56:19 INFO - PROCESS | 9912 | |5;yui.html;619.9411055949683;669.2103318084659;685.492735375822;711.5979471598547;770.6647608290394;12242.387880605967;12715.745685086293;12753.234805911652;13128.47486100556;13156;12238.694032649166;12262.693432664188;12282.692932676666;12341.753164936696;12349.444275007623;633.9144215530913;780.4536824223038;785.5090568394753;793.7856778669784;805.9032916050082;790.8457850719112;793.6904607203195;795.3478147918709;796.1282395776616;796.1839114907237;842.2630198576246;842.4397775479299;842.9367797415188;843.2789964580287;843.3759018326425;824.3652387661497;831.1522247307712;832.2592892325835;834.1200033964226;835.1398059998212;610.5878531990933;610.8320211941707;611.7767015039523;612.2652816620074;612.2928018139012;13051;13164.473421063147;13182.209067455984;13193.934030329883;13195.142315749446;12913.548025819051;13400.262985535792;13411.798823017663;13508.864911350956;13668.179909205479;10317.484125793755;10488.475576221159;10541.367517948871;10576.471176441224;10630.78738425235;3331.666833316649;3360.7647464677484;3370.1911541230174;3382.695557399821;3464.41105012146;57096.714516427564;57139.428605714245;57593.712031439994;59226.40773592295;59560.702196489176;10533.104686101615;10533.683989480327;10661.573537058586;10740.140788736882;10837.078848297826;19636.214551417783;19643.508912277022;19794.20823167086;19821.60356792856;20119.497012574804;6951.65241737911;6977.51157418986;7039.718411263492;7061.89407158893;7073.221945585981;3705.203381273039;3762.981185094057;3768.2651882882574;3799.3351163546267;3855.1133239355104;2952.704729527073;3072.7695422843376;3079.0762771169007;3084.814911105341;3087.4442600332154;500.6170279736005;515.7008934817796;527.3697930972528;539.5979994903822;539.7301349325337;475.5125995854208;517.9844604661866;525.4535283305396;534.9759260833272;536.6860386673761;7547.698092076365;7721.575313357707;7741.419393545507;7871.527708337518;7923.643436045391;461.6399208617284;479.5851588376099;506.92396140579206;511.1642464570454;523.947605239473;3510.7015903648476;3554.8222588870453;3619.2761447710564;3626.6917312028245;3668.119651283726;87630.12369876348;92777.53611231901;93040;93626;94077.52961235287;78329;81279.5936020328;82536.58731706304;82627;83296.16703833005;71865;75291.62354188303;75534.62232688801;75597.62201188959;77544;6929.792106236821;7072.71709131629;7096.53872498286;7226.4218862491925;7262.891056634049;37348.62651373452;38401.23197535978;44346.55653443424;45697;45780.31329530126;38126.237475249785;43076.78461607672;58508;62772;63244.36755632569;11353.091752659933;11643.243189192675;11646.534138634359;11660.88339116598;11685.591004315149;9484.383515071499;10042.347247428894;12108.576199832964;12176.939115304367;12204.694882628006;10210.863512528993;10659;10906.61826836057;11044.613438529614;11191.384473854016;11113.666590002313;11522.654320370402;11581.420928953687;11837.763244734884;12075.27548347102;10759.784804304027;10999.835002474809;11075.224734268846;11256.043236325004;11335.829962550733;9807.607695692092;9906.603735850773;10153.898461015295;10166.745831354276;10207.285490015925;9047.909520904706;9667;9857.408555486694;9857.654982075594;9977.102060814272 05:56:19 INFO - PROCESS | 9912 | __end_tp_report 05:56:19 INFO - PROCESS | 9912 | __start_cc_report 05:56:19 INFO - PROCESS | 9912 | _x_x_mozilla_cycle_collect,406 05:56:19 INFO - PROCESS | 9912 | __end_cc_report 05:56:19 INFO - PROCESS | 9912 | __startTimestamp1465390579560__endTimestamp 05:56:19 INFO - PROCESS | 9912 | 05:56:19 INFO - PROCESS | 9912 | ------- Summary: start ------- 05:56:19 INFO - PROCESS | 9912 | Number of tests: 6 05:56:19 INFO - PROCESS | 9912 | 05:56:19 INFO - PROCESS | 9912 | [#0] dojo.html Cycles:165 Average:4791.38 Median:4942.70 stddev:502.85 (10.2%) stddev-sans-first:476.53 05:56:19 INFO - PROCESS | 9912 | Values: 2687.0 2743.9 2761.4 2765.6 2778.8 4767.7 4810.2 4850.0 4893.3 4942.7 4712.6 4819.4 4826.0 4848.0 4851.6 4392.6 4413.1 4486.1 4519.5 4528.3 4224.9 4524.6 4548.6 4614.3 4621.5 4353.4 4390.1 4397.3 4419.2 4496.3 4357.3 4358.9 4420.4 4425.4 4445.6 4428.4 4431.2 4439.8 4443.0 4465.3 4704.8 4747.5 4751.2 4777.9 4790.3 5171.8 5175.2 5180.1 5199.1 5242.5 5048.4 5214.7 5215.4 5215.7 5219.9 4873.3 4885.8 4905.5 4906.8 4957.4 5397.1 5400.2 5407.5 5420.0 5453.9 4952.3 5067.3 5078.7 5161.3 5164.0 5010.2 5167.3 5185.2 5211.2 5237.1 5159.0 5185.2 5201.9 5205.3 5207.2 4974.3 5069.5 5112.4 5142.5 5212.4 4375.9 4396.4 4397.1 4442.1 4457.8 3801.4 3807.5 3835.7 3846.5 3894.6 4373.5 4433.2 4466.6 4478.9 4479.6 5167.3 5209.6 5213.3 5225.5 5256.5 4457.4 4468.7 4476.3 4499.0 4524.7 4549.1 4668.9 4710.2 4713.0 4720.2 4915.8 4917.1 4931.0 4950.9 4970.2 5124.0 5260.8 5281.6 5283.5 5334.6 4779.6 4805.0 4805.8 4809.1 4828.2 5041.3 5041.4 5046.4 5046.7 5092.5 5054.9 5113.0 5126.2 5150.9 5172.2 4943.6 5009.3 5022.0 5047.8 5058.0 5003.4 5077.1 5079.6 5111.5 5116.7 4886.3 4977.4 4981.4 4989.0 4998.1 5113.2 5136.3 5140.5 5140.8 5198.0 4973.6 5019.6 5029.7 5038.7 5086.7 05:56:19 INFO - PROCESS | 9912 | 05:56:19 INFO - PROCESS | 9912 | [#1] ext.html Cycles:180 Average:47725.82 Median:37344.94 stddev:88192.87 (236.2%) stddev-sans-first:88369.15 05:56:19 INFO - PROCESS | 9912 | Values: 549.1 582.5 586.2 589.8 596.9 40311.2 41613.4 42000.6 45544.5 45683.3 41637.6 42757.8 42798.0 42853.8 42868.8 7761.7 7900.4 7983.2 7987.2 8002.8 7751.1 7837.0 7876.8 7892.8 7894.5 7876.8 7895.8 7923.5 7934.1 7949.3 7871.5 7909.1 7935.6 7943.4 7968.4 7750.7 7774.1 7842.1 7866.4 7876.7 39363.2 39524.2 39570.2 39682.2 39931.4 2876.8 2890.1 3051.7 3059.6 3141.7 28590.4 28791.4 29327.1 29709.9 30231.4 3477.7 3479.5 3540.6 3601.0 3602.3 252729.0 254533.7 254786.0 255114.0 255849.0 32189.7 55826.4 55918.7 56316.4 56332.4 32758.3 34393.1 34504.7 34555.7 34790.5 14038.6 14212.0 14262.7 14266.4 14331.5 11706.5 11828.5 11839.6 11845.3 11915.6 7927.8 7979.5 8039.6 8072.7 8094.6 3146.6 3150.7 3197.9 3197.9 3220.6 896.4 918.2 930.0 998.4 1069.8 27614.0 28078.7 28376.0 28623.9 28734.9 946.6 977.9 984.1 985.4 996.4 14386.7 14769.4 14833.3 15122.7 15150.6 389247.0 389649.0 393657.0 393719.0 395348.0 51079.5 51112.7 51133.2 51437.5 51647.2 1172.7 1243.0 1260.7 1268.7 1276.2 25765.6 27252.0 27669.9 27807.9 28031.2 42788.0 42865.8 43496.0 43558.3 43653.6 338712.0 340855.0 340996.0 342159.0 342584.0 25767.7 25982.6 26073.7 26226.3 26377.5 43049.1 43101.8 43755.8 44099.0 44433.8 37328.6 37496.0 37600.4 37647.8 37712.8 36874.4 36880.0 37079.3 37361.3 37842.8 31486.8 36273.6 36330.5 36833.7 36985.0 28851.7 33173.7 33347.3 33352.5 33495.7 24758.8 25374.5 25607.4 25784.0 25969.0 05:56:19 INFO - PROCESS | 9912 | 05:56:19 INFO - PROCESS | 9912 | [#2] jquery.html Cycles:180 Average:24459.14 Median:4465.55 stddev:64217.41 (1438.1%) stddev-sans-first:64372.08 05:56:19 INFO - PROCESS | 9912 | Values: 369.4 370.3 381.3 390.7 392.8 15946.7 16225.8 16960.8 17073.3 17110.1 15941.6 16004.4 16629.6 16756.9 17737.7 4374.8 4556.3 4592.5 4592.9 4596.9 3344.8 6713.7 7119.9 7130.3 7136.0 6885.0 6963.3 6995.5 7080.4 7091.9 6696.1 6947.2 6958.5 6994.1 7000.1 6868.9 6895.9 6904.2 6911.3 6930.2 21918.2 22632.5 22851.0 23884.2 24044.6 1922.8 2015.5 2045.3 2108.2 2136.3 13297.1 14146.4 14206.6 14791.4 14982.9 1713.7 1904.5 1922.6 1924.1 1941.7 48949.0 49657.3 49707.8 62545.7 83985.6 8344.3 8683.0 8868.0 9242.5 9337.7 12121.8 12160.1 12202.6 12206.0 12222.7 7215.2 7295.3 7323.7 7431.1 7460.7 7181.9 7230.4 7410.9 7528.8 7531.4 3743.2 3797.2 3810.7 3892.4 4049.9 1749.2 1807.1 1843.3 1880.2 1900.5 812.9 866.4 878.4 945.4 952.9 15302.9 16134.3 16592.9 16842.7 16877.7 844.7 879.3 908.2 918.0 930.5 9283.6 9357.2 9559.6 9657.0 9674.7 377511.0 379583.0 387585.0 396758.0 402647.0 75654.0 82044.0 87076.6 87605.6 88615.6 940.8 966.3 979.4 979.7 988.4 15492.4 15781.9 15837.3 16006.3 16131.6 35559.6 36830.3 37364.9 38069.2 38154.4 50015.7 50224.5 51172.2 51254.5 52039.2 7105.6 7137.3 7169.0 7494.6 7552.2 11006.4 11552.8 12215.1 12259.4 12278.6 10083.7 10188.2 10319.3 10343.2 10460.5 10597.9 10601.1 10665.8 10783.1 10934.3 9886.7 10184.4 10265.5 10353.6 10525.9 7517.5 7605.1 7659.2 7780.5 7837.6 9581.5 9667.7 9821.0 9915.7 9928.5 05:56:19 INFO - PROCESS | 9912 | 05:56:19 INFO - PROCESS | 9912 | [#3] mootools.html Cycles:180 Average:5276.43 Median:5062.59 stddev:3024.67 (59.7%) stddev-sans-first:3019.24 05:56:19 INFO - PROCESS | 9912 | Values: 1416.1 1446.1 1585.4 1782.3 1797.7 6914.1 7672.1 7830.1 8185.5 8207.1 7920.2 8099.3 8124.6 8198.1 8207.3 2161.5 2192.0 2208.1 2212.4 2214.2 2177.0 2180.5 2240.9 2257.4 2261.5 2190.2 2193.2 2216.6 2220.3 2226.0 2153.8 2177.7 2179.5 2182.7 2197.7 1971.5 1980.9 1990.2 2165.3 2184.4 8097.4 8121.1 8124.9 8133.1 8133.5 4638.9 4751.1 4755.2 4760.4 4761.5 2855.7 2949.2 3023.2 3029.8 3039.6 904.2 946.9 947.6 949.5 1008.0 11301.5 11326.7 11326.9 11337.0 11364.4 4140.8 4252.0 4287.8 4316.7 4356.0 9511.7 9532.3 9534.7 9536.4 9590.6 4760.7 4835.0 4836.6 4837.3 4848.1 3586.1 4115.2 4234.7 4407.1 4409.2 3645.6 3651.1 3736.6 3747.3 3765.1 1175.3 1176.9 1205.6 1211.7 1216.2 687.9 858.6 862.6 865.3 889.0 5310.3 5495.2 5500.3 5517.3 5558.2 407.5 409.3 411.4 416.2 422.2 3485.1 3498.9 3522.8 3522.9 3525.9 9522.4 9742.9 9819.0 9971.3 9991.1 9865.0 9868.8 9917.0 9922.2 9978.7 7508.2 7518.4 7586.5 7698.9 7705.4 5277.1 5379.2 5414.8 5483.2 5547.4 8826.5 9155.5 9158.1 9252.0 9389.2 9283.4 9356.3 9380.2 9389.2 9438.7 5989.4 6621.4 6656.1 6759.4 6815.8 7851.0 7864.0 7881.8 7884.1 7896.0 6898.9 7011.9 7072.4 7091.1 7167.2 6930.1 6952.7 6987.3 6991.8 7047.5 6396.0 6406.3 6439.4 6446.2 6456.1 4561.7 4621.5 4656.3 4690.1 4734.0 4690.2 4742.2 4746.1 4759.2 4760.8 05:56:19 INFO - PROCESS | 9912 | 05:56:19 INFO - PROCESS | 9912 | [#4] prototype.html Cycles:180 Average:4363.75 Median:5058.40 stddev:1299.98 (25.7%) stddev-sans-first:1267.07 05:56:19 INFO - PROCESS | 9912 | Values: 285.5 289.7 293.4 299.9 300.0 5060.8 5073.7 5091.7 5106.7 5128.9 4999.5 5015.7 5036.4 5043.1 5056.0 3644.8 3772.0 3873.8 3882.9 3885.4 3857.9 3884.6 3884.6 3893.3 3900.8 3803.5 3807.8 3823.8 3877.1 3878.1 3747.4 3782.8 3845.8 3855.5 3897.3 3335.6 3336.5 3342.8 3345.2 3374.8 4782.2 4785.7 4788.3 4804.5 4856.9 4381.5 4394.8 4435.5 4436.5 4477.4 5019.2 5231.4 5232.7 5247.9 5269.8 3651.3 3660.4 3666.7 3671.9 3681.9 5519.6 5538.2 5543.7 5556.8 5561.1 3514.9 3720.7 3735.5 3740.8 3748.4 3746.0 3759.0 3762.1 3775.4 3781.8 4264.9 4299.7 4334.8 4355.3 4359.6 5068.2 5193.3 5246.5 5251.0 5260.3 1301.4 1314.3 1319.9 1320.7 1323.0 798.3 816.4 827.2 837.2 846.9 4485.9 4581.0 4585.7 4597.9 4610.1 5394.6 5477.3 5489.7 5510.8 5514.3 4531.4 4588.4 4621.6 4636.1 4651.3 2872.0 2872.5 2916.7 2917.2 2925.3 5123.9 5145.9 5155.2 5167.8 5184.7 5467.3 5598.2 5606.7 5612.3 5629.5 5134.7 5145.5 5151.3 5154.1 5154.9 5424.9 5454.5 5477.2 5484.8 5513.8 5182.6 5353.5 5429.4 5446.6 5456.1 5122.8 5148.6 5172.1 5233.5 5237.0 3913.8 3924.2 3928.8 3943.1 3954.6 5453.2 5489.1 5491.8 5500.9 5508.8 5318.6 5321.1 5335.6 5339.6 5372.8 5072.0 5267.9 5285.3 5332.4 5336.8 5150.9 5187.4 5191.8 5207.3 5267.5 5126.8 5144.7 5329.6 5350.1 5370.9 5230.1 5232.5 5256.5 5271.3 5283.6 05:56:19 INFO - PROCESS | 9912 | 05:56:19 INFO - PROCESS | 9912 | [#5] yui.html Cycles:180 Average:17028.56 Median:477.55 stddev:24124.72 (5051.8%) stddev-sans-first:24160.94 05:56:19 INFO - PROCESS | 9912 | Values: 619.9 669.2 685.5 711.6 770.7 12242.4 12715.7 12753.2 13128.5 13156.0 12238.7 12262.7 12282.7 12341.8 12349.4 633.9 780.5 785.5 793.8 805.9 790.8 793.7 795.3 796.1 796.2 842.3 842.4 842.9 843.3 843.4 824.4 831.2 832.3 834.1 835.1 610.6 610.8 611.8 612.3 612.3 13051.0 13164.5 13182.2 13193.9 13195.1 12913.5 13400.3 13411.8 13508.9 13668.2 10317.5 10488.5 10541.4 10576.5 10630.8 3331.7 3360.8 3370.2 3382.7 3464.4 57096.7 57139.4 57593.7 59226.4 59560.7 10533.1 10533.7 10661.6 10740.1 10837.1 19636.2 19643.5 19794.2 19821.6 20119.5 6951.7 6977.5 7039.7 7061.9 7073.2 3705.2 3763.0 3768.3 3799.3 3855.1 2952.7 3072.8 3079.1 3084.8 3087.4 500.6 515.7 527.4 539.6 539.7 475.5 518.0 525.5 535.0 536.7 7547.7 7721.6 7741.4 7871.5 7923.6 461.6 479.6 506.9 511.2 523.9 3510.7 3554.8 3619.3 3626.7 3668.1 87630.1 92777.5 93040.0 93626.0 94077.5 78329.0 81279.6 82536.6 82627.0 83296.2 71865.0 75291.6 75534.6 75597.6 77544.0 6929.8 7072.7 7096.5 7226.4 7262.9 37348.6 38401.2 44346.6 45697.0 45780.3 38126.2 43076.8 58508.0 62772.0 63244.4 11353.1 11643.2 11646.5 11660.9 11685.6 9484.4 10042.3 12108.6 12176.9 12204.7 10210.9 10659.0 10906.6 11044.6 11191.4 11113.7 11522.7 11581.4 11837.8 12075.3 10759.8 10999.8 11075.2 11256.0 11335.8 9807.6 9906.6 10153.9 10166.7 10207.3 9047.9 9667.0 9857.4 9857.7 9977.1 05:56:19 INFO - PROCESS | 9912 | -------- Summary: end -------- 05:56:19 INFO - PROCESS | 9912 | 05:56:20 INFO - TEST-INFO | 9912: exit 0 05:56:20 INFO - TEST-OK | dromaeo_css | took 1119268ms 05:56:20 INFO - TEST-START | kraken 05:56:20 INFO - operating with platform_type : linux_ 05:56:20 INFO - Initialising browser for kraken test... 05:56:20 INFO - TEST-INFO | started process 10145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfBWEb_/profile http://localhost:34319/getInfo.html) 05:56:26 INFO - PROCESS | 10145 | __metrics Screen width/height:1600/1200 05:56:26 INFO - PROCESS | 10145 | colorDepth:24 05:56:26 INFO - PROCESS | 10145 | Browser inner width/height: 1024/697 05:56:26 INFO - PROCESS | 10145 | __metrics 05:56:27 ERROR - PROCESS | 10145 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:56:27 INFO - TEST-INFO | 10145: exit 0 05:56:27 INFO - Browser initialized. 05:56:27 INFO - Running cycle 1/1 for kraken test... 05:56:28 INFO - TEST-INFO | started process 10263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfBWEb_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:56:39 INFO - PROCESS | 10263 | RSS: Main: 168587264 05:56:39 INFO - PROCESS | 10263 | 05:56:42 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34319/tests/kraken/driver.html?testName=audio-beat-detection) 05:56:43 INFO - PROCESS | 10263 | RSS: Main: 173473792 05:56:43 INFO - PROCESS | 10263 | 05:56:46 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34319/tests/kraken/driver.html?testName=audio-dft) 05:56:47 INFO - PROCESS | 10263 | RSS: Main: 173023232 05:56:47 INFO - PROCESS | 10263 | 05:56:50 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34319/tests/kraken/driver.html?testName=audio-fft) 05:56:50 INFO - PROCESS | 10263 | RSS: Main: 167788544 05:56:50 INFO - PROCESS | 10263 | 05:56:52 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34319/tests/kraken/driver.html?testName=audio-oscillator) 05:56:53 INFO - PROCESS | 10263 | RSS: Main: 168521728 05:56:53 INFO - PROCESS | 10263 | 05:56:55 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34319/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:56:56 INFO - PROCESS | 10263 | RSS: Main: 168546304 05:56:56 INFO - PROCESS | 10263 | 05:56:59 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34319/tests/kraken/driver.html?testName=imaging-darkroom) 05:57:00 INFO - PROCESS | 10263 | RSS: Main: 169209856 05:57:00 INFO - PROCESS | 10263 | 05:57:03 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34319/tests/kraken/driver.html?testName=imaging-desaturate) 05:57:04 INFO - PROCESS | 10263 | RSS: Main: 166277120 05:57:04 INFO - PROCESS | 10263 | 05:57:07 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34319/tests/kraken/driver.html?testName=json-parse-financial) 05:57:08 INFO - PROCESS | 10263 | RSS: Main: 168026112 05:57:08 INFO - PROCESS | 10263 | 05:57:09 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34319/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:57:10 INFO - PROCESS | 10263 | RSS: Main: 168439808 05:57:10 INFO - PROCESS | 10263 | 05:57:12 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:57:12 INFO - PROCESS | 10263 | RSS: Main: 168484864 05:57:12 INFO - PROCESS | 10263 | 05:57:15 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:57:15 INFO - PROCESS | 10263 | RSS: Main: 169234432 05:57:15 INFO - PROCESS | 10263 | 05:57:18 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:57:19 INFO - PROCESS | 10263 | RSS: Main: 168955904 05:57:19 INFO - PROCESS | 10263 | 05:57:22 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:57:22 INFO - PROCESS | 10263 | RSS: Main: 168886272 05:57:22 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:34319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34319/tests/kraken/driver.html?testName=ai-astar) 05:57:24 INFO - PROCESS | 10263 | RSS: Main: 169684992 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | __start_tp_report 05:57:24 INFO - PROCESS | 10263 | _x_x_mozilla_page_load 05:57:24 INFO - PROCESS | 10263 | _x_x_mozilla_page_load_details 05:57:24 INFO - PROCESS | 10263 | |i|pagename|runs| 05:57:24 INFO - PROCESS | 10263 | |0;ai-astar;120;109;114;114;113;114;115;112;115;114 05:57:24 INFO - PROCESS | 10263 | |1;audio-beat-detection;161;131;155;180;133;154;168;138;194;134 05:57:24 INFO - PROCESS | 10263 | |2;audio-dft;163;161;165;177;164;164;163;164;164;161 05:57:24 INFO - PROCESS | 10263 | |3;audio-fft;78;77;76;168;77;87;76;76;156;75 05:57:24 INFO - PROCESS | 10263 | |4;audio-oscillator;87;90;143;87;87;86;142;86;86;139 05:57:24 INFO - PROCESS | 10263 | |5;imaging-gaussian-blur;118;118;117;118;117;118;119;118;118;117 05:57:24 INFO - PROCESS | 10263 | |6;imaging-darkroom;149;148;147;147;148;148;148;148;152;147 05:57:24 INFO - PROCESS | 10263 | |7;imaging-desaturate;95;96;96;95;96;97;96;96;95;95 05:57:24 INFO - PROCESS | 10263 | |8;json-parse-financial;66;63;62;64;64;63;66;65;63;63 05:57:24 INFO - PROCESS | 10263 | |9;json-stringify-tinderbox;66;66;70;66;65;65;65;65;65;65 05:57:24 INFO - PROCESS | 10263 | |10;stanford-crypto-aes;91;87;85;86;90;91;84;87;110;91 05:57:24 INFO - PROCESS | 10263 | |11;stanford-crypto-ccm;133;147;136;141;132;131;133;132;140;140 05:57:24 INFO - PROCESS | 10263 | |12;stanford-crypto-pbkdf2;182;174;171;170;173;176;175;173;171;174 05:57:24 INFO - PROCESS | 10263 | |13;stanford-crypto-sha256-iterative;68;72;68;68;71;66;70;69;67;67 05:57:24 INFO - PROCESS | 10263 | __end_tp_report 05:57:24 INFO - PROCESS | 10263 | __start_cc_report 05:57:24 INFO - PROCESS | 10263 | _x_x_mozilla_cycle_collect,960 05:57:24 INFO - PROCESS | 10263 | __end_cc_report 05:57:24 INFO - PROCESS | 10263 | __startTimestamp1465390644790__endTimestamp 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | ------- Summary: start ------- 05:57:24 INFO - PROCESS | 10263 | Number of tests: 14 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:2.75 (2.4%) stddev-sans-first:1.87 05:57:24 INFO - PROCESS | 10263 | Values: 120.0 109.0 114.0 114.0 113.0 114.0 115.0 112.0 115.0 114.0 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:158.00 stddev:21.45 (13.6%) stddev-sans-first:22.64 05:57:24 INFO - PROCESS | 10263 | Values: 161.0 131.0 155.0 180.0 133.0 154.0 168.0 138.0 194.0 134.0 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:4.55 (2.8%) stddev-sans-first:4.79 05:57:24 INFO - PROCESS | 10263 | Values: 163.0 161.0 165.0 177.0 164.0 164.0 163.0 164.0 164.0 161.0 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.50 stddev:35.80 (46.8%) stddev-sans-first:37.46 05:57:24 INFO - PROCESS | 10263 | Values: 78.0 77.0 76.0 168.0 77.0 87.0 76.0 76.0 156.0 75.0 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:86.50 stddev:26.29 (30.4%) stddev-sans-first:27.21 05:57:24 INFO - PROCESS | 10263 | Values: 87.0 90.0 143.0 87.0 87.0 86.0 142.0 86.0 86.0 139.0 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 05:57:24 INFO - PROCESS | 10263 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 119.0 118.0 118.0 117.0 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.48 (1.0%) stddev-sans-first:1.54 05:57:24 INFO - PROCESS | 10263 | Values: 149.0 148.0 147.0 147.0 148.0 148.0 148.0 148.0 152.0 147.0 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 05:57:24 INFO - PROCESS | 10263 | Values: 95.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 95.0 95.0 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:1.37 (2.1%) stddev-sans-first:1.22 05:57:24 INFO - PROCESS | 10263 | Values: 66.0 63.0 62.0 64.0 64.0 63.0 66.0 65.0 63.0 63.0 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:65.50 stddev:1.55 (2.4%) stddev-sans-first:1.64 05:57:24 INFO - PROCESS | 10263 | Values: 66.0 66.0 70.0 66.0 65.0 65.0 65.0 65.0 65.0 65.0 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:88.50 stddev:7.44 (8.4%) stddev-sans-first:7.88 05:57:24 INFO - PROCESS | 10263 | Values: 91.0 87.0 85.0 86.0 90.0 91.0 84.0 87.0 110.0 91.0 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:138.00 stddev:5.28 (3.8%) stddev-sans-first:5.44 05:57:24 INFO - PROCESS | 10263 | Values: 133.0 147.0 136.0 141.0 132.0 131.0 133.0 132.0 140.0 140.0 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.00 stddev:3.41 (2.0%) stddev-sans-first:2.00 05:57:24 INFO - PROCESS | 10263 | Values: 182.0 174.0 171.0 170.0 173.0 176.0 175.0 173.0 171.0 174.0 05:57:24 INFO - PROCESS | 10263 | 05:57:24 INFO - PROCESS | 10263 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.90 (2.8%) stddev-sans-first:2.00 05:57:24 INFO - PROCESS | 10263 | Values: 68.0 72.0 68.0 68.0 71.0 66.0 70.0 69.0 67.0 67.0 05:57:24 INFO - PROCESS | 10263 | -------- Summary: end -------- 05:57:24 INFO - PROCESS | 10263 | 05:57:25 INFO - TEST-INFO | 10263: exit 0 05:57:25 INFO - TEST-OK | kraken | took 65408ms 05:57:25 INFO - SUITE-END | took 1184s 05:57:25 INFO - Completed test suite (00:19:44) 05:57:25 INFO - javascript benchmark 05:57:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6439.8423628973005, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2686.9731302686973, 2743.8765255563503, 2761.4201017786263, 2765.6128142060115, 2778.8054836161464, 4767.737774422401, 4810.1582223110945, 4849.9515004849945, 4893.29047288143, 4942.703437793726, 4712.5758681718635, 4819.3734814474155, 4825.951740482594, 4847.975760121203, 4851.563359297663, 4392.582704643054, 4413.0732546165345, 4486.080353527535, 4519.52544982777, 4528.252838281696, 4224.894377640569, 4524.6380289576755, 4548.613367863719, 4614.284785858181, 4621.514740952202, 4353.41228934093, 4390.100029493946, 4397.31841564558, 4419.204543182258, 4496.348029535699, 4357.346398040288, 4358.8910277243, 4420.447444069491, 4425.424694789689, 4445.555444455528, 4428.3578881062385, 4431.2466880630045, 4439.75581343026, 4443.0, 4465.263231566788, 4704.811807527695, 4747.501512341223, 4751.192297309466, 4777.904441911177, 4790.329353890458, 5171.793128274864, 5175.223716442526, 5180.119379705459, 5199.1161502544655, 5242.501962313574, 5048.444671086178, 5214.6871187728475, 5215.426303106655, 5215.660982036194, 5219.921701174486, 4873.269009648581, 4885.755712214375, 4905.484924082992, 4906.779194936236, 4957.355543779286, 5397.10947693634, 5400.1899715043055, 5407.459254074561, 5420.0, 5453.863653408617, 4952.281919121707, 5067.265246539231, 5078.695278283315, 5161.329027226437, 5164.0188364211435, 5010.223415370623, 5167.302414174038, 5185.222216667455, 5211.218317252443, 5237.057329680694, 5159.0, 5185.196294574347, 5201.947980520222, 5205.349331333583, 5207.1668533034535, 4974.253861920669, 5069.543741063322, 5112.3865136183895, 5142.537171654494, 5212.4266330703595, 4375.912481750347, 4396.384506169139, 4397.142557201315, 4442.089371678862, 4457.754823484739, 3801.4297855321925, 3807.5240594925635, 3835.6547910688173, 3846.4999550058874, 3894.6494815466745, 4373.475182978063, 4433.246348120762, 4466.57567531084, 4478.910421791546, 4479.59683628475, 5167.302414174038, 5209.645492171987, 5213.348331458567, 5225.477452254744, 5256.500632439988, 4457.375967364572, 4468.731876087445, 4476.26141686618, 4499.0, 4524.660650451229, 4549.067441174618, 4668.929966050512, 4710.199266124767, 4713.033828065307, 4720.197566413718, 4915.8033678652455, 4917.139500587455, 4930.950690493192, 4950.851474455772, 4970.155073637418, 5123.974380128076, 5260.815871444481, 5281.577473802164, 5283.524482796567, 5334.599905007062, 4779.641526885428, 4805.0, 4805.831795887128, 4809.062232864558, 4828.179209534458, 5041.269015992734, 5041.395032596112, 5046.419661738947, 5046.674301124884, 5092.490750924878, 5054.873628159178, 5113.0, 5126.154184559506, 5150.948490515047, 5172.19830926207, 4943.555080042814, 5009.273655319886, 5022.045811295842, 5047.848564543069, 5057.974710126573, 5003.424606170337, 5077.111505486599, 5079.593632509464, 5111.488851114858, 5116.667416617908, 4886.267059941038, 4977.427595826526, 4981.402231732215, 4988.975055124701, 4998.100341938486, 5113.233015047773, 5136.332276803992, 5140.537351638221, 5140.794368225379, 5198.038362902875, 4973.602111831117, 5019.573336266459, 5029.74851257443, 5038.672486288379, 5086.669366491166], "value": 4759.681638664953, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.1301389833802, 582.5485248932077, 586.2466730251627, 589.7994681808187, 596.9493691103658, 40311.19377612446, 41613.375799363035, 42000.57999420009, 45544.54455455444, 45683.31475027869, 41637.58362416375, 42757.7862110689, 42798.0, 42853.78573107138, 42868.785656071756, 7761.689532418696, 7900.446968712193, 7983.201679831999, 7987.201279871995, 8002.759917202464, 7751.069871615386, 7837.0, 7876.763697089068, 7892.842143157133, 7894.4868583542175, 7876.803079923019, 7895.763127106196, 7923.484973476734, 7934.087579928324, 7949.284564389204, 7871.5277083374895, 7909.050913890313, 7935.603219839014, 7943.364530837519, 7968.362530997506, 7750.651220695082, 7774.105977812511, 7842.137364889858, 7866.370690344758, 7876.72431464896, 39363.212735745125, 39524.20951580981, 39570.20859582821, 39682.20635587301, 39931.40102898459, 2876.798624096314, 2890.132960111958, 3051.6948305169526, 3059.632844058705, 3141.748660107186, 28590.428191436054, 28791.424171516453, 29327.12018639444, 29709.851450742608, 30231.395372092655, 3477.7043951264172, 3479.5128681984543, 3540.6105328413855, 3600.981995090008, 3602.3155600435834, 252729.0, 254533.727331364, 254786.0, 255114.0, 255849.0, 32189.678103219136, 55826.441735582936, 55918.720406397704, 56316.43683563194, 56332.43667563272, 32758.344833103205, 34393.140171495914, 34504.65495345065, 34555.65444345574, 34790.47814282788, 14038.649033774238, 14212.0, 14262.714745705029, 14266.42934282617, 14331.498397556245, 11706.473208705629, 11828.526858925547, 11839.644810655695, 11845.289282643069, 11915.582954596548, 7927.762167134995, 7979.4813337134065, 8039.557824319719, 8072.717454889051, 8094.595270236465, 3146.575212346304, 3150.684931506831, 3197.8560964756643, 3197.888073917402, 3220.6457289698114, 896.4397251717677, 918.1919910478736, 929.9860502092474, 998.3610489286863, 1069.8288273876142, 27614.0, 28078.71921280761, 28376.0, 28623.856880715462, 28734.856325718236, 946.5503885654397, 977.8728765260613, 984.1241295247236, 985.4333758088984, 996.3623281100101, 14386.712265754835, 14769.409223630935, 14833.332500037524, 15122.697546049018, 15150.621234469227, 389247.0, 389649.0, 393657.0, 393719.0, 395348.0, 51079.48920510821, 51112.74443627832, 51133.23300150501, 51437.48562514402, 51647.225291620656, 1172.6775136837268, 1242.9813552796716, 1260.7352455984162, 1268.7081971146504, 1276.2087505746497, 25765.613515797653, 27252.0, 27669.86165069162, 27807.860960695067, 28031.159065228076, 42788.0, 42865.78567107145, 43496.0, 43558.346624801285, 43653.56346436495, 338712.0, 340855.0, 340996.0, 342159.0, 342584.0, 25767.742322577284, 25982.610260845726, 26073.73926260713, 26226.344341391617, 26377.472450550496, 43049.139017218855, 43101.78449107734, 43755.78122109496, 44099.0, 44433.77783111064, 37328.62671373251, 37496.0, 37600.43599345957, 37647.81176094102, 37712.81143594265, 36874.44688329731, 36880.0, 37079.25841483101, 37361.25277494489, 37842.81078594589, 31486.842565787025, 36273.637263627024, 36330.455043173846, 36833.71082012117, 36985.0, 28851.7114828849, 33173.66826331706, 33347.33305333831, 33352.49971250482, 33495.665043349254, 24758.752412475646, 25374.492510150063, 25607.359816004748, 25784.0, 25969.0], "value": 16853.74353155046, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.4071016019289, 370.327854943278, 381.30221694299416, 390.7011136480591, 392.8153767729168, 15946.681066378665, 16225.756613650805, 16960.83039169608, 17073.317067317294, 17110.058946757923, 15941.601459963507, 16004.439844605442, 16629.584260393498, 16756.916215418936, 17737.733933991, 4374.825006999724, 4556.270996640522, 4592.517785632511, 4592.931106033412, 4596.931046034296, 3344.7825891317107, 6713.731450741989, 7119.9288007119785, 7130.2513236110235, 7136.036635054254, 6885.001674757183, 6963.303669633046, 6995.510314278003, 7080.362767350937, 7091.85816283674, 6696.125084976215, 6947.2358040615745, 6958.478114141409, 6994.0907682001525, 7000.124984376953, 6868.862622747567, 6895.896561551581, 6904.240533541307, 6911.343422374866, 6930.20302665195, 21918.23286184992, 22632.547349053093, 22851.0, 23884.16405425819, 24044.639330410057, 1922.7884932657396, 2015.4860510569858, 2045.2841505473114, 2108.1883474862134, 2136.2629892686996, 13297.069205155643, 14146.434142634282, 14206.644833879132, 14791.40834366624, 14982.850171498254, 1713.7258038713746, 1904.4857888370063, 1922.5866438715602, 1924.0956750327323, 1941.7378653881685, 48949.0, 49657.255141172915, 49707.75146124282, 62545.68727156381, 83985.58007209985, 8344.332453403713, 8682.956585217033, 8868.0, 9242.491662958468, 9337.719868403823, 12121.757564848655, 12160.14878958482, 12202.633920982385, 12206.023518118707, 12222.694432639255, 7215.206327303992, 7295.270472952662, 7323.670434830446, 7431.071116110486, 7460.664270107858, 7181.8922716159295, 7230.421566274686, 7410.888836667346, 7528.811779705442, 7531.3598344141365, 3743.1577894973957, 3797.240551889633, 3810.657040866335, 3892.4355968384425, 4049.91900162001, 1749.2041121289783, 1807.1325763633267, 1843.271907596492, 1880.2103116691023, 1900.5058684741791, 812.8861959325699, 866.4021824940771, 878.4026861733954, 945.4421891084294, 952.8613307097951, 15302.923485382724, 16134.273957671932, 16592.917035414746, 16842.663146736995, 16877.66244675124, 844.7212419901418, 879.2702057292432, 908.2189317187214, 918.008550765172, 930.5161316115717, 9283.58223879927, 9357.20463760588, 9559.569819358006, 9657.0, 9674.686546933277, 377511.0, 379583.0, 387585.0, 396758.0, 402647.0, 75654.0, 82044.0, 87076.56461717651, 87605.561972191, 88615.55692221498, 940.8024314893812, 966.2801213096288, 979.4319294808994, 979.7305740921161, 988.4464699768153, 15492.380304787683, 15781.921090394475, 15837.287322070764, 16006.279717412977, 16131.596710081873, 35559.64440355667, 36830.263394732494, 37364.94492802922, 38069.23861522698, 38154.375334343196, 50015.749921250164, 50224.497755021985, 51172.232416514526, 51254.487455124974, 52039.219411708094, 7105.57888422328, 7137.321954414322, 7169.0, 7494.6252687366505, 7552.169261381134, 11006.449677516252, 11552.82670759956, 12215.144939854124, 12259.448324825225, 12278.631641050782, 10083.747906302402, 10188.184945204217, 10319.277650564389, 10343.18994176001, 10460.47697615101, 10597.89402106, 10601.098906593026, 10665.840012399975, 10783.137349011904, 10934.289271197347, 9886.653967111117, 10184.439855807705, 10265.486725663837, 10353.63762268317, 10525.9473702631, 7517.511361761468, 7605.125410577633, 7659.157492675913, 7780.455368124177, 7837.568933708701, 9581.520923953914, 9667.70996870095, 9820.950895245478, 9915.702528924145, 9928.503574821374], "value": 8488.407699089721, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.079548293609, 1446.07451231212, 1585.3500064973357, 1782.2870851659343, 1797.7393277974686, 6914.101166848315, 7672.079350477943, 7830.138684744674, 8185.549794761286, 8207.097219305871, 7920.16838231986, 8099.311558517518, 8124.634391452384, 8198.139195384474, 8207.261346478816, 2161.5136594266323, 2192.013593882751, 2208.116753298685, 2212.4468882779306, 2214.2250212425683, 2177.0, 2180.4548862784304, 2240.9215677451293, 2257.3679369776487, 2261.525079733258, 2190.156789635994, 2193.2104442400723, 2216.612092883739, 2220.2673117871145, 2225.9888700556476, 2153.8384621153477, 2177.7495588007423, 2179.4660308224506, 2182.68351089092, 2197.6703494475796, 1971.5465442948203, 1980.9108590113478, 1990.1939714415685, 2165.2962787094098, 2184.377452426051, 8097.35221182304, 8121.106678265386, 8124.86251924731, 8133.146019667909, 8133.511989280662, 4638.907221855544, 4751.097291514636, 4755.2153894607345, 4760.404949381327, 4761.4524329701835, 2855.728705772948, 2949.174231215242, 3023.183740390082, 3029.8182109073527, 3039.6200474940633, 904.2449554621899, 946.9384490008197, 947.5783276441986, 949.4588084791671, 1008.037324355239, 11301.547938082467, 11326.660200194008, 11326.943365283121, 11336.999999999918, 11364.374959377232, 4140.792960351971, 4252.043290259667, 4287.849925252601, 4316.697831151852, 4355.956440435555, 9511.66709165176, 9532.332736708364, 9534.713958581253, 9536.380135291183, 9590.568424420917, 4760.690555113906, 4835.0, 4836.637252206098, 4837.250226214942, 4848.0788650156355, 3586.103474131467, 4115.176964607091, 4234.745915245096, 4407.140607581491, 4409.184300904343, 3645.5625324960643, 3651.123730304761, 3736.551613806361, 3747.3442147624055, 3765.077555998798, 1175.2595864605244, 1176.858776946772, 1205.5539450403407, 1211.715246916974, 1216.227695413401, 687.8830598798216, 858.5878778186506, 862.6376921692904, 865.260202526843, 889.0, 5310.309659744208, 5495.175723641486, 5500.339959204841, 5517.310336207974, 5558.221848941152, 407.5333742864463, 409.29192496979795, 411.37676420223386, 416.2133567557319, 422.23364593263744, 3485.0938755923135, 3498.930021399558, 3522.8238588070494, 3522.876699315512, 3525.94711079334, 9522.428654280766, 9742.902570974342, 9818.95090524557, 9971.252156088321, 9991.050850169222, 9864.950675246579, 9868.80262394748, 9917.0, 9922.156616687518, 9978.700638980843, 7508.211637777955, 7518.436117291225, 7586.468947173756, 7698.923010769932, 7705.383569314441, 5277.102892508359, 5379.1662292344745, 5414.810481633124, 5483.2323474712775, 5547.41752116022, 8826.470411775314, 9155.450672959643, 9158.084191581054, 9251.953740231256, 9389.248860091313, 9283.442993420416, 9356.345055846026, 9380.20268277204, 9389.201917837061, 9438.716838494582, 5989.431004054608, 6621.437177839937, 6656.068150458843, 6759.425448836707, 6815.795526134224, 7851.0, 7863.960680196562, 7881.802954925944, 7884.132745398117, 7895.960520197592, 6898.896516552155, 7011.859762804817, 7072.3634872861685, 7091.11361079865, 7167.175774785758, 6930.064441300561, 6952.687129079102, 6987.266337034538, 6991.755288564876, 7047.471439641945, 6395.968020159869, 6406.263279722705, 6439.388258115471, 6446.226452825691, 6456.096146539582, 4561.749103799323, 4621.468531118964, 4656.254999200111, 4690.061987602425, 4733.952660473351, 4690.202665546797, 4742.170120229015, 4746.050789841976, 4759.1671457495495, 4760.833370832004], "value": 4151.689723477902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.4633289415898, 289.7088426131737, 293.3692560993863, 299.9130252226854, 299.9565063065854, 5060.822871199509, 5073.7209453480045, 5091.669041512299, 5106.6935983840995, 5128.9230661540105, 4999.500049994998, 5015.7492125393765, 5036.420811606667, 5043.067032598962, 5055.9747201263945, 3644.81775911204, 3771.9819896355457, 3873.825677844504, 3882.8835134946, 3885.417187421881, 3857.9035524111982, 3884.5726970033274, 3884.59211782763, 3893.299206142893, 3900.8049597520153, 3803.5055442792536, 3807.7905715185652, 3823.808809559525, 3877.1276462795927, 3878.146807702301, 3747.3629482987685, 3782.8486860525823, 3845.788481633509, 3855.47951026612, 3897.279003384355, 3335.616404113534, 3336.516205150264, 3342.782719123249, 3345.1637090727318, 3374.8312584370683, 4782.234842425195, 4785.66500344976, 4788.3056956741075, 4804.471508134103, 4856.858638220016, 4381.518033016366, 4394.802233899451, 4435.534268901783, 4436.489803672586, 4477.440319960005, 5019.222020586778, 5231.424543300234, 5232.7122008289525, 5247.86880327991, 5269.841904742864, 3651.2879988402005, 3660.432632941898, 3666.661668490982, 3671.9265614687824, 3681.9263614727556, 5519.558435325164, 5538.169274608801, 5543.722813859331, 5556.833295001197, 5561.138023606348, 3514.876979305712, 3720.6651401374006, 3735.495708079429, 3740.775553466801, 3748.3627783276906, 3745.962540374616, 3759.0, 3762.1159027628487, 3775.414810704345, 3781.7541859779026, 4264.914701705949, 4299.720518166309, 4334.783260836945, 4355.259605866947, 4359.648508962168, 5068.16375298079, 5193.272941788153, 5246.501582349671, 5250.97374513125, 5260.28986086881, 1301.4208677138583, 1314.2574445438297, 1319.9142055766345, 1320.6962398648366, 1323.0011341437153, 798.2616080125977, 816.3673153306116, 827.2182787265975, 837.1712005115014, 846.9407141500159, 4485.865424037219, 4580.954190458119, 4585.747783871919, 4597.8965048388145, 4610.101030299126, 5394.622376433612, 5477.342718873681, 5489.6980666062955, 5510.8071217507995, 5514.255575497336, 4531.43357080365, 4588.403507543998, 4621.60716339115, 4636.076028448157, 4651.2557990722, 2871.9712802872123, 2872.5116730155924, 2916.6500019997734, 2917.1831887071653, 2925.254060214632, 5123.8719032023755, 5145.9485405146215, 5155.175171972542, 5167.844964651066, 5184.714840683799, 5467.343918729778, 5598.188262701886, 5606.6916319602, 5612.270404847343, 5629.4652008059165, 5134.717590532482, 5145.45972672864, 5151.278820965068, 5154.123798954111, 5154.8969020620125, 5424.891502169856, 5454.536364409069, 5477.1510415885605, 5484.753186106555, 5513.8345849624575, 5182.6113041521285, 5353.54494867925, 5429.40276569585, 5446.591505637172, 5456.127019676833, 5122.769475373691, 5148.58811295103, 5172.094883395466, 5233.476652334736, 5236.978789136082, 3913.7887093791915, 3924.1955399143676, 3928.8035598220545, 3943.093088589583, 3954.6440820326306, 5453.182022696627, 5489.11821293824, 5491.807786727445, 5500.9273191727225, 5508.834734957958, 5318.627696061239, 5321.148616221386, 5335.626506144533, 5339.572834173179, 5372.811951581676, 5071.974640126776, 5267.894642107213, 5285.260063591178, 5332.440093790251, 5336.759845807026, 5150.871228219175, 5187.429382767968, 5191.76637051326, 5207.3230480037355, 5267.499587539178, 5126.84698910175, 5144.710603781281, 5329.600279979095, 5350.143976963823, 5370.892582148414, 5230.137027390438, 5232.502912223333, 5256.526912577886, 5271.288376069181, 5283.603729720363], "value": 3940.74846200904, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.9411055949683, 669.2103318084659, 685.492735375822, 711.5979471598547, 770.6647608290394, 12242.387880605967, 12715.745685086293, 12753.234805911652, 13128.47486100556, 13156.0, 12238.694032649166, 12262.693432664188, 12282.692932676666, 12341.753164936696, 12349.444275007623, 633.9144215530913, 780.4536824223038, 785.5090568394753, 793.7856778669784, 805.9032916050082, 790.8457850719112, 793.6904607203195, 795.3478147918709, 796.1282395776616, 796.1839114907237, 842.2630198576246, 842.4397775479299, 842.9367797415188, 843.2789964580287, 843.3759018326425, 824.3652387661497, 831.1522247307712, 832.2592892325835, 834.1200033964226, 835.1398059998212, 610.5878531990933, 610.8320211941707, 611.7767015039523, 612.2652816620074, 612.2928018139012, 13051.0, 13164.473421063147, 13182.209067455984, 13193.934030329883, 13195.142315749446, 12913.548025819051, 13400.262985535792, 13411.798823017663, 13508.864911350956, 13668.179909205479, 10317.484125793755, 10488.475576221159, 10541.367517948871, 10576.471176441224, 10630.78738425235, 3331.666833316649, 3360.7647464677484, 3370.1911541230174, 3382.695557399821, 3464.41105012146, 57096.714516427564, 57139.428605714245, 57593.712031439994, 59226.40773592295, 59560.702196489176, 10533.104686101615, 10533.683989480327, 10661.573537058586, 10740.140788736882, 10837.078848297826, 19636.214551417783, 19643.508912277022, 19794.20823167086, 19821.60356792856, 20119.497012574804, 6951.65241737911, 6977.51157418986, 7039.718411263492, 7061.89407158893, 7073.221945585981, 3705.203381273039, 3762.981185094057, 3768.2651882882574, 3799.3351163546267, 3855.1133239355104, 2952.704729527073, 3072.7695422843376, 3079.0762771169007, 3084.814911105341, 3087.4442600332154, 500.6170279736005, 515.7008934817796, 527.3697930972528, 539.5979994903822, 539.7301349325337, 475.5125995854208, 517.9844604661866, 525.4535283305396, 534.9759260833272, 536.6860386673761, 7547.698092076365, 7721.575313357707, 7741.419393545507, 7871.527708337518, 7923.643436045391, 461.6399208617284, 479.5851588376099, 506.92396140579206, 511.1642464570454, 523.947605239473, 3510.7015903648476, 3554.8222588870453, 3619.2761447710564, 3626.6917312028245, 3668.119651283726, 87630.12369876348, 92777.53611231901, 93040.0, 93626.0, 94077.52961235287, 78329.0, 81279.5936020328, 82536.58731706304, 82627.0, 83296.16703833005, 71865.0, 75291.62354188303, 75534.62232688801, 75597.62201188959, 77544.0, 6929.792106236821, 7072.71709131629, 7096.53872498286, 7226.4218862491925, 7262.891056634049, 37348.62651373452, 38401.23197535978, 44346.55653443424, 45697.0, 45780.31329530126, 38126.237475249785, 43076.78461607672, 58508.0, 62772.0, 63244.36755632569, 11353.091752659933, 11643.243189192675, 11646.534138634359, 11660.88339116598, 11685.591004315149, 9484.383515071499, 10042.347247428894, 12108.576199832964, 12176.939115304367, 12204.694882628006, 10210.863512528993, 10659.0, 10906.61826836057, 11044.613438529614, 11191.384473854016, 11113.666590002313, 11522.654320370402, 11581.420928953687, 11837.763244734884, 12075.27548347102, 10759.784804304027, 10999.835002474809, 11075.224734268846, 11256.043236325004, 11335.829962550733, 9807.607695692092, 9906.603735850773, 10153.898461015295, 10166.745831354276, 10207.285490015925, 9047.909520904706, 9667.0, 9857.408555486694, 9857.654982075594, 9977.102060814272], "value": 6401.785480335177, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 109.0, 114.0, 114.0, 113.0, 114.0, 115.0, 112.0, 115.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 131.0, 155.0, 180.0, 133.0, 154.0, 168.0, 138.0, 194.0, 134.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 165.0, 177.0, 164.0, 164.0, 163.0, 164.0, 164.0, 161.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 168.0, 77.0, 87.0, 76.0, 76.0, 156.0, 75.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 143.0, 87.0, 87.0, 86.0, 142.0, 86.0, 86.0, 139.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 119.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 152.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 62.0, 64.0, 64.0, 63.0, 66.0, 65.0, 63.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 70.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 85.0, 86.0, 90.0, 91.0, 84.0, 87.0, 110.0, 91.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 147.0, 136.0, 141.0, 132.0, 131.0, 133.0, 132.0, 140.0, 140.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 174.0, 171.0, 170.0, 173.0, 176.0, 175.0, 173.0, 171.0, 174.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 68.0, 68.0, 71.0, 66.0, 70.0, 69.0, 67.0, 67.0], "value": 68.6, "unit": "score"}]}]} 05:57:26 INFO - Return code: 0 05:57:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:57:26 ERROR - # TBPL SUCCESS # 05:57:26 INFO - Running post-action listener: _resource_record_post_action 05:57:26 INFO - ##### 05:57:26 INFO - ##### Finished run-tests step (success) 05:57:26 INFO - ##### 05:57:26 INFO - Running post-run listener: _resource_record_post_run 05:57:26 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310247424; Read time: 12; Write time: 583972 05:57:26 INFO - TinderboxPrint: CPU usage
13.5% 05:57:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:57:26 INFO - TinderboxPrint: I/O write bytes / time
310,247,424 / 583,972 05:57:26 INFO - TinderboxPrint: CPU idle
8,301.4 (86.5%) 05:57:26 INFO - TinderboxPrint: CPU user
1,230.9 (12.8%) 05:57:26 INFO - TinderboxPrint: Swap in / out
0 / 0 05:57:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14860288; Read time: 0; Write time: 20932 05:57:26 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295387136; Read time: 12; Write time: 563040 05:57:26 INFO - Running post-run listener: _upload_blobber_files 05:57:26 INFO - Blob upload gear active. 05:57:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:57:26 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 05:57:26 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'] 05:57:26 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 05:57:27 INFO - (blobuploader) - INFO - Open directory for files ... 05:57:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:57:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:57:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:31 INFO - (blobuploader) - INFO - Done attempting. 05:57:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:57:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:57:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:31 INFO - (blobuploader) - INFO - Done attempting. 05:57:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:57:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:57:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:32 INFO - (blobuploader) - INFO - Done attempting. 05:57:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:57:32 INFO - Return code: 0 05:57:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:57:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:57:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b41605fe08ee74daa05378d439e1625fac9a70bf3a0e181568a370d03fd63871973941d61f8a30334261e540ef291829f29a1f4fd7e31440dcf36b12a55e630", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6651c05659bfb681809ddb7f51481866cd76b3ec6a684db32c607808d9a71b39f4c3ad743f618098b1f40ace5d02c5ca4ded68f49b09c7ccb70d2c6945150ac7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec2f2b1803a4f7e6c80c5f7484a167c050652f02372a0fc16483e5834b5ae6b5c2645639a7417b4a7c92980c9e9e1c47b1ac397383d330de5a556e1e5ef5364f"} 05:57:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:57:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:57:32 INFO - Contents: 05:57:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b41605fe08ee74daa05378d439e1625fac9a70bf3a0e181568a370d03fd63871973941d61f8a30334261e540ef291829f29a1f4fd7e31440dcf36b12a55e630", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6651c05659bfb681809ddb7f51481866cd76b3ec6a684db32c607808d9a71b39f4c3ad743f618098b1f40ace5d02c5ca4ded68f49b09c7ccb70d2c6945150ac7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec2f2b1803a4f7e6c80c5f7484a167c050652f02372a0fc16483e5834b5ae6b5c2645639a7417b4a7c92980c9e9e1c47b1ac397383d330de5a556e1e5ef5364f"} 05:57:32 INFO - Running post-run listener: copy_logs_to_upload_dir 05:57:32 INFO - Copying logs to upload dir... 05:57:32 INFO - mkdir: /builds/slave/test/build/upload/logs 05:57:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.805390 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-06-08 05:57:32.340832) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 05:57:32.343919) ========= 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=df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698 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/4b41605fe08ee74daa05378d439e1625fac9a70bf3a0e181568a370d03fd63871973941d61f8a30334261e540ef291829f29a1f4fd7e31440dcf36b12a55e630", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6651c05659bfb681809ddb7f51481866cd76b3ec6a684db32c607808d9a71b39f4c3ad743f618098b1f40ace5d02c5ca4ded68f49b09c7ccb70d2c6945150ac7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec2f2b1803a4f7e6c80c5f7484a167c050652f02372a0fc16483e5834b5ae6b5c2645639a7417b4a7c92980c9e9e1c47b1ac397383d330de5a556e1e5ef5364f"} build_url:https://queue.taskcluster.net/v1/task/GdmWkLNAQnSQYtvnT3m6aA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011449 build_url: 'https://queue.taskcluster.net/v1/task/GdmWkLNAQnSQYtvnT3m6aA/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/4b41605fe08ee74daa05378d439e1625fac9a70bf3a0e181568a370d03fd63871973941d61f8a30334261e540ef291829f29a1f4fd7e31440dcf36b12a55e630", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6651c05659bfb681809ddb7f51481866cd76b3ec6a684db32c607808d9a71b39f4c3ad743f618098b1f40ace5d02c5ca4ded68f49b09c7ccb70d2c6945150ac7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec2f2b1803a4f7e6c80c5f7484a167c050652f02372a0fc16483e5834b5ae6b5c2645639a7417b4a7c92980c9e9e1c47b1ac397383d330de5a556e1e5ef5364f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 05:57:32.368657) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:57:32.368955) ========= 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=df17445c3590ff7897617a0e00000225-1465388488.20058-1514709698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:57:32.454276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 05:57:32.454593) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 05:57:32.454860) ========= ========= Total master_lag: 0.19 =========