builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1465164017.74 results: success (0) buildid: 20160605113243 builduid: 91d7d1bdae394bbb858d02ad880b0d34 revision: 87207eee5e4785e29d405e7f3586d7bde08b91ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 15:00:17.738419) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 15:00:17.738915) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 15:00:17.739209) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 15:00:17.766540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 15:00:17.766863) ========= 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=52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-05 15:00:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-05 15:00:20 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113403 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 15:00:17.904520) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 15:00:17.904831) ========= 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=52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017097 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 15:00:17.960060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 15:00:17.960381) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 87207eee5e4785e29d405e7f3586d7bde08b91ce --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 87207eee5e4785e29d405e7f3586d7bde08b91ce --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=52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-05 15:00:20,369 truncating revision to first 12 chars 2016-06-05 15:00:20,369 Setting DEBUG logging. 2016-06-05 15:00:20,369 attempt 1/10 2016-06-05 15:00:20,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/87207eee5e47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-05 15:00:20,853 unpacking tar archive at: fx-team-87207eee5e47/testing/mozharness/ program finished with exit code 0 elapsedTime=0.871645 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 15:00:18.845609) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 15:00:18.845942) ========= script_repo_revision: 87207eee5e4785e29d405e7f3586d7bde08b91ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 15:00:18.846328) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 15:00:18.846636) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 15:00:18.855534) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-05 15:00:18.855858) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:00:21 INFO - MultiFileLogger online at 20160605 15:00:21 in /builds/slave/test 15:00:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:00:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:00:21 INFO - {'append_to_log': False, 15:00:21 INFO - 'base_work_dir': '/builds/slave/test', 15:00:21 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:00:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:00:21 INFO - 'branch': 'Fx-Team-Non-PGO', 15:00:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:00:21 INFO - 'config_files': ('talos/linux_config.py',), 15:00:21 INFO - 'default_actions': ('clobber', 15:00:21 INFO - 'read-buildbot-config', 15:00:21 INFO - 'download-and-extract', 15:00:21 INFO - 'populate-webroot', 15:00:21 INFO - 'create-virtualenv', 15:00:21 INFO - 'install', 15:00:21 INFO - 'run-tests'), 15:00:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:00:21 INFO - 'download_minidump_stackwalk': True, 15:00:21 INFO - 'download_symbols': 'ondemand', 15:00:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:00:21 INFO - 'tooltool.py': '/tools/tooltool.py', 15:00:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:00:21 INFO - '/tools/misc-python/virtualenv.py')}, 15:00:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:00:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:00:21 INFO - 'installer_path': 'installer.exe', 15:00:21 INFO - 'log_level': 'info', 15:00:21 INFO - 'log_name': 'talos', 15:00:21 INFO - 'log_to_console': True, 15:00:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:00:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:00:21 INFO - 'opt_config_files': (), 15:00:21 INFO - 'pip_index': False, 15:00:21 INFO - 'sps_profile': False, 15:00:21 INFO - 'sps_profile_interval': 0, 15:00:21 INFO - 'suite': 'dromaeojs', 15:00:21 INFO - 'system_bits': '32', 15:00:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:00:21 INFO - 'title': 'talos-linux64-ix-056', 15:00:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:00:21 INFO - 'use_talos_json': True, 15:00:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:00:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:00:21 INFO - 'work_dir': 'build'} 15:00:21 INFO - ##### 15:00:21 INFO - ##### Running clobber step. 15:00:21 INFO - ##### 15:00:21 INFO - Running pre-action listener: _resource_record_pre_action 15:00:21 INFO - Running main action method: clobber 15:00:21 INFO - rmtree: /builds/slave/test/build 15:00:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:00:21 INFO - Running post-action listener: _resource_record_post_action 15:00:21 INFO - ##### 15:00:21 INFO - ##### Finished clobber step (success) 15:00:21 INFO - ##### 15:00:21 INFO - ##### 15:00:21 INFO - ##### Running read-buildbot-config step. 15:00:21 INFO - ##### 15:00:21 INFO - Running pre-action listener: _resource_record_pre_action 15:00:21 INFO - Running main action method: read_buildbot_config 15:00:21 INFO - Using buildbot properties: 15:00:21 INFO - { 15:00:21 INFO - "project": "", 15:00:21 INFO - "product": "firefox", 15:00:21 INFO - "script_repo_revision": "production", 15:00:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:00:21 INFO - "repository": "", 15:00:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:00:21 INFO - "buildid": "20160605113243", 15:00:21 INFO - "pgo_build": "False", 15:00:21 INFO - "basedir": "/builds/slave/test", 15:00:21 INFO - "buildnumber": 1820, 15:00:21 INFO - "slavename": "talos-linux64-ix-056", 15:00:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:00:21 INFO - "platform": "ubuntu64_hw", 15:00:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:00:21 INFO - "branch": "fx-team", 15:00:21 INFO - "repo_path": "integration/fx-team", 15:00:21 INFO - "revision": "87207eee5e4785e29d405e7f3586d7bde08b91ce", 15:00:21 INFO - "stage_platform": "linux64", 15:00:21 INFO - "builduid": "91d7d1bdae394bbb858d02ad880b0d34", 15:00:21 INFO - "slavebuilddir": "test" 15:00:21 INFO - } 15:00:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:00:21 INFO - Running post-action listener: _resource_record_post_action 15:00:21 INFO - ##### 15:00:21 INFO - ##### Finished read-buildbot-config step (success) 15:00:21 INFO - ##### 15:00:21 INFO - ##### 15:00:21 INFO - ##### Running download-and-extract step. 15:00:21 INFO - ##### 15:00:21 INFO - Running pre-action listener: _resource_record_pre_action 15:00:21 INFO - Running main action method: download_and_extract 15:00:21 INFO - mkdir: /builds/slave/test/build/tests 15:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:21 INFO - https://queue.taskcluster.net/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:00:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:00:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:00:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:00:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:00:28 INFO - Downloaded 1361 bytes. 15:00:28 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:00:28 INFO - Using the following test package requirements: 15:00:28 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:00:28 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:00:28 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:00:28 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:28 INFO - u'jsshell-linux-x86_64.zip'], 15:00:28 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:00:28 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:00:28 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:00:28 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:00:28 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:00:28 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:00:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:00:28 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:00: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')]} 15:00:28 INFO - https://queue.taskcluster.net/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:00:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:00:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:00:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:00:33 INFO - Downloaded 22868152 bytes. 15:00:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:00:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:00:34 INFO - Return code: 0 15:00:34 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:34 INFO - https://queue.taskcluster.net/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:00:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:00:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:00:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:00:40 INFO - Downloaded 22868152 bytes. 15:00:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:00:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:00:42 INFO - Return code: 0 15:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:42 INFO - https://queue.taskcluster.net/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:00:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:00:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:00:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:00:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:00:43 INFO - Downloaded 10833369 bytes. 15:00:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:00:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:00:43 INFO - Return code: 0 15:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:43 INFO - https://queue.taskcluster.net/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:00:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:00:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:00:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:00:44 INFO - Downloaded 55183263 bytes. 15:00:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:00:44 INFO - mkdir: /builds/slave/test/properties 15:00:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:00:44 INFO - Writing to file /builds/slave/test/properties/build_url 15:00:44 INFO - Contents: 15:00:44 INFO - build_url:https://queue.taskcluster.net/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:00:45 INFO - Running post-action listener: _resource_record_post_action 15:00:45 INFO - Running post-action listener: set_extra_try_arguments 15:00:45 INFO - ##### 15:00:45 INFO - ##### Finished download-and-extract step (success) 15:00:45 INFO - ##### 15:00:45 INFO - ##### 15:00:45 INFO - ##### Running populate-webroot step. 15:00:45 INFO - ##### 15:00:45 INFO - Running pre-action listener: _resource_record_pre_action 15:00:45 INFO - Running main action method: populate_webroot 15:00:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:00:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:00:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:00:45 INFO - '--tppagecycles', 15:00:45 INFO - '7'], 15:00:45 INFO - 'tests': ['tsvgm']}}, 15:00:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:00:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:00:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:00:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:00:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:00:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:00:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:45 INFO - 'talos_options': ['--disable-e10s'], 15:00:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:00:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:00:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:45 INFO - 'talos_options': ['--disable-e10s'], 15:00:45 INFO - 'tests': ['damp', 'tps']}, 15:00:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:45 INFO - 'tests': ['damp', 'tps']}, 15:00:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:00:45 INFO - 'tests': ['dromaeo_dom']}, 15:00:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:00:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:00:45 INFO - 'tests': ['a11yr', 15:00:45 INFO - 'ts_paint', 15:00:45 INFO - 'tpaint', 15:00:45 INFO - 'sessionrestore', 15:00:45 INFO - 'sessionrestore_no_auto_restore', 15:00:45 INFO - 'tabpaint']}, 15:00:45 INFO - 'other-e10s': {'tests': ['a11yr', 15:00:45 INFO - 'ts_paint', 15:00:45 INFO - 'tpaint', 15:00:45 INFO - 'sessionrestore', 15:00:45 INFO - 'sessionrestore_no_auto_restore', 15:00:45 INFO - 'tabpaint']}, 15:00:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:00:45 INFO - 'ts_paint', 15:00:45 INFO - 'tpaint', 15:00:45 INFO - 'sessionrestore', 15:00:45 INFO - 'sessionrestore_no_auto_restore', 15:00:45 INFO - 'tabpaint']}, 15:00:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:00:45 INFO - 'ts_paint', 15:00:45 INFO - 'tpaint', 15:00:45 INFO - 'sessionrestore', 15:00:45 INFO - 'sessionrestore_no_auto_restore', 15:00:45 INFO - 'tabpaint']}, 15:00:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:00:45 INFO - 'tests': ['a11yr', 15:00:45 INFO - 'ts_paint', 15:00:45 INFO - 'tpaint', 15:00:45 INFO - 'sessionrestore', 15:00:45 INFO - 'sessionrestore_no_auto_restore', 15:00:45 INFO - 'tabpaint']}, 15:00:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:00:45 INFO - 'tests': ['a11yr', 15:00:45 INFO - 'ts_paint', 15:00:45 INFO - 'tpaint', 15:00:45 INFO - 'sessionrestore', 15:00:45 INFO - 'sessionrestore_no_auto_restore', 15:00:45 INFO - 'tabpaint']}, 15:00:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:00:45 INFO - 'tests': ['tsvgx', 15:00:45 INFO - 'tsvgr_opacity', 15:00:45 INFO - 'tart', 15:00:45 INFO - 'tscrollx', 15:00:45 INFO - 'cart']}, 15:00:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:00:45 INFO - 'tsvgr_opacity', 15:00:45 INFO - 'tart', 15:00:45 INFO - 'tscrollx', 15:00:45 INFO - 'cart']}, 15:00:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:45 INFO - 'talos_options': ['--disable-e10s'], 15:00:45 INFO - 'tests': ['tp5o']}, 15:00:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:45 INFO - 'tests': ['tp5o']}, 15:00:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:45 INFO - 'talos_options': ['--disable-e10s', 15:00:45 INFO - '--xperf_path', 15:00:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:00:45 INFO - 'tests': ['tp5n']}, 15:00:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:45 INFO - 'talos_options': ['--xperf_path', 15:00:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:00:45 INFO - 'tests': ['tp5n']}}, 15:00:45 INFO - 'talos.zip': {'path': '', 15:00:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:00:45 INFO - Running post-action listener: _resource_record_post_action 15:00:45 INFO - ##### 15:00:45 INFO - ##### Finished populate-webroot step (success) 15:00:45 INFO - ##### 15:00:45 INFO - ##### 15:00:45 INFO - ##### Running create-virtualenv step. 15:00:45 INFO - ##### 15:00:45 INFO - Running pre-action listener: _resource_record_pre_action 15:00:45 INFO - Running main action method: create_virtualenv 15:00:45 INFO - Creating virtualenv /builds/slave/test/build/venv 15:00:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:00:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:00:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:00:45 INFO - Using real prefix '/usr' 15:00:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:00:46 INFO - Installing distribute.............................................................................................................................................................................................done. 15:00:48 INFO - Installing pip.................done. 15:00:48 INFO - Return code: 0 15:00:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:48 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 0x7f7f2ed70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e1c0>, '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 0xd6f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6f550>, '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': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:00:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:00:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:00:48 INFO - Using env: {'DISPLAY': ':0', 15:00:48 INFO - 'HOME': '/home/cltbld', 15:00:48 INFO - 'LANG': 'en_US.UTF-8', 15:00:48 INFO - 'LANGUAGE': 'en_US:en', 15:00:48 INFO - 'LOGNAME': 'cltbld', 15:00:48 INFO - 'MAIL': '/var/mail/cltbld', 15:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:48 INFO - 'MOZ_NO_REMOTE': '1', 15:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:48 INFO - 'NO_EM_RESTART': '1', 15:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:48 INFO - 'PWD': '/builds/slave/test', 15:00:48 INFO - 'SHELL': '/bin/bash', 15:00:48 INFO - 'SHLVL': '1', 15:00:48 INFO - 'TERM': 'linux', 15:00:48 INFO - 'TMOUT': '86400', 15:00:48 INFO - 'USER': 'cltbld', 15:00:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 15:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:48 INFO - '_': '/tools/buildbot/bin/python'} 15:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:00:48 INFO - Cleaning up... 15:00:48 INFO - Return code: 0 15:00:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:48 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 0x7f7f2ed70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e1c0>, '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 0xd6f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6f550>, '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': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:00:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:00:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:00:48 INFO - Using env: {'DISPLAY': ':0', 15:00:48 INFO - 'HOME': '/home/cltbld', 15:00:48 INFO - 'LANG': 'en_US.UTF-8', 15:00:48 INFO - 'LANGUAGE': 'en_US:en', 15:00:48 INFO - 'LOGNAME': 'cltbld', 15:00:48 INFO - 'MAIL': '/var/mail/cltbld', 15:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:48 INFO - 'MOZ_NO_REMOTE': '1', 15:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:48 INFO - 'NO_EM_RESTART': '1', 15:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:48 INFO - 'PWD': '/builds/slave/test', 15:00:48 INFO - 'SHELL': '/bin/bash', 15:00:48 INFO - 'SHLVL': '1', 15:00:48 INFO - 'TERM': 'linux', 15:00:48 INFO - 'TMOUT': '86400', 15:00:48 INFO - 'USER': 'cltbld', 15:00:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 15:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:48 INFO - '_': '/tools/buildbot/bin/python'} 15:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:48 INFO - Downloading/unpacking psutil>=3.1.1 15:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:00:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:00:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:00:50 INFO - Installing collected packages: psutil 15:00:50 INFO - Running setup.py install for psutil 15:00:50 INFO - building 'psutil._psutil_linux' extension 15:00:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:00:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:00:51 INFO - building 'psutil._psutil_posix' extension 15:00:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:00:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:00:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:00:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:00:51 INFO - Successfully installed psutil 15:00:51 INFO - Cleaning up... 15:00:51 INFO - Return code: 0 15:00:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:51 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 0x7f7f2ed70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e1c0>, '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 0xd6f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6f550>, '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': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:00:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:00:51 INFO - Using env: {'DISPLAY': ':0', 15:00:51 INFO - 'HOME': '/home/cltbld', 15:00:51 INFO - 'LANG': 'en_US.UTF-8', 15:00:51 INFO - 'LANGUAGE': 'en_US:en', 15:00:51 INFO - 'LOGNAME': 'cltbld', 15:00:51 INFO - 'MAIL': '/var/mail/cltbld', 15:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:51 INFO - 'MOZ_NO_REMOTE': '1', 15:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:51 INFO - 'NO_EM_RESTART': '1', 15:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:51 INFO - 'PWD': '/builds/slave/test', 15:00:51 INFO - 'SHELL': '/bin/bash', 15:00:51 INFO - 'SHLVL': '1', 15:00:51 INFO - 'TERM': 'linux', 15:00:51 INFO - 'TMOUT': '86400', 15:00:51 INFO - 'USER': 'cltbld', 15:00:51 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 15:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:51 INFO - '_': '/tools/buildbot/bin/python'} 15:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:00:53 INFO - Installing collected packages: mozsystemmonitor 15:00:53 INFO - Running setup.py install for mozsystemmonitor 15:00:53 INFO - Successfully installed mozsystemmonitor 15:00:53 INFO - Cleaning up... 15:00:53 INFO - Return code: 0 15:00:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:53 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 0x7f7f2ed70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e1c0>, '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 0xd6f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6f550>, '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': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:00:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:00:53 INFO - Using env: {'DISPLAY': ':0', 15:00:53 INFO - 'HOME': '/home/cltbld', 15:00:53 INFO - 'LANG': 'en_US.UTF-8', 15:00:53 INFO - 'LANGUAGE': 'en_US:en', 15:00:53 INFO - 'LOGNAME': 'cltbld', 15:00:53 INFO - 'MAIL': '/var/mail/cltbld', 15:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:53 INFO - 'MOZ_NO_REMOTE': '1', 15:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:53 INFO - 'NO_EM_RESTART': '1', 15:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:53 INFO - 'PWD': '/builds/slave/test', 15:00:53 INFO - 'SHELL': '/bin/bash', 15:00:53 INFO - 'SHLVL': '1', 15:00:53 INFO - 'TERM': 'linux', 15:00:53 INFO - 'TMOUT': '86400', 15:00:53 INFO - 'USER': 'cltbld', 15:00:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 15:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:53 INFO - '_': '/tools/buildbot/bin/python'} 15:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:53 INFO - Downloading/unpacking jsonschema==2.5.1 15:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:00:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:55 INFO - Downloading functools32-3.2.3-2.tar.gz 15:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:00:56 INFO - warning: no files found matching '*.txt' 15:00:56 INFO - no previously-included directories found matching 'build' 15:00:56 INFO - no previously-included directories found matching 'dist' 15:00:56 INFO - no previously-included directories found matching '.git*' 15:00:56 INFO - Installing collected packages: jsonschema, functools32 15:00:56 INFO - Running setup.py install for functools32 15:00:56 INFO - warning: no files found matching '*.txt' 15:00:56 INFO - no previously-included directories found matching 'build' 15:00:56 INFO - no previously-included directories found matching 'dist' 15:00:56 INFO - no previously-included directories found matching '.git*' 15:00:56 INFO - Successfully installed jsonschema functools32 15:00:56 INFO - Cleaning up... 15:00:56 INFO - Return code: 0 15:00:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:56 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 0x7f7f2ed70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e1c0>, '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 0xd6f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6f550>, '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': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:00:56 INFO - Using env: {'DISPLAY': ':0', 15:00:56 INFO - 'HOME': '/home/cltbld', 15:00:56 INFO - 'LANG': 'en_US.UTF-8', 15:00:56 INFO - 'LANGUAGE': 'en_US:en', 15:00:56 INFO - 'LOGNAME': 'cltbld', 15:00:56 INFO - 'MAIL': '/var/mail/cltbld', 15:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:56 INFO - 'MOZ_NO_REMOTE': '1', 15:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:56 INFO - 'NO_EM_RESTART': '1', 15:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:56 INFO - 'PWD': '/builds/slave/test', 15:00:56 INFO - 'SHELL': '/bin/bash', 15:00:56 INFO - 'SHLVL': '1', 15:00:56 INFO - 'TERM': 'linux', 15:00:56 INFO - 'TMOUT': '86400', 15:00:56 INFO - 'USER': 'cltbld', 15:00:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 15:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:56 INFO - '_': '/tools/buildbot/bin/python'} 15:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:56 INFO - Downloading/unpacking blobuploader==1.2.4 15:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:58 INFO - Downloading blobuploader-1.2.4.tar.gz 15:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:00:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:00: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 15:00: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 15:00: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 15:00: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 15:00: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 15:00: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 15:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:00:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:00: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 15:00: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 15:00: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 15:00: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 15:00: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 15:00: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 15:00:59 INFO - Downloading docopt-0.6.1.tar.gz 15:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:00:59 INFO - Installing collected packages: blobuploader, requests, docopt 15:00:59 INFO - Running setup.py install for blobuploader 15:00:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:00:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:00:59 INFO - Running setup.py install for requests 15:00:59 INFO - Running setup.py install for docopt 15:00:59 INFO - Successfully installed blobuploader requests docopt 15:00:59 INFO - Cleaning up... 15:00:59 INFO - Return code: 0 15:00:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:59 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 0x7f7f2ed70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e1c0>, '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 0xd6f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6f550>, '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': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:00:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:00:59 INFO - Using env: {'DISPLAY': ':0', 15:00:59 INFO - 'HOME': '/home/cltbld', 15:00:59 INFO - 'LANG': 'en_US.UTF-8', 15:00:59 INFO - 'LANGUAGE': 'en_US:en', 15:00:59 INFO - 'LOGNAME': 'cltbld', 15:00:59 INFO - 'MAIL': '/var/mail/cltbld', 15:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:59 INFO - 'MOZ_NO_REMOTE': '1', 15:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:59 INFO - 'NO_EM_RESTART': '1', 15:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:59 INFO - 'PWD': '/builds/slave/test', 15:00:59 INFO - 'SHELL': '/bin/bash', 15:00:59 INFO - 'SHLVL': '1', 15:00:59 INFO - 'TERM': 'linux', 15:00:59 INFO - 'TMOUT': '86400', 15:00:59 INFO - 'USER': 'cltbld', 15:00:59 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 15:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:59 INFO - '_': '/tools/buildbot/bin/python'} 15:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:00:59 INFO - Running setup.py (path:/tmp/pip-LXbGSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:00:59 INFO - Running setup.py (path:/tmp/pip-RbhfOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:00 INFO - Running setup.py (path:/tmp/pip-_W8ZQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:00 INFO - Running setup.py (path:/tmp/pip-5P4uTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:00 INFO - Running setup.py (path:/tmp/pip-y6fjz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:00 INFO - Running setup.py (path:/tmp/pip-hkPOsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:00 INFO - Running setup.py (path:/tmp/pip-v67aqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:00 INFO - Running setup.py (path:/tmp/pip-CfkOW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:00 INFO - Running setup.py (path:/tmp/pip-n0TOpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:00 INFO - Running setup.py (path:/tmp/pip-5r2Cy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:00 INFO - Running setup.py (path:/tmp/pip-xLGboX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:00 INFO - Running setup.py (path:/tmp/pip-yBtpIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:00 INFO - Running setup.py (path:/tmp/pip-336o7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:00 INFO - Running setup.py (path:/tmp/pip-2HZrAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:00 INFO - Running setup.py (path:/tmp/pip-rZxn9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:01 INFO - Running setup.py (path:/tmp/pip-8UjeLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:01 INFO - Running setup.py (path:/tmp/pip-W_JwIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:01:01 INFO - Running setup.py install for manifestparser 15:01:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:01:01 INFO - Running setup.py install for mozcrash 15:01:01 INFO - Running setup.py install for mozdebug 15:01:01 INFO - Running setup.py install for mozdevice 15:01:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:01:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:01:01 INFO - Running setup.py install for mozfile 15:01:01 INFO - Running setup.py install for mozhttpd 15:01:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:01:01 INFO - Running setup.py install for mozinfo 15:01:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:01:01 INFO - Running setup.py install for mozInstall 15:01:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:01:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:01:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:01:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:01:01 INFO - Running setup.py install for mozleak 15:01:02 INFO - Running setup.py install for mozlog 15:01:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:01:02 INFO - Running setup.py install for moznetwork 15:01:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:01:02 INFO - Running setup.py install for mozprocess 15:01:02 INFO - Running setup.py install for mozprofile 15:01:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:01:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:01:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:01:02 INFO - Running setup.py install for mozrunner 15:01:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:01:02 INFO - Running setup.py install for mozscreenshot 15:01:02 INFO - Running setup.py install for moztest 15:01:02 INFO - Running setup.py install for mozversion 15:01:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:01:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:01:02 INFO - Cleaning up... 15:01:02 INFO - Return code: 0 15:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:02 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 0x7f7f2ed70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e1c0>, '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 0xd6f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6f550>, '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': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:01:02 INFO - Using env: {'DISPLAY': ':0', 15:01:02 INFO - 'HOME': '/home/cltbld', 15:01:02 INFO - 'LANG': 'en_US.UTF-8', 15:01:02 INFO - 'LANGUAGE': 'en_US:en', 15:01:02 INFO - 'LOGNAME': 'cltbld', 15:01:02 INFO - 'MAIL': '/var/mail/cltbld', 15:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:02 INFO - 'MOZ_NO_REMOTE': '1', 15:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:02 INFO - 'NO_EM_RESTART': '1', 15:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:02 INFO - 'PWD': '/builds/slave/test', 15:01:02 INFO - 'SHELL': '/bin/bash', 15:01:02 INFO - 'SHLVL': '1', 15:01:02 INFO - 'TERM': 'linux', 15:01:02 INFO - 'TMOUT': '86400', 15:01:02 INFO - 'USER': 'cltbld', 15:01:02 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 15:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:02 INFO - '_': '/tools/buildbot/bin/python'} 15:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:03 INFO - Running setup.py (path:/tmp/pip-bt5sNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:03 INFO - Running setup.py (path:/tmp/pip-YXoKIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:03 INFO - Running setup.py (path:/tmp/pip-2eNq9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:03 INFO - Running setup.py (path:/tmp/pip-MFPuV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:03 INFO - Running setup.py (path:/tmp/pip-pNSU4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:03 INFO - Running setup.py (path:/tmp/pip-Jdh_u0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:03 INFO - Running setup.py (path:/tmp/pip-ripr6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:03 INFO - Running setup.py (path:/tmp/pip-DhXG68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:03 INFO - Running setup.py (path:/tmp/pip-MksDSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:03 INFO - Running setup.py (path:/tmp/pip-lAnFHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:03 INFO - Running setup.py (path:/tmp/pip-f7t6NX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:03 INFO - Running setup.py (path:/tmp/pip-vpF9U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:04 INFO - Running setup.py (path:/tmp/pip-Qboj5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:04 INFO - Running setup.py (path:/tmp/pip-ZBKkTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:04 INFO - Running setup.py (path:/tmp/pip-A1EzZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:04 INFO - Running setup.py (path:/tmp/pip-0gfUOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:04 INFO - Running setup.py (path:/tmp/pip-T9hQPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:06 INFO - Downloading blessings-1.6.tar.gz 15:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:01:06 INFO - Installing collected packages: blessings 15:01:06 INFO - Running setup.py install for blessings 15:01:06 INFO - Successfully installed blessings 15:01:06 INFO - Cleaning up... 15:01:06 INFO - Return code: 0 15:01:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:06 INFO - Reading from file tmpfile_stdout 15:01:06 INFO - Current package versions: 15:01:06 INFO - argparse == 1.2.1 15:01:06 INFO - blessings == 1.6 15:01:06 INFO - blobuploader == 1.2.4 15:01:06 INFO - docopt == 0.6.1 15:01:06 INFO - functools32 == 3.2.3-2 15:01:06 INFO - jsonschema == 2.5.1 15:01:06 INFO - manifestparser == 1.1 15:01:06 INFO - mozInstall == 1.12 15:01:06 INFO - mozcrash == 0.17 15:01:06 INFO - mozdebug == 0.1 15:01:06 INFO - mozdevice == 0.48 15:01:06 INFO - mozfile == 1.2 15:01:06 INFO - mozhttpd == 0.7 15:01:06 INFO - mozinfo == 0.9 15:01:06 INFO - mozleak == 0.1 15:01:06 INFO - mozlog == 3.2 15:01:06 INFO - moznetwork == 0.27 15:01:06 INFO - mozprocess == 0.22 15:01:06 INFO - mozprofile == 0.28 15:01:06 INFO - mozrunner == 6.11 15:01:06 INFO - mozscreenshot == 0.1 15:01:06 INFO - mozsystemmonitor == 0.3 15:01:06 INFO - moztest == 0.7 15:01:06 INFO - mozversion == 1.4 15:01:06 INFO - psutil == 3.1.1 15:01:06 INFO - requests == 1.2.3 15:01:06 INFO - wsgiref == 0.1.2 15:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:06 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 0x7f7f2ed70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e1c0>, '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 0xd6f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6f550>, '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': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:01:06 INFO - Using env: {'DISPLAY': ':0', 15:01:06 INFO - 'HOME': '/home/cltbld', 15:01:06 INFO - 'LANG': 'en_US.UTF-8', 15:01:06 INFO - 'LANGUAGE': 'en_US:en', 15:01:06 INFO - 'LOGNAME': 'cltbld', 15:01:06 INFO - 'MAIL': '/var/mail/cltbld', 15:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:06 INFO - 'MOZ_NO_REMOTE': '1', 15:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:06 INFO - 'NO_EM_RESTART': '1', 15:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:06 INFO - 'PWD': '/builds/slave/test', 15:01:06 INFO - 'SHELL': '/bin/bash', 15:01:06 INFO - 'SHLVL': '1', 15:01:06 INFO - 'TERM': 'linux', 15:01:06 INFO - 'TMOUT': '86400', 15:01:06 INFO - 'USER': 'cltbld', 15:01:06 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 15:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:06 INFO - '_': '/tools/buildbot/bin/python'} 15:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:01:06 INFO - Cleaning up... 15:01:06 INFO - Return code: 0 15:01:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f2ed70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e1c0>, '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 0xd6f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6f550>, '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': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01: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', 'jsonschema'] in /builds/slave/test/build 15:01: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 jsonschema 15:01:06 INFO - Using env: {'DISPLAY': ':0', 15:01:06 INFO - 'HOME': '/home/cltbld', 15:01:06 INFO - 'LANG': 'en_US.UTF-8', 15:01:06 INFO - 'LANGUAGE': 'en_US:en', 15:01:06 INFO - 'LOGNAME': 'cltbld', 15:01:06 INFO - 'MAIL': '/var/mail/cltbld', 15:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:06 INFO - 'MOZ_NO_REMOTE': '1', 15:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:06 INFO - 'NO_EM_RESTART': '1', 15:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:06 INFO - 'PWD': '/builds/slave/test', 15:01:06 INFO - 'SHELL': '/bin/bash', 15:01:07 INFO - 'SHLVL': '1', 15:01:07 INFO - 'TERM': 'linux', 15:01:07 INFO - 'TMOUT': '86400', 15:01:07 INFO - 'USER': 'cltbld', 15:01:07 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 15:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:07 INFO - '_': '/tools/buildbot/bin/python'} 15:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:01:07 INFO - Cleaning up... 15:01:07 INFO - Return code: 0 15:01:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:07 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 0x7f7f2ed70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcdf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e1c0>, '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 0xd6f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6f550>, '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': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:01:07 INFO - Using env: {'DISPLAY': ':0', 15:01:07 INFO - 'HOME': '/home/cltbld', 15:01:07 INFO - 'LANG': 'en_US.UTF-8', 15:01:07 INFO - 'LANGUAGE': 'en_US:en', 15:01:07 INFO - 'LOGNAME': 'cltbld', 15:01:07 INFO - 'MAIL': '/var/mail/cltbld', 15:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:07 INFO - 'MOZ_NO_REMOTE': '1', 15:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:07 INFO - 'NO_EM_RESTART': '1', 15:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:07 INFO - 'PWD': '/builds/slave/test', 15:01:07 INFO - 'SHELL': '/bin/bash', 15:01:07 INFO - 'SHLVL': '1', 15:01:07 INFO - 'TERM': 'linux', 15:01:07 INFO - 'TMOUT': '86400', 15:01:07 INFO - 'USER': 'cltbld', 15:01:07 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 15:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:07 INFO - '_': '/tools/buildbot/bin/python'} 15:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:07 INFO - Downloading/unpacking flake8 15:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:01:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:01:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:01:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:01:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:01:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:01:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:01:10 INFO - no previously-included directories found matching 'docs/_build' 15:01:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:01:10 INFO - Running setup.py install for pep8 15:01:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:01:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:01:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:01:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:01:10 INFO - no previously-included directories found matching 'docs/_build' 15:01:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:01:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:01:10 INFO - Cleaning up... 15:01:10 INFO - Return code: 0 15:01:10 INFO - Running post-action listener: _resource_record_post_action 15:01:10 INFO - Running post-action listener: _start_resource_monitoring 15:01:10 INFO - Starting resource monitoring. 15:01:10 INFO - ##### 15:01:10 INFO - ##### Finished create-virtualenv step (success) 15:01:10 INFO - ##### 15:01:10 INFO - ##### 15:01:10 INFO - ##### Running install step. 15:01:10 INFO - ##### 15:01:10 INFO - Running pre-action listener: _resource_record_pre_action 15:01:10 INFO - Running main action method: install 15:01:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:10 INFO - Reading from file tmpfile_stdout 15:01:10 INFO - Detecting whether we're running mozinstall >=1.0... 15:01:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:01:10 INFO - Reading from file tmpfile_stdout 15:01:10 INFO - Output received: 15:01:10 INFO - Usage: mozinstall [options] installer 15:01:10 INFO - Options: 15:01:10 INFO - -h, --help show this help message and exit 15:01:10 INFO - -d DEST, --destination=DEST 15:01:10 INFO - Directory to install application into. [default: 15:01:10 INFO - "/builds/slave/test"] 15:01:10 INFO - --app=APP Application being installed. [default: firefox] 15:01:10 INFO - mkdir: /builds/slave/test/build/application 15:01:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:01:26 INFO - Reading from file tmpfile_stdout 15:01:26 INFO - Output received: 15:01:26 INFO - /builds/slave/test/build/application/firefox/firefox 15:01:26 INFO - Running post-action listener: _resource_record_post_action 15:01:26 INFO - ##### 15:01:26 INFO - ##### Finished install step (success) 15:01:26 INFO - ##### 15:01:26 INFO - ##### 15:01:26 INFO - ##### Running run-tests step. 15:01:26 INFO - ##### 15:01:26 INFO - Running pre-action listener: _resource_record_pre_action 15:01:26 INFO - Running main action method: run_tests 15:01:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:01:26 INFO - Python 2.7.3 15:01:26 INFO - Return code: 0 15:01:26 INFO - grabbing minidump binary from tooltool 15:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:26 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 0xd6e1c0>, '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 0xd6f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd6f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:01:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:01:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:01:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:01:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:01:26 INFO - Return code: 0 15:01:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:01:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:01:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:01:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:01:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:01:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:01:27 INFO - Return code: 0 15:01:27 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:01:27 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:01:27 INFO - Using env: {'DISPLAY': ':0', 15:01:27 INFO - 'HOME': '/home/cltbld', 15:01:27 INFO - 'LANG': 'en_US.UTF-8', 15:01:27 INFO - 'LANGUAGE': 'en_US:en', 15:01:27 INFO - 'LOGNAME': 'cltbld', 15:01:27 INFO - 'MAIL': '/var/mail/cltbld', 15:01:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:01:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:27 INFO - 'MOZ_NO_REMOTE': '1', 15:01:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:27 INFO - 'NO_EM_RESTART': '1', 15:01:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:27 INFO - 'PWD': '/builds/slave/test', 15:01:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:01:27 INFO - 'SHELL': '/bin/bash', 15:01:27 INFO - 'SHLVL': '1', 15:01:27 INFO - 'TERM': 'linux', 15:01:27 INFO - 'TMOUT': '86400', 15:01:27 INFO - 'USER': 'cltbld', 15:01:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262', 15:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:27 INFO - '_': '/tools/buildbot/bin/python'} 15:01:27 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:01:27 INFO - mozversion application_buildid: 20160605113243 15:01:27 INFO - mozversion application_changeset: 87207eee5e4785e29d405e7f3586d7bde08b91ce 15:01:27 INFO - mozversion application_display_name: Nightly 15:01:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:01:27 INFO - mozversion application_name: Firefox 15:01:27 INFO - mozversion application_remotingname: firefox 15:01:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:01:27 INFO - mozversion application_vendor: Mozilla 15:01:27 INFO - mozversion application_version: 49.0a1 15:01:27 INFO - mozversion platform_buildid: 20160605113243 15:01:27 INFO - mozversion platform_changeset: 87207eee5e4785e29d405e7f3586d7bde08b91ce 15:01:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:01:27 INFO - mozversion platform_version: 49.0a1 15:01:27 INFO - using testdate: 1465164087 15:01:27 INFO - actual date: 1465164087 15:01:27 INFO - starting webserver on 'localhost:44126' 15:01:27 INFO - SUITE-START | Running 2 tests 15:01:27 INFO - TEST-START | dromaeo_css 15:01:27 INFO - operating with platform_type : linux_ 15:01:27 INFO - Initialising browser for dromaeo_css test... 15:01:27 INFO - TEST-INFO | started process 2772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWeZNFZ/profile http://localhost:44126/getInfo.html) 15:01:32 INFO - PROCESS | 2772 | __metrics Screen width/height:1600/1200 15:01:32 INFO - PROCESS | 2772 | colorDepth:24 15:01:32 INFO - PROCESS | 2772 | Browser inner width/height: 1024/697 15:01:32 INFO - PROCESS | 2772 | __metrics 15:01:33 ERROR - PROCESS | 2772 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:01:34 INFO - TEST-INFO | 2772: exit 0 15:01:34 INFO - Browser initialized. 15:01:34 INFO - Running cycle 1/1 for dromaeo_css test... 15:01:34 INFO - TEST-INFO | started process 2903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWeZNFZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:01:46 INFO - PROCESS | 2903 | RSS: Main: 158031872 15:01:46 INFO - PROCESS | 2903 | 15:02:38 INFO - PROCESS | 2903 | 1465164158322 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:04:49 INFO - PROCESS | 2903 | Cycle 1(1): loaded http://localhost:44126/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44126/tests/dromaeo/cssquery-ext.html) 15:04:51 INFO - PROCESS | 2903 | RSS: Main: 270028800 15:04:51 INFO - PROCESS | 2903 | 15:07:53 INFO - PROCESS | 2903 | Cycle 1(1): loaded http://localhost:44126/tests/dromaeo/cssquery-ext.html (next: http://localhost:44126/tests/dromaeo/cssquery-jquery.html) 15:07:54 INFO - PROCESS | 2903 | RSS: Main: 240717824 15:07:54 INFO - PROCESS | 2903 | 15:10:56 INFO - PROCESS | 2903 | Cycle 1(1): loaded http://localhost:44126/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44126/tests/dromaeo/cssquery-mootools.html) 15:10:57 INFO - PROCESS | 2903 | RSS: Main: 240455680 15:10:57 INFO - PROCESS | 2903 | 15:13:59 INFO - PROCESS | 2903 | Cycle 1(1): loaded http://localhost:44126/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44126/tests/dromaeo/cssquery-prototype.html) 15:14:00 INFO - PROCESS | 2903 | RSS: Main: 232603648 15:14:00 INFO - PROCESS | 2903 | 15:17:03 INFO - PROCESS | 2903 | Cycle 1(1): loaded http://localhost:44126/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44126/tests/dromaeo/cssquery-yui.html) 15:17:03 INFO - PROCESS | 2903 | RSS: Main: 227962880 15:17:03 INFO - PROCESS | 2903 | 15:20:06 INFO - PROCESS | 2903 | Cycle 1(1): loaded http://localhost:44126/tests/dromaeo/cssquery-yui.html (next: http://localhost:44126/tests/dromaeo/cssquery-dojo.html) 15:20:07 INFO - PROCESS | 2903 | RSS: Main: 257728512 15:20:07 INFO - PROCESS | 2903 | 15:20:07 INFO - PROCESS | 2903 | __start_tp_report 15:20:07 INFO - PROCESS | 2903 | _x_x_mozilla_page_load 15:20:07 INFO - PROCESS | 2903 | _x_x_mozilla_page_load_details 15:20:07 INFO - PROCESS | 2903 | |i|pagename|runs| 15:20:07 INFO - PROCESS | 2903 | |0;dojo.html;2653.2305631366903;2658.654374931259;2688.139795265515;2694.6227528146064;2701.1086341507303;4503.639708823294;4567.817287308504;4700.271457924018;4776.6178705703505;4806.399200099988;4584.19776539106;4612.21592329304;4693.178693728601;4695.812167513295;4748.548887855648;4064.634182923536;4182.728122672024;4251.914961700764;4298.46269216348;4387.780610969455;4343.500497442803;4344.239758042346;4376.059147283333;4377.080813029268;4411.911761764763;4234.55537168599;4245.511766146902;4277.465316835395;4279.679024073176;4312.159128969852;4288.270993931039;4289.1421715657;4295.14097180562;4339.414179085815;4342.717723348004;4308.676849236288;4319.632831209319;4323.135372925396;4365.563443655641;4375.649948004152;4477.731336119843;4588.059447813191;4612.215923293014;4662.3705799716945;4688.953110468886;5163.457836927106;5171.7672704728375;5174.3790745110455;5182.870428239325;5189.740512974374;5073.162928116856;5140.151874940668;5175.585953123741;5196.1166601677805;5199.974000130013;4601.102784956935;4702.623790096784;4741.217699079613;4756.286557016406;4775.140474714515;5192.428832828386;5221.791128354899;5263.499967503081;5264;5265.631405801634;4768.117898188846;4925.9014819704125;4930.802767889244;4968.8757781055765;4993.725345106054;4972.875678108004;5023.171176755867;5032.773525191302;5069.366329208849;5097.719625420564;5033.496650335011;5034.043531728959;5035.269885866529;5038.067957427887;5080.415752188472;4854.660173787801;4987.301777751118;5000.1249781288125;5029.949700503022;5033.823816166417;4210.052738133957;4225.345071513921;4231.280682284019;4261.808218630169;4277.337012763027;3735.4210097434943;3763.9623603764157;3778.508793856781;3801;3816.8282427290837;4181.937270940938;4236.809343579546;4241.34259189826;4391.494978077498;4401.40581021558;4901.436334821541;4934.55588996992;4962.454130045692;4978.4025916890205;5056.696598204119;4252.064545799919;4266.978665106717;4322.243607368698;4333.349997500401;4337.371081193272;4541.795619197144;4545.477270113913;4546.772661366985;4563.361129441881;4583.243764778841;4610.239310513794;4706.976465117653;4754.904901902012;4761.952380476151;4819.807207711652;5036.622253330942;5054.317667114892;5056.115179843439;5060.569851562511;5088.160453525127;4759.333693282874;4764.33299338086;4765.309030190672;4767.641222251642;4809.903801923872;4743.715377077248;4906.852794416173;5010.774515146754;5021.297018417497;5066.442691304027;5107.310513080686;5110.591152707849;5113.335266415343;5114.2840002400435;5172.250023746611;4966.975165124151;4966.975165124151;4970.105381031449;4974.452810190804;4974.900501989868;4755.785989630405;4895.1922932717125;4921.384826896638;4943.3573635427165;4981.053599816023;4828.324034635084;4867.7322747249245;4905.681130726492;4909.386326709161;4916.139675556835;4811.230203167476;5008.84973450797;5014.874628134326;5056.140456122394;5069.7465126744255;4771;4812.542808433193;4816.012717392856;4822.276658501253;4822.807087716452 15:20:07 INFO - PROCESS | 2903 | |1;ext.html;540.110737246308;576.7664096041104;590.8936391449539;594.5927039977613;597.3130899465615;27030.324241893937;39278.803605981964;40133.799331003305;40196.1960760785;44412.3338149928;41837.581624183746;42436.151276974444;42440;42452.363214551726;42469;7546.2831031051965;7669.693212271516;7858.1356050834365;7863.449558530905;9826.263030272723;9858.408495490257;10018.699439016842;10041.899581004205;10165.288429809916;10176.542055607515;10097.54561044751;10176.64381746639;10214.9785021498;10271.075603195712;10278.229132815031;7682.807929801744;10143.695689129338;10176.79646407075;10488.213383996155;10501.894981050169;9938.10557049869;10043.347182433119;10063.345882517613;10066.848997265048;10072.647457338959;38497.615023849685;38961.610383896084;38968.61031389678;39002;39072.60927390718;3013.819170849756;3158.5735925649974;3305.7851239669344;3689.4281386385155;3726.161613636937;29581.55627665587;29640.555391669142;29996;30075.548866767014;31083.533746993813;3387.7289816814596;3419.247765491613;3459.515667806509;3521.876734314312;3539;247268;248695;249123;249890;251286;33712.49431258533;34984.9504514865;51690;52552;52671.47328526742;34007.82996085004;34153.829230854186;34240.48639270413;34365.65634343675;34398.48402273968;13336.5332213374;13564.796528052088;13570.86429135696;13580.45678172862;13592.320383980761;8996.145366190201;10696.51865666047;10968.506417211245;11004.779904401867;11196.328220306808;7983.68065277394;7989.520628762293;8016.398770092266;8070.556119413372;8073.6366863491285;3091.629004519472;3095.2261934516373;3120.7503399727966;3147.244661281276;3152.621685397767;842.6292431330318;949.2500924269888;972.8783902012249;1015.4567306490992;1036.0623635609786;26121.477570448864;26993.730062699513;27430.725692743217;27526.17421477359;27819.304517386823;1011.0748664971616;1039.111559616517;1051.542578978147;1061.0662616897234;1101.2456467319912;14192.503262385768;14603.612656797588;14782.704345913022;14824.110553366832;15074.849251507563;365963;366208;367580;371209;371760;49451.752741236785;50109.498905010485;50128.49871501311;50130.24804627933;50144.74927625339;1107.789519991199;1186.4398316214151;1203.374245392391;1229.6003798765437;1240.7828629989535;28342;29278.26804329909;29739.851300743358;29866.402671946875;30213.848930755204;41136;41747.37378939258;41781.58218417777;41787.283826551175;41802.163956720084;231701;235921;236575;236756;237008;22161.33515994523;23965.880170599732;24557.140500082412;24686.13598524043;26716.732832671423;41619;42189.57810421856;42249.577504224566;42520;43415.56584434115;35336;36366;36578.63421365859;36741.63258367489;37021.6297837029;35878.820605896806;36101.638983609824;36399.81800090983;36684.44973325349;36737.44893826648;35393.46909796304;35554;35772.64227357693;35934.8203258982;36075.819620901726;31670.524942126347;32421.35157296794;33064.50403243905;33130.66869331276;33187.33625327528;23991.943485335443;24151.275461736175;24237;24424.51150976935;24444.388890277885 15:20:07 INFO - PROCESS | 2903 | |2;jquery.html;371.4242923468623;372.5399132071891;376.08611075087526;391.56536244768284;394.72369341460984;15486.845131548682;16952.915235423807;17125.143742812856;17199.226034828433;17390.73913891291;15643.843561564381;16408.17959102046;16415.83584164161;16429.01425914446;16429.507114786546;4819.132556139903;5019.272205530196;5058.443571207183;5064.645474816764;5069.2649565812935;3687.244114956441;4963.305137280783;5710.514606258473;6032.276126864783;6046.637201767886;6050.606710563821;6064.181335519715;6072.483838873679;6084.148219249309;6087.573869829113;5624.943750562483;5780.7687692492245;5922.733476993524;6006.639601623895;6015.458608725214;3328.8335583220983;4911.68074075184;5081.517255860687;5290.100682883919;5293.3647962244395;19358.70961935558;20114.497137571532;20173;20201.29295474666;20231;1761.3042848075067;2119.7032415461695;2204.9448763780874;2256.4922892349255;2519.3071905226025;9202.53987300639;9314.323421784076;9508.952455237679;11102.722431939186;13146.60560183196;1626.7478540826073;1648.6398721055177;1710.700627390214;1759.2259405861507;1765.5056584156328;64499.355006449805;65736;65942.67028664827;66141.66929165323;67441;10064.094231519199;10156.898431015743;10254.94901019784;10410.427426491615;10454.372737635766;14118.152910825178;14184.929075354763;14228.217448040457;14251.643708907153;14268.286585670676;6841.281665425158;7038.401735852408;7044.753433629799;7146.285371462916;7186.928130718626;6444.645544495098;6498.057781621638;6578.868422631521;6589.670516474157;6613.338666133348;4316.482022157361;4406.581374769392;4493;4518.909621807546;4537.296719008559;1666.3505027007118;1768.593223558563;1792.4353828543967;1798.6492633936257;1815.7276408538826;783.1893989720726;873.1486800369589;889.2530274569264;893.687209476691;927.5825878354632;15133.243337833064;15558;15560.688786224213;16006.279717412745;16134.75797863033;797.1589972578869;840.2185967050701;857.8455877941906;885.9778505537413;967.0184762466102;8779.561021948877;9172.633094676139;9189.77025574366;9222.723318300461;9230.049425361747;344377;350699;350831;353384;357277;71752;73178;74813.08434491011;75138;76373.61813190898;828.9544075075929;911.129870973219;923.4136323434533;928.6285485805597;939.7556635274877;12445.751084978068;14529.200893950934;14708.926455367655;15242.161681107646;15869.761953570474;32993.505097423076;33586.16034599154;33789.32421351608;34202.48696269608;35174.12064698403;45119.32321015122;45169.77415112904;46384.53615463937;46447.767761160976;46557.30164047474;7483.775486735407;7555.508891922227;7581.949913841549;7625.199354067743;7826.178251283761;10819.513121909376;11673.35796531165;11691.707707307385;11740.354280514654;11805.468753905923;9726.319157658896;9901;10006.399616023062;10177.236707246839;10356.896431035593;10016.749581260527;10137.341072830242;10221.540030698785;10269.794604108025;10428.217883658604;9585;10067.597296108073;10071.446070466194;10337.638182663572;10385.792284154426;7656.196099409704;7674.884876726966;7715.614219289126;7829.491083079582;7923.366130709414;9149.496777677292;9698.175655069399;9816.31285810015;9849.950750246202;10306.487094494525 15:20:07 INFO - PROCESS | 2903 | |3;mootools.html;1216.452596331651;1384.4531410093011;1436.0952599862085;1525.4508376984284;1766.390595244641;6616.735330586776;7408.777736667902;7653.69385224591;7655.961720191392;7847.372210223182;7589.354904833082;7730.845383092349;7746.728864489744;7750.689972401097;7754.612269386522;1823.2069049963309;2028.3712049264775;2121.8939053047325;2132.3922682035623;2150.3441450357636;2162.38372063961;2182.6616874384495;2184.0390228299498;2184.595849767798;2191.912323507058;2042.2852001799326;2082.208760670943;2090.205721825704;2091.9267825626107;2092.2781640334138;1744.9476515704612;1935.5741736817877;2015.606956643455;2017.8486613503899;2080.95838083239;2052.48687828043;2055.2190167736167;2057.660486019805;2065.917363305466;2084.781097984705;7616.3906887448875;7624.161342252348;7672.961635191844;7680.38556915451;7694.5383277003;4176.874693759192;4284.250256205183;4285.914281714379;4315.978420107911;4341.826326946918;2763.585462180669;2888.3068063664778;2897.913062608125;2900.4344152890194;2901.17316564778;834.649447232164;842.5660784695887;861.9310455163571;864.2308345572445;873.6898401067657;9951.502424878727;9965;9968.302218844683;9968.950155249322;10029.849552256723;3954.5452272988973;4066.0851308455362;4120.052387950788;4148.688848336386;4158.500979882433;8640.092790257058;8689.782755431164;8701.17338852808;8716.12838716136;8724.738257852274;4304.677149213821;4367.432233809584;4371.934420983688;4372.125574885035;4373.300271956472;3473.392156372625;3851.171998020439;3982.820773065219;4004.65960393364;4049.91900162001;3604.1710406606626;3622.7826330420257;3685.1339935115225;3710.18375957289;3749.3813520769313;1148.8908553687386;1159.1074872348413;1164.4177911044478;1169.5321871251567;1169.8830116988404;640.1997503121098;673.1854456108164;764.4152223548879;781.6052893288853;786.2648423723837;5115.539601435814;5178.922316165261;5247.422783493813;5305.336832895888;5365.973170134124;380.84766093562797;387.25646758224275;389.73303287248325;398.1876970979228;399.08808372867855;3517.191046059421;3543;3573.76770509916;3601.819909004592;3624.637536246354;8713.477191368538;8929.464232145961;9009.09909009107;9029.051949545203;9048.321375896703;8874;8953.686620968365;8987.19115279628;9001.909980900238;9005.549722513848;6884.690188941609;7003.8599228015155;7076.115485564304;7077.150741911004;7091.361777440055;5124.538791508633;5223.973880130575;5238.768889311085;5250.76606997363;5318.601104917069;8052.275295223458;8357.95821020891;8361.665533378597;8432.831343372976;8588.742337729878;8505.489670619536;8590;8594.226519613016;8622.698205562776;8730.825383492422;5871.706414679164;6084.117802918464;6102.847428814315;6398.48812095022;6552.08270842092;6945.444364450933;7040.190378106583;7155.356017958408;7455.515391499535;7465.06686664167;6655.467562594884;6739.292374300628;6747.865042699217;6838.179418469816;6902.8619427610165;6624.105745724266;6648.335166483313;6661.134052573135;6736.562123461959;6797.93202067973;6372.55392122547;6385.8722825544155;6482.027695845472;6490;6502;4324.654027677841;4380.518143004203;4396.032872767986;4447.955520444754;4463.843765468193;4527.796249168861;4537.750423726727;4539.84110556129;4579.473360563577;4596.5863072323655 15:20:07 INFO - PROCESS | 2903 | |4;prototype.html;290.6454125966321;295.88164734106357;297.7022977022977;300.2763340349758;302.3846472428608;4749.430068391794;4771.332013518101;4809.422869255694;4810.567048965592;4837.80648774049;4772.856814295576;4777.163996300651;4784.976075119628;4790.664653474259;4835.226363781796;3567.1973805893663;3660.5973342932257;3667.431548110047;3748.737588368815;3794.620537946197;3717;3737.8412692065413;3739.7943113128767;3749.400095984643;3769.868054618089;3695.427208782643;3711.0351308659806;3719.051641831329;3723.702103831687;3733.533308336458;3520.489529018291;3620.0949762559494;3772.2832661794173;3784.9621503784883;3813.3707938190164;3334.249793796401;3347.6317605063423;3349.7152742016956;3353.161709572607;3364.814935178564;4573.336866154422;4588.724676519386;4589.770511474447;4628.976855115703;4669.439667239919;4185.455890734185;4327.5239723630375;4335.114225312;4341.110072435144;4356.8257269709175;4943.3439797667825;5023.598112151019;5029.145045342264;5040.42035165957;5046.1926091825135;3659.6157403472516;3669.1377526281303;3675.9707281960827;3682.9263414731554;3683.4843121962945;5083.364579427572;5186.273921650972;5229.692576855786;5292.947070529284;5300.496452836975;3731.160488889978;3732.2162345907122;3736.962630373716;3739.1399978004665;3756.4740936268945;3794.2032173243374;3797.1394016931504;3797.4493698413576;3799.886003419902;3801.904952376213;4278.144371125787;4285.292926667065;4289.871303860889;4292.763897985641;4320.503142138694;4899.779509922062;4933.901321973541;4976.730933611906;5000.774965126578;5052.04011237871;1288.1176394170025;1294.8187253784479;1299.9415026323838;1300.5513097981182;1305.5626365167586;815.8089189782864;833.4166083741405;854.4147259127518;868.4789126524036;870.1385628228135;4316.719413238129;4422.624076953431;4427.424434823452;4470.821167153277;4472.329150627432;5129.897402051938;5155.252488389163;5167.03652612005;5201.193814958688;5205.505476979681;4372.956270437318;4385.101054283864;4413.823447062082;4426.313921342197;4437.5784300491405;2595.7923366130663;2750.642416485844;2768.169549135251;2769.584562315669;2779.069011881002;4842.806287748521;4897.951020489821;4912.6561140719805;4924.261360795837;4933.950660493421;5020.472850350734;5291.174544782044;5318.723506358523;5319.973400132974;5333.2266821310695;4906.435759887659;4924.72913989734;4927.531884471041;4939.863831318817;4945.851624451272;5154.737089413118;5216.947830521646;5241.895162096813;5249.7375131242525;5261.736913154404;4912.606991440748;5072.898542029213;5078;5111.309973153725;5154.433012368561;4891.902161956812;4909.5090490950615;4915.6067514598035;4930.348333308382;4934.161192597339;3745.906352341104;3790.5261842269715;3817.8737272504122;3817.961820381872;3820.1595648957186;5060.006487187775;5139.460356662496;5238.1618940969265;5272.261883336413;5278.445763194963;4951.603871690184;5028.321176641107;5028.346314979176;5033.723145227048;5052.292679025013;5013.248012797963;5022.974885125551;5024.723640199824;5032.572231360376;5048.59611231108;4746.38297021385;4888.388951381077;4889.315495830658;4905.435874874435;4946.455889852042;4843.418789745253;4987.376577927759;4997.650164488597;5005.599552035901;5114.232865070269;4753.786079626356;4855.810326470038;4856.441509226484;4865.489123641966;4897.559219670246 15:20:07 INFO - PROCESS | 2903 | |5;yui.html;580.0429291668746;648.71132346106;708.9858202835943;727.3453891497652;736.6316841579211;11526.654200373992;11965.58120465784;11992.280463172216;12319.905616045271;12746.10777245593;11767.7646447071;11883.108766842479;11887.702807429798;11893.286402815836;11961.880381196186;630.7886857902586;767.7850201943437;794.5709316968845;807.3299161695778;822.3380178955938;798.022422532396;798.3573223555036;800.5516910530092;800.6397121295412;800.8838718385831;828.056016141599;828.7430896422098;829.8879651247065;830.5390508267909;831.600831600832;661.1207094564218;806.7983004248968;832.1221111727125;832.488019867777;836.1387770596295;611.9541034422436;612.1643956000028;613.5030625193607;614.3518587889774;614.4347200575481;12992.155509891827;13011;13027.739445211042;13034.348282585834;13040.80438793419;12233.571824986171;12511.436985335591;12638;12691.492340306377;13005.674858128528;10427.322224055411;10508.684739457829;10586.841197382046;10837.024667779859;10917.454127293604;4111.568285330027;4111.588841115894;4169.291220492523;4177.415161877339;4239.173361194568;55188.44811551873;56368;56373.71813140949;56958.715206424116;56972.43027569713;10303.793924121475;10373.948130259301;10443.11233545142;10485.947570262253;10487.528061237263;19005.714914276297;19040.52398690016;19052.61894762097;19060.332888348843;19089.140988655545;6438.581492202992;6462.224533056064;6468.191476065492;6514.934850651528;6710.328967103251;3680.4663323817895;3733;3736.551613806361;3743.494628225209;3749.643783840531;2630.4476060027228;2693.0978122328847;2713.579395193748;2715.646965894421;2716.307341627872;454.7044421126228;477.0792370724535;509.87762936894876;526.9631125821156;530.6285600079882;512.9512696293846;549.7745924171071;584.1471451680509;614.3610644929223;623.6351734235433;8160.4287699861625;8487.533185674847;8632.870506942401;8753.693620723245;8814.074522175079;468.71408440851053;505.89376230991905;513.8098903405689;563.6626161685789;650.2392201124695;4133.586641335903;4147.460830092069;4269.167512335127;4282.678799090018;4308.870733877989;83842;84647;85502.57248713716;86622.56688716516;90280;74612.25387746161;76886.61556692292;77032;77670.61164694253;78196.60901695455;64693;65206.34793652098;65409;65479;65613.99999999904;6879.552829066095;7022.754203602849;7044.366007059184;7161.785146445615;7162.391196748335;42417.48572685531;43376.56623433725;44037.779811100736;44266;44368.778156109016;54130.18804718011;60822.391776083445;60872;61050.08424873719;61423.385766143554;9226.953865230631;10312.742181445225;10373.740656483647;10406;10528.263021588415;10957;10999.505022273857;13036.152650077714;13219.66950826237;13240.86759132435;11979.940100299442;11987.940060299643;12188.878111219128;12228.082893782825;12326.81509777336;9417.561428094084;10245.641402550875;11183.832242516532;11322.60370887015;11786.76426471483;11634.301941883514;11731.178817483036;12027.047901894064;12322.800348459607;12386.442610082388;9278.95360523193;9394.95302523483;9460.432374057578;9610;9878.30851840393;9888.901110989085;10422.270441069355;10461.476926153815;10502.789944201226;10530.842037369292 15:20:07 INFO - PROCESS | 2903 | __end_tp_report 15:20:07 INFO - PROCESS | 2903 | __start_cc_report 15:20:07 INFO - PROCESS | 2903 | _x_x_mozilla_cycle_collect,1031 15:20:07 INFO - PROCESS | 2903 | __end_cc_report 15:20:07 INFO - PROCESS | 2903 | __startTimestamp1465165207054__endTimestamp 15:20:07 INFO - PROCESS | 2903 | 15:20:07 INFO - PROCESS | 2903 | ------- Summary: start ------- 15:20:07 INFO - PROCESS | 2903 | Number of tests: 6 15:20:07 INFO - PROCESS | 2903 | 15:20:07 INFO - PROCESS | 2903 | [#0] dojo.html Cycles:165 Average:4659.13 Median:4768.12 stddev:497.64 (10.4%) stddev-sans-first:473.64 15:20:07 INFO - PROCESS | 2903 | Values: 2653.2 2658.7 2688.1 2694.6 2701.1 4503.6 4567.8 4700.3 4776.6 4806.4 4584.2 4612.2 4693.2 4695.8 4748.5 4064.6 4182.7 4251.9 4298.5 4387.8 4343.5 4344.2 4376.1 4377.1 4411.9 4234.6 4245.5 4277.5 4279.7 4312.2 4288.3 4289.1 4295.1 4339.4 4342.7 4308.7 4319.6 4323.1 4365.6 4375.6 4477.7 4588.1 4612.2 4662.4 4689.0 5163.5 5171.8 5174.4 5182.9 5189.7 5073.2 5140.2 5175.6 5196.1 5200.0 4601.1 4702.6 4741.2 4756.3 4775.1 5192.4 5221.8 5263.5 5264.0 5265.6 4768.1 4925.9 4930.8 4968.9 4993.7 4972.9 5023.2 5032.8 5069.4 5097.7 5033.5 5034.0 5035.3 5038.1 5080.4 4854.7 4987.3 5000.1 5029.9 5033.8 4210.1 4225.3 4231.3 4261.8 4277.3 3735.4 3764.0 3778.5 3801.0 3816.8 4181.9 4236.8 4241.3 4391.5 4401.4 4901.4 4934.6 4962.5 4978.4 5056.7 4252.1 4267.0 4322.2 4333.3 4337.4 4541.8 4545.5 4546.8 4563.4 4583.2 4610.2 4707.0 4754.9 4762.0 4819.8 5036.6 5054.3 5056.1 5060.6 5088.2 4759.3 4764.3 4765.3 4767.6 4809.9 4743.7 4906.9 5010.8 5021.3 5066.4 5107.3 5110.6 5113.3 5114.3 5172.3 4967.0 4967.0 4970.1 4974.5 4974.9 4755.8 4895.2 4921.4 4943.4 4981.1 4828.3 4867.7 4905.7 4909.4 4916.1 4811.2 5008.8 5014.9 5056.1 5069.7 4771.0 4812.5 4816.0 4822.3 4822.8 15:20:07 INFO - PROCESS | 2903 | 15:20:07 INFO - PROCESS | 2903 | [#1] ext.html Cycles:180 Average:43657.53 Median:33159.00 stddev:76360.60 (230.3%) stddev-sans-first:76506.19 15:20:07 INFO - PROCESS | 2903 | Values: 540.1 576.8 590.9 594.6 597.3 27030.3 39278.8 40133.8 40196.2 44412.3 41837.6 42436.2 42440.0 42452.4 42469.0 7546.3 7669.7 7858.1 7863.4 9826.3 9858.4 10018.7 10041.9 10165.3 10176.5 10097.5 10176.6 10215.0 10271.1 10278.2 7682.8 10143.7 10176.8 10488.2 10501.9 9938.1 10043.3 10063.3 10066.8 10072.6 38497.6 38961.6 38968.6 39002.0 39072.6 3013.8 3158.6 3305.8 3689.4 3726.2 29581.6 29640.6 29996.0 30075.5 31083.5 3387.7 3419.2 3459.5 3521.9 3539.0 247268.0 248695.0 249123.0 249890.0 251286.0 33712.5 34985.0 51690.0 52552.0 52671.5 34007.8 34153.8 34240.5 34365.7 34398.5 13336.5 13564.8 13570.9 13580.5 13592.3 8996.1 10696.5 10968.5 11004.8 11196.3 7983.7 7989.5 8016.4 8070.6 8073.6 3091.6 3095.2 3120.8 3147.2 3152.6 842.6 949.3 972.9 1015.5 1036.1 26121.5 26993.7 27430.7 27526.2 27819.3 1011.1 1039.1 1051.5 1061.1 1101.2 14192.5 14603.6 14782.7 14824.1 15074.8 365963.0 366208.0 367580.0 371209.0 371760.0 49451.8 50109.5 50128.5 50130.2 50144.7 1107.8 1186.4 1203.4 1229.6 1240.8 28342.0 29278.3 29739.9 29866.4 30213.8 41136.0 41747.4 41781.6 41787.3 41802.2 231701.0 235921.0 236575.0 236756.0 237008.0 22161.3 23965.9 24557.1 24686.1 26716.7 41619.0 42189.6 42249.6 42520.0 43415.6 35336.0 36366.0 36578.6 36741.6 37021.6 35878.8 36101.6 36399.8 36684.4 36737.4 35393.5 35554.0 35772.6 35934.8 36075.8 31670.5 32421.4 33064.5 33130.7 33187.3 23991.9 24151.3 24237.0 24424.5 24444.4 15:20:07 INFO - PROCESS | 2903 | 15:20:07 INFO - PROCESS | 2903 | [#2] jquery.html Cycles:180 Average:22765.77 Median:45144.55 stddev:58076.67 (128.6%) stddev-sans-first:58215.25 15:20:07 INFO - PROCESS | 2903 | Values: 371.4 372.5 376.1 391.6 394.7 15486.8 16952.9 17125.1 17199.2 17390.7 15643.8 16408.2 16415.8 16429.0 16429.5 4819.1 5019.3 5058.4 5064.6 5069.3 3687.2 4963.3 5710.5 6032.3 6046.6 6050.6 6064.2 6072.5 6084.1 6087.6 5624.9 5780.8 5922.7 6006.6 6015.5 3328.8 4911.7 5081.5 5290.1 5293.4 19358.7 20114.5 20173.0 20201.3 20231.0 1761.3 2119.7 2204.9 2256.5 2519.3 9202.5 9314.3 9509.0 11102.7 13146.6 1626.7 1648.6 1710.7 1759.2 1765.5 64499.4 65736.0 65942.7 66141.7 67441.0 10064.1 10156.9 10254.9 10410.4 10454.4 14118.2 14184.9 14228.2 14251.6 14268.3 6841.3 7038.4 7044.8 7146.3 7186.9 6444.6 6498.1 6578.9 6589.7 6613.3 4316.5 4406.6 4493.0 4518.9 4537.3 1666.4 1768.6 1792.4 1798.6 1815.7 783.2 873.1 889.3 893.7 927.6 15133.2 15558.0 15560.7 16006.3 16134.8 797.2 840.2 857.8 886.0 967.0 8779.6 9172.6 9189.8 9222.7 9230.0 344377.0 350699.0 350831.0 353384.0 357277.0 71752.0 73178.0 74813.1 75138.0 76373.6 829.0 911.1 923.4 928.6 939.8 12445.8 14529.2 14708.9 15242.2 15869.8 32993.5 33586.2 33789.3 34202.5 35174.1 45119.3 45169.8 46384.5 46447.8 46557.3 7483.8 7555.5 7581.9 7625.2 7826.2 10819.5 11673.4 11691.7 11740.4 11805.5 9726.3 9901.0 10006.4 10177.2 10356.9 10016.7 10137.3 10221.5 10269.8 10428.2 9585.0 10067.6 10071.4 10337.6 10385.8 7656.2 7674.9 7715.6 7829.5 7923.4 9149.5 9698.2 9816.3 9850.0 10306.5 15:20:07 INFO - PROCESS | 2903 | 15:20:07 INFO - PROCESS | 2903 | [#3] mootools.html Cycles:180 Average:4938.99 Median:5243.10 stddev:2757.75 (52.6%) stddev-sans-first:2751.29 15:20:07 INFO - PROCESS | 2903 | Values: 1216.5 1384.5 1436.1 1525.5 1766.4 6616.7 7408.8 7653.7 7656.0 7847.4 7589.4 7730.8 7746.7 7750.7 7754.6 1823.2 2028.4 2121.9 2132.4 2150.3 2162.4 2182.7 2184.0 2184.6 2191.9 2042.3 2082.2 2090.2 2091.9 2092.3 1744.9 1935.6 2015.6 2017.8 2081.0 2052.5 2055.2 2057.7 2065.9 2084.8 7616.4 7624.2 7673.0 7680.4 7694.5 4176.9 4284.3 4285.9 4316.0 4341.8 2763.6 2888.3 2897.9 2900.4 2901.2 834.6 842.6 861.9 864.2 873.7 9951.5 9965.0 9968.3 9969.0 10029.8 3954.5 4066.1 4120.1 4148.7 4158.5 8640.1 8689.8 8701.2 8716.1 8724.7 4304.7 4367.4 4371.9 4372.1 4373.3 3473.4 3851.2 3982.8 4004.7 4049.9 3604.2 3622.8 3685.1 3710.2 3749.4 1148.9 1159.1 1164.4 1169.5 1169.9 640.2 673.2 764.4 781.6 786.3 5115.5 5178.9 5247.4 5305.3 5366.0 380.8 387.3 389.7 398.2 399.1 3517.2 3543.0 3573.8 3601.8 3624.6 8713.5 8929.5 9009.1 9029.1 9048.3 8874.0 8953.7 8987.2 9001.9 9005.5 6884.7 7003.9 7076.1 7077.2 7091.4 5124.5 5224.0 5238.8 5250.8 5318.6 8052.3 8358.0 8361.7 8432.8 8588.7 8505.5 8590.0 8594.2 8622.7 8730.8 5871.7 6084.1 6102.8 6398.5 6552.1 6945.4 7040.2 7155.4 7455.5 7465.1 6655.5 6739.3 6747.9 6838.2 6902.9 6624.1 6648.3 6661.1 6736.6 6797.9 6372.6 6385.9 6482.0 6490.0 6502.0 4324.7 4380.5 4396.0 4448.0 4463.8 4527.8 4537.8 4539.8 4579.5 4596.6 15:20:07 INFO - PROCESS | 2903 | 15:20:07 INFO - PROCESS | 2903 | [#4] prototype.html Cycles:180 Average:4184.59 Median:4781.07 stddev:1206.91 (25.2%) stddev-sans-first:1174.38 15:20:07 INFO - PROCESS | 2903 | Values: 290.6 295.9 297.7 300.3 302.4 4749.4 4771.3 4809.4 4810.6 4837.8 4772.9 4777.2 4785.0 4790.7 4835.2 3567.2 3660.6 3667.4 3748.7 3794.6 3717.0 3737.8 3739.8 3749.4 3769.9 3695.4 3711.0 3719.1 3723.7 3733.5 3520.5 3620.1 3772.3 3785.0 3813.4 3334.2 3347.6 3349.7 3353.2 3364.8 4573.3 4588.7 4589.8 4629.0 4669.4 4185.5 4327.5 4335.1 4341.1 4356.8 4943.3 5023.6 5029.1 5040.4 5046.2 3659.6 3669.1 3676.0 3682.9 3683.5 5083.4 5186.3 5229.7 5292.9 5300.5 3731.2 3732.2 3737.0 3739.1 3756.5 3794.2 3797.1 3797.4 3799.9 3801.9 4278.1 4285.3 4289.9 4292.8 4320.5 4899.8 4933.9 4976.7 5000.8 5052.0 1288.1 1294.8 1299.9 1300.6 1305.6 815.8 833.4 854.4 868.5 870.1 4316.7 4422.6 4427.4 4470.8 4472.3 5129.9 5155.3 5167.0 5201.2 5205.5 4373.0 4385.1 4413.8 4426.3 4437.6 2595.8 2750.6 2768.2 2769.6 2779.1 4842.8 4898.0 4912.7 4924.3 4934.0 5020.5 5291.2 5318.7 5320.0 5333.2 4906.4 4924.7 4927.5 4939.9 4945.9 5154.7 5216.9 5241.9 5249.7 5261.7 4912.6 5072.9 5078.0 5111.3 5154.4 4891.9 4909.5 4915.6 4930.3 4934.2 3745.9 3790.5 3817.9 3818.0 3820.2 5060.0 5139.5 5238.2 5272.3 5278.4 4951.6 5028.3 5028.3 5033.7 5052.3 5013.2 5023.0 5024.7 5032.6 5048.6 4746.4 4888.4 4889.3 4905.4 4946.5 4843.4 4987.4 4997.7 5005.6 5114.2 4753.8 4855.8 4856.4 4865.5 4897.6 15:20:07 INFO - PROCESS | 2903 | 15:20:07 INFO - PROCESS | 2903 | [#5] yui.html Cycles:180 Average:16615.78 Median:507.89 stddev:22801.46 (4489.5%) stddev-sans-first:22833.63 15:20:07 INFO - PROCESS | 2903 | Values: 580.0 648.7 709.0 727.3 736.6 11526.7 11965.6 11992.3 12319.9 12746.1 11767.8 11883.1 11887.7 11893.3 11961.9 630.8 767.8 794.6 807.3 822.3 798.0 798.4 800.6 800.6 800.9 828.1 828.7 829.9 830.5 831.6 661.1 806.8 832.1 832.5 836.1 612.0 612.2 613.5 614.4 614.4 12992.2 13011.0 13027.7 13034.3 13040.8 12233.6 12511.4 12638.0 12691.5 13005.7 10427.3 10508.7 10586.8 10837.0 10917.5 4111.6 4111.6 4169.3 4177.4 4239.2 55188.4 56368.0 56373.7 56958.7 56972.4 10303.8 10373.9 10443.1 10485.9 10487.5 19005.7 19040.5 19052.6 19060.3 19089.1 6438.6 6462.2 6468.2 6514.9 6710.3 3680.5 3733.0 3736.6 3743.5 3749.6 2630.4 2693.1 2713.6 2715.6 2716.3 454.7 477.1 509.9 527.0 530.6 513.0 549.8 584.1 614.4 623.6 8160.4 8487.5 8632.9 8753.7 8814.1 468.7 505.9 513.8 563.7 650.2 4133.6 4147.5 4269.2 4282.7 4308.9 83842.0 84647.0 85502.6 86622.6 90280.0 74612.3 76886.6 77032.0 77670.6 78196.6 64693.0 65206.3 65409.0 65479.0 65614.0 6879.6 7022.8 7044.4 7161.8 7162.4 42417.5 43376.6 44037.8 44266.0 44368.8 54130.2 60822.4 60872.0 61050.1 61423.4 9227.0 10312.7 10373.7 10406.0 10528.3 10957.0 10999.5 13036.2 13219.7 13240.9 11979.9 11987.9 12188.9 12228.1 12326.8 9417.6 10245.6 11183.8 11322.6 11786.8 11634.3 11731.2 12027.0 12322.8 12386.4 9279.0 9395.0 9460.4 9610.0 9878.3 9888.9 10422.3 10461.5 10502.8 10530.8 15:20:07 INFO - PROCESS | 2903 | -------- Summary: end -------- 15:20:07 INFO - PROCESS | 2903 | 15:20:07 INFO - TEST-INFO | 2903: exit 0 15:20:07 INFO - TEST-OK | dromaeo_css | took 1119856ms 15:20:07 INFO - TEST-START | kraken 15:20:07 INFO - operating with platform_type : linux_ 15:20:07 INFO - Initialising browser for kraken test... 15:20:07 INFO - TEST-INFO | started process 3097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6XQ9yV/profile http://localhost:44126/getInfo.html) 15:20:12 INFO - PROCESS | 3097 | __metrics Screen width/height:1600/1200 15:20:12 INFO - PROCESS | 3097 | colorDepth:24 15:20:12 INFO - PROCESS | 3097 | Browser inner width/height: 1024/697 15:20:12 INFO - PROCESS | 3097 | __metrics 15:20:13 ERROR - PROCESS | 3097 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:20:14 INFO - TEST-INFO | 3097: exit 0 15:20:14 INFO - Browser initialized. 15:20:14 INFO - Running cycle 1/1 for kraken test... 15:20:14 INFO - TEST-INFO | started process 3176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6XQ9yV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:20:26 INFO - PROCESS | 3176 | RSS: Main: 158019584 15:20:26 INFO - PROCESS | 3176 | 15:20:29 INFO - PROCESS | 3176 | Cycle 1(1): loaded http://localhost:44126/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44126/tests/kraken/driver.html?testName=audio-beat-detection) 15:20:30 INFO - PROCESS | 3176 | RSS: Main: 215113728 15:20:30 INFO - PROCESS | 3176 | 15:20:32 INFO - PROCESS | 3176 | Cycle 1(1): loaded http://localhost:44126/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44126/tests/kraken/driver.html?testName=audio-dft) 15:20:33 INFO - PROCESS | 3176 | RSS: Main: 202309632 15:20:33 INFO - PROCESS | 3176 | 15:20:36 INFO - PROCESS | 3176 | Cycle 1(1): loaded http://localhost:44126/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44126/tests/kraken/driver.html?testName=audio-fft) 15:20:37 INFO - PROCESS | 3176 | RSS: Main: 270213120 15:20:37 INFO - PROCESS | 3176 | 15:20:39 INFO - PROCESS | 3176 | Cycle 1(1): loaded http://localhost:44126/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44126/tests/kraken/driver.html?testName=audio-oscillator) 15:20:40 INFO - PROCESS | 3176 | RSS: Main: 180838400 15:20:40 INFO - PROCESS | 3176 | 15:20:42 INFO - PROCESS | 3176 | Cycle 1(1): loaded http://localhost:44126/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44126/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:20:43 INFO - PROCESS | 3176 | RSS: Main: 185200640 15:20:43 INFO - PROCESS | 3176 | 15:20:46 INFO - PROCESS | 3176 | Cycle 1(1): loaded http://localhost:44126/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44126/tests/kraken/driver.html?testName=imaging-darkroom) 15:20:46 INFO - PROCESS | 3176 | RSS: Main: 220991488 15:20:46 INFO - PROCESS | 3176 | 15:20:50 INFO - PROCESS | 3176 | Cycle 1(1): loaded http://localhost:44126/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44126/tests/kraken/driver.html?testName=imaging-desaturate) 15:20:50 INFO - PROCESS | 3176 | RSS: Main: 216805376 15:20:50 INFO - PROCESS | 3176 | 15:20:53 INFO - PROCESS | 3176 | Cycle 1(1): loaded http://localhost:44126/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44126/tests/kraken/driver.html?testName=json-parse-financial) 15:20:54 INFO - PROCESS | 3176 | RSS: Main: 219713536 15:20:54 INFO - PROCESS | 3176 | 15:20:56 INFO - PROCESS | 3176 | Cycle 1(1): loaded http://localhost:44126/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44126/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:20:56 INFO - PROCESS | 3176 | RSS: Main: 208568320 15:20:56 INFO - PROCESS | 3176 | 15:20:58 INFO - PROCESS | 3176 | Cycle 1(1): loaded http://localhost:44126/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44126/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:20:59 INFO - PROCESS | 3176 | RSS: Main: 211910656 15:20:59 INFO - PROCESS | 3176 | 15:21:01 INFO - PROCESS | 3176 | Cycle 1(1): loaded http://localhost:44126/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44126/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:21:02 INFO - PROCESS | 3176 | RSS: Main: 218394624 15:21:02 INFO - PROCESS | 3176 | 15:21:05 INFO - PROCESS | 3176 | Cycle 1(1): loaded http://localhost:44126/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:21:05 INFO - PROCESS | 3176 | RSS: Main: 222707712 15:21:05 INFO - PROCESS | 3176 | 15:21:08 INFO - PROCESS | 3176 | Cycle 1(1): loaded http://localhost:44126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:21:09 INFO - PROCESS | 3176 | RSS: Main: 222605312 15:21:09 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | Cycle 1(1): loaded http://localhost:44126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44126/tests/kraken/driver.html?testName=ai-astar) 15:21:11 INFO - PROCESS | 3176 | RSS: Main: 264413184 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | __start_tp_report 15:21:11 INFO - PROCESS | 3176 | _x_x_mozilla_page_load 15:21:11 INFO - PROCESS | 3176 | _x_x_mozilla_page_load_details 15:21:11 INFO - PROCESS | 3176 | |i|pagename|runs| 15:21:11 INFO - PROCESS | 3176 | |0;ai-astar;113;108;113;113;113;114;112;113;113;112 15:21:11 INFO - PROCESS | 3176 | |1;audio-beat-detection;156;142;131;187;141;142;166;130;194;129 15:21:11 INFO - PROCESS | 3176 | |2;audio-dft;161;162;160;161;161;160;161;161;164;163 15:21:11 INFO - PROCESS | 3176 | |3;audio-fft;82;76;76;127;76;76;77;77;102;76 15:21:11 INFO - PROCESS | 3176 | |4;audio-oscillator;86;87;114;86;87;87;117;86;87;126 15:21:11 INFO - PROCESS | 3176 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 15:21:11 INFO - PROCESS | 3176 | |6;imaging-darkroom;146;147;146;145;146;146;146;146;145;146 15:21:11 INFO - PROCESS | 3176 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 15:21:11 INFO - PROCESS | 3176 | |8;json-parse-financial;65;65;64;65;65;72;64;64;64;65 15:21:11 INFO - PROCESS | 3176 | |9;json-stringify-tinderbox;66;65;66;65;66;65;66;65;65;66 15:21:11 INFO - PROCESS | 3176 | |10;stanford-crypto-aes;89;90;85;90;91;86;86;86;115;90 15:21:11 INFO - PROCESS | 3176 | |11;stanford-crypto-ccm;144;143;143;151;133;140;133;134;136;136 15:21:11 INFO - PROCESS | 3176 | |12;stanford-crypto-pbkdf2;170;173;170;169;169;171;172;176;177;173 15:21:11 INFO - PROCESS | 3176 | |13;stanford-crypto-sha256-iterative;68;68;69;67;66;67;67;67;70;67 15:21:11 INFO - PROCESS | 3176 | __end_tp_report 15:21:11 INFO - PROCESS | 3176 | __start_cc_report 15:21:11 INFO - PROCESS | 3176 | _x_x_mozilla_cycle_collect,1894 15:21:11 INFO - PROCESS | 3176 | __end_cc_report 15:21:11 INFO - PROCESS | 3176 | __startTimestamp1465165271314__endTimestamp 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | ------- Summary: start ------- 15:21:11 INFO - PROCESS | 3176 | Number of tests: 14 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:1.65 (1.5%) stddev-sans-first:1.73 15:21:11 INFO - PROCESS | 3176 | Values: 113.0 108.0 113.0 113.0 113.0 114.0 112.0 113.0 113.0 112.0 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:149.00 stddev:23.51 (15.8%) stddev-sans-first:24.89 15:21:11 INFO - PROCESS | 3176 | Values: 156.0 142.0 131.0 187.0 141.0 142.0 166.0 130.0 194.0 129.0 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 15:21:11 INFO - PROCESS | 3176 | Values: 161.0 162.0 160.0 161.0 161.0 160.0 161.0 161.0 164.0 163.0 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | [#3] audio-fft Cycles:10 Average:84.50 Median:76.00 stddev:16.97 (22.3%) stddev-sans-first:17.98 15:21:11 INFO - PROCESS | 3176 | Values: 82.0 76.0 76.0 127.0 76.0 76.0 77.0 77.0 102.0 76.0 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:86.50 stddev:15.94 (18.4%) stddev-sans-first:16.47 15:21:11 INFO - PROCESS | 3176 | Values: 86.0 87.0 114.0 86.0 87.0 87.0 117.0 86.0 87.0 126.0 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:21:11 INFO - PROCESS | 3176 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 15:21:11 INFO - PROCESS | 3176 | Values: 146.0 147.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:21:11 INFO - PROCESS | 3176 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:2.41 (3.7%) stddev-sans-first:2.55 15:21:11 INFO - PROCESS | 3176 | Values: 65.0 65.0 64.0 65.0 65.0 72.0 64.0 64.0 64.0 65.0 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 15:21:11 INFO - PROCESS | 3176 | Values: 66.0 65.0 66.0 65.0 66.0 65.0 66.0 65.0 65.0 66.0 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:89.50 stddev:8.78 (9.8%) stddev-sans-first:9.29 15:21:11 INFO - PROCESS | 3176 | Values: 89.0 90.0 85.0 90.0 91.0 86.0 86.0 86.0 115.0 90.0 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:141.50 stddev:5.93 (4.2%) stddev-sans-first:6.04 15:21:11 INFO - PROCESS | 3176 | Values: 144.0 143.0 143.0 151.0 133.0 140.0 133.0 134.0 136.0 136.0 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.50 stddev:2.79 (1.6%) stddev-sans-first:2.86 15:21:11 INFO - PROCESS | 3176 | Values: 170.0 173.0 170.0 169.0 169.0 171.0 172.0 176.0 177.0 173.0 15:21:11 INFO - PROCESS | 3176 | 15:21:11 INFO - PROCESS | 3176 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.17 (1.7%) stddev-sans-first:1.24 15:21:11 INFO - PROCESS | 3176 | Values: 68.0 68.0 69.0 67.0 66.0 67.0 67.0 67.0 70.0 67.0 15:21:11 INFO - PROCESS | 3176 | -------- Summary: end -------- 15:21:11 INFO - PROCESS | 3176 | 15:21:12 INFO - TEST-INFO | 3176: exit 0 15:21:12 INFO - TEST-OK | kraken | took 64537ms 15:21:12 INFO - SUITE-END | took 1184s 15:21:12 INFO - Completed test suite (00:19:44) 15:21:12 INFO - javascript benchmark 15:21:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2653.2305631366903, 2658.654374931259, 2688.139795265515, 2694.6227528146064, 2701.1086341507303, 4503.639708823294, 4567.817287308504, 4700.271457924018, 4776.6178705703505, 4806.399200099988, 4584.19776539106, 4612.21592329304, 4693.178693728601, 4695.812167513295, 4748.548887855648, 4064.634182923536, 4182.728122672024, 4251.914961700764, 4298.46269216348, 4387.780610969455, 4343.500497442803, 4344.239758042346, 4376.059147283333, 4377.080813029268, 4411.911761764763, 4234.55537168599, 4245.511766146902, 4277.465316835395, 4279.679024073176, 4312.159128969852, 4288.270993931039, 4289.1421715657, 4295.14097180562, 4339.414179085815, 4342.717723348004, 4308.676849236288, 4319.632831209319, 4323.135372925396, 4365.563443655641, 4375.649948004152, 4477.731336119843, 4588.059447813191, 4612.215923293014, 4662.3705799716945, 4688.953110468886, 5163.457836927106, 5171.7672704728375, 5174.3790745110455, 5182.870428239325, 5189.740512974374, 5073.162928116856, 5140.151874940668, 5175.585953123741, 5196.1166601677805, 5199.974000130013, 4601.102784956935, 4702.623790096784, 4741.217699079613, 4756.286557016406, 4775.140474714515, 5192.428832828386, 5221.791128354899, 5263.499967503081, 5264.0, 5265.631405801634, 4768.117898188846, 4925.9014819704125, 4930.802767889244, 4968.8757781055765, 4993.725345106054, 4972.875678108004, 5023.171176755867, 5032.773525191302, 5069.366329208849, 5097.719625420564, 5033.496650335011, 5034.043531728959, 5035.269885866529, 5038.067957427887, 5080.415752188472, 4854.660173787801, 4987.301777751118, 5000.1249781288125, 5029.949700503022, 5033.823816166417, 4210.052738133957, 4225.345071513921, 4231.280682284019, 4261.808218630169, 4277.337012763027, 3735.4210097434943, 3763.9623603764157, 3778.508793856781, 3801.0, 3816.8282427290837, 4181.937270940938, 4236.809343579546, 4241.34259189826, 4391.494978077498, 4401.40581021558, 4901.436334821541, 4934.55588996992, 4962.454130045692, 4978.4025916890205, 5056.696598204119, 4252.064545799919, 4266.978665106717, 4322.243607368698, 4333.349997500401, 4337.371081193272, 4541.795619197144, 4545.477270113913, 4546.772661366985, 4563.361129441881, 4583.243764778841, 4610.239310513794, 4706.976465117653, 4754.904901902012, 4761.952380476151, 4819.807207711652, 5036.622253330942, 5054.317667114892, 5056.115179843439, 5060.569851562511, 5088.160453525127, 4759.333693282874, 4764.33299338086, 4765.309030190672, 4767.641222251642, 4809.903801923872, 4743.715377077248, 4906.852794416173, 5010.774515146754, 5021.297018417497, 5066.442691304027, 5107.310513080686, 5110.591152707849, 5113.335266415343, 5114.2840002400435, 5172.250023746611, 4966.975165124151, 4966.975165124151, 4970.105381031449, 4974.452810190804, 4974.900501989868, 4755.785989630405, 4895.1922932717125, 4921.384826896638, 4943.3573635427165, 4981.053599816023, 4828.324034635084, 4867.7322747249245, 4905.681130726492, 4909.386326709161, 4916.139675556835, 4811.230203167476, 5008.84973450797, 5014.874628134326, 5056.140456122394, 5069.7465126744255, 4771.0, 4812.542808433193, 4816.012717392856, 4822.276658501253, 4822.807087716452], "value": 4627.642605115022, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.110737246308, 576.7664096041104, 590.8936391449539, 594.5927039977613, 597.3130899465615, 27030.324241893937, 39278.803605981964, 40133.799331003305, 40196.1960760785, 44412.3338149928, 41837.581624183746, 42436.151276974444, 42440.0, 42452.363214551726, 42469.0, 7546.2831031051965, 7669.693212271516, 7858.1356050834365, 7863.449558530905, 9826.263030272723, 9858.408495490257, 10018.699439016842, 10041.899581004205, 10165.288429809916, 10176.542055607515, 10097.54561044751, 10176.64381746639, 10214.9785021498, 10271.075603195712, 10278.229132815031, 7682.807929801744, 10143.695689129338, 10176.79646407075, 10488.213383996155, 10501.894981050169, 9938.10557049869, 10043.347182433119, 10063.345882517613, 10066.848997265048, 10072.647457338959, 38497.615023849685, 38961.610383896084, 38968.61031389678, 39002.0, 39072.60927390718, 3013.819170849756, 3158.5735925649974, 3305.7851239669344, 3689.4281386385155, 3726.161613636937, 29581.55627665587, 29640.555391669142, 29996.0, 30075.548866767014, 31083.533746993813, 3387.7289816814596, 3419.247765491613, 3459.515667806509, 3521.876734314312, 3539.0, 247268.0, 248695.0, 249123.0, 249890.0, 251286.0, 33712.49431258533, 34984.9504514865, 51690.0, 52552.0, 52671.47328526742, 34007.82996085004, 34153.829230854186, 34240.48639270413, 34365.65634343675, 34398.48402273968, 13336.5332213374, 13564.796528052088, 13570.86429135696, 13580.45678172862, 13592.320383980761, 8996.145366190201, 10696.51865666047, 10968.506417211245, 11004.779904401867, 11196.328220306808, 7983.68065277394, 7989.520628762293, 8016.398770092266, 8070.556119413372, 8073.6366863491285, 3091.629004519472, 3095.2261934516373, 3120.7503399727966, 3147.244661281276, 3152.621685397767, 842.6292431330318, 949.2500924269888, 972.8783902012249, 1015.4567306490992, 1036.0623635609786, 26121.477570448864, 26993.730062699513, 27430.725692743217, 27526.17421477359, 27819.304517386823, 1011.0748664971616, 1039.111559616517, 1051.542578978147, 1061.0662616897234, 1101.2456467319912, 14192.503262385768, 14603.612656797588, 14782.704345913022, 14824.110553366832, 15074.849251507563, 365963.0, 366208.0, 367580.0, 371209.0, 371760.0, 49451.752741236785, 50109.498905010485, 50128.49871501311, 50130.24804627933, 50144.74927625339, 1107.789519991199, 1186.4398316214151, 1203.374245392391, 1229.6003798765437, 1240.7828629989535, 28342.0, 29278.26804329909, 29739.851300743358, 29866.402671946875, 30213.848930755204, 41136.0, 41747.37378939258, 41781.58218417777, 41787.283826551175, 41802.163956720084, 231701.0, 235921.0, 236575.0, 236756.0, 237008.0, 22161.33515994523, 23965.880170599732, 24557.140500082412, 24686.13598524043, 26716.732832671423, 41619.0, 42189.57810421856, 42249.577504224566, 42520.0, 43415.56584434115, 35336.0, 36366.0, 36578.63421365859, 36741.63258367489, 37021.6297837029, 35878.820605896806, 36101.638983609824, 36399.81800090983, 36684.44973325349, 36737.44893826648, 35393.46909796304, 35554.0, 35772.64227357693, 35934.8203258982, 36075.819620901726, 31670.524942126347, 32421.35157296794, 33064.50403243905, 33130.66869331276, 33187.33625327528, 23991.943485335443, 24151.275461736175, 24237.0, 24424.51150976935, 24444.388890277885], "value": 16859.575416306285, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.4242923468623, 372.5399132071891, 376.08611075087526, 391.56536244768284, 394.72369341460984, 15486.845131548682, 16952.915235423807, 17125.143742812856, 17199.226034828433, 17390.73913891291, 15643.843561564381, 16408.17959102046, 16415.83584164161, 16429.01425914446, 16429.507114786546, 4819.132556139903, 5019.272205530196, 5058.443571207183, 5064.645474816764, 5069.2649565812935, 3687.244114956441, 4963.305137280783, 5710.514606258473, 6032.276126864783, 6046.637201767886, 6050.606710563821, 6064.181335519715, 6072.483838873679, 6084.148219249309, 6087.573869829113, 5624.943750562483, 5780.7687692492245, 5922.733476993524, 6006.639601623895, 6015.458608725214, 3328.8335583220983, 4911.68074075184, 5081.517255860687, 5290.100682883919, 5293.3647962244395, 19358.70961935558, 20114.497137571532, 20173.0, 20201.29295474666, 20231.0, 1761.3042848075067, 2119.7032415461695, 2204.9448763780874, 2256.4922892349255, 2519.3071905226025, 9202.53987300639, 9314.323421784076, 9508.952455237679, 11102.722431939186, 13146.60560183196, 1626.7478540826073, 1648.6398721055177, 1710.700627390214, 1759.2259405861507, 1765.5056584156328, 64499.355006449805, 65736.0, 65942.67028664827, 66141.66929165323, 67441.0, 10064.094231519199, 10156.898431015743, 10254.94901019784, 10410.427426491615, 10454.372737635766, 14118.152910825178, 14184.929075354763, 14228.217448040457, 14251.643708907153, 14268.286585670676, 6841.281665425158, 7038.401735852408, 7044.753433629799, 7146.285371462916, 7186.928130718626, 6444.645544495098, 6498.057781621638, 6578.868422631521, 6589.670516474157, 6613.338666133348, 4316.482022157361, 4406.581374769392, 4493.0, 4518.909621807546, 4537.296719008559, 1666.3505027007118, 1768.593223558563, 1792.4353828543967, 1798.6492633936257, 1815.7276408538826, 783.1893989720726, 873.1486800369589, 889.2530274569264, 893.687209476691, 927.5825878354632, 15133.243337833064, 15558.0, 15560.688786224213, 16006.279717412745, 16134.75797863033, 797.1589972578869, 840.2185967050701, 857.8455877941906, 885.9778505537413, 967.0184762466102, 8779.561021948877, 9172.633094676139, 9189.77025574366, 9222.723318300461, 9230.049425361747, 344377.0, 350699.0, 350831.0, 353384.0, 357277.0, 71752.0, 73178.0, 74813.08434491011, 75138.0, 76373.61813190898, 828.9544075075929, 911.129870973219, 923.4136323434533, 928.6285485805597, 939.7556635274877, 12445.751084978068, 14529.200893950934, 14708.926455367655, 15242.161681107646, 15869.761953570474, 32993.505097423076, 33586.16034599154, 33789.32421351608, 34202.48696269608, 35174.12064698403, 45119.32321015122, 45169.77415112904, 46384.53615463937, 46447.767761160976, 46557.30164047474, 7483.775486735407, 7555.508891922227, 7581.949913841549, 7625.199354067743, 7826.178251283761, 10819.513121909376, 11673.35796531165, 11691.707707307385, 11740.354280514654, 11805.468753905923, 9726.319157658896, 9901.0, 10006.399616023062, 10177.236707246839, 10356.896431035593, 10016.749581260527, 10137.341072830242, 10221.540030698785, 10269.794604108025, 10428.217883658604, 9585.0, 10067.597296108073, 10071.446070466194, 10337.638182663572, 10385.792284154426, 7656.196099409704, 7674.884876726966, 7715.614219289126, 7829.491083079582, 7923.366130709414, 9149.496777677292, 9698.175655069399, 9816.31285810015, 9849.950750246202, 10306.487094494525], "value": 8103.277961894842, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1216.452596331651, 1384.4531410093011, 1436.0952599862085, 1525.4508376984284, 1766.390595244641, 6616.735330586776, 7408.777736667902, 7653.69385224591, 7655.961720191392, 7847.372210223182, 7589.354904833082, 7730.845383092349, 7746.728864489744, 7750.689972401097, 7754.612269386522, 1823.2069049963309, 2028.3712049264775, 2121.8939053047325, 2132.3922682035623, 2150.3441450357636, 2162.38372063961, 2182.6616874384495, 2184.0390228299498, 2184.595849767798, 2191.912323507058, 2042.2852001799326, 2082.208760670943, 2090.205721825704, 2091.9267825626107, 2092.2781640334138, 1744.9476515704612, 1935.5741736817877, 2015.606956643455, 2017.8486613503899, 2080.95838083239, 2052.48687828043, 2055.2190167736167, 2057.660486019805, 2065.917363305466, 2084.781097984705, 7616.3906887448875, 7624.161342252348, 7672.961635191844, 7680.38556915451, 7694.5383277003, 4176.874693759192, 4284.250256205183, 4285.914281714379, 4315.978420107911, 4341.826326946918, 2763.585462180669, 2888.3068063664778, 2897.913062608125, 2900.4344152890194, 2901.17316564778, 834.649447232164, 842.5660784695887, 861.9310455163571, 864.2308345572445, 873.6898401067657, 9951.502424878727, 9965.0, 9968.302218844683, 9968.950155249322, 10029.849552256723, 3954.5452272988973, 4066.0851308455362, 4120.052387950788, 4148.688848336386, 4158.500979882433, 8640.092790257058, 8689.782755431164, 8701.17338852808, 8716.12838716136, 8724.738257852274, 4304.677149213821, 4367.432233809584, 4371.934420983688, 4372.125574885035, 4373.300271956472, 3473.392156372625, 3851.171998020439, 3982.820773065219, 4004.65960393364, 4049.91900162001, 3604.1710406606626, 3622.7826330420257, 3685.1339935115225, 3710.18375957289, 3749.3813520769313, 1148.8908553687386, 1159.1074872348413, 1164.4177911044478, 1169.5321871251567, 1169.8830116988404, 640.1997503121098, 673.1854456108164, 764.4152223548879, 781.6052893288853, 786.2648423723837, 5115.539601435814, 5178.922316165261, 5247.422783493813, 5305.336832895888, 5365.973170134124, 380.84766093562797, 387.25646758224275, 389.73303287248325, 398.1876970979228, 399.08808372867855, 3517.191046059421, 3543.0, 3573.76770509916, 3601.819909004592, 3624.637536246354, 8713.477191368538, 8929.464232145961, 9009.09909009107, 9029.051949545203, 9048.321375896703, 8874.0, 8953.686620968365, 8987.19115279628, 9001.909980900238, 9005.549722513848, 6884.690188941609, 7003.8599228015155, 7076.115485564304, 7077.150741911004, 7091.361777440055, 5124.538791508633, 5223.973880130575, 5238.768889311085, 5250.76606997363, 5318.601104917069, 8052.275295223458, 8357.95821020891, 8361.665533378597, 8432.831343372976, 8588.742337729878, 8505.489670619536, 8590.0, 8594.226519613016, 8622.698205562776, 8730.825383492422, 5871.706414679164, 6084.117802918464, 6102.847428814315, 6398.48812095022, 6552.08270842092, 6945.444364450933, 7040.190378106583, 7155.356017958408, 7455.515391499535, 7465.06686664167, 6655.467562594884, 6739.292374300628, 6747.865042699217, 6838.179418469816, 6902.8619427610165, 6624.105745724266, 6648.335166483313, 6661.134052573135, 6736.562123461959, 6797.93202067973, 6372.55392122547, 6385.8722825544155, 6482.027695845472, 6490.0, 6502.0, 4324.654027677841, 4380.518143004203, 4396.032872767986, 4447.955520444754, 4463.843765468193, 4527.796249168861, 4537.750423726727, 4539.84110556129, 4579.473360563577, 4596.5863072323655], "value": 3902.509627464352, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.6454125966321, 295.88164734106357, 297.7022977022977, 300.2763340349758, 302.3846472428608, 4749.430068391794, 4771.332013518101, 4809.422869255694, 4810.567048965592, 4837.80648774049, 4772.856814295576, 4777.163996300651, 4784.976075119628, 4790.664653474259, 4835.226363781796, 3567.1973805893663, 3660.5973342932257, 3667.431548110047, 3748.737588368815, 3794.620537946197, 3717.0, 3737.8412692065413, 3739.7943113128767, 3749.400095984643, 3769.868054618089, 3695.427208782643, 3711.0351308659806, 3719.051641831329, 3723.702103831687, 3733.533308336458, 3520.489529018291, 3620.0949762559494, 3772.2832661794173, 3784.9621503784883, 3813.3707938190164, 3334.249793796401, 3347.6317605063423, 3349.7152742016956, 3353.161709572607, 3364.814935178564, 4573.336866154422, 4588.724676519386, 4589.770511474447, 4628.976855115703, 4669.439667239919, 4185.455890734185, 4327.5239723630375, 4335.114225312, 4341.110072435144, 4356.8257269709175, 4943.3439797667825, 5023.598112151019, 5029.145045342264, 5040.42035165957, 5046.1926091825135, 3659.6157403472516, 3669.1377526281303, 3675.9707281960827, 3682.9263414731554, 3683.4843121962945, 5083.364579427572, 5186.273921650972, 5229.692576855786, 5292.947070529284, 5300.496452836975, 3731.160488889978, 3732.2162345907122, 3736.962630373716, 3739.1399978004665, 3756.4740936268945, 3794.2032173243374, 3797.1394016931504, 3797.4493698413576, 3799.886003419902, 3801.904952376213, 4278.144371125787, 4285.292926667065, 4289.871303860889, 4292.763897985641, 4320.503142138694, 4899.779509922062, 4933.901321973541, 4976.730933611906, 5000.774965126578, 5052.04011237871, 1288.1176394170025, 1294.8187253784479, 1299.9415026323838, 1300.5513097981182, 1305.5626365167586, 815.8089189782864, 833.4166083741405, 854.4147259127518, 868.4789126524036, 870.1385628228135, 4316.719413238129, 4422.624076953431, 4427.424434823452, 4470.821167153277, 4472.329150627432, 5129.897402051938, 5155.252488389163, 5167.03652612005, 5201.193814958688, 5205.505476979681, 4372.956270437318, 4385.101054283864, 4413.823447062082, 4426.313921342197, 4437.5784300491405, 2595.7923366130663, 2750.642416485844, 2768.169549135251, 2769.584562315669, 2779.069011881002, 4842.806287748521, 4897.951020489821, 4912.6561140719805, 4924.261360795837, 4933.950660493421, 5020.472850350734, 5291.174544782044, 5318.723506358523, 5319.973400132974, 5333.2266821310695, 4906.435759887659, 4924.72913989734, 4927.531884471041, 4939.863831318817, 4945.851624451272, 5154.737089413118, 5216.947830521646, 5241.895162096813, 5249.7375131242525, 5261.736913154404, 4912.606991440748, 5072.898542029213, 5078.0, 5111.309973153725, 5154.433012368561, 4891.902161956812, 4909.5090490950615, 4915.6067514598035, 4930.348333308382, 4934.161192597339, 3745.906352341104, 3790.5261842269715, 3817.8737272504122, 3817.961820381872, 3820.1595648957186, 5060.006487187775, 5139.460356662496, 5238.1618940969265, 5272.261883336413, 5278.445763194963, 4951.603871690184, 5028.321176641107, 5028.346314979176, 5033.723145227048, 5052.292679025013, 5013.248012797963, 5022.974885125551, 5024.723640199824, 5032.572231360376, 5048.59611231108, 4746.38297021385, 4888.388951381077, 4889.315495830658, 4905.435874874435, 4946.455889852042, 4843.418789745253, 4987.376577927759, 4997.650164488597, 5005.599552035901, 5114.232865070269, 4753.786079626356, 4855.810326470038, 4856.441509226484, 4865.489123641966, 4897.559219670246], "value": 3799.866492314095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.0429291668746, 648.71132346106, 708.9858202835943, 727.3453891497652, 736.6316841579211, 11526.654200373992, 11965.58120465784, 11992.280463172216, 12319.905616045271, 12746.10777245593, 11767.7646447071, 11883.108766842479, 11887.702807429798, 11893.286402815836, 11961.880381196186, 630.7886857902586, 767.7850201943437, 794.5709316968845, 807.3299161695778, 822.3380178955938, 798.022422532396, 798.3573223555036, 800.5516910530092, 800.6397121295412, 800.8838718385831, 828.056016141599, 828.7430896422098, 829.8879651247065, 830.5390508267909, 831.600831600832, 661.1207094564218, 806.7983004248968, 832.1221111727125, 832.488019867777, 836.1387770596295, 611.9541034422436, 612.1643956000028, 613.5030625193607, 614.3518587889774, 614.4347200575481, 12992.155509891827, 13011.0, 13027.739445211042, 13034.348282585834, 13040.80438793419, 12233.571824986171, 12511.436985335591, 12638.0, 12691.492340306377, 13005.674858128528, 10427.322224055411, 10508.684739457829, 10586.841197382046, 10837.024667779859, 10917.454127293604, 4111.568285330027, 4111.588841115894, 4169.291220492523, 4177.415161877339, 4239.173361194568, 55188.44811551873, 56368.0, 56373.71813140949, 56958.715206424116, 56972.43027569713, 10303.793924121475, 10373.948130259301, 10443.11233545142, 10485.947570262253, 10487.528061237263, 19005.714914276297, 19040.52398690016, 19052.61894762097, 19060.332888348843, 19089.140988655545, 6438.581492202992, 6462.224533056064, 6468.191476065492, 6514.934850651528, 6710.328967103251, 3680.4663323817895, 3733.0, 3736.551613806361, 3743.494628225209, 3749.643783840531, 2630.4476060027228, 2693.0978122328847, 2713.579395193748, 2715.646965894421, 2716.307341627872, 454.7044421126228, 477.0792370724535, 509.87762936894876, 526.9631125821156, 530.6285600079882, 512.9512696293846, 549.7745924171071, 584.1471451680509, 614.3610644929223, 623.6351734235433, 8160.4287699861625, 8487.533185674847, 8632.870506942401, 8753.693620723245, 8814.074522175079, 468.71408440851053, 505.89376230991905, 513.8098903405689, 563.6626161685789, 650.2392201124695, 4133.586641335903, 4147.460830092069, 4269.167512335127, 4282.678799090018, 4308.870733877989, 83842.0, 84647.0, 85502.57248713716, 86622.56688716516, 90280.0, 74612.25387746161, 76886.61556692292, 77032.0, 77670.61164694253, 78196.60901695455, 64693.0, 65206.34793652098, 65409.0, 65479.0, 65613.99999999904, 6879.552829066095, 7022.754203602849, 7044.366007059184, 7161.785146445615, 7162.391196748335, 42417.48572685531, 43376.56623433725, 44037.779811100736, 44266.0, 44368.778156109016, 54130.18804718011, 60822.391776083445, 60872.0, 61050.08424873719, 61423.385766143554, 9226.953865230631, 10312.742181445225, 10373.740656483647, 10406.0, 10528.263021588415, 10957.0, 10999.505022273857, 13036.152650077714, 13219.66950826237, 13240.86759132435, 11979.940100299442, 11987.940060299643, 12188.878111219128, 12228.082893782825, 12326.81509777336, 9417.561428094084, 10245.641402550875, 11183.832242516532, 11322.60370887015, 11786.76426471483, 11634.301941883514, 11731.178817483036, 12027.047901894064, 12322.800348459607, 12386.442610082388, 9278.95360523193, 9394.95302523483, 9460.432374057578, 9610.0, 9878.30851840393, 9888.901110989085, 10422.270441069355, 10461.476926153815, 10502.789944201226, 10530.842037369292], "value": 6413.803157037883, "unit": "score"}], "name": "dromaeo_css", "value": 6259.277656096691, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 113.0, 113.0, 113.0, 114.0, 112.0, 113.0, 113.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 142.0, 131.0, 187.0, 141.0, 142.0, 166.0, 130.0, 194.0, 129.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 164.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 76.0, 127.0, 76.0, 76.0, 77.0, 77.0, 102.0, 76.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 114.0, 86.0, 87.0, 87.0, 117.0, 86.0, 87.0, 126.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 72.0, 64.0, 64.0, 64.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 85.0, 90.0, 91.0, 86.0, 86.0, 86.0, 115.0, 90.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 143.0, 143.0, 151.0, 133.0, 140.0, 133.0, 134.0, 136.0, 136.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 170.0, 169.0, 169.0, 171.0, 172.0, 176.0, 177.0, 173.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 67.0, 66.0, 67.0, 67.0, 67.0, 70.0, 67.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1564.8999999999999, "alertThreshold": 2.0}]} 15:21:12 INFO - Return code: 0 15:21:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:21:12 ERROR - # TBPL SUCCESS # 15:21:12 INFO - Running post-action listener: _resource_record_post_action 15:21:12 INFO - ##### 15:21:12 INFO - ##### Finished run-tests step (success) 15:21:12 INFO - ##### 15:21:12 INFO - Running post-run listener: _resource_record_post_run 15:21:12 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 523587584; Read time: 4; Write time: 599068 15:21:12 INFO - TinderboxPrint: CPU usage
13.1% 15:21:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 15:21:12 INFO - TinderboxPrint: I/O write bytes / time
523,587,584 / 599,068 15:21:12 INFO - TinderboxPrint: CPU idle
8,326.6 (86.9%) 15:21:12 INFO - TinderboxPrint: CPU user
1,212.4 (12.6%) 15:21:12 INFO - TinderboxPrint: Swap in / out
0 / 0 15:21:12 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237543424; Read time: 0; Write time: 343264 15:21:12 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285315072; Read time: 4; Write time: 254840 15:21:13 INFO - Running post-run listener: _upload_blobber_files 15:21:13 INFO - Blob upload gear active. 15:21:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:21:13 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 15:21:13 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'] 15:21:13 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 15:21:13 INFO - (blobuploader) - INFO - Open directory for files ... 15:21:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:21:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:21:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:17 INFO - (blobuploader) - INFO - Done attempting. 15:21:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:21:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:21:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:18 INFO - (blobuploader) - INFO - Done attempting. 15:21:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:21:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:21:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:18 INFO - (blobuploader) - INFO - Done attempting. 15:21:18 INFO - (blobuploader) - INFO - Iteration through files over. 15:21:18 INFO - Return code: 0 15:21:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:21:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:21:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73f565050b7888514221d826a553fddd342b22b67effb4c0e36144d10b2499fc6eb7acf143c35e31a0cb22fc656abadfd5a5ef248d3d736001601ea096a34b06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8bf8fe6ae757dd4b84a70dc729a4696e757628e42c03ce84e12273b070a44b4cb00cf50e57f660d9a8b253b6fe0d09c5770b431f040839f1f1a2a42d1c23fa55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcbed112fc226e7f221ffc01b2d32f184c338a88fe096731107f8a789221eb008f90f3435d6c001ba4fde66229b17804d087ca02a931e1b74ca5362c37a2aae1"} 15:21:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:21:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:21:18 INFO - Contents: 15:21:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73f565050b7888514221d826a553fddd342b22b67effb4c0e36144d10b2499fc6eb7acf143c35e31a0cb22fc656abadfd5a5ef248d3d736001601ea096a34b06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8bf8fe6ae757dd4b84a70dc729a4696e757628e42c03ce84e12273b070a44b4cb00cf50e57f660d9a8b253b6fe0d09c5770b431f040839f1f1a2a42d1c23fa55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcbed112fc226e7f221ffc01b2d32f184c338a88fe096731107f8a789221eb008f90f3435d6c001ba4fde66229b17804d087ca02a931e1b74ca5362c37a2aae1"} 15:21:18 INFO - Running post-run listener: copy_logs_to_upload_dir 15:21:18 INFO - Copying logs to upload dir... 15:21:18 INFO - mkdir: /builds/slave/test/build/upload/logs 15:21:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.506861 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-05 15:21:16.358183) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 15:21:16.361912) ========= 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=52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73f565050b7888514221d826a553fddd342b22b67effb4c0e36144d10b2499fc6eb7acf143c35e31a0cb22fc656abadfd5a5ef248d3d736001601ea096a34b06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8bf8fe6ae757dd4b84a70dc729a4696e757628e42c03ce84e12273b070a44b4cb00cf50e57f660d9a8b253b6fe0d09c5770b431f040839f1f1a2a42d1c23fa55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcbed112fc226e7f221ffc01b2d32f184c338a88fe096731107f8a789221eb008f90f3435d6c001ba4fde66229b17804d087ca02a931e1b74ca5362c37a2aae1"} build_url:https://queue.taskcluster.net/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/AxfdSiguRTKTm4nHTY9T9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73f565050b7888514221d826a553fddd342b22b67effb4c0e36144d10b2499fc6eb7acf143c35e31a0cb22fc656abadfd5a5ef248d3d736001601ea096a34b06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8bf8fe6ae757dd4b84a70dc729a4696e757628e42c03ce84e12273b070a44b4cb00cf50e57f660d9a8b253b6fe0d09c5770b431f040839f1f1a2a42d1c23fa55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcbed112fc226e7f221ffc01b2d32f184c338a88fe096731107f8a789221eb008f90f3435d6c001ba4fde66229b17804d087ca02a931e1b74ca5362c37a2aae1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 15:21:16.386921) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 15:21:16.387246) ========= 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=52faae308a556c440401f8e5000001e8-1465163246.309720-1283728262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 15:21:16.469209) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 15:21:16.469567) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 15:21:16.469847) ========= ========= Total master_lag: 0.16 =========