builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-060 starttime: 1465007958.06 results: success (0) buildid: 20160603190727 builduid: b0500c55fdaf4a30984a92dd2b825791 revision: d1c3952c299da44bbb1215d73a5c34118f92279e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 19:39:18.065317) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 19:39:18.065824) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 19:39:18.066114) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 19:39:18.109103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 19:39:18.109376) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 19:39:18-- 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% 113M=0s 2016-06-03 19:39:18 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119586 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 19:39:18.246233) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 19:39:18.246807) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016435 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 19:39:18.299395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 19:39:18.299803) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d1c3952c299da44bbb1215d73a5c34118f92279e --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 d1c3952c299da44bbb1215d73a5c34118f92279e --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=337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 19:39:18,894 truncating revision to first 12 chars 2016-06-03 19:39:18,894 Setting DEBUG logging. 2016-06-03 19:39:18,894 attempt 1/10 2016-06-03 19:39:18,894 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d1c3952c299d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 19:39:19,288 unpacking tar archive at: fx-team-d1c3952c299d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.730010 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 19:39:19.043676) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 19:39:19.043993) ========= script_repo_revision: d1c3952c299da44bbb1215d73a5c34118f92279e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 19:39:19.044397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 19:39:19.044708) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 19:39:19.054472) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-03 19:39:19.054792) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:39:19 INFO - MultiFileLogger online at 20160603 19:39:19 in /builds/slave/test 19:39:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 19:39:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:39:19 INFO - {'append_to_log': False, 19:39:19 INFO - 'base_work_dir': '/builds/slave/test', 19:39:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:39:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:39:19 INFO - 'branch': 'Fx-Team-Non-PGO', 19:39:19 INFO - 'buildbot_json_path': 'buildprops.json', 19:39:19 INFO - 'config_files': ('talos/linux_config.py',), 19:39:19 INFO - 'default_actions': ('clobber', 19:39:19 INFO - 'read-buildbot-config', 19:39:19 INFO - 'download-and-extract', 19:39:19 INFO - 'populate-webroot', 19:39:19 INFO - 'create-virtualenv', 19:39:19 INFO - 'install', 19:39:19 INFO - 'run-tests'), 19:39:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:39:19 INFO - 'download_minidump_stackwalk': True, 19:39:19 INFO - 'download_symbols': 'ondemand', 19:39:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:39:19 INFO - 'tooltool.py': '/tools/tooltool.py', 19:39:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:39:19 INFO - '/tools/misc-python/virtualenv.py')}, 19:39:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:39:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:39:19 INFO - 'installer_path': 'installer.exe', 19:39:19 INFO - 'log_level': 'info', 19:39:19 INFO - 'log_name': 'talos', 19:39:19 INFO - 'log_to_console': True, 19:39:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:39:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:39:19 INFO - 'opt_config_files': (), 19:39:19 INFO - 'pip_index': False, 19:39:19 INFO - 'sps_profile': False, 19:39:19 INFO - 'sps_profile_interval': 0, 19:39:19 INFO - 'suite': 'dromaeojs-e10s', 19:39:19 INFO - 'system_bits': '32', 19:39:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:39:19 INFO - 'title': 'talos-linux64-ix-060', 19:39:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:39:19 INFO - 'use_talos_json': True, 19:39:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:39:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:39:19 INFO - 'work_dir': 'build'} 19:39:19 INFO - ##### 19:39:19 INFO - ##### Running clobber step. 19:39:19 INFO - ##### 19:39:19 INFO - Running pre-action listener: _resource_record_pre_action 19:39:19 INFO - Running main action method: clobber 19:39:19 INFO - rmtree: /builds/slave/test/build 19:39:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:39:20 INFO - Running post-action listener: _resource_record_post_action 19:39:20 INFO - ##### 19:39:20 INFO - ##### Finished clobber step (success) 19:39:20 INFO - ##### 19:39:20 INFO - ##### 19:39:20 INFO - ##### Running read-buildbot-config step. 19:39:20 INFO - ##### 19:39:20 INFO - Running pre-action listener: _resource_record_pre_action 19:39:20 INFO - Running main action method: read_buildbot_config 19:39:20 INFO - Using buildbot properties: 19:39:20 INFO - { 19:39:20 INFO - "project": "", 19:39:20 INFO - "product": "firefox", 19:39:20 INFO - "script_repo_revision": "production", 19:39:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:39:20 INFO - "repository": "", 19:39:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 19:39:20 INFO - "buildid": "20160603190727", 19:39:20 INFO - "pgo_build": "False", 19:39:20 INFO - "basedir": "/builds/slave/test", 19:39:20 INFO - "buildnumber": 1342, 19:39:20 INFO - "slavename": "talos-linux64-ix-060", 19:39:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:39:20 INFO - "platform": "ubuntu64_hw", 19:39:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:39:20 INFO - "branch": "fx-team", 19:39:20 INFO - "repo_path": "integration/fx-team", 19:39:20 INFO - "revision": "d1c3952c299da44bbb1215d73a5c34118f92279e", 19:39:20 INFO - "stage_platform": "linux64", 19:39:20 INFO - "builduid": "b0500c55fdaf4a30984a92dd2b825791", 19:39:20 INFO - "slavebuilddir": "test" 19:39:20 INFO - } 19:39:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:39:20 INFO - Running post-action listener: _resource_record_post_action 19:39:20 INFO - ##### 19:39:20 INFO - ##### Finished read-buildbot-config step (success) 19:39:20 INFO - ##### 19:39:20 INFO - ##### 19:39:20 INFO - ##### Running download-and-extract step. 19:39:20 INFO - ##### 19:39:20 INFO - Running pre-action listener: _resource_record_pre_action 19:39:20 INFO - Running main action method: download_and_extract 19:39:20 INFO - mkdir: /builds/slave/test/build/tests 19:39:20 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')]} 19:39:20 INFO - https://queue.taskcluster.net/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:39:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:39:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:39:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/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 19:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/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 19:39:26 INFO - Downloaded 1361 bytes. 19:39:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:39:26 INFO - Using the following test package requirements: 19:39:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:39:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:39:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:39:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:26 INFO - u'jsshell-linux-x86_64.zip'], 19:39:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:39:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:39:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:39:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:39:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:39:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:39:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:39: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')]} 19:39:26 INFO - https://queue.taskcluster.net/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:39:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:39:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:39:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/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 19:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/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 19:39:34 INFO - Downloaded 22868152 bytes. 19:39:34 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'] 19:39:34 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 19:39:35 INFO - Return code: 0 19:39:35 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 19:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:39:35 INFO - https://queue.taskcluster.net/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:39:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:39:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:39:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/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 19:39:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/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 19:39:41 INFO - Downloaded 22868152 bytes. 19:39:41 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'] 19:39:41 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 19:39:42 INFO - Return code: 0 19:39: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')]} 19:39:42 INFO - https://queue.taskcluster.net/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:39:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:39:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:39:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/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 19:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/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 19:39:44 INFO - Downloaded 10833369 bytes. 19:39:44 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'] 19:39:44 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 19:39:44 INFO - Return code: 0 19:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:39:44 INFO - https://queue.taskcluster.net/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:39:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:39:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:39:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/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 19:39:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeZyBYJGSN2raK1uSv9aKQ/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 19:39:46 INFO - Downloaded 55178834 bytes. 19:39:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:39:46 INFO - mkdir: /builds/slave/test/properties 19:39:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:39:46 INFO - Writing to file /builds/slave/test/properties/build_url 19:39:46 INFO - Contents: 19:39:46 INFO - build_url:https://queue.taskcluster.net/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:39:47 INFO - Running post-action listener: _resource_record_post_action 19:39:47 INFO - Running post-action listener: set_extra_try_arguments 19:39:47 INFO - ##### 19:39:47 INFO - ##### Finished download-and-extract step (success) 19:39:47 INFO - ##### 19:39:47 INFO - ##### 19:39:47 INFO - ##### Running populate-webroot step. 19:39:47 INFO - ##### 19:39:47 INFO - Running pre-action listener: _resource_record_pre_action 19:39:47 INFO - Running main action method: populate_webroot 19:39:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:39:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:39:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:39:47 INFO - '--tppagecycles', 19:39:47 INFO - '7'], 19:39:47 INFO - 'tests': ['tsvgm']}}, 19:39:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:39:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:39:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:39:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:39:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:39:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:39:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:47 INFO - 'talos_options': ['--disable-e10s'], 19:39:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:39:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:39:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:47 INFO - 'talos_options': ['--disable-e10s'], 19:39:47 INFO - 'tests': ['damp', 'tps']}, 19:39:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:47 INFO - 'tests': ['damp', 'tps']}, 19:39:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:39:47 INFO - 'tests': ['dromaeo_dom']}, 19:39:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:39:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:39:47 INFO - 'tests': ['a11yr', 19:39:47 INFO - 'ts_paint', 19:39:47 INFO - 'tpaint', 19:39:47 INFO - 'sessionrestore', 19:39:47 INFO - 'sessionrestore_no_auto_restore', 19:39:47 INFO - 'tabpaint']}, 19:39:47 INFO - 'other-e10s': {'tests': ['a11yr', 19:39:47 INFO - 'ts_paint', 19:39:47 INFO - 'tpaint', 19:39:47 INFO - 'sessionrestore', 19:39:47 INFO - 'sessionrestore_no_auto_restore', 19:39:47 INFO - 'tabpaint']}, 19:39:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:39:47 INFO - 'ts_paint', 19:39:47 INFO - 'tpaint', 19:39:47 INFO - 'sessionrestore', 19:39:47 INFO - 'sessionrestore_no_auto_restore', 19:39:47 INFO - 'tabpaint']}, 19:39:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:39:47 INFO - 'ts_paint', 19:39:47 INFO - 'tpaint', 19:39:47 INFO - 'sessionrestore', 19:39:47 INFO - 'sessionrestore_no_auto_restore', 19:39:47 INFO - 'tabpaint']}, 19:39:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:39:47 INFO - 'tests': ['a11yr', 19:39:47 INFO - 'ts_paint', 19:39:47 INFO - 'tpaint', 19:39:47 INFO - 'sessionrestore', 19:39:47 INFO - 'sessionrestore_no_auto_restore', 19:39:47 INFO - 'tabpaint']}, 19:39:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:39:47 INFO - 'tests': ['a11yr', 19:39:47 INFO - 'ts_paint', 19:39:47 INFO - 'tpaint', 19:39:47 INFO - 'sessionrestore', 19:39:47 INFO - 'sessionrestore_no_auto_restore', 19:39:47 INFO - 'tabpaint']}, 19:39:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:39:47 INFO - 'tests': ['tsvgx', 19:39:47 INFO - 'tsvgr_opacity', 19:39:47 INFO - 'tart', 19:39:47 INFO - 'tscrollx', 19:39:47 INFO - 'cart']}, 19:39:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:39:47 INFO - 'tsvgr_opacity', 19:39:47 INFO - 'tart', 19:39:47 INFO - 'tscrollx', 19:39:47 INFO - 'cart']}, 19:39:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:47 INFO - 'talos_options': ['--disable-e10s'], 19:39:47 INFO - 'tests': ['tp5o']}, 19:39:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:47 INFO - 'tests': ['tp5o']}, 19:39:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:47 INFO - 'talos_options': ['--disable-e10s', 19:39:47 INFO - '--xperf_path', 19:39:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:39:47 INFO - 'tests': ['tp5n']}, 19:39:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:47 INFO - 'talos_options': ['--xperf_path', 19:39:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:39:47 INFO - 'tests': ['tp5n']}}, 19:39:47 INFO - 'talos.zip': {'path': '', 19:39:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:39:47 INFO - Running post-action listener: _resource_record_post_action 19:39:47 INFO - ##### 19:39:47 INFO - ##### Finished populate-webroot step (success) 19:39:47 INFO - ##### 19:39:47 INFO - ##### 19:39:47 INFO - ##### Running create-virtualenv step. 19:39:47 INFO - ##### 19:39:47 INFO - Running pre-action listener: _resource_record_pre_action 19:39:47 INFO - Running main action method: create_virtualenv 19:39:47 INFO - Creating virtualenv /builds/slave/test/build/venv 19:39:47 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 19:39:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:39:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:39:47 INFO - Using real prefix '/usr' 19:39:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:39:47 INFO - Installing distribute.............................................................................................................................................................................................done. 19:39:49 INFO - Installing pip.................done. 19:39:49 INFO - Return code: 0 19:39:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:39:49 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')]} 19:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:49 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')]} 19:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:49 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 0x7f29ba92df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c871c0>, '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 0x2c880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c88550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', '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 19:39:49 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 19:39:49 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 19:39:49 INFO - Using env: {'DISPLAY': ':0', 19:39:49 INFO - 'HOME': '/home/cltbld', 19:39:49 INFO - 'LANG': 'en_US.UTF-8', 19:39:49 INFO - 'LANGUAGE': 'en_US:en', 19:39:49 INFO - 'LOGNAME': 'cltbld', 19:39:49 INFO - 'MAIL': '/var/mail/cltbld', 19:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:49 INFO - 'MOZ_NO_REMOTE': '1', 19:39:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:39:49 INFO - 'NO_EM_RESTART': '1', 19:39:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:49 INFO - 'PWD': '/builds/slave/test', 19:39:49 INFO - 'SHELL': '/bin/bash', 19:39:49 INFO - 'SHLVL': '1', 19:39:49 INFO - 'TERM': 'linux', 19:39:49 INFO - 'TMOUT': '86400', 19:39:49 INFO - 'USER': 'cltbld', 19:39:49 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', 19:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:49 INFO - '_': '/tools/buildbot/bin/python'} 19:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:50 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 19:39:50 INFO - Cleaning up... 19:39:50 INFO - Return code: 0 19:39:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:39:50 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')]} 19:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:50 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')]} 19:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:50 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 0x7f29ba92df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c871c0>, '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 0x2c880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c88550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', '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 19:39:50 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 19:39:50 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 19:39:50 INFO - Using env: {'DISPLAY': ':0', 19:39:50 INFO - 'HOME': '/home/cltbld', 19:39:50 INFO - 'LANG': 'en_US.UTF-8', 19:39:50 INFO - 'LANGUAGE': 'en_US:en', 19:39:50 INFO - 'LOGNAME': 'cltbld', 19:39:50 INFO - 'MAIL': '/var/mail/cltbld', 19:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:50 INFO - 'MOZ_NO_REMOTE': '1', 19:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:39:50 INFO - 'NO_EM_RESTART': '1', 19:39:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:50 INFO - 'PWD': '/builds/slave/test', 19:39:50 INFO - 'SHELL': '/bin/bash', 19:39:50 INFO - 'SHLVL': '1', 19:39:50 INFO - 'TERM': 'linux', 19:39:50 INFO - 'TMOUT': '86400', 19:39:50 INFO - 'USER': 'cltbld', 19:39:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', 19:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:50 INFO - '_': '/tools/buildbot/bin/python'} 19:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:50 INFO - Downloading/unpacking psutil>=3.1.1 19:39:50 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 19:39:50 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 19:39:50 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 19:39:50 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 19:39:50 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 19:39:50 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 19:39:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:39:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:39:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:39:52 INFO - Installing collected packages: psutil 19:39:52 INFO - Running setup.py install for psutil 19:39:52 INFO - building 'psutil._psutil_linux' extension 19:39:52 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 19:39:52 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 19:39:52 INFO - building 'psutil._psutil_posix' extension 19:39:52 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 19:39:52 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 19:39:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:39:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:39:52 INFO - Successfully installed psutil 19:39:52 INFO - Cleaning up... 19:39:52 INFO - Return code: 0 19:39:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:39:52 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')]} 19:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:52 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')]} 19:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:52 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 0x7f29ba92df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c871c0>, '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 0x2c880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c88550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', '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 19:39:52 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 19:39:52 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 19:39:52 INFO - Using env: {'DISPLAY': ':0', 19:39:52 INFO - 'HOME': '/home/cltbld', 19:39:52 INFO - 'LANG': 'en_US.UTF-8', 19:39:52 INFO - 'LANGUAGE': 'en_US:en', 19:39:52 INFO - 'LOGNAME': 'cltbld', 19:39:52 INFO - 'MAIL': '/var/mail/cltbld', 19:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:52 INFO - 'MOZ_NO_REMOTE': '1', 19:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:39:52 INFO - 'NO_EM_RESTART': '1', 19:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:52 INFO - 'PWD': '/builds/slave/test', 19:39:52 INFO - 'SHELL': '/bin/bash', 19:39:52 INFO - 'SHLVL': '1', 19:39:52 INFO - 'TERM': 'linux', 19:39:52 INFO - 'TMOUT': '86400', 19:39:52 INFO - 'USER': 'cltbld', 19:39:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', 19:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:52 INFO - '_': '/tools/buildbot/bin/python'} 19:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:39: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 19:39: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 19:39: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 19:39: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 19:39: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 19:39: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 19:39:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:39:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:39:54 INFO - Installing collected packages: mozsystemmonitor 19:39:54 INFO - Running setup.py install for mozsystemmonitor 19:39:55 INFO - Successfully installed mozsystemmonitor 19:39:55 INFO - Cleaning up... 19:39:55 INFO - Return code: 0 19:39:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:39:55 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')]} 19:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:55 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')]} 19:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:55 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 0x7f29ba92df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c871c0>, '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 0x2c880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c88550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', '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 19:39:55 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 19:39:55 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 19:39:55 INFO - Using env: {'DISPLAY': ':0', 19:39:55 INFO - 'HOME': '/home/cltbld', 19:39:55 INFO - 'LANG': 'en_US.UTF-8', 19:39:55 INFO - 'LANGUAGE': 'en_US:en', 19:39:55 INFO - 'LOGNAME': 'cltbld', 19:39:55 INFO - 'MAIL': '/var/mail/cltbld', 19:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:55 INFO - 'MOZ_NO_REMOTE': '1', 19:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:39:55 INFO - 'NO_EM_RESTART': '1', 19:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:55 INFO - 'PWD': '/builds/slave/test', 19:39:55 INFO - 'SHELL': '/bin/bash', 19:39:55 INFO - 'SHLVL': '1', 19:39:55 INFO - 'TERM': 'linux', 19:39:55 INFO - 'TMOUT': '86400', 19:39:55 INFO - 'USER': 'cltbld', 19:39:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', 19:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:55 INFO - '_': '/tools/buildbot/bin/python'} 19:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:55 INFO - Downloading/unpacking jsonschema==2.5.1 19:39: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 19:39: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 19:39: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 19:39: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 19:39: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 19:39: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 19:39:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:39:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:39:57 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 19:39:57 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 19:39:57 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 19:39:57 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 19:39:57 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 19:39:57 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 19:39:57 INFO - Downloading functools32-3.2.3-2.tar.gz 19:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:39:57 INFO - warning: no files found matching '*.txt' 19:39:57 INFO - no previously-included directories found matching 'build' 19:39:57 INFO - no previously-included directories found matching 'dist' 19:39:57 INFO - no previously-included directories found matching '.git*' 19:39:57 INFO - Installing collected packages: jsonschema, functools32 19:39:57 INFO - Running setup.py install for functools32 19:39:57 INFO - warning: no files found matching '*.txt' 19:39:57 INFO - no previously-included directories found matching 'build' 19:39:57 INFO - no previously-included directories found matching 'dist' 19:39:57 INFO - no previously-included directories found matching '.git*' 19:39:57 INFO - Successfully installed jsonschema functools32 19:39:57 INFO - Cleaning up... 19:39:57 INFO - Return code: 0 19:39:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:39:57 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')]} 19:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:57 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')]} 19:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:57 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 0x7f29ba92df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c871c0>, '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 0x2c880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c88550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', '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 19:39:57 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 19:39:57 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 19:39:57 INFO - Using env: {'DISPLAY': ':0', 19:39:57 INFO - 'HOME': '/home/cltbld', 19:39:57 INFO - 'LANG': 'en_US.UTF-8', 19:39:57 INFO - 'LANGUAGE': 'en_US:en', 19:39:57 INFO - 'LOGNAME': 'cltbld', 19:39:57 INFO - 'MAIL': '/var/mail/cltbld', 19:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:57 INFO - 'MOZ_NO_REMOTE': '1', 19:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:39:57 INFO - 'NO_EM_RESTART': '1', 19:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:57 INFO - 'PWD': '/builds/slave/test', 19:39:57 INFO - 'SHELL': '/bin/bash', 19:39:57 INFO - 'SHLVL': '1', 19:39:57 INFO - 'TERM': 'linux', 19:39:57 INFO - 'TMOUT': '86400', 19:39:57 INFO - 'USER': 'cltbld', 19:39:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', 19:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:57 INFO - '_': '/tools/buildbot/bin/python'} 19:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:57 INFO - Downloading/unpacking blobuploader==1.2.4 19:39:57 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 19:39:57 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 19:39:57 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 19:39:57 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 19:39:57 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 19:39:57 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 19:39:59 INFO - Downloading blobuploader-1.2.4.tar.gz 19:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:39:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:39:59 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 19:39:59 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 19:39:59 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 19:39:59 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 19:39:59 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 19:39:59 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 19:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:40:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:40:00 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 19:40:00 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 19:40:00 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 19:40:00 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 19:40:00 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 19:40:00 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 19:40:00 INFO - Downloading docopt-0.6.1.tar.gz 19:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:40:00 INFO - Installing collected packages: blobuploader, requests, docopt 19:40:00 INFO - Running setup.py install for blobuploader 19:40:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:40:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:40:00 INFO - Running setup.py install for requests 19:40:00 INFO - Running setup.py install for docopt 19:40:01 INFO - Successfully installed blobuploader requests docopt 19:40:01 INFO - Cleaning up... 19:40:01 INFO - Return code: 0 19:40:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:01 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 0x7f29ba92df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c871c0>, '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 0x2c880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c88550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', '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 19:40:01 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 19:40:01 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 19:40:01 INFO - Using env: {'DISPLAY': ':0', 19:40:01 INFO - 'HOME': '/home/cltbld', 19:40:01 INFO - 'LANG': 'en_US.UTF-8', 19:40:01 INFO - 'LANGUAGE': 'en_US:en', 19:40:01 INFO - 'LOGNAME': 'cltbld', 19:40:01 INFO - 'MAIL': '/var/mail/cltbld', 19:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:01 INFO - 'MOZ_NO_REMOTE': '1', 19:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:01 INFO - 'NO_EM_RESTART': '1', 19:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:01 INFO - 'PWD': '/builds/slave/test', 19:40:01 INFO - 'SHELL': '/bin/bash', 19:40:01 INFO - 'SHLVL': '1', 19:40:01 INFO - 'TERM': 'linux', 19:40:01 INFO - 'TMOUT': '86400', 19:40:01 INFO - 'USER': 'cltbld', 19:40:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', 19:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:01 INFO - '_': '/tools/buildbot/bin/python'} 19:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:40:01 INFO - Running setup.py (path:/tmp/pip-Dp8Cpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:40:01 INFO - Running setup.py (path:/tmp/pip-x3adFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:40:01 INFO - Running setup.py (path:/tmp/pip-OBv06K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:40:01 INFO - Running setup.py (path:/tmp/pip-9MT7ei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:40:01 INFO - Running setup.py (path:/tmp/pip-foSs1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:40:01 INFO - Running setup.py (path:/tmp/pip-oqQf6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:40:01 INFO - Running setup.py (path:/tmp/pip-IzgNo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:40:01 INFO - Running setup.py (path:/tmp/pip-ChqdF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:40:01 INFO - Running setup.py (path:/tmp/pip-NfvbFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:40:02 INFO - Running setup.py (path:/tmp/pip-7PThVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:40:02 INFO - Running setup.py (path:/tmp/pip-LugqVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:40:02 INFO - Running setup.py (path:/tmp/pip-jBoFf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:40:02 INFO - Running setup.py (path:/tmp/pip-3HESIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:40:02 INFO - Running setup.py (path:/tmp/pip-HD142T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:02 INFO - Running setup.py (path:/tmp/pip-L9cDCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:40:02 INFO - Running setup.py (path:/tmp/pip-6cMc_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:40:02 INFO - Running setup.py (path:/tmp/pip-qqOFTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:40:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:40:02 INFO - Running setup.py install for manifestparser 19:40:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:40:02 INFO - Running setup.py install for mozcrash 19:40:02 INFO - Running setup.py install for mozdebug 19:40:02 INFO - Running setup.py install for mozdevice 19:40:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:40:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:40:03 INFO - Running setup.py install for mozfile 19:40:03 INFO - Running setup.py install for mozhttpd 19:40:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:40:03 INFO - Running setup.py install for mozinfo 19:40:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:40:03 INFO - Running setup.py install for mozInstall 19:40:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:40:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:40:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:40:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:40:03 INFO - Running setup.py install for mozleak 19:40:03 INFO - Running setup.py install for mozlog 19:40:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:40:03 INFO - Running setup.py install for moznetwork 19:40:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:40:03 INFO - Running setup.py install for mozprocess 19:40:03 INFO - Running setup.py install for mozprofile 19:40:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:40:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:40:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:40:03 INFO - Running setup.py install for mozrunner 19:40:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:40:04 INFO - Running setup.py install for mozscreenshot 19:40:04 INFO - Running setup.py install for moztest 19:40:04 INFO - Running setup.py install for mozversion 19:40:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:40:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:40:04 INFO - Cleaning up... 19:40:04 INFO - Return code: 0 19:40:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:40:04 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')]} 19:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:04 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')]} 19:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:04 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 0x7f29ba92df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c871c0>, '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 0x2c880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c88550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', '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 19:40:04 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 19:40:04 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 19:40:04 INFO - Using env: {'DISPLAY': ':0', 19:40:04 INFO - 'HOME': '/home/cltbld', 19:40:04 INFO - 'LANG': 'en_US.UTF-8', 19:40:04 INFO - 'LANGUAGE': 'en_US:en', 19:40:04 INFO - 'LOGNAME': 'cltbld', 19:40:04 INFO - 'MAIL': '/var/mail/cltbld', 19:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:04 INFO - 'MOZ_NO_REMOTE': '1', 19:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:04 INFO - 'NO_EM_RESTART': '1', 19:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:04 INFO - 'PWD': '/builds/slave/test', 19:40:04 INFO - 'SHELL': '/bin/bash', 19:40:04 INFO - 'SHLVL': '1', 19:40:04 INFO - 'TERM': 'linux', 19:40:04 INFO - 'TMOUT': '86400', 19:40:04 INFO - 'USER': 'cltbld', 19:40:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', 19:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:04 INFO - '_': '/tools/buildbot/bin/python'} 19:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:40:04 INFO - Running setup.py (path:/tmp/pip-iYPJXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:40:04 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)) 19:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:40:04 INFO - Running setup.py (path:/tmp/pip-Rnx4Gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:40:04 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)) 19:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:40:04 INFO - Running setup.py (path:/tmp/pip-iiMLwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:40:04 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)) 19:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:40:04 INFO - Running setup.py (path:/tmp/pip-azRhyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:40:04 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)) 19:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:40:04 INFO - Running setup.py (path:/tmp/pip-rPoGYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:40:04 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)) 19:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:40:04 INFO - Running setup.py (path:/tmp/pip-Izycvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:40:05 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)) 19:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:40:05 INFO - Running setup.py (path:/tmp/pip-d5ZoeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:40:05 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)) 19:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:40:05 INFO - Running setup.py (path:/tmp/pip-OEyJkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:40:05 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)) 19:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:40:05 INFO - Running setup.py (path:/tmp/pip-1_YUFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:40:05 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)) 19:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:40:05 INFO - Running setup.py (path:/tmp/pip-P8X8eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:40:05 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)) 19:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:40:05 INFO - Running setup.py (path:/tmp/pip-hvlrTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:40:05 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)) 19:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:40:05 INFO - Running setup.py (path:/tmp/pip-VZRPmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:40:05 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)) 19:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:40:05 INFO - Running setup.py (path:/tmp/pip-cvM7fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:40:05 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)) 19:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:40:05 INFO - Running setup.py (path:/tmp/pip-tDLA9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:40:05 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)) 19:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:05 INFO - Running setup.py (path:/tmp/pip-r39oA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:05 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)) 19:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:40:05 INFO - Running setup.py (path:/tmp/pip-v3IzUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:40:05 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)) 19:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:40:05 INFO - Running setup.py (path:/tmp/pip-9oyNM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:40:05 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)) 19:40:05 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)) 19:40:05 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)) 19:40:05 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)) 19:40:05 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)) 19:40:05 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)) 19:40:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:07 INFO - Downloading blessings-1.6.tar.gz 19:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:40:07 INFO - Installing collected packages: blessings 19:40:07 INFO - Running setup.py install for blessings 19:40:07 INFO - Successfully installed blessings 19:40:07 INFO - Cleaning up... 19:40:08 INFO - Return code: 0 19:40:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:40:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:40:08 INFO - Reading from file tmpfile_stdout 19:40:08 INFO - Current package versions: 19:40:08 INFO - argparse == 1.2.1 19:40:08 INFO - blessings == 1.6 19:40:08 INFO - blobuploader == 1.2.4 19:40:08 INFO - docopt == 0.6.1 19:40:08 INFO - functools32 == 3.2.3-2 19:40:08 INFO - jsonschema == 2.5.1 19:40:08 INFO - manifestparser == 1.1 19:40:08 INFO - mozInstall == 1.12 19:40:08 INFO - mozcrash == 0.17 19:40:08 INFO - mozdebug == 0.1 19:40:08 INFO - mozdevice == 0.48 19:40:08 INFO - mozfile == 1.2 19:40:08 INFO - mozhttpd == 0.7 19:40:08 INFO - mozinfo == 0.9 19:40:08 INFO - mozleak == 0.1 19:40:08 INFO - mozlog == 3.2 19:40:08 INFO - moznetwork == 0.27 19:40:08 INFO - mozprocess == 0.22 19:40:08 INFO - mozprofile == 0.28 19:40:08 INFO - mozrunner == 6.11 19:40:08 INFO - mozscreenshot == 0.1 19:40:08 INFO - mozsystemmonitor == 0.3 19:40:08 INFO - moztest == 0.7 19:40:08 INFO - mozversion == 1.4 19:40:08 INFO - psutil == 3.1.1 19:40:08 INFO - requests == 1.2.3 19:40:08 INFO - wsgiref == 0.1.2 19:40:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:40:08 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')]} 19:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:08 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')]} 19:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:08 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 0x7f29ba92df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c871c0>, '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 0x2c880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c88550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', '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 19:40:08 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 19:40:08 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 19:40:08 INFO - Using env: {'DISPLAY': ':0', 19:40:08 INFO - 'HOME': '/home/cltbld', 19:40:08 INFO - 'LANG': 'en_US.UTF-8', 19:40:08 INFO - 'LANGUAGE': 'en_US:en', 19:40:08 INFO - 'LOGNAME': 'cltbld', 19:40:08 INFO - 'MAIL': '/var/mail/cltbld', 19:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:08 INFO - 'MOZ_NO_REMOTE': '1', 19:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:08 INFO - 'NO_EM_RESTART': '1', 19:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:08 INFO - 'PWD': '/builds/slave/test', 19:40:08 INFO - 'SHELL': '/bin/bash', 19:40:08 INFO - 'SHLVL': '1', 19:40:08 INFO - 'TERM': 'linux', 19:40:08 INFO - 'TMOUT': '86400', 19:40:08 INFO - 'USER': 'cltbld', 19:40:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', 19:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:08 INFO - '_': '/tools/buildbot/bin/python'} 19:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:08 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)) 19:40:08 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)) 19:40:08 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)) 19:40:08 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)) 19:40:08 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)) 19:40:08 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)) 19:40:08 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)) 19:40:08 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)) 19:40:08 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)) 19:40:08 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)) 19:40:08 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)) 19:40:08 INFO - Cleaning up... 19:40:08 INFO - Return code: 0 19:40:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:40:08 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')]} 19:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:08 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')]} 19:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:08 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 0x7f29ba92df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c871c0>, '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 0x2c880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c88550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', '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 19:40:08 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 19:40:08 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 19:40:08 INFO - Using env: {'DISPLAY': ':0', 19:40:08 INFO - 'HOME': '/home/cltbld', 19:40:08 INFO - 'LANG': 'en_US.UTF-8', 19:40:08 INFO - 'LANGUAGE': 'en_US:en', 19:40:08 INFO - 'LOGNAME': 'cltbld', 19:40:08 INFO - 'MAIL': '/var/mail/cltbld', 19:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:08 INFO - 'MOZ_NO_REMOTE': '1', 19:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:08 INFO - 'NO_EM_RESTART': '1', 19:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:08 INFO - 'PWD': '/builds/slave/test', 19:40:08 INFO - 'SHELL': '/bin/bash', 19:40:08 INFO - 'SHLVL': '1', 19:40:08 INFO - 'TERM': 'linux', 19:40:08 INFO - 'TMOUT': '86400', 19:40:08 INFO - 'USER': 'cltbld', 19:40:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', 19:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:08 INFO - '_': '/tools/buildbot/bin/python'} 19:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:40:08 INFO - Cleaning up... 19:40:08 INFO - Return code: 0 19:40:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:40:08 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')]} 19:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:08 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')]} 19:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:08 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 0x7f29ba92df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c871c0>, '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 0x2c880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c88550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', '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 19:40:08 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 19:40:08 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 19:40:08 INFO - Using env: {'DISPLAY': ':0', 19:40:08 INFO - 'HOME': '/home/cltbld', 19:40:08 INFO - 'LANG': 'en_US.UTF-8', 19:40:08 INFO - 'LANGUAGE': 'en_US:en', 19:40:08 INFO - 'LOGNAME': 'cltbld', 19:40:08 INFO - 'MAIL': '/var/mail/cltbld', 19:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:08 INFO - 'MOZ_NO_REMOTE': '1', 19:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:08 INFO - 'NO_EM_RESTART': '1', 19:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:08 INFO - 'PWD': '/builds/slave/test', 19:40:08 INFO - 'SHELL': '/bin/bash', 19:40:08 INFO - 'SHLVL': '1', 19:40:08 INFO - 'TERM': 'linux', 19:40:08 INFO - 'TMOUT': '86400', 19:40:08 INFO - 'USER': 'cltbld', 19:40:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', 19:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:08 INFO - '_': '/tools/buildbot/bin/python'} 19:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:08 INFO - Downloading/unpacking flake8 19:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:40:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:40:10 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 19:40:10 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 19:40:10 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 19:40:10 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 19:40:10 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 19:40:10 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 19:40:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:40:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:40:11 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 19:40:11 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 19:40:11 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 19:40:11 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 19:40:11 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 19:40:11 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 19:40:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:40:11 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 19:40:11 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 19:40:11 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 19:40:11 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 19:40:11 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 19:40:11 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 19:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:40:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:40:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:40:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:40:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:40:11 INFO - no previously-included directories found matching 'docs/_build' 19:40:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:40:11 INFO - Running setup.py install for pep8 19:40:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:40:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:40:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:40:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:40:11 INFO - no previously-included directories found matching 'docs/_build' 19:40:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:40:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:40:11 INFO - Cleaning up... 19:40:11 INFO - Return code: 0 19:40:11 INFO - Running post-action listener: _resource_record_post_action 19:40:11 INFO - Running post-action listener: _start_resource_monitoring 19:40:11 INFO - Starting resource monitoring. 19:40:11 INFO - ##### 19:40:11 INFO - ##### Finished create-virtualenv step (success) 19:40:11 INFO - ##### 19:40:11 INFO - ##### 19:40:11 INFO - ##### Running install step. 19:40:11 INFO - ##### 19:40:11 INFO - Running pre-action listener: _resource_record_pre_action 19:40:11 INFO - Running main action method: install 19:40:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:40:12 INFO - Reading from file tmpfile_stdout 19:40:12 INFO - Detecting whether we're running mozinstall >=1.0... 19:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:40:12 INFO - Reading from file tmpfile_stdout 19:40:12 INFO - Output received: 19:40:12 INFO - Usage: mozinstall [options] installer 19:40:12 INFO - Options: 19:40:12 INFO - -h, --help show this help message and exit 19:40:12 INFO - -d DEST, --destination=DEST 19:40:12 INFO - Directory to install application into. [default: 19:40:12 INFO - "/builds/slave/test"] 19:40:12 INFO - --app=APP Application being installed. [default: firefox] 19:40:12 INFO - mkdir: /builds/slave/test/build/application 19:40:12 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'] 19:40:12 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 19:40:28 INFO - Reading from file tmpfile_stdout 19:40:28 INFO - Output received: 19:40:28 INFO - /builds/slave/test/build/application/firefox/firefox 19:40:28 INFO - Running post-action listener: _resource_record_post_action 19:40:28 INFO - ##### 19:40:28 INFO - ##### Finished install step (success) 19:40:28 INFO - ##### 19:40:28 INFO - ##### 19:40:28 INFO - ##### Running run-tests step. 19:40:28 INFO - ##### 19:40:28 INFO - Running pre-action listener: _resource_record_pre_action 19:40:28 INFO - Running main action method: run_tests 19:40:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:40:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:40:28 INFO - Python 2.7.3 19:40:28 INFO - Return code: 0 19:40:28 INFO - grabbing minidump binary from tooltool 19:40: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')]} 19:40:28 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 0x2c871c0>, '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 0x2c880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c88550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:40:28 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 19:40:28 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 19:40:28 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 19:40:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:40:28 INFO - Return code: 0 19:40:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:40:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:40:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:40:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:40:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:40:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:40:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:40:29 INFO - Return code: 0 19:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:40:29 INFO - Using env: {'DISPLAY': ':0', 19:40:29 INFO - 'HOME': '/home/cltbld', 19:40:29 INFO - 'LANG': 'en_US.UTF-8', 19:40:29 INFO - 'LANGUAGE': 'en_US:en', 19:40:29 INFO - 'LOGNAME': 'cltbld', 19:40:29 INFO - 'MAIL': '/var/mail/cltbld', 19:40:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:40:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:29 INFO - 'MOZ_NO_REMOTE': '1', 19:40:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:29 INFO - 'NO_EM_RESTART': '1', 19:40:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:29 INFO - 'PWD': '/builds/slave/test', 19:40:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:40:29 INFO - 'SHELL': '/bin/bash', 19:40:29 INFO - 'SHLVL': '1', 19:40:29 INFO - 'TERM': 'linux', 19:40:29 INFO - 'TMOUT': '86400', 19:40:29 INFO - 'USER': 'cltbld', 19:40:29 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702', 19:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:29 INFO - '_': '/tools/buildbot/bin/python'} 19:40:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:40:29 INFO - mozversion application_buildid: 20160603190727 19:40:29 INFO - mozversion application_changeset: d1c3952c299da44bbb1215d73a5c34118f92279e 19:40:29 INFO - mozversion application_display_name: Nightly 19:40:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:40:29 INFO - mozversion application_name: Firefox 19:40:29 INFO - mozversion application_remotingname: firefox 19:40:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:40:29 INFO - mozversion application_vendor: Mozilla 19:40:29 INFO - mozversion application_version: 49.0a1 19:40:29 INFO - mozversion platform_buildid: 20160603190727 19:40:29 INFO - mozversion platform_changeset: d1c3952c299da44bbb1215d73a5c34118f92279e 19:40:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:40:29 INFO - mozversion platform_version: 49.0a1 19:40:29 INFO - using testdate: 1465008029 19:40:29 INFO - actual date: 1465008029 19:40:29 INFO - starting webserver on 'localhost:44545' 19:40:29 INFO - SUITE-START | Running 2 tests 19:40:29 INFO - TEST-START | dromaeo_css 19:40:29 INFO - operating with platform_type : linux_ 19:40:29 INFO - Initialising browser for dromaeo_css test... 19:40:29 INFO - TEST-INFO | started process 6934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ojMRC/profile http://localhost:44545/getInfo.html) 19:40:33 INFO - PROCESS | 6934 | __metrics Screen width/height:1600/1200 19:40:33 INFO - PROCESS | 6934 | colorDepth:24 19:40:33 INFO - PROCESS | 6934 | Browser inner width/height: 1024/697 19:40:33 INFO - PROCESS | 6934 | __metrics 19:40:34 ERROR - PROCESS | 6934 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 19:40:35 INFO - TEST-INFO | 6934: exit 0 19:40:35 INFO - Browser initialized. 19:40:35 INFO - Running cycle 1/1 for dromaeo_css test... 19:40:35 INFO - TEST-INFO | started process 7052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ojMRC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:40:47 INFO - PROCESS | 7052 | RSS: Main: 168558592 19:40:47 INFO - PROCESS | 7052 | 19:41:37 INFO - PROCESS | 7052 | 1465008097588 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] 19:43:49 INFO - PROCESS | 7052 | Cycle 1(1): loaded http://localhost:44545/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44545/tests/dromaeo/cssquery-ext.html) 19:43:50 INFO - PROCESS | 7052 | RSS: Main: 169959424 19:43:50 INFO - PROCESS | 7052 | 19:46:52 INFO - PROCESS | 7052 | Cycle 1(1): loaded http://localhost:44545/tests/dromaeo/cssquery-ext.html (next: http://localhost:44545/tests/dromaeo/cssquery-jquery.html) 19:46:53 INFO - PROCESS | 7052 | RSS: Main: 169422848 19:46:53 INFO - PROCESS | 7052 | 19:49:55 INFO - PROCESS | 7052 | Cycle 1(1): loaded http://localhost:44545/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44545/tests/dromaeo/cssquery-mootools.html) 19:49:55 INFO - PROCESS | 7052 | RSS: Main: 171335680 19:49:55 INFO - PROCESS | 7052 | 19:52:57 INFO - PROCESS | 7052 | Cycle 1(1): loaded http://localhost:44545/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44545/tests/dromaeo/cssquery-prototype.html) 19:52:58 INFO - PROCESS | 7052 | RSS: Main: 168165376 19:52:58 INFO - PROCESS | 7052 | 19:56:01 INFO - PROCESS | 7052 | Cycle 1(1): loaded http://localhost:44545/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44545/tests/dromaeo/cssquery-yui.html) 19:56:01 INFO - PROCESS | 7052 | RSS: Main: 171016192 19:56:01 INFO - PROCESS | 7052 | 19:59:04 INFO - PROCESS | 7052 | Cycle 1(1): loaded http://localhost:44545/tests/dromaeo/cssquery-yui.html (next: http://localhost:44545/tests/dromaeo/cssquery-dojo.html) 19:59:04 INFO - PROCESS | 7052 | RSS: Main: 172498944 19:59:04 INFO - PROCESS | 7052 | 19:59:04 INFO - PROCESS | 7052 | __start_tp_report 19:59:04 INFO - PROCESS | 7052 | _x_x_mozilla_page_load 19:59:04 INFO - PROCESS | 7052 | _x_x_mozilla_page_load_details 19:59:04 INFO - PROCESS | 7052 | |i|pagename|runs| 19:59:04 INFO - PROCESS | 7052 | |0;dojo.html;2681.772049375803;2701.432699133182;2709.5800150976593;2717.7689896358806;2718.9803823566162;4672.859814205575;4728.5744283014565;4764.857054288377;4772.809087636495;4806.855794326167;4678.555537223967;4725.858224253269;4755.857324280269;4757.952420475803;4759.214729569617;4316.740995540262;4367.672424568154;4437.356583295436;4476.865694029184;4477.932831007537;4171.416001759756;4510.188166130095;4538.115067561826;4570.131674981742;4570.702904311209;4353.216421044211;4358.2808836541935;4373;4387.736735795863;4449.4660640723;4370.606645401897;4376.6498680105515;4377.627901628365;4383.167198232326;4427.180971520279;4409;4414.6688998324935;4420.359047938063;4434.60088592025;4465.82136714531;4627.167109920213;4688.156131896258;4691.976540117312;4693.249080147194;4748.643851711101;5128.461511541272;5129.487051294878;5133.794648214067;5135.024345374404;5140.768665410065;5119.360079990001;5122.769475373617;5130.281760553526;5147.150720131174;5178.870528236825;4831.637627177941;4868.537488938545;4871.610271178297;4887.560119589254;4918.262260660929;5304.840854774286;5350.250964864922;5354.625176237704;5373.3551973762615;5405.297311349499;4922.286268491049;4950.702957822542;4959.628027897922;5124.92312615311;5128.3076784633595;5043.2687260347775;5061.772220250024;5062.316587260746;5074.035933172685;5086.186210206423;4951.257311403247;4989.126902791997;5010.173321401928;5051.898962020739;5052.747362631853;4903.583195428358;4957.504249575086;4966.602671786249;4998.300237966688;5011.924821127686;4273;4282.700210985264;4300.182965236595;4312.37470566766;4320.848770293088;3765.058735316171;3768.6042965488778;3783.6405541473514;3796.6013568574904;3801.904952376213;4318.3738357938555;4439.911201775946;4441.467023957146;4447.577480139382;4478.484974228006;5160.638755287094;5178.559822415137;5191.558717508979;5200.063988482034;5227.26818245446;4463.738966360145;4480.820767169277;4504.572065653823;4504.707194032378;4550.908981820345;4467.5755803198645;4580.061087477059;4641.257398816173;4647.000894807633;4672.392588963413;4845.41854977405;4852.078105160008;4868.975655121843;4874.488178741181;4920.630952678492;5136.512031357015;5182.53357197854;5191.6884986900905;5192.610554208525;5204.687718736736;4748.05038992196;4772.928406073842;4788.090262850047;4865.610751139971;4929;5041.697498150123;5046.621503387188;5054.16606259963;5062.645614807076;5088.313077734459;5119.078565858182;5121.8463446096675;5123.87190320245;5126.8974620508125;5160.200168973815;4984.22744474607;4985.875353116201;4992.950070499249;5020.949790502048;5065.544101030925;4802.471728109836;4900.387451568554;4937.432195297587;4993.275974983534;5005.299258103942;4890.755462226945;4900.4854490278;4907.55831975124;4915.287283343823;4925.729084900221;4882.36529251195;5000.399952005782;5034.949650503448;5039.546440820343;5048.899022019613;4890.193118135468;4908.28829819667;4914.533119353656;4935.555799978019;4979.053979743837 19:59:04 INFO - PROCESS | 7052 | |1;ext.html;543.0713479949286;593.4658807073636;596.5972968246434;616.8180386785897;618.6844709198308;37620.81189594052;39044.41433378502;39046.41430378547;39049.609503904954;39077.41383879244;40347.79826100873;40865.38701919466;41084;41128.17743645125;41300.58699413005;7715.922840771591;7910.604469776517;7955.482893611926;7955.522668639871;7965.641546130409;7754.534727916315;7849.843003139934;7861.017372828396;7883.724069657563;7893.763187104368;7837.960810195941;7882.487638303492;7904.762857114296;7957.084935232436;7963.442559020871;7864.370850331989;7876.094249161362;7905.841883162305;7934.523928564276;7968;7797.493162944391;7892.881606775903;7900.565468899208;7906.52560846351;7908.327792137675;37276.44085338722;37443.62556374429;37504.81247593772;37540.81229593862;37557.43663845045;2992.4613569557473;3037.817730936151;3155.3058327167987;3160.2099475131217;3768.6419790119894;28435;28907.277318067005;29076.418471630448;29112.417751644847;29639.851800740857;3092.8608212630484;3124.2501799568167;3128.655847856734;3153.1171272043866;3187.4103290891026;184882;185947;185999;186278;186915;32064.83967580147;54375.72812135914;54882;54899;54964.17553736697;32196;34538.61845526201;34542.30915381679;34806.825965870514;34866.47700284498;12663.366831658564;12813.743725125445;12825.486980520862;12829.679258018625;12840.935795320964;10550.314229575053;10613.946930265454;10627.734306642396;10653.201009924287;10679.305845120043;7997.520148791091;8020.83958320842;8023.83952320962;8082.838343233102;8125.268725814705;3094.97865704317;3146.7639927005566;3165.3985742709274;3192.0902542775198;3222.452183128874;871.9912800872037;921.3274309753917;927.2350310993457;954.6515521834481;1020.2144348851343;27165.763749269907;27174.320641984108;27323.45353092927;27784;27822;1018.1905385218769;1022.4989755020135;1054.267284237463;1061.7823346214007;1077.6066735641434;14849;15042.32309546073;15111.168885711391;15253.694926101416;15507.534773956799;401607;407277;407420;407737;407843;51183.23225151626;51186;51739.74130129401;51798.22302665463;51805.7409712949;1175.0711544110911;1212.2605210821391;1226.6994586326407;1229.1396022784088;1246.9688257793446;26745.33136671599;28283.717162828107;28698.282542935758;29030.12909612715;29147.85426072856;43783.78108109439;43826.342604860314;44140.77929610331;44173.779131105424;44190.33714494221;340487;343342;344083;344557;345061;25230.495390092463;25232.495350093264;25947.481050379265;25961.610575841754;26016.73983260143;43057.354139687304;43252.78373608112;43286.78356608323;43386.56613433825;43475.565244348414;35515.82242088876;36833.447498288086;37237.255254895295;37755.24489510249;37917.62082379251;36613.450798238584;36627;36647.63352366442;37053.25893482169;37192.814035929645;31290.687093128778;35817.46273805843;35912.82043589765;36179.81910090433;36477;31157.37685246237;33180.33639327248;33515;33717.325653487285;33719.32561348809;23924.162654307016;24153.275401737978;24679.629805552573;24721.87639061793;24749.752502474745 19:59:04 INFO - PROCESS | 7052 | |2;jquery.html;364.4311240111321;366.0500999905245;368.93912504436764;381.68320294155853;383.46698089655365;15539.922300388496;16695.58261043473;17448.389306374247;17463.825361746378;17480.21339039743;14782.482613108543;15377.769333459979;15969.760453593177;15992;16009.19954002301;4922.261660750889;5106.4382917879;5133.076046311662;5135.666181698178;5145.536901678848;3716.1824398632257;4990.451050384455;5546.112621980484;5827.504662103705;5878.853028674274;5843.035899076647;5877.735501902424;5890.028145356033;5891.145783861338;5906.468417842393;5684.829455116333;5747.195392645033;5833.329167145769;5834.358220595731;5842.094475356326;4954.529319714621;5033.7734801934;5067.543921047123;5077.035363280965;5088.23676448532;19754;20035;20279.4930126748;20368.18527258908;20390.79609203904;1588.698147352011;1711.9657606847918;1847.7320788485729;1860.5627677495777;2479.070348619268;9041.186293233575;9203.539823008823;9356.251499879992;9436.433813971184;9465.432074075508;1647.6128109894166;1730.7057800174;1738.2178019890973;1748.6939785537606;1750.7811523559556;44619.553804462186;45475.31787023197;69808.30191698119;75409;87096;8025.317847982987;8198.83602327962;8395;8525.19010693983;8876.068012858686;11372.48823802931;11396.00569900264;11484.679261884823;11522.36626985507;11525.538978440936;6418.19772528434;6491.67541622917;6527.249366322839;6675.732970681215;6710.798676039727;6202.100695399142;6272.090546870678;6290.748370065237;6543.803685889431;6573.572717773425;3362.4956256561713;3437.123533498992;3472;3539.876104336336;3622.0582648511577;1663.1850393307434;1713.4688246643332;1804.927802887896;1830.3136323878546;1850.139685046433;848.7920459487465;879.5865943006777;930.7393929699559;951.0156987517886;955.3742298794301;15691;15842;15863.206839658202;15871.841281587036;16409.83590164107;858.965641374338;879.7140929198036;882.1355072029447;897.4121950122681;928.1971095002909;9056.320775941831;9159.49622770754;9179.58691858868;9241.445513269226;9402.341836071546;371764;375269;376421;379345;381039;79090.60454697805;79495.60252198702;79625.60187199026;79716;80472;901.4230892228978;904.2810965282616;919.5310391700281;940.1303793990668;940.3135710930922;14794.778078328618;14810;14926.626834329229;15033.725677878543;15164;34196.65803341935;34283.828580856934;35873;35977.460338094425;36115.638843611225;46837.76581117073;47252.7637361811;48114.759426204044;48183.518164817906;48647.27029094496;7418.258174182539;7424.220456851953;7443.739469118555;7631.732889348847;7644.464887457824;10177.949110254698;11198.38408887519;11481.655550333504;11671.59149429766;11703.76592468129;6460.806175814733;9215.262778977532;9397.590361445838;9720;10163.593456261668;10018.267378829603;10093.444860532742;10115.14021308197;10115.39307641544;10198.643047493302;9956.601735930482;10030.197584193102;10038.980509745128;10099.949500252746;10122.848157277795;7381.4094872409005;7561.621918904143;7624.8475030500185;7676.501027433423;7925.603719813871;9324.720258392259;9579.473128977974;9741.9025809741;9910.801783964136;10090.192784577363 19:59:04 INFO - PROCESS | 7052 | |3;mootools.html;1405.5361730628892;1441.9906065753971;1492.8507149285074;1706.5051135170802;1711.4437807712488;6748.257691653914;7454.478186526945;7473.887891681629;7891.210878912113;7941.047074351079;7475.813104672386;7738;7738.7678369649;7756.379489640829;7787.4938129021575;2119.830413566911;2137.5297434564372;2151.8170955468804;2153.7846215378495;2155.4395857077116;2067.7105205271273;2110.915563377463;2124.362691192644;2129.872207667545;2130.5419334843004;2096.287262330807;2109.8523103382768;2111.7571479279927;2112.6302896992966;2120.9257675981344;1989.5225145964864;1995.5011247188204;1999.3202311214256;2008.8995550222503;2011.3664195778429;1992.9900350498156;2010.4069299556666;2038.0319348309583;2044.9591008179752;2046.6827641715558;7721.343685786715;7804.453688241825;7820.257075577811;7820.530768153929;7827.530348179071;4481.955180448186;4621.69958952667;4651.7441540715245;4652.464966528859;4652.790624421876;2919.124262721175;2944.219781757836;2957.142428695676;2967.198856308806;3046.1166261784056;911.5578944212052;912.1516989200042;918.7106061590645;930.1767935377172;947.8720372749729;10532.473376331152;10542.10392116671;10577.9471102644;10582.9470852646;10622.893771062345;4081.8163182656854;4148.585141485888;4192.413062171298;4195.496540415109;4215.346621273708;9128.361014729038;9129.315301352424;9131.178193962574;9136.035752313284;9140.862887056699;4534.569215924482;4560.95439045612;4571.062932098912;4571.451425828922;4588.220002599499;3660.9816950915606;3967.682585393162;4063.1264278180333;4102;4107.691923105779;3554.0937061049785;3565.1978304881195;3667.1015601177883;3669.798161101165;3675.22820207754;1133.6599020294043;1145.4158379226487;1147.822087576427;1148.7817314710178;1157.675850761788;746.3842330077707;841.8484672758963;876.8947726272761;878.1438097854541;884.7080463447047;5113.130767769489;5378.11261141915;5433.402325744165;5459.426760190202;5512.118061110284;382.57916292079045;385.4103222070237;385.90738222826883;389.1341764573857;392.47212499188544;3748.456473811282;3768.1333293342686;3770.7171962102952;3795.791231482295;3832.7891965941585;9228.307876909259;9532.714018579454;9677.322587418814;9691.370060946016;9705.854412183822;9413.058694130668;9480.810383792423;9515.857262141073;9533.23734101284;9655.420674759536;7469.589172595451;7518.28576285252;7535.849283014309;7619.657115429819;7620.161782203953;5287.920681189708;5416.133418652997;5468.4531546845;5474.206240095244;5526.115821468546;8495.405321627673;8818.911810882066;8862.601182946912;8989.730308090768;9041.367104302635;9012.639494420411;9031.412958157962;9224.446533208029;9548.570314335733;9677.758056048373;6003.429674180946;6382.234131904202;6453.419192272718;6584.078229048033;6652.83367915806;7399.741009064657;7449.8882516761205;7490.213527579744;7494.962525187339;7514.361279291322;6612.305707900601;6865.382115609419;6879.6216208107035;6896.827579310558;6977.895331569929;6806.149231346082;6820.693068812015;6835;6878.621675807879;6896.1035065443175;6210.689465526796;6217.285012223471;6274.560780745486;6281.937180628318;6304.747810087545;4732.5030871759345;4761.40482439695;4771.427428708577;4781.713097214179;4784.880377990578;4575.222212223996;4594.977025114853;4600.401947746772;4625.699329543569;4650.906981860411 19:59:04 INFO - PROCESS | 7052 | |4;prototype.html;285.4277174265597;287.2416819596265;292.36264942425515;300.6392329204955;301.49499588189775;4770.902692380746;4938.580220681238;4967.733228026853;4999.650024498286;5007.273945277937;4745.57289843914;4824.179889418799;4871.955028107433;4880.707157570549;4885.706857588547;3873.360895452254;3877.2827026999953;3880.9029774255728;3886.844526218948;3897.395903634941;3562.0382496725997;3863.208042351311;3871.341871881787;3878.204967981571;3884.9028774280728;3739.6073412291726;3745.962540374602;3749.6876093367378;3756.5116534850567;3776.1692427666007;3728.77627342359;3732.555176359489;3772.1889793694486;3775.207206486641;3801.581825999138;3122.937541249162;3268.5587445694764;3273.3126043530647;3274.5251938469028;3281.4585593377064;4647.838040489877;4722.83470078549;4730.195866702668;4755.952440475586;4769.713817170981;4266.402703621496;4267.167902259061;4275.679324050678;4278.315469524892;4279.251131052053;4997.250412438163;5135.101357262464;5157.704821354499;5171.948280517185;5172.32759741235;3569.7322700797545;3596.2447885943984;3600.6759391654614;3608.278344331144;3613.94579081314;5430.945690543083;5438.211459338374;5440.6735595863975;5441.945580544183;5442.564594832404;3595.1191957970464;3603.3333833240936;3631.3826649469124;3658.817059147032;3659.323025240339;3613.6205698401814;3705.9987606692625;3715.4241092630687;3736.3560033585136;3739.672416292177;4252.596003379674;4256.553061928515;4272.9359059614135;4293.355996600472;4307.655387568987;5126.410462796752;5140.537351638296;5145.9742701287005;5183.196604526304;5187.662801917863;1206.0231212717727;1287.291989405823;1302.7915533514592;1306.5753630070076;1334.5129027904745;848.3382961290204;856.1524091149716;859.4971941414343;871.2681347667989;876.9429987050821;4075.4294398784195;4084.7549147051272;4098.221337945781;4103.343465045578;4128.483939507561;4690.9914368410955;4735.242361222188;4757.215059515142;4759.405599124263;4763.976180119077;4046.59534046593;4102.179564087194;4103.010040130534;4118.794060296973;4123.381492776048;2440.6461063145744;2467.383154211447;2525.7600527949817;2534.3157347516067;2558.4883023395023;4371.890702732457;4416.9178551255145;4418.116376724668;4426.251630605892;4459.643228541774;4587.174308624413;4774.880627984258;4779.402574678165;4790.443105990567;4812.398450193726;4188.544212134618;4480.327950807405;4481.35020422037;4511.5262897395305;4515.661325400673;4701.341812146234;4704.905901882012;4708.623310135249;4734.26618874075;4746.9525304747895;4578.221702310549;4624.3757092793385;4624.7687615618415;4635.7218566886095;4643.930341044955;4412.8014239359945;4418.8453404130705;4632.837850675211;5087.524617860779;5093.821716240062;3709.5548534176073;3720.4605332227216;3729.757565758217;3740.6446387593137;3749.3813520768767;5053.343065401475;5341.278927344759;5344.9732751336;5360.437154098763;5369.758360873848;5026;5165.457626949116;5166.405863325615;5168.276441298296;5213.556847667991;5197.946811009554;5218.765155568084;5233.659812112201;5239.214117882349;5266.289050978222;4851.762800485853;5088.135017047037;5113.156329205788;5133.743312834418;5145.871353216199;5216.9739151304;5255.868603284948;5270.920936186037;5277.182036784305;5283.973580132075;5093.516115968977;5099.56653684441;5102.540771330598;5123.180291153398;5135.071670172396 19:59:04 INFO - PROCESS | 7052 | |5;yui.html;600.4012582666634;620.9068639704046;625.9217597800275;670.4904272752707;679.5786612300375;11807.822882656767;11879.109066820001;12026.639200823989;12191.32947687878;13051.673708157301;12600.936995315033;12621.873781262184;12675.556355527558;12683.873161268384;12786.488540458371;638.214995555467;771.2364758888701;776.763087258386;805.0178781886119;807.317816445103;786.4848524216619;793.4882001109281;795.5664163031162;795.9920400795976;798.2217338095339;854.4702284583567;855.1320409784043;855.1918437076964;856.3406177243519;856.4903882190118;838.446625227347;843.0726201178685;845.6448291717463;846.3356265331685;849.4351256414477;610.6488768957867;611.8011646214998;612.1766224428137;614.8616561273723;615.8121772859276;12831.74336513274;12847.229166250056;12940.288284144368;12986.155899866479;12997.220166789928;12656.17734847232;12690.619281421572;12743.568020689392;12765.55320563785;12801;10266;10339.276250662457;10462.738431539196;10508.474576271155;10681.038706516372;3180.745540356766;3229.9031029069165;3262.2333751568362;3283.097148284241;3368.8652453901814;60008.699956499935;60499;60541.6972915137;60593;61138;10227.43749093792;10275.434851083113;10322.48387580618;10337.534810933526;10401.167906567607;19737.605247895248;19904.800951990583;19969.800301997086;19980.60038799216;20069.197232110844;6348.301686814447;6395.712192951329;6426.325235850169;6512.641804700787;6532.08550802888;3610.5667319921777;3611.566612006576;3653.6529029742132;3700.130469339703;3749.1564398010773;2891.7397434230597;2958.6597541283027;2966.0805150403444;2978.0767961931438;2980.165553644983;496.1070073867025;507.19356223604643;517.567830861235;517.9922301165485;522.1593234891822;541.3693047599503;580.4630716587141;589.9941000590024;634.8984162533973;635.7997230872261;8076.8788468173025;8112.433381028122;8630.266427353745;8701.782455438664;8715.956420217859;464.3406362964598;533.4345593670721;551.0604419464803;563.155267099351;622.8411755002445;3889.824957876846;4001.139754952641;4008.959910400917;4029.8589549365634;4075.673946084306;53482;53843;53946.730266348415;54096.45903540993;76194;74452;77262.6136869312;78385.60807195927;79390.60304698555;80511.59744201241;70936;72915.63542182255;73215.63392183006;73317.6334118326;74212;7493.175750667313;7664.808379790326;7682.058396418912;7725.381969442319;7883.605819708877;44079.33880991724;44903;45208;45563.772181138884;45827.77086114548;58084.419155807904;63708.36291637024;63759.681201593696;63950;64110.679446604336;9667.758306042406;9990.750231243986;10199.7450063749;10220.284580079324;10277.53751081218;10106.595736170471;10292.279540432099;10773.784524309627;10935.945320273348;11506.07951363872;10321.638742644272;10426.582936682447;10499.212559058255;10577.36535807854;10745.838812417976;10395.428251446243;10422.895771042497;10485.633002845168;10647.148228141885;11147.219694621299;9907.801843962936;10121.089101980562;10219.489025548544;10349.068583827491;10431.739206519898;8379.916200838157;8664.48013119215;8920.509371984603;9010.324225682969;9116.316276279438;8628.611712473079;8697.391182617155;8877.73366798997;8922.063183365653;8972.730818075468 19:59:04 INFO - PROCESS | 7052 | __end_tp_report 19:59:04 INFO - PROCESS | 7052 | __start_cc_report 19:59:04 INFO - PROCESS | 7052 | _x_x_mozilla_cycle_collect,384 19:59:04 INFO - PROCESS | 7052 | __end_cc_report 19:59:04 INFO - PROCESS | 7052 | __startTimestamp1465009144643__endTimestamp 19:59:04 INFO - PROCESS | 7052 | 19:59:04 INFO - PROCESS | 7052 | ------- Summary: start ------- 19:59:04 INFO - PROCESS | 7052 | Number of tests: 6 19:59:04 INFO - PROCESS | 7052 | 19:59:04 INFO - PROCESS | 7052 | [#0] dojo.html Cycles:165 Average:4732.49 Median:4882.37 stddev:492.74 (10.1%) stddev-sans-first:467.25 19:59:04 INFO - PROCESS | 7052 | Values: 2681.8 2701.4 2709.6 2717.8 2719.0 4672.9 4728.6 4764.9 4772.8 4806.9 4678.6 4725.9 4755.9 4758.0 4759.2 4316.7 4367.7 4437.4 4476.9 4477.9 4171.4 4510.2 4538.1 4570.1 4570.7 4353.2 4358.3 4373.0 4387.7 4449.5 4370.6 4376.6 4377.6 4383.2 4427.2 4409.0 4414.7 4420.4 4434.6 4465.8 4627.2 4688.2 4692.0 4693.2 4748.6 5128.5 5129.5 5133.8 5135.0 5140.8 5119.4 5122.8 5130.3 5147.2 5178.9 4831.6 4868.5 4871.6 4887.6 4918.3 5304.8 5350.3 5354.6 5373.4 5405.3 4922.3 4950.7 4959.6 5124.9 5128.3 5043.3 5061.8 5062.3 5074.0 5086.2 4951.3 4989.1 5010.2 5051.9 5052.7 4903.6 4957.5 4966.6 4998.3 5011.9 4273.0 4282.7 4300.2 4312.4 4320.8 3765.1 3768.6 3783.6 3796.6 3801.9 4318.4 4439.9 4441.5 4447.6 4478.5 5160.6 5178.6 5191.6 5200.1 5227.3 4463.7 4480.8 4504.6 4504.7 4550.9 4467.6 4580.1 4641.3 4647.0 4672.4 4845.4 4852.1 4869.0 4874.5 4920.6 5136.5 5182.5 5191.7 5192.6 5204.7 4748.1 4772.9 4788.1 4865.6 4929.0 5041.7 5046.6 5054.2 5062.6 5088.3 5119.1 5121.8 5123.9 5126.9 5160.2 4984.2 4985.9 4993.0 5020.9 5065.5 4802.5 4900.4 4937.4 4993.3 5005.3 4890.8 4900.5 4907.6 4915.3 4925.7 4882.4 5000.4 5034.9 5039.5 5048.9 4890.2 4908.3 4914.5 4935.6 4979.1 19:59:04 INFO - PROCESS | 7052 | 19:59:04 INFO - PROCESS | 7052 | [#1] ext.html Cycles:180 Average:45911.33 Median:36328.41 stddev:86251.83 (237.4%) stddev-sans-first:86426.53 19:59:04 INFO - PROCESS | 7052 | Values: 543.1 593.5 596.6 616.8 618.7 37620.8 39044.4 39046.4 39049.6 39077.4 40347.8 40865.4 41084.0 41128.2 41300.6 7715.9 7910.6 7955.5 7955.5 7965.6 7754.5 7849.8 7861.0 7883.7 7893.8 7838.0 7882.5 7904.8 7957.1 7963.4 7864.4 7876.1 7905.8 7934.5 7968.0 7797.5 7892.9 7900.6 7906.5 7908.3 37276.4 37443.6 37504.8 37540.8 37557.4 2992.5 3037.8 3155.3 3160.2 3768.6 28435.0 28907.3 29076.4 29112.4 29639.9 3092.9 3124.3 3128.7 3153.1 3187.4 184882.0 185947.0 185999.0 186278.0 186915.0 32064.8 54375.7 54882.0 54899.0 54964.2 32196.0 34538.6 34542.3 34806.8 34866.5 12663.4 12813.7 12825.5 12829.7 12840.9 10550.3 10613.9 10627.7 10653.2 10679.3 7997.5 8020.8 8023.8 8082.8 8125.3 3095.0 3146.8 3165.4 3192.1 3222.5 872.0 921.3 927.2 954.7 1020.2 27165.8 27174.3 27323.5 27784.0 27822.0 1018.2 1022.5 1054.3 1061.8 1077.6 14849.0 15042.3 15111.2 15253.7 15507.5 401607.0 407277.0 407420.0 407737.0 407843.0 51183.2 51186.0 51739.7 51798.2 51805.7 1175.1 1212.3 1226.7 1229.1 1247.0 26745.3 28283.7 28698.3 29030.1 29147.9 43783.8 43826.3 44140.8 44173.8 44190.3 340487.0 343342.0 344083.0 344557.0 345061.0 25230.5 25232.5 25947.5 25961.6 26016.7 43057.4 43252.8 43286.8 43386.6 43475.6 35515.8 36833.4 37237.3 37755.2 37917.6 36613.5 36627.0 36647.6 37053.3 37192.8 31290.7 35817.5 35912.8 36179.8 36477.0 31157.4 33180.3 33515.0 33717.3 33719.3 23924.2 24153.3 24679.6 24721.9 24749.8 19:59:04 INFO - PROCESS | 7052 | 19:59:04 INFO - PROCESS | 7052 | [#2] jquery.html Cycles:180 Average:23421.70 Median:4972.49 stddev:62356.86 (1254.0%) stddev-sans-first:62507.76 19:59:04 INFO - PROCESS | 7052 | Values: 364.4 366.1 368.9 381.7 383.5 15539.9 16695.6 17448.4 17463.8 17480.2 14782.5 15377.8 15969.8 15992.0 16009.2 4922.3 5106.4 5133.1 5135.7 5145.5 3716.2 4990.5 5546.1 5827.5 5878.9 5843.0 5877.7 5890.0 5891.1 5906.5 5684.8 5747.2 5833.3 5834.4 5842.1 4954.5 5033.8 5067.5 5077.0 5088.2 19754.0 20035.0 20279.5 20368.2 20390.8 1588.7 1712.0 1847.7 1860.6 2479.1 9041.2 9203.5 9356.3 9436.4 9465.4 1647.6 1730.7 1738.2 1748.7 1750.8 44619.6 45475.3 69808.3 75409.0 87096.0 8025.3 8198.8 8395.0 8525.2 8876.1 11372.5 11396.0 11484.7 11522.4 11525.5 6418.2 6491.7 6527.2 6675.7 6710.8 6202.1 6272.1 6290.7 6543.8 6573.6 3362.5 3437.1 3472.0 3539.9 3622.1 1663.2 1713.5 1804.9 1830.3 1850.1 848.8 879.6 930.7 951.0 955.4 15691.0 15842.0 15863.2 15871.8 16409.8 859.0 879.7 882.1 897.4 928.2 9056.3 9159.5 9179.6 9241.4 9402.3 371764.0 375269.0 376421.0 379345.0 381039.0 79090.6 79495.6 79625.6 79716.0 80472.0 901.4 904.3 919.5 940.1 940.3 14794.8 14810.0 14926.6 15033.7 15164.0 34196.7 34283.8 35873.0 35977.5 36115.6 46837.8 47252.8 48114.8 48183.5 48647.3 7418.3 7424.2 7443.7 7631.7 7644.5 10177.9 11198.4 11481.7 11671.6 11703.8 6460.8 9215.3 9397.6 9720.0 10163.6 10018.3 10093.4 10115.1 10115.4 10198.6 9956.6 10030.2 10039.0 10099.9 10122.8 7381.4 7561.6 7624.8 7676.5 7925.6 9324.7 9579.5 9741.9 9910.8 10090.2 19:59:04 INFO - PROCESS | 7052 | 19:59:04 INFO - PROCESS | 7052 | [#3] mootools.html Cycles:180 Average:5123.92 Median:5200.53 stddev:2902.98 (55.8%) stddev-sans-first:2897.68 19:59:04 INFO - PROCESS | 7052 | Values: 1405.5 1442.0 1492.9 1706.5 1711.4 6748.3 7454.5 7473.9 7891.2 7941.0 7475.8 7738.0 7738.8 7756.4 7787.5 2119.8 2137.5 2151.8 2153.8 2155.4 2067.7 2110.9 2124.4 2129.9 2130.5 2096.3 2109.9 2111.8 2112.6 2120.9 1989.5 1995.5 1999.3 2008.9 2011.4 1993.0 2010.4 2038.0 2045.0 2046.7 7721.3 7804.5 7820.3 7820.5 7827.5 4482.0 4621.7 4651.7 4652.5 4652.8 2919.1 2944.2 2957.1 2967.2 3046.1 911.6 912.2 918.7 930.2 947.9 10532.5 10542.1 10577.9 10582.9 10622.9 4081.8 4148.6 4192.4 4195.5 4215.3 9128.4 9129.3 9131.2 9136.0 9140.9 4534.6 4561.0 4571.1 4571.5 4588.2 3661.0 3967.7 4063.1 4102.0 4107.7 3554.1 3565.2 3667.1 3669.8 3675.2 1133.7 1145.4 1147.8 1148.8 1157.7 746.4 841.8 876.9 878.1 884.7 5113.1 5378.1 5433.4 5459.4 5512.1 382.6 385.4 385.9 389.1 392.5 3748.5 3768.1 3770.7 3795.8 3832.8 9228.3 9532.7 9677.3 9691.4 9705.9 9413.1 9480.8 9515.9 9533.2 9655.4 7469.6 7518.3 7535.8 7619.7 7620.2 5287.9 5416.1 5468.5 5474.2 5526.1 8495.4 8818.9 8862.6 8989.7 9041.4 9012.6 9031.4 9224.4 9548.6 9677.8 6003.4 6382.2 6453.4 6584.1 6652.8 7399.7 7449.9 7490.2 7495.0 7514.4 6612.3 6865.4 6879.6 6896.8 6977.9 6806.1 6820.7 6835.0 6878.6 6896.1 6210.7 6217.3 6274.6 6281.9 6304.7 4732.5 4761.4 4771.4 4781.7 4784.9 4575.2 4595.0 4600.4 4625.7 4650.9 19:59:04 INFO - PROCESS | 7052 | 19:59:04 INFO - PROCESS | 7052 | [#4] prototype.html Cycles:180 Average:4126.71 Median:4513.59 stddev:1209.04 (26.8%) stddev-sans-first:1177.55 19:59:04 INFO - PROCESS | 7052 | Values: 285.4 287.2 292.4 300.6 301.5 4770.9 4938.6 4967.7 4999.7 5007.3 4745.6 4824.2 4872.0 4880.7 4885.7 3873.4 3877.3 3880.9 3886.8 3897.4 3562.0 3863.2 3871.3 3878.2 3884.9 3739.6 3746.0 3749.7 3756.5 3776.2 3728.8 3732.6 3772.2 3775.2 3801.6 3122.9 3268.6 3273.3 3274.5 3281.5 4647.8 4722.8 4730.2 4756.0 4769.7 4266.4 4267.2 4275.7 4278.3 4279.3 4997.3 5135.1 5157.7 5171.9 5172.3 3569.7 3596.2 3600.7 3608.3 3613.9 5430.9 5438.2 5440.7 5441.9 5442.6 3595.1 3603.3 3631.4 3658.8 3659.3 3613.6 3706.0 3715.4 3736.4 3739.7 4252.6 4256.6 4272.9 4293.4 4307.7 5126.4 5140.5 5146.0 5183.2 5187.7 1206.0 1287.3 1302.8 1306.6 1334.5 848.3 856.2 859.5 871.3 876.9 4075.4 4084.8 4098.2 4103.3 4128.5 4691.0 4735.2 4757.2 4759.4 4764.0 4046.6 4102.2 4103.0 4118.8 4123.4 2440.6 2467.4 2525.8 2534.3 2558.5 4371.9 4416.9 4418.1 4426.3 4459.6 4587.2 4774.9 4779.4 4790.4 4812.4 4188.5 4480.3 4481.4 4511.5 4515.7 4701.3 4704.9 4708.6 4734.3 4747.0 4578.2 4624.4 4624.8 4635.7 4643.9 4412.8 4418.8 4632.8 5087.5 5093.8 3709.6 3720.5 3729.8 3740.6 3749.4 5053.3 5341.3 5345.0 5360.4 5369.8 5026.0 5165.5 5166.4 5168.3 5213.6 5197.9 5218.8 5233.7 5239.2 5266.3 4851.8 5088.1 5113.2 5133.7 5145.9 5217.0 5255.9 5270.9 5277.2 5284.0 5093.5 5099.6 5102.5 5123.2 5135.1 19:59:04 INFO - PROCESS | 7052 | 19:59:04 INFO - PROCESS | 7052 | [#5] yui.html Cycles:180 Average:16145.59 Median:53894.87 stddev:21996.62 (40.8%) stddev-sans-first:22027.35 19:59:04 INFO - PROCESS | 7052 | Values: 600.4 620.9 625.9 670.5 679.6 11807.8 11879.1 12026.6 12191.3 13051.7 12600.9 12621.9 12675.6 12683.9 12786.5 638.2 771.2 776.8 805.0 807.3 786.5 793.5 795.6 796.0 798.2 854.5 855.1 855.2 856.3 856.5 838.4 843.1 845.6 846.3 849.4 610.6 611.8 612.2 614.9 615.8 12831.7 12847.2 12940.3 12986.2 12997.2 12656.2 12690.6 12743.6 12765.6 12801.0 10266.0 10339.3 10462.7 10508.5 10681.0 3180.7 3229.9 3262.2 3283.1 3368.9 60008.7 60499.0 60541.7 60593.0 61138.0 10227.4 10275.4 10322.5 10337.5 10401.2 19737.6 19904.8 19969.8 19980.6 20069.2 6348.3 6395.7 6426.3 6512.6 6532.1 3610.6 3611.6 3653.7 3700.1 3749.2 2891.7 2958.7 2966.1 2978.1 2980.2 496.1 507.2 517.6 518.0 522.2 541.4 580.5 590.0 634.9 635.8 8076.9 8112.4 8630.3 8701.8 8716.0 464.3 533.4 551.1 563.2 622.8 3889.8 4001.1 4009.0 4029.9 4075.7 53482.0 53843.0 53946.7 54096.5 76194.0 74452.0 77262.6 78385.6 79390.6 80511.6 70936.0 72915.6 73215.6 73317.6 74212.0 7493.2 7664.8 7682.1 7725.4 7883.6 44079.3 44903.0 45208.0 45563.8 45827.8 58084.4 63708.4 63759.7 63950.0 64110.7 9667.8 9990.8 10199.7 10220.3 10277.5 10106.6 10292.3 10773.8 10935.9 11506.1 10321.6 10426.6 10499.2 10577.4 10745.8 10395.4 10422.9 10485.6 10647.1 11147.2 9907.8 10121.1 10219.5 10349.1 10431.7 8379.9 8664.5 8920.5 9010.3 9116.3 8628.6 8697.4 8877.7 8922.1 8972.7 19:59:04 INFO - PROCESS | 7052 | -------- Summary: end -------- 19:59:04 INFO - PROCESS | 7052 | 19:59:05 INFO - TEST-INFO | 7052: exit 0 19:59:05 INFO - TEST-OK | dromaeo_css | took 1116143ms 19:59:05 INFO - TEST-START | kraken 19:59:05 INFO - operating with platform_type : linux_ 19:59:05 INFO - Initialising browser for kraken test... 19:59:05 INFO - TEST-INFO | started process 7289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp78xjHx/profile http://localhost:44545/getInfo.html) 19:59:10 INFO - PROCESS | 7289 | __metrics Screen width/height:1600/1200 19:59:10 INFO - PROCESS | 7289 | colorDepth:24 19:59:10 INFO - PROCESS | 7289 | Browser inner width/height: 1024/697 19:59:10 INFO - PROCESS | 7289 | __metrics 19:59:10 ERROR - PROCESS | 7289 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 19:59:11 INFO - TEST-INFO | 7289: exit 0 19:59:11 INFO - Browser initialized. 19:59:11 INFO - Running cycle 1/1 for kraken test... 19:59:11 INFO - TEST-INFO | started process 7408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp78xjHx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:23 INFO - PROCESS | 7408 | RSS: Main: 168251392 19:59:23 INFO - PROCESS | 7408 | 19:59:26 INFO - PROCESS | 7408 | Cycle 1(1): loaded http://localhost:44545/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44545/tests/kraken/driver.html?testName=audio-beat-detection) 19:59:27 INFO - PROCESS | 7408 | RSS: Main: 172589056 19:59:27 INFO - PROCESS | 7408 | 19:59:30 INFO - PROCESS | 7408 | Cycle 1(1): loaded http://localhost:44545/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44545/tests/kraken/driver.html?testName=audio-dft) 19:59:30 INFO - PROCESS | 7408 | RSS: Main: 172380160 19:59:30 INFO - PROCESS | 7408 | 19:59:33 INFO - PROCESS | 7408 | Cycle 1(1): loaded http://localhost:44545/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44545/tests/kraken/driver.html?testName=audio-fft) 19:59:34 INFO - PROCESS | 7408 | RSS: Main: 167981056 19:59:34 INFO - PROCESS | 7408 | 19:59:36 INFO - PROCESS | 7408 | Cycle 1(1): loaded http://localhost:44545/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44545/tests/kraken/driver.html?testName=audio-oscillator) 19:59:37 INFO - PROCESS | 7408 | RSS: Main: 168357888 19:59:37 INFO - PROCESS | 7408 | 19:59:39 INFO - PROCESS | 7408 | Cycle 1(1): loaded http://localhost:44545/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44545/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:59:39 INFO - PROCESS | 7408 | RSS: Main: 168869888 19:59:39 INFO - PROCESS | 7408 | 19:59:43 INFO - PROCESS | 7408 | Cycle 1(1): loaded http://localhost:44545/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44545/tests/kraken/driver.html?testName=imaging-darkroom) 19:59:43 INFO - PROCESS | 7408 | RSS: Main: 168968192 19:59:43 INFO - PROCESS | 7408 | 19:59:47 INFO - PROCESS | 7408 | Cycle 1(1): loaded http://localhost:44545/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44545/tests/kraken/driver.html?testName=imaging-desaturate) 19:59:48 INFO - PROCESS | 7408 | RSS: Main: 166666240 19:59:48 INFO - PROCESS | 7408 | 19:59:51 INFO - PROCESS | 7408 | Cycle 1(1): loaded http://localhost:44545/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44545/tests/kraken/driver.html?testName=json-parse-financial) 19:59:51 INFO - PROCESS | 7408 | RSS: Main: 167481344 19:59:51 INFO - PROCESS | 7408 | 19:59:53 INFO - PROCESS | 7408 | Cycle 1(1): loaded http://localhost:44545/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44545/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:59:54 INFO - PROCESS | 7408 | RSS: Main: 167862272 19:59:54 INFO - PROCESS | 7408 | 19:59:55 INFO - PROCESS | 7408 | Cycle 1(1): loaded http://localhost:44545/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44545/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:59:56 INFO - PROCESS | 7408 | RSS: Main: 168366080 19:59:56 INFO - PROCESS | 7408 | 19:59:58 INFO - PROCESS | 7408 | Cycle 1(1): loaded http://localhost:44545/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44545/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:59:59 INFO - PROCESS | 7408 | RSS: Main: 169037824 19:59:59 INFO - PROCESS | 7408 | 20:00:02 INFO - PROCESS | 7408 | Cycle 1(1): loaded http://localhost:44545/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44545/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:00:02 INFO - PROCESS | 7408 | RSS: Main: 169181184 20:00:02 INFO - PROCESS | 7408 | 20:00:05 INFO - PROCESS | 7408 | Cycle 1(1): loaded http://localhost:44545/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44545/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:00:06 INFO - PROCESS | 7408 | RSS: Main: 168755200 20:00:06 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | Cycle 1(1): loaded http://localhost:44545/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44545/tests/kraken/driver.html?testName=ai-astar) 20:00:08 INFO - PROCESS | 7408 | RSS: Main: 169844736 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | __start_tp_report 20:00:08 INFO - PROCESS | 7408 | _x_x_mozilla_page_load 20:00:08 INFO - PROCESS | 7408 | _x_x_mozilla_page_load_details 20:00:08 INFO - PROCESS | 7408 | |i|pagename|runs| 20:00:08 INFO - PROCESS | 7408 | |0;ai-astar;116;110;115;114;113;113;114;115;115;114 20:00:08 INFO - PROCESS | 7408 | |1;audio-beat-detection;162;132;156;180;144;153;153;136;193;141 20:00:08 INFO - PROCESS | 7408 | |2;audio-dft;164;165;165;177;162;164;164;165;161;162 20:00:08 INFO - PROCESS | 7408 | |3;audio-fft;75;77;76;155;77;79;77;78;160;78 20:00:08 INFO - PROCESS | 7408 | |4;audio-oscillator;86;87;144;87;87;86;130;87;87;139 20:00:08 INFO - PROCESS | 7408 | |5;imaging-gaussian-blur;118;118;118;117;118;117;118;118;118;117 20:00:08 INFO - PROCESS | 7408 | |6;imaging-darkroom;148;147;148;147;148;147;150;148;148;147 20:00:08 INFO - PROCESS | 7408 | |7;imaging-desaturate;96;95;97;96;96;96;96;96;95;95 20:00:08 INFO - PROCESS | 7408 | |8;json-parse-financial;65;65;65;64;69;65;65;65;65;65 20:00:08 INFO - PROCESS | 7408 | |9;json-stringify-tinderbox;66;66;65;66;66;66;68;65;66;65 20:00:08 INFO - PROCESS | 7408 | |10;stanford-crypto-aes;84;90;84;86;84;89;85;84;108;85 20:00:08 INFO - PROCESS | 7408 | |11;stanford-crypto-ccm;134;140;133;144;135;144;134;141;138;137 20:00:08 INFO - PROCESS | 7408 | |12;stanford-crypto-pbkdf2;172;168;168;167;170;167;167;166;168;168 20:00:08 INFO - PROCESS | 7408 | |13;stanford-crypto-sha256-iterative;68;68;68;69;66;67;67;69;68;67 20:00:08 INFO - PROCESS | 7408 | __end_tp_report 20:00:08 INFO - PROCESS | 7408 | __start_cc_report 20:00:08 INFO - PROCESS | 7408 | _x_x_mozilla_cycle_collect,967 20:00:08 INFO - PROCESS | 7408 | __end_cc_report 20:00:08 INFO - PROCESS | 7408 | __startTimestamp1465009208372__endTimestamp 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | ------- Summary: start ------- 20:00:08 INFO - PROCESS | 7408 | Number of tests: 14 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.50 stddev:1.66 (1.5%) stddev-sans-first:1.58 20:00:08 INFO - PROCESS | 7408 | Values: 116.0 110.0 115.0 114.0 113.0 113.0 114.0 115.0 115.0 114.0 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:154.50 stddev:19.25 (12.5%) stddev-sans-first:20.25 20:00:08 INFO - PROCESS | 7408 | Values: 162.0 132.0 156.0 180.0 144.0 153.0 153.0 136.0 193.0 141.0 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:4.48 (2.7%) stddev-sans-first:4.74 20:00:08 INFO - PROCESS | 7408 | Values: 164.0 165.0 165.0 177.0 162.0 164.0 164.0 165.0 161.0 162.0 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | [#3] audio-fft Cycles:10 Average:93.20 Median:77.00 stddev:33.93 (44.1%) stddev-sans-first:35.34 20:00:08 INFO - PROCESS | 7408 | Values: 75.0 77.0 76.0 155.0 77.0 79.0 77.0 78.0 160.0 78.0 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:87.00 stddev:24.84 (28.6%) stddev-sans-first:25.67 20:00:08 INFO - PROCESS | 7408 | Values: 86.0 87.0 144.0 87.0 87.0 86.0 130.0 87.0 87.0 139.0 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:00:08 INFO - PROCESS | 7408 | Values: 118.0 118.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 20:00:08 INFO - PROCESS | 7408 | Values: 148.0 147.0 148.0 147.0 148.0 147.0 150.0 148.0 148.0 147.0 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 20:00:08 INFO - PROCESS | 7408 | Values: 96.0 95.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:1.34 (2.1%) stddev-sans-first:1.41 20:00:08 INFO - PROCESS | 7408 | Values: 65.0 65.0 65.0 64.0 69.0 65.0 65.0 65.0 65.0 65.0 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 20:00:08 INFO - PROCESS | 7408 | Values: 66.0 66.0 65.0 66.0 66.0 66.0 68.0 65.0 66.0 65.0 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:85.00 stddev:7.39 (8.7%) stddev-sans-first:7.70 20:00:08 INFO - PROCESS | 7408 | Values: 84.0 90.0 84.0 86.0 84.0 89.0 85.0 84.0 108.0 85.0 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:139.00 stddev:4.11 (3.0%) stddev-sans-first:4.10 20:00:08 INFO - PROCESS | 7408 | Values: 134.0 140.0 133.0 144.0 135.0 144.0 134.0 141.0 138.0 137.0 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:168.00 stddev:1.73 (1.0%) stddev-sans-first:1.12 20:00:08 INFO - PROCESS | 7408 | Values: 172.0 168.0 168.0 167.0 170.0 167.0 167.0 166.0 168.0 168.0 20:00:08 INFO - PROCESS | 7408 | 20:00:08 INFO - PROCESS | 7408 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 20:00:08 INFO - PROCESS | 7408 | Values: 68.0 68.0 68.0 69.0 66.0 67.0 67.0 69.0 68.0 67.0 20:00:08 INFO - PROCESS | 7408 | -------- Summary: end -------- 20:00:08 INFO - PROCESS | 7408 | 20:00:09 INFO - TEST-INFO | 7408: exit 0 20:00:09 INFO - TEST-OK | kraken | took 64157ms 20:00:09 INFO - SUITE-END | took 1180s 20:00:09 INFO - Completed test suite (00:19:40) 20:00:09 INFO - javascript benchmark 20:00:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6224.721080783495, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2681.772049375803, 2701.432699133182, 2709.5800150976593, 2717.7689896358806, 2718.9803823566162, 4672.859814205575, 4728.5744283014565, 4764.857054288377, 4772.809087636495, 4806.855794326167, 4678.555537223967, 4725.858224253269, 4755.857324280269, 4757.952420475803, 4759.214729569617, 4316.740995540262, 4367.672424568154, 4437.356583295436, 4476.865694029184, 4477.932831007537, 4171.416001759756, 4510.188166130095, 4538.115067561826, 4570.131674981742, 4570.702904311209, 4353.216421044211, 4358.2808836541935, 4373.0, 4387.736735795863, 4449.4660640723, 4370.606645401897, 4376.6498680105515, 4377.627901628365, 4383.167198232326, 4427.180971520279, 4409.0, 4414.6688998324935, 4420.359047938063, 4434.60088592025, 4465.82136714531, 4627.167109920213, 4688.156131896258, 4691.976540117312, 4693.249080147194, 4748.643851711101, 5128.461511541272, 5129.487051294878, 5133.794648214067, 5135.024345374404, 5140.768665410065, 5119.360079990001, 5122.769475373617, 5130.281760553526, 5147.150720131174, 5178.870528236825, 4831.637627177941, 4868.537488938545, 4871.610271178297, 4887.560119589254, 4918.262260660929, 5304.840854774286, 5350.250964864922, 5354.625176237704, 5373.3551973762615, 5405.297311349499, 4922.286268491049, 4950.702957822542, 4959.628027897922, 5124.92312615311, 5128.3076784633595, 5043.2687260347775, 5061.772220250024, 5062.316587260746, 5074.035933172685, 5086.186210206423, 4951.257311403247, 4989.126902791997, 5010.173321401928, 5051.898962020739, 5052.747362631853, 4903.583195428358, 4957.504249575086, 4966.602671786249, 4998.300237966688, 5011.924821127686, 4273.0, 4282.700210985264, 4300.182965236595, 4312.37470566766, 4320.848770293088, 3765.058735316171, 3768.6042965488778, 3783.6405541473514, 3796.6013568574904, 3801.904952376213, 4318.3738357938555, 4439.911201775946, 4441.467023957146, 4447.577480139382, 4478.484974228006, 5160.638755287094, 5178.559822415137, 5191.558717508979, 5200.063988482034, 5227.26818245446, 4463.738966360145, 4480.820767169277, 4504.572065653823, 4504.707194032378, 4550.908981820345, 4467.5755803198645, 4580.061087477059, 4641.257398816173, 4647.000894807633, 4672.392588963413, 4845.41854977405, 4852.078105160008, 4868.975655121843, 4874.488178741181, 4920.630952678492, 5136.512031357015, 5182.53357197854, 5191.6884986900905, 5192.610554208525, 5204.687718736736, 4748.05038992196, 4772.928406073842, 4788.090262850047, 4865.610751139971, 4929.0, 5041.697498150123, 5046.621503387188, 5054.16606259963, 5062.645614807076, 5088.313077734459, 5119.078565858182, 5121.8463446096675, 5123.87190320245, 5126.8974620508125, 5160.200168973815, 4984.22744474607, 4985.875353116201, 4992.950070499249, 5020.949790502048, 5065.544101030925, 4802.471728109836, 4900.387451568554, 4937.432195297587, 4993.275974983534, 5005.299258103942, 4890.755462226945, 4900.4854490278, 4907.55831975124, 4915.287283343823, 4925.729084900221, 4882.36529251195, 5000.399952005782, 5034.949650503448, 5039.546440820343, 5048.899022019613, 4890.193118135468, 4908.28829819667, 4914.533119353656, 4935.555799978019, 4979.053979743837], "value": 4701.497764488338, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.0713479949286, 593.4658807073636, 596.5972968246434, 616.8180386785897, 618.6844709198308, 37620.81189594052, 39044.41433378502, 39046.41430378547, 39049.609503904954, 39077.41383879244, 40347.79826100873, 40865.38701919466, 41084.0, 41128.17743645125, 41300.58699413005, 7715.922840771591, 7910.604469776517, 7955.482893611926, 7955.522668639871, 7965.641546130409, 7754.534727916315, 7849.843003139934, 7861.017372828396, 7883.724069657563, 7893.763187104368, 7837.960810195941, 7882.487638303492, 7904.762857114296, 7957.084935232436, 7963.442559020871, 7864.370850331989, 7876.094249161362, 7905.841883162305, 7934.523928564276, 7968.0, 7797.493162944391, 7892.881606775903, 7900.565468899208, 7906.52560846351, 7908.327792137675, 37276.44085338722, 37443.62556374429, 37504.81247593772, 37540.81229593862, 37557.43663845045, 2992.4613569557473, 3037.817730936151, 3155.3058327167987, 3160.2099475131217, 3768.6419790119894, 28435.0, 28907.277318067005, 29076.418471630448, 29112.417751644847, 29639.851800740857, 3092.8608212630484, 3124.2501799568167, 3128.655847856734, 3153.1171272043866, 3187.4103290891026, 184882.0, 185947.0, 185999.0, 186278.0, 186915.0, 32064.83967580147, 54375.72812135914, 54882.0, 54899.0, 54964.17553736697, 32196.0, 34538.61845526201, 34542.30915381679, 34806.825965870514, 34866.47700284498, 12663.366831658564, 12813.743725125445, 12825.486980520862, 12829.679258018625, 12840.935795320964, 10550.314229575053, 10613.946930265454, 10627.734306642396, 10653.201009924287, 10679.305845120043, 7997.520148791091, 8020.83958320842, 8023.83952320962, 8082.838343233102, 8125.268725814705, 3094.97865704317, 3146.7639927005566, 3165.3985742709274, 3192.0902542775198, 3222.452183128874, 871.9912800872037, 921.3274309753917, 927.2350310993457, 954.6515521834481, 1020.2144348851343, 27165.763749269907, 27174.320641984108, 27323.45353092927, 27784.0, 27822.0, 1018.1905385218769, 1022.4989755020135, 1054.267284237463, 1061.7823346214007, 1077.6066735641434, 14849.0, 15042.32309546073, 15111.168885711391, 15253.694926101416, 15507.534773956799, 401607.0, 407277.0, 407420.0, 407737.0, 407843.0, 51183.23225151626, 51186.0, 51739.74130129401, 51798.22302665463, 51805.7409712949, 1175.0711544110911, 1212.2605210821391, 1226.6994586326407, 1229.1396022784088, 1246.9688257793446, 26745.33136671599, 28283.717162828107, 28698.282542935758, 29030.12909612715, 29147.85426072856, 43783.78108109439, 43826.342604860314, 44140.77929610331, 44173.779131105424, 44190.33714494221, 340487.0, 343342.0, 344083.0, 344557.0, 345061.0, 25230.495390092463, 25232.495350093264, 25947.481050379265, 25961.610575841754, 26016.73983260143, 43057.354139687304, 43252.78373608112, 43286.78356608323, 43386.56613433825, 43475.565244348414, 35515.82242088876, 36833.447498288086, 37237.255254895295, 37755.24489510249, 37917.62082379251, 36613.450798238584, 36627.0, 36647.63352366442, 37053.25893482169, 37192.814035929645, 31290.687093128778, 35817.46273805843, 35912.82043589765, 36179.81910090433, 36477.0, 31157.37685246237, 33180.33639327248, 33515.0, 33717.325653487285, 33719.32561348809, 23924.162654307016, 24153.275401737978, 24679.629805552573, 24721.87639061793, 24749.752502474745], "value": 16502.86101307978, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.4311240111321, 366.0500999905245, 368.93912504436764, 381.68320294155853, 383.46698089655365, 15539.922300388496, 16695.58261043473, 17448.389306374247, 17463.825361746378, 17480.21339039743, 14782.482613108543, 15377.769333459979, 15969.760453593177, 15992.0, 16009.19954002301, 4922.261660750889, 5106.4382917879, 5133.076046311662, 5135.666181698178, 5145.536901678848, 3716.1824398632257, 4990.451050384455, 5546.112621980484, 5827.504662103705, 5878.853028674274, 5843.035899076647, 5877.735501902424, 5890.028145356033, 5891.145783861338, 5906.468417842393, 5684.829455116333, 5747.195392645033, 5833.329167145769, 5834.358220595731, 5842.094475356326, 4954.529319714621, 5033.7734801934, 5067.543921047123, 5077.035363280965, 5088.23676448532, 19754.0, 20035.0, 20279.4930126748, 20368.18527258908, 20390.79609203904, 1588.698147352011, 1711.9657606847918, 1847.7320788485729, 1860.5627677495777, 2479.070348619268, 9041.186293233575, 9203.539823008823, 9356.251499879992, 9436.433813971184, 9465.432074075508, 1647.6128109894166, 1730.7057800174, 1738.2178019890973, 1748.6939785537606, 1750.7811523559556, 44619.553804462186, 45475.31787023197, 69808.30191698119, 75409.0, 87096.0, 8025.317847982987, 8198.83602327962, 8395.0, 8525.19010693983, 8876.068012858686, 11372.48823802931, 11396.00569900264, 11484.679261884823, 11522.36626985507, 11525.538978440936, 6418.19772528434, 6491.67541622917, 6527.249366322839, 6675.732970681215, 6710.798676039727, 6202.100695399142, 6272.090546870678, 6290.748370065237, 6543.803685889431, 6573.572717773425, 3362.4956256561713, 3437.123533498992, 3472.0, 3539.876104336336, 3622.0582648511577, 1663.1850393307434, 1713.4688246643332, 1804.927802887896, 1830.3136323878546, 1850.139685046433, 848.7920459487465, 879.5865943006777, 930.7393929699559, 951.0156987517886, 955.3742298794301, 15691.0, 15842.0, 15863.206839658202, 15871.841281587036, 16409.83590164107, 858.965641374338, 879.7140929198036, 882.1355072029447, 897.4121950122681, 928.1971095002909, 9056.320775941831, 9159.49622770754, 9179.58691858868, 9241.445513269226, 9402.341836071546, 371764.0, 375269.0, 376421.0, 379345.0, 381039.0, 79090.60454697805, 79495.60252198702, 79625.60187199026, 79716.0, 80472.0, 901.4230892228978, 904.2810965282616, 919.5310391700281, 940.1303793990668, 940.3135710930922, 14794.778078328618, 14810.0, 14926.626834329229, 15033.725677878543, 15164.0, 34196.65803341935, 34283.828580856934, 35873.0, 35977.460338094425, 36115.638843611225, 46837.76581117073, 47252.7637361811, 48114.759426204044, 48183.518164817906, 48647.27029094496, 7418.258174182539, 7424.220456851953, 7443.739469118555, 7631.732889348847, 7644.464887457824, 10177.949110254698, 11198.38408887519, 11481.655550333504, 11671.59149429766, 11703.76592468129, 6460.806175814733, 9215.262778977532, 9397.590361445838, 9720.0, 10163.593456261668, 10018.267378829603, 10093.444860532742, 10115.14021308197, 10115.39307641544, 10198.643047493302, 9956.601735930482, 10030.197584193102, 10038.980509745128, 10099.949500252746, 10122.848157277795, 7381.4094872409005, 7561.621918904143, 7624.8475030500185, 7676.501027433423, 7925.603719813871, 9324.720258392259, 9579.473128977974, 9741.9025809741, 9910.801783964136, 10090.192784577363], "value": 7905.175091629597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.5361730628892, 1441.9906065753971, 1492.8507149285074, 1706.5051135170802, 1711.4437807712488, 6748.257691653914, 7454.478186526945, 7473.887891681629, 7891.210878912113, 7941.047074351079, 7475.813104672386, 7738.0, 7738.7678369649, 7756.379489640829, 7787.4938129021575, 2119.830413566911, 2137.5297434564372, 2151.8170955468804, 2153.7846215378495, 2155.4395857077116, 2067.7105205271273, 2110.915563377463, 2124.362691192644, 2129.872207667545, 2130.5419334843004, 2096.287262330807, 2109.8523103382768, 2111.7571479279927, 2112.6302896992966, 2120.9257675981344, 1989.5225145964864, 1995.5011247188204, 1999.3202311214256, 2008.8995550222503, 2011.3664195778429, 1992.9900350498156, 2010.4069299556666, 2038.0319348309583, 2044.9591008179752, 2046.6827641715558, 7721.343685786715, 7804.453688241825, 7820.257075577811, 7820.530768153929, 7827.530348179071, 4481.955180448186, 4621.69958952667, 4651.7441540715245, 4652.464966528859, 4652.790624421876, 2919.124262721175, 2944.219781757836, 2957.142428695676, 2967.198856308806, 3046.1166261784056, 911.5578944212052, 912.1516989200042, 918.7106061590645, 930.1767935377172, 947.8720372749729, 10532.473376331152, 10542.10392116671, 10577.9471102644, 10582.9470852646, 10622.893771062345, 4081.8163182656854, 4148.585141485888, 4192.413062171298, 4195.496540415109, 4215.346621273708, 9128.361014729038, 9129.315301352424, 9131.178193962574, 9136.035752313284, 9140.862887056699, 4534.569215924482, 4560.95439045612, 4571.062932098912, 4571.451425828922, 4588.220002599499, 3660.9816950915606, 3967.682585393162, 4063.1264278180333, 4102.0, 4107.691923105779, 3554.0937061049785, 3565.1978304881195, 3667.1015601177883, 3669.798161101165, 3675.22820207754, 1133.6599020294043, 1145.4158379226487, 1147.822087576427, 1148.7817314710178, 1157.675850761788, 746.3842330077707, 841.8484672758963, 876.8947726272761, 878.1438097854541, 884.7080463447047, 5113.130767769489, 5378.11261141915, 5433.402325744165, 5459.426760190202, 5512.118061110284, 382.57916292079045, 385.4103222070237, 385.90738222826883, 389.1341764573857, 392.47212499188544, 3748.456473811282, 3768.1333293342686, 3770.7171962102952, 3795.791231482295, 3832.7891965941585, 9228.307876909259, 9532.714018579454, 9677.322587418814, 9691.370060946016, 9705.854412183822, 9413.058694130668, 9480.810383792423, 9515.857262141073, 9533.23734101284, 9655.420674759536, 7469.589172595451, 7518.28576285252, 7535.849283014309, 7619.657115429819, 7620.161782203953, 5287.920681189708, 5416.133418652997, 5468.4531546845, 5474.206240095244, 5526.115821468546, 8495.405321627673, 8818.911810882066, 8862.601182946912, 8989.730308090768, 9041.367104302635, 9012.639494420411, 9031.412958157962, 9224.446533208029, 9548.570314335733, 9677.758056048373, 6003.429674180946, 6382.234131904202, 6453.419192272718, 6584.078229048033, 6652.83367915806, 7399.741009064657, 7449.8882516761205, 7490.213527579744, 7494.962525187339, 7514.361279291322, 6612.305707900601, 6865.382115609419, 6879.6216208107035, 6896.827579310558, 6977.895331569929, 6806.149231346082, 6820.693068812015, 6835.0, 6878.621675807879, 6896.1035065443175, 6210.689465526796, 6217.285012223471, 6274.560780745486, 6281.937180628318, 6304.747810087545, 4732.5030871759345, 4761.40482439695, 4771.427428708577, 4781.713097214179, 4784.880377990578, 4575.222212223996, 4594.977025114853, 4600.401947746772, 4625.699329543569, 4650.906981860411], "value": 4037.583968431778, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.4277174265597, 287.2416819596265, 292.36264942425515, 300.6392329204955, 301.49499588189775, 4770.902692380746, 4938.580220681238, 4967.733228026853, 4999.650024498286, 5007.273945277937, 4745.57289843914, 4824.179889418799, 4871.955028107433, 4880.707157570549, 4885.706857588547, 3873.360895452254, 3877.2827026999953, 3880.9029774255728, 3886.844526218948, 3897.395903634941, 3562.0382496725997, 3863.208042351311, 3871.341871881787, 3878.204967981571, 3884.9028774280728, 3739.6073412291726, 3745.962540374602, 3749.6876093367378, 3756.5116534850567, 3776.1692427666007, 3728.77627342359, 3732.555176359489, 3772.1889793694486, 3775.207206486641, 3801.581825999138, 3122.937541249162, 3268.5587445694764, 3273.3126043530647, 3274.5251938469028, 3281.4585593377064, 4647.838040489877, 4722.83470078549, 4730.195866702668, 4755.952440475586, 4769.713817170981, 4266.402703621496, 4267.167902259061, 4275.679324050678, 4278.315469524892, 4279.251131052053, 4997.250412438163, 5135.101357262464, 5157.704821354499, 5171.948280517185, 5172.32759741235, 3569.7322700797545, 3596.2447885943984, 3600.6759391654614, 3608.278344331144, 3613.94579081314, 5430.945690543083, 5438.211459338374, 5440.6735595863975, 5441.945580544183, 5442.564594832404, 3595.1191957970464, 3603.3333833240936, 3631.3826649469124, 3658.817059147032, 3659.323025240339, 3613.6205698401814, 3705.9987606692625, 3715.4241092630687, 3736.3560033585136, 3739.672416292177, 4252.596003379674, 4256.553061928515, 4272.9359059614135, 4293.355996600472, 4307.655387568987, 5126.410462796752, 5140.537351638296, 5145.9742701287005, 5183.196604526304, 5187.662801917863, 1206.0231212717727, 1287.291989405823, 1302.7915533514592, 1306.5753630070076, 1334.5129027904745, 848.3382961290204, 856.1524091149716, 859.4971941414343, 871.2681347667989, 876.9429987050821, 4075.4294398784195, 4084.7549147051272, 4098.221337945781, 4103.343465045578, 4128.483939507561, 4690.9914368410955, 4735.242361222188, 4757.215059515142, 4759.405599124263, 4763.976180119077, 4046.59534046593, 4102.179564087194, 4103.010040130534, 4118.794060296973, 4123.381492776048, 2440.6461063145744, 2467.383154211447, 2525.7600527949817, 2534.3157347516067, 2558.4883023395023, 4371.890702732457, 4416.9178551255145, 4418.116376724668, 4426.251630605892, 4459.643228541774, 4587.174308624413, 4774.880627984258, 4779.402574678165, 4790.443105990567, 4812.398450193726, 4188.544212134618, 4480.327950807405, 4481.35020422037, 4511.5262897395305, 4515.661325400673, 4701.341812146234, 4704.905901882012, 4708.623310135249, 4734.26618874075, 4746.9525304747895, 4578.221702310549, 4624.3757092793385, 4624.7687615618415, 4635.7218566886095, 4643.930341044955, 4412.8014239359945, 4418.8453404130705, 4632.837850675211, 5087.524617860779, 5093.821716240062, 3709.5548534176073, 3720.4605332227216, 3729.757565758217, 3740.6446387593137, 3749.3813520768767, 5053.343065401475, 5341.278927344759, 5344.9732751336, 5360.437154098763, 5369.758360873848, 5026.0, 5165.457626949116, 5166.405863325615, 5168.276441298296, 5213.556847667991, 5197.946811009554, 5218.765155568084, 5233.659812112201, 5239.214117882349, 5266.289050978222, 4851.762800485853, 5088.135017047037, 5113.156329205788, 5133.743312834418, 5145.871353216199, 5216.9739151304, 5255.868603284948, 5270.920936186037, 5277.182036784305, 5283.973580132075, 5093.516115968977, 5099.56653684441, 5102.540771330598, 5123.180291153398, 5135.071670172396], "value": 3745.127248477715, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.4012582666634, 620.9068639704046, 625.9217597800275, 670.4904272752707, 679.5786612300375, 11807.822882656767, 11879.109066820001, 12026.639200823989, 12191.32947687878, 13051.673708157301, 12600.936995315033, 12621.873781262184, 12675.556355527558, 12683.873161268384, 12786.488540458371, 638.214995555467, 771.2364758888701, 776.763087258386, 805.0178781886119, 807.317816445103, 786.4848524216619, 793.4882001109281, 795.5664163031162, 795.9920400795976, 798.2217338095339, 854.4702284583567, 855.1320409784043, 855.1918437076964, 856.3406177243519, 856.4903882190118, 838.446625227347, 843.0726201178685, 845.6448291717463, 846.3356265331685, 849.4351256414477, 610.6488768957867, 611.8011646214998, 612.1766224428137, 614.8616561273723, 615.8121772859276, 12831.74336513274, 12847.229166250056, 12940.288284144368, 12986.155899866479, 12997.220166789928, 12656.17734847232, 12690.619281421572, 12743.568020689392, 12765.55320563785, 12801.0, 10266.0, 10339.276250662457, 10462.738431539196, 10508.474576271155, 10681.038706516372, 3180.745540356766, 3229.9031029069165, 3262.2333751568362, 3283.097148284241, 3368.8652453901814, 60008.699956499935, 60499.0, 60541.6972915137, 60593.0, 61138.0, 10227.43749093792, 10275.434851083113, 10322.48387580618, 10337.534810933526, 10401.167906567607, 19737.605247895248, 19904.800951990583, 19969.800301997086, 19980.60038799216, 20069.197232110844, 6348.301686814447, 6395.712192951329, 6426.325235850169, 6512.641804700787, 6532.08550802888, 3610.5667319921777, 3611.566612006576, 3653.6529029742132, 3700.130469339703, 3749.1564398010773, 2891.7397434230597, 2958.6597541283027, 2966.0805150403444, 2978.0767961931438, 2980.165553644983, 496.1070073867025, 507.19356223604643, 517.567830861235, 517.9922301165485, 522.1593234891822, 541.3693047599503, 580.4630716587141, 589.9941000590024, 634.8984162533973, 635.7997230872261, 8076.8788468173025, 8112.433381028122, 8630.266427353745, 8701.782455438664, 8715.956420217859, 464.3406362964598, 533.4345593670721, 551.0604419464803, 563.155267099351, 622.8411755002445, 3889.824957876846, 4001.139754952641, 4008.959910400917, 4029.8589549365634, 4075.673946084306, 53482.0, 53843.0, 53946.730266348415, 54096.45903540993, 76194.0, 74452.0, 77262.6136869312, 78385.60807195927, 79390.60304698555, 80511.59744201241, 70936.0, 72915.63542182255, 73215.63392183006, 73317.6334118326, 74212.0, 7493.175750667313, 7664.808379790326, 7682.058396418912, 7725.381969442319, 7883.605819708877, 44079.33880991724, 44903.0, 45208.0, 45563.772181138884, 45827.77086114548, 58084.419155807904, 63708.36291637024, 63759.681201593696, 63950.0, 64110.679446604336, 9667.758306042406, 9990.750231243986, 10199.7450063749, 10220.284580079324, 10277.53751081218, 10106.595736170471, 10292.279540432099, 10773.784524309627, 10935.945320273348, 11506.07951363872, 10321.638742644272, 10426.582936682447, 10499.212559058255, 10577.36535807854, 10745.838812417976, 10395.428251446243, 10422.895771042497, 10485.633002845168, 10647.148228141885, 11147.219694621299, 9907.801843962936, 10121.089101980562, 10219.489025548544, 10349.068583827491, 10431.739206519898, 8379.916200838157, 8664.48013119215, 8920.509371984603, 9010.324225682969, 9116.316276279438, 8628.611712473079, 8697.391182617155, 8877.73366798997, 8922.063183365653, 8972.730818075468], "value": 6271.573134676334, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 115.0, 114.0, 113.0, 113.0, 114.0, 115.0, 115.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 132.0, 156.0, 180.0, 144.0, 153.0, 153.0, 136.0, 193.0, 141.0], "value": 155.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 177.0, 162.0, 164.0, 164.0, 165.0, 161.0, 162.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 155.0, 77.0, 79.0, 77.0, 78.0, 160.0, 78.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 144.0, 87.0, 87.0, 86.0, 130.0, 87.0, 87.0, 139.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 150.0, 148.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 69.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 68.0, 65.0, 66.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 90.0, 84.0, 86.0, 84.0, 89.0, 85.0, 84.0, 108.0, 85.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 140.0, 133.0, 144.0, 135.0, 144.0, 134.0, 141.0, 138.0, 137.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 168.0, 167.0, 170.0, 167.0, 167.0, 166.0, 168.0, 168.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 69.0, 66.0, 67.0, 67.0, 69.0, 68.0, 67.0], "value": 67.7, "unit": "score"}]}]} 20:00:09 INFO - Return code: 0 20:00:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:00:09 ERROR - # TBPL SUCCESS # 20:00:09 INFO - Running post-action listener: _resource_record_post_action 20:00:09 INFO - ##### 20:00:09 INFO - ##### Finished run-tests step (success) 20:00:09 INFO - ##### 20:00:09 INFO - Running post-run listener: _resource_record_post_run 20:00:09 INFO - Total resource usage - Wall time: 1197s; CPU: 14.0%; Read bytes: 0; Write bytes: 523816960; Read time: 0; Write time: 394648 20:00:09 INFO - TinderboxPrint: CPU usage
13.5% 20:00:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:00:09 INFO - TinderboxPrint: I/O write bytes / time
523,816,960 / 394,648 20:00:09 INFO - TinderboxPrint: CPU idle
8,260.7 (86.5%) 20:00:09 INFO - TinderboxPrint: CPU user
1,235.8 (12.9%) 20:00:09 INFO - TinderboxPrint: Swap in / out
0 / 0 20:00:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237457408; Read time: 0; Write time: 210156 20:00:09 INFO - run-tests - Wall time: 1182s; CPU: 14.0%; Read bytes: 0; Write bytes: 286359552; Read time: 0; Write time: 184492 20:00:10 INFO - Running post-run listener: _upload_blobber_files 20:00:10 INFO - Blob upload gear active. 20:00:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:00:10 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 20:00:10 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'] 20:00:10 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 20:00:10 INFO - (blobuploader) - INFO - Open directory for files ... 20:00:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:00:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:00:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:11 INFO - (blobuploader) - INFO - Done attempting. 20:00:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:00:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:00:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:15 INFO - (blobuploader) - INFO - Done attempting. 20:00:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:00:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:00:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:16 INFO - (blobuploader) - INFO - Done attempting. 20:00:16 INFO - (blobuploader) - INFO - Iteration through files over. 20:00:16 INFO - Return code: 0 20:00:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:00:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:00:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/640e9358a42c434807148b06ec43ee103507c8f8429ed5870208abaaf758956e125efe4b78118560092bd85a6deb64d586e3ab20bc783c27807f23ad7b21ea2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae079cd83d157bfc377663c69d57a497583457ba25555a2d7380ace9299ca1f0178b930283ea44019b2a9156f5d3d4d2c3b695e72d997376f9bcc1f972d36c97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62d812820298c3c4c5279552c7a112b383c240d4ff4b79d583b9108e0b3c2f76a85dfbd0b0b7c65695f10ccffbde6ee8858ce1923a15b07fbd481c490c78d2c6"} 20:00:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:00:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:00:16 INFO - Contents: 20:00:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/640e9358a42c434807148b06ec43ee103507c8f8429ed5870208abaaf758956e125efe4b78118560092bd85a6deb64d586e3ab20bc783c27807f23ad7b21ea2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae079cd83d157bfc377663c69d57a497583457ba25555a2d7380ace9299ca1f0178b930283ea44019b2a9156f5d3d4d2c3b695e72d997376f9bcc1f972d36c97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62d812820298c3c4c5279552c7a112b383c240d4ff4b79d583b9108e0b3c2f76a85dfbd0b0b7c65695f10ccffbde6ee8858ce1923a15b07fbd481c490c78d2c6"} 20:00:16 INFO - Running post-run listener: copy_logs_to_upload_dir 20:00:16 INFO - Copying logs to upload dir... 20:00:16 INFO - mkdir: /builds/slave/test/build/upload/logs 20:00:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.546081 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-03 20:00:15.619954) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 20:00:15.626018) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/640e9358a42c434807148b06ec43ee103507c8f8429ed5870208abaaf758956e125efe4b78118560092bd85a6deb64d586e3ab20bc783c27807f23ad7b21ea2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae079cd83d157bfc377663c69d57a497583457ba25555a2d7380ace9299ca1f0178b930283ea44019b2a9156f5d3d4d2c3b695e72d997376f9bcc1f972d36c97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62d812820298c3c4c5279552c7a112b383c240d4ff4b79d583b9108e0b3c2f76a85dfbd0b0b7c65695f10ccffbde6ee8858ce1923a15b07fbd481c490c78d2c6"} build_url:https://queue.taskcluster.net/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011497 build_url: 'https://queue.taskcluster.net/v1/task/aeZyBYJGSN2raK1uSv9aKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/640e9358a42c434807148b06ec43ee103507c8f8429ed5870208abaaf758956e125efe4b78118560092bd85a6deb64d586e3ab20bc783c27807f23ad7b21ea2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae079cd83d157bfc377663c69d57a497583457ba25555a2d7380ace9299ca1f0178b930283ea44019b2a9156f5d3d4d2c3b695e72d997376f9bcc1f972d36c97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62d812820298c3c4c5279552c7a112b383c240d4ff4b79d583b9108e0b3c2f76a85dfbd0b0b7c65695f10ccffbde6ee8858ce1923a15b07fbd481c490c78d2c6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 20:00:15.652017) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 20:00:15.652391) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465007744.887773-165841702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 20:00:15.734463) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 20:00:15.734791) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 20:00:15.735146) ========= ========= Total master_lag: 0.18 =========