builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1465239506.4 results: success (0) buildid: 20160606111526 builduid: 982d952838364bf4bed53d1b614866b7 revision: 728c00d3640817a4d41823cc5516fbde396a01ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 11:58:26.397048) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 11:58:26.397523) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 11:58:26.397808) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 11:58:26.412102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:58:26.412383) ========= 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-1465239505.617646-1388006960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 11:58:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-06-06 11:58:26 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:58:26.551474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:58:26.551882) ========= 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-1465239505.617646-1388006960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019714 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:58:26.621205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 11:58:26.621557) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 728c00d3640817a4d41823cc5516fbde396a01ef --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 728c00d3640817a4d41823cc5516fbde396a01ef --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-1465239505.617646-1388006960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 11:58:26,760 truncating revision to first 12 chars 2016-06-06 11:58:26,760 Setting DEBUG logging. 2016-06-06 11:58:26,760 attempt 1/10 2016-06-06 11:58:26,760 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/728c00d36408?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 11:58:27,796 unpacking tar archive at: fx-team-728c00d36408/testing/mozharness/ program finished with exit code 0 elapsedTime=1.373291 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 11:58:28.008822) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 11:58:28.009156) ========= script_repo_revision: 728c00d3640817a4d41823cc5516fbde396a01ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 11:58:28.009582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 11:58:28.009856) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 11:58:28.020506) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 41 secs) (at 2016-06-06 11:58:28.020909) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1465239505.617646-1388006960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:58:28 INFO - MultiFileLogger online at 20160606 11:58:28 in /builds/slave/test 11:58:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:58:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:58:28 INFO - {'append_to_log': False, 11:58:28 INFO - 'base_work_dir': '/builds/slave/test', 11:58:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:58:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:58:28 INFO - 'branch': 'Fx-Team-Non-PGO', 11:58:28 INFO - 'buildbot_json_path': 'buildprops.json', 11:58:28 INFO - 'config_files': ('talos/linux_config.py',), 11:58:28 INFO - 'default_actions': ('clobber', 11:58:28 INFO - 'read-buildbot-config', 11:58:28 INFO - 'download-and-extract', 11:58:28 INFO - 'populate-webroot', 11:58:28 INFO - 'create-virtualenv', 11:58:28 INFO - 'install', 11:58:28 INFO - 'run-tests'), 11:58:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:58:28 INFO - 'download_minidump_stackwalk': True, 11:58:28 INFO - 'download_symbols': 'ondemand', 11:58:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:58:28 INFO - 'tooltool.py': '/tools/tooltool.py', 11:58:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:58:28 INFO - '/tools/misc-python/virtualenv.py')}, 11:58:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:58:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:58:28 INFO - 'installer_path': 'installer.exe', 11:58:28 INFO - 'log_level': 'info', 11:58:28 INFO - 'log_name': 'talos', 11:58:28 INFO - 'log_to_console': True, 11:58:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:58:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:58:28 INFO - 'opt_config_files': (), 11:58:28 INFO - 'pip_index': False, 11:58:28 INFO - 'sps_profile': False, 11:58:28 INFO - 'sps_profile_interval': 0, 11:58:28 INFO - 'suite': 'dromaeojs', 11:58:28 INFO - 'system_bits': '32', 11:58:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:58:28 INFO - 'title': 'talos-linux64-ix-060', 11:58:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:58:28 INFO - 'use_talos_json': True, 11:58:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:58:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:58:28 INFO - 'work_dir': 'build'} 11:58:28 INFO - ##### 11:58:28 INFO - ##### Running clobber step. 11:58:28 INFO - ##### 11:58:28 INFO - Running pre-action listener: _resource_record_pre_action 11:58:28 INFO - Running main action method: clobber 11:58:28 INFO - rmtree: /builds/slave/test/build 11:58:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:58:28 INFO - Running post-action listener: _resource_record_post_action 11:58:28 INFO - ##### 11:58:28 INFO - ##### Finished clobber step (success) 11:58:28 INFO - ##### 11:58:28 INFO - ##### 11:58:28 INFO - ##### Running read-buildbot-config step. 11:58:28 INFO - ##### 11:58:28 INFO - Running pre-action listener: _resource_record_pre_action 11:58:28 INFO - Running main action method: read_buildbot_config 11:58:28 INFO - Using buildbot properties: 11:58:28 INFO - { 11:58:28 INFO - "project": "", 11:58:28 INFO - "product": "firefox", 11:58:28 INFO - "script_repo_revision": "production", 11:58:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:58:28 INFO - "repository": "", 11:58:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:58:28 INFO - "buildid": "20160606111526", 11:58:28 INFO - "pgo_build": "False", 11:58:28 INFO - "basedir": "/builds/slave/test", 11:58:28 INFO - "buildnumber": 1822, 11:58:28 INFO - "slavename": "talos-linux64-ix-060", 11:58:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:58:28 INFO - "platform": "ubuntu64_hw", 11:58:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:58:28 INFO - "branch": "fx-team", 11:58:28 INFO - "repo_path": "integration/fx-team", 11:58:28 INFO - "revision": "728c00d3640817a4d41823cc5516fbde396a01ef", 11:58:28 INFO - "stage_platform": "linux64", 11:58:28 INFO - "builduid": "982d952838364bf4bed53d1b614866b7", 11:58:28 INFO - "slavebuilddir": "test" 11:58:28 INFO - } 11:58:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:58:28 INFO - Running post-action listener: _resource_record_post_action 11:58:28 INFO - ##### 11:58:28 INFO - ##### Finished read-buildbot-config step (success) 11:58:28 INFO - ##### 11:58:28 INFO - ##### 11:58:28 INFO - ##### Running download-and-extract step. 11:58:28 INFO - ##### 11:58:28 INFO - Running pre-action listener: _resource_record_pre_action 11:58:28 INFO - Running main action method: download_and_extract 11:58:28 INFO - mkdir: /builds/slave/test/build/tests 11:58: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')]} 11:58:28 INFO - https://queue.taskcluster.net/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:58:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:58:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:58:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/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 11:58:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/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 11:58:29 INFO - Downloaded 1361 bytes. 11:58:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:58:29 INFO - Using the following test package requirements: 11:58:29 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:58:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:58:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:58:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:29 INFO - u'jsshell-linux-x86_64.zip'], 11:58:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:58:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:58:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:58:29 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:58:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:58:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:58:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:29 INFO - https://queue.taskcluster.net/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:58:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:58:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:58:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/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 11:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/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 11:58:33 INFO - Downloaded 22870980 bytes. 11:58:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:58:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:58:34 INFO - Return code: 0 11:58:34 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:34 INFO - https://queue.taskcluster.net/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/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 11:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/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 11:58:36 INFO - Downloaded 22870980 bytes. 11:58:36 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'] 11:58:36 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 11:58:37 INFO - Return code: 0 11:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:37 INFO - https://queue.taskcluster.net/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/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 11:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/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 12:00:53 INFO - Downloaded 10833369 bytes. 12:00:53 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'] 12:00:53 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 12:00:53 INFO - Return code: 0 12:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:53 INFO - https://queue.taskcluster.net/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:00:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:00:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:00:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/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 12:00:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RThiU7WhTB-M9PhVdWX3yg/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 12:06:31 INFO - Downloaded 55203122 bytes. 12:06:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:06:31 INFO - mkdir: /builds/slave/test/properties 12:06:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:06:31 INFO - Writing to file /builds/slave/test/properties/build_url 12:06:31 INFO - Contents: 12:06:31 INFO - build_url:https://queue.taskcluster.net/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:06:32 INFO - Running post-action listener: _resource_record_post_action 12:06:32 INFO - Running post-action listener: set_extra_try_arguments 12:06:32 INFO - ##### 12:06:32 INFO - ##### Finished download-and-extract step (success) 12:06:32 INFO - ##### 12:06:32 INFO - ##### 12:06:32 INFO - ##### Running populate-webroot step. 12:06:32 INFO - ##### 12:06:32 INFO - Running pre-action listener: _resource_record_pre_action 12:06:32 INFO - Running main action method: populate_webroot 12:06:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:06:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:06:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:06:32 INFO - '--tppagecycles', 12:06:32 INFO - '7'], 12:06:32 INFO - 'tests': ['tsvgm']}}, 12:06:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:06:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:06:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:06:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:06:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:06:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:06:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:32 INFO - 'talos_options': ['--disable-e10s'], 12:06:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:06:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:06:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:32 INFO - 'talos_options': ['--disable-e10s'], 12:06:32 INFO - 'tests': ['damp', 'tps']}, 12:06:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:32 INFO - 'tests': ['damp', 'tps']}, 12:06:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:06:32 INFO - 'tests': ['dromaeo_dom']}, 12:06:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:06:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:06:32 INFO - 'tests': ['a11yr', 12:06:32 INFO - 'ts_paint', 12:06:32 INFO - 'tpaint', 12:06:32 INFO - 'sessionrestore', 12:06:32 INFO - 'sessionrestore_no_auto_restore', 12:06:32 INFO - 'tabpaint']}, 12:06:32 INFO - 'other-e10s': {'tests': ['a11yr', 12:06:32 INFO - 'ts_paint', 12:06:32 INFO - 'tpaint', 12:06:32 INFO - 'sessionrestore', 12:06:32 INFO - 'sessionrestore_no_auto_restore', 12:06:32 INFO - 'tabpaint']}, 12:06:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:06:32 INFO - 'ts_paint', 12:06:32 INFO - 'tpaint', 12:06:32 INFO - 'sessionrestore', 12:06:32 INFO - 'sessionrestore_no_auto_restore', 12:06:32 INFO - 'tabpaint']}, 12:06:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:06:32 INFO - 'ts_paint', 12:06:32 INFO - 'tpaint', 12:06:32 INFO - 'sessionrestore', 12:06:32 INFO - 'sessionrestore_no_auto_restore', 12:06:32 INFO - 'tabpaint']}, 12:06:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:06:32 INFO - 'tests': ['a11yr', 12:06:32 INFO - 'ts_paint', 12:06:32 INFO - 'tpaint', 12:06:32 INFO - 'sessionrestore', 12:06:32 INFO - 'sessionrestore_no_auto_restore', 12:06:32 INFO - 'tabpaint']}, 12:06:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:06:32 INFO - 'tests': ['a11yr', 12:06:32 INFO - 'ts_paint', 12:06:32 INFO - 'tpaint', 12:06:32 INFO - 'sessionrestore', 12:06:32 INFO - 'sessionrestore_no_auto_restore', 12:06:32 INFO - 'tabpaint']}, 12:06:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:06:32 INFO - 'tests': ['tsvgx', 12:06:32 INFO - 'tsvgr_opacity', 12:06:32 INFO - 'tart', 12:06:32 INFO - 'tscrollx', 12:06:32 INFO - 'cart']}, 12:06:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:06:32 INFO - 'tsvgr_opacity', 12:06:32 INFO - 'tart', 12:06:32 INFO - 'tscrollx', 12:06:32 INFO - 'cart']}, 12:06:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:32 INFO - 'talos_options': ['--disable-e10s'], 12:06:32 INFO - 'tests': ['tp5o']}, 12:06:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:32 INFO - 'tests': ['tp5o']}, 12:06:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:32 INFO - 'talos_options': ['--disable-e10s', 12:06:32 INFO - '--xperf_path', 12:06:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:06:32 INFO - 'tests': ['tp5n']}, 12:06:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:06:32 INFO - 'talos_options': ['--xperf_path', 12:06:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:06:32 INFO - 'tests': ['tp5n']}}, 12:06:32 INFO - 'talos.zip': {'path': '', 12:06:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:06:32 INFO - Running post-action listener: _resource_record_post_action 12:06:32 INFO - ##### 12:06:32 INFO - ##### Finished populate-webroot step (success) 12:06:32 INFO - ##### 12:06:32 INFO - ##### 12:06:32 INFO - ##### Running create-virtualenv step. 12:06:32 INFO - ##### 12:06:32 INFO - Running pre-action listener: _resource_record_pre_action 12:06:32 INFO - Running main action method: create_virtualenv 12:06:32 INFO - Creating virtualenv /builds/slave/test/build/venv 12:06:32 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 12:06:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:06:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:06:32 INFO - Using real prefix '/usr' 12:06:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:06:33 INFO - Installing distribute.............................................................................................................................................................................................done. 12:06:35 INFO - Installing pip.................done. 12:06:35 INFO - Return code: 0 12:06:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:06: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')]} 12:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06: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')]} 12:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:35 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 0x7f434c0c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa1c0>, '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 0x1afb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb550>, '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-1465239505.617646-1388006960', '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 12:06:35 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 12:06:35 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 12:06:35 INFO - Using env: {'DISPLAY': ':0', 12:06:35 INFO - 'HOME': '/home/cltbld', 12:06:35 INFO - 'LANG': 'en_US.UTF-8', 12:06:35 INFO - 'LANGUAGE': 'en_US:en', 12:06:35 INFO - 'LOGNAME': 'cltbld', 12:06:35 INFO - 'MAIL': '/var/mail/cltbld', 12:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:35 INFO - 'MOZ_NO_REMOTE': '1', 12:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:35 INFO - 'NO_EM_RESTART': '1', 12:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:35 INFO - 'PWD': '/builds/slave/test', 12:06:35 INFO - 'SHELL': '/bin/bash', 12:06:35 INFO - 'SHLVL': '1', 12:06:35 INFO - 'TERM': 'linux', 12:06:35 INFO - 'TMOUT': '86400', 12:06:35 INFO - 'USER': 'cltbld', 12:06:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465239505.617646-1388006960', 12:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:35 INFO - '_': '/tools/buildbot/bin/python'} 12:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:35 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 12:06:35 INFO - Cleaning up... 12:06:35 INFO - Return code: 0 12:06:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:06: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')]} 12:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06: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')]} 12:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:35 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 0x7f434c0c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa1c0>, '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 0x1afb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb550>, '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-1465239505.617646-1388006960', '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 12:06:35 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 12:06:35 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 12:06:35 INFO - Using env: {'DISPLAY': ':0', 12:06:35 INFO - 'HOME': '/home/cltbld', 12:06:35 INFO - 'LANG': 'en_US.UTF-8', 12:06:35 INFO - 'LANGUAGE': 'en_US:en', 12:06:35 INFO - 'LOGNAME': 'cltbld', 12:06:35 INFO - 'MAIL': '/var/mail/cltbld', 12:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:35 INFO - 'MOZ_NO_REMOTE': '1', 12:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:35 INFO - 'NO_EM_RESTART': '1', 12:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:35 INFO - 'PWD': '/builds/slave/test', 12:06:35 INFO - 'SHELL': '/bin/bash', 12:06:35 INFO - 'SHLVL': '1', 12:06:35 INFO - 'TERM': 'linux', 12:06:35 INFO - 'TMOUT': '86400', 12:06:35 INFO - 'USER': 'cltbld', 12:06:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465239505.617646-1388006960', 12:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:35 INFO - '_': '/tools/buildbot/bin/python'} 12:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:35 INFO - Downloading/unpacking psutil>=3.1.1 12:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:35 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 12:06:35 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 12:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:06:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:06:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:06:37 INFO - Installing collected packages: psutil 12:06:37 INFO - Running setup.py install for psutil 12:06:37 INFO - building 'psutil._psutil_linux' extension 12:06:37 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 12:06:37 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 12:06:38 INFO - building 'psutil._psutil_posix' extension 12:06:38 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 12:06:38 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 12:06:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:06:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:06:38 INFO - Successfully installed psutil 12:06:38 INFO - Cleaning up... 12:06:38 INFO - Return code: 0 12:06:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:06:38 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')]} 12:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:38 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')]} 12:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:38 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 0x7f434c0c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa1c0>, '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 0x1afb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb550>, '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-1465239505.617646-1388006960', '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 12:06:38 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 12:06:38 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 12:06:38 INFO - Using env: {'DISPLAY': ':0', 12:06:38 INFO - 'HOME': '/home/cltbld', 12:06:38 INFO - 'LANG': 'en_US.UTF-8', 12:06:38 INFO - 'LANGUAGE': 'en_US:en', 12:06:38 INFO - 'LOGNAME': 'cltbld', 12:06:38 INFO - 'MAIL': '/var/mail/cltbld', 12:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:38 INFO - 'MOZ_NO_REMOTE': '1', 12:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:38 INFO - 'NO_EM_RESTART': '1', 12:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:38 INFO - 'PWD': '/builds/slave/test', 12:06:38 INFO - 'SHELL': '/bin/bash', 12:06:38 INFO - 'SHLVL': '1', 12:06:38 INFO - 'TERM': 'linux', 12:06:38 INFO - 'TMOUT': '86400', 12:06:38 INFO - 'USER': 'cltbld', 12:06:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465239505.617646-1388006960', 12:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:38 INFO - '_': '/tools/buildbot/bin/python'} 12:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:06:38 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 12:06:38 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 12:06:38 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 12:06:38 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 12:06:38 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 12:06:38 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 12:06:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:06:40 INFO - Installing collected packages: mozsystemmonitor 12:06:40 INFO - Running setup.py install for mozsystemmonitor 12:06:40 INFO - Successfully installed mozsystemmonitor 12:06:40 INFO - Cleaning up... 12:06:40 INFO - Return code: 0 12:06:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:40 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 0x7f434c0c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa1c0>, '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 0x1afb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb550>, '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-1465239505.617646-1388006960', '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 12:06:40 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 12:06:40 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 12:06:40 INFO - Using env: {'DISPLAY': ':0', 12:06:40 INFO - 'HOME': '/home/cltbld', 12:06:40 INFO - 'LANG': 'en_US.UTF-8', 12:06:40 INFO - 'LANGUAGE': 'en_US:en', 12:06:40 INFO - 'LOGNAME': 'cltbld', 12:06:40 INFO - 'MAIL': '/var/mail/cltbld', 12:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:40 INFO - 'MOZ_NO_REMOTE': '1', 12:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:40 INFO - 'NO_EM_RESTART': '1', 12:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:40 INFO - 'PWD': '/builds/slave/test', 12:06:40 INFO - 'SHELL': '/bin/bash', 12:06:40 INFO - 'SHLVL': '1', 12:06:40 INFO - 'TERM': 'linux', 12:06:40 INFO - 'TMOUT': '86400', 12:06:40 INFO - 'USER': 'cltbld', 12:06:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465239505.617646-1388006960', 12:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:40 INFO - '_': '/tools/buildbot/bin/python'} 12:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:40 INFO - Downloading/unpacking jsonschema==2.5.1 12:06:40 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 12:06:40 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 12:06:40 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 12:06:40 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 12:06:40 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 12:06:40 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 12:06:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:06:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:06:42 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 12:06:42 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 12:06:42 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 12:06:42 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 12:06:42 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 12:06:42 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 12:06:42 INFO - Downloading functools32-3.2.3-2.tar.gz 12:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:06:42 INFO - warning: no files found matching '*.txt' 12:06:42 INFO - no previously-included directories found matching 'build' 12:06:42 INFO - no previously-included directories found matching 'dist' 12:06:42 INFO - no previously-included directories found matching '.git*' 12:06:42 INFO - Installing collected packages: jsonschema, functools32 12:06:43 INFO - Running setup.py install for functools32 12:06:43 INFO - warning: no files found matching '*.txt' 12:06:43 INFO - no previously-included directories found matching 'build' 12:06:43 INFO - no previously-included directories found matching 'dist' 12:06:43 INFO - no previously-included directories found matching '.git*' 12:06:43 INFO - Successfully installed jsonschema functools32 12:06:43 INFO - Cleaning up... 12:06:43 INFO - Return code: 0 12:06:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:43 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 0x7f434c0c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa1c0>, '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 0x1afb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb550>, '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-1465239505.617646-1388006960', '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 12:06:43 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 12:06:43 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 12:06:43 INFO - Using env: {'DISPLAY': ':0', 12:06:43 INFO - 'HOME': '/home/cltbld', 12:06:43 INFO - 'LANG': 'en_US.UTF-8', 12:06:43 INFO - 'LANGUAGE': 'en_US:en', 12:06:43 INFO - 'LOGNAME': 'cltbld', 12:06:43 INFO - 'MAIL': '/var/mail/cltbld', 12:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:43 INFO - 'MOZ_NO_REMOTE': '1', 12:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:43 INFO - 'NO_EM_RESTART': '1', 12:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:43 INFO - 'PWD': '/builds/slave/test', 12:06:43 INFO - 'SHELL': '/bin/bash', 12:06:43 INFO - 'SHLVL': '1', 12:06:43 INFO - 'TERM': 'linux', 12:06:43 INFO - 'TMOUT': '86400', 12:06:43 INFO - 'USER': 'cltbld', 12:06:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465239505.617646-1388006960', 12:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:43 INFO - '_': '/tools/buildbot/bin/python'} 12:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:43 INFO - Downloading/unpacking blobuploader==1.2.4 12:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:43 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 12:06:43 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 12:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:45 INFO - Downloading blobuploader-1.2.4.tar.gz 12:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:06:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:06:45 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 12:06:45 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 12:06:45 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 12:06:45 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 12:06:45 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 12:06:45 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 12:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:06:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:06:45 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 12:06:45 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 12:06:45 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 12:06:45 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 12:06:45 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 12:06:45 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 12:06:45 INFO - Downloading docopt-0.6.1.tar.gz 12:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:06:46 INFO - Installing collected packages: blobuploader, requests, docopt 12:06:46 INFO - Running setup.py install for blobuploader 12:06:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:06:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:06:46 INFO - Running setup.py install for requests 12:06:46 INFO - Running setup.py install for docopt 12:06:46 INFO - Successfully installed blobuploader requests docopt 12:06:46 INFO - Cleaning up... 12:06:46 INFO - Return code: 0 12:06:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06:46 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')]} 12:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:46 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')]} 12:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:46 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 0x7f434c0c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa1c0>, '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 0x1afb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb550>, '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-1465239505.617646-1388006960', '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 12:06:46 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 12:06:46 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 12:06:46 INFO - Using env: {'DISPLAY': ':0', 12:06:46 INFO - 'HOME': '/home/cltbld', 12:06:46 INFO - 'LANG': 'en_US.UTF-8', 12:06:46 INFO - 'LANGUAGE': 'en_US:en', 12:06:46 INFO - 'LOGNAME': 'cltbld', 12:06:46 INFO - 'MAIL': '/var/mail/cltbld', 12:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:46 INFO - 'MOZ_NO_REMOTE': '1', 12:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:46 INFO - 'NO_EM_RESTART': '1', 12:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:46 INFO - 'PWD': '/builds/slave/test', 12:06:46 INFO - 'SHELL': '/bin/bash', 12:06:46 INFO - 'SHLVL': '1', 12:06:46 INFO - 'TERM': 'linux', 12:06:46 INFO - 'TMOUT': '86400', 12:06:46 INFO - 'USER': 'cltbld', 12:06:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465239505.617646-1388006960', 12:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:46 INFO - '_': '/tools/buildbot/bin/python'} 12:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:06:46 INFO - Running setup.py (path:/tmp/pip-fS_mT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:06:46 INFO - Running setup.py (path:/tmp/pip-liAGhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:06:47 INFO - Running setup.py (path:/tmp/pip-hxYkg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:06:47 INFO - Running setup.py (path:/tmp/pip-KYYv8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:06:47 INFO - Running setup.py (path:/tmp/pip-qOlpkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:06:47 INFO - Running setup.py (path:/tmp/pip-DLKhQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:06:47 INFO - Running setup.py (path:/tmp/pip-TuvPI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:06:47 INFO - Running setup.py (path:/tmp/pip-xkVTjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:06:47 INFO - Running setup.py (path:/tmp/pip-t3Wp9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:06:47 INFO - Running setup.py (path:/tmp/pip-9lyXgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:06:47 INFO - Running setup.py (path:/tmp/pip-hsuLgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:06:47 INFO - Running setup.py (path:/tmp/pip-JxkX7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:06:47 INFO - Running setup.py (path:/tmp/pip-CJO4kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:06:47 INFO - Running setup.py (path:/tmp/pip-XNS1Bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:47 INFO - Running setup.py (path:/tmp/pip-rq4wd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:06:47 INFO - Running setup.py (path:/tmp/pip-dvSdeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:06:48 INFO - Running setup.py (path:/tmp/pip-17LGwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:06:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:06:48 INFO - Running setup.py install for manifestparser 12:06:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:06:48 INFO - Running setup.py install for mozcrash 12:06:48 INFO - Running setup.py install for mozdebug 12:06:48 INFO - Running setup.py install for mozdevice 12:06:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:06:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:06:48 INFO - Running setup.py install for mozfile 12:06:48 INFO - Running setup.py install for mozhttpd 12:06:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:06:48 INFO - Running setup.py install for mozinfo 12:06:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:06:48 INFO - Running setup.py install for mozInstall 12:06:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:06:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:06:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:06:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:06:48 INFO - Running setup.py install for mozleak 12:06:48 INFO - Running setup.py install for mozlog 12:06:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:06:49 INFO - Running setup.py install for moznetwork 12:06:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:06:49 INFO - Running setup.py install for mozprocess 12:06:49 INFO - Running setup.py install for mozprofile 12:06:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:06:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:06:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:06:49 INFO - Running setup.py install for mozrunner 12:06:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:06:49 INFO - Running setup.py install for mozscreenshot 12:06:49 INFO - Running setup.py install for moztest 12:06:49 INFO - Running setup.py install for mozversion 12:06:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:06:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:06:49 INFO - Cleaning up... 12:06:49 INFO - Return code: 0 12:06:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06: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')]} 12:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06: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')]} 12:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:49 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 0x7f434c0c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa1c0>, '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 0x1afb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb550>, '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-1465239505.617646-1388006960', '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 12:06:49 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 12:06:49 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 12:06:49 INFO - Using env: {'DISPLAY': ':0', 12:06:49 INFO - 'HOME': '/home/cltbld', 12:06:49 INFO - 'LANG': 'en_US.UTF-8', 12:06:49 INFO - 'LANGUAGE': 'en_US:en', 12:06:49 INFO - 'LOGNAME': 'cltbld', 12:06:49 INFO - 'MAIL': '/var/mail/cltbld', 12:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:49 INFO - 'MOZ_NO_REMOTE': '1', 12:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:49 INFO - 'NO_EM_RESTART': '1', 12:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:49 INFO - 'PWD': '/builds/slave/test', 12:06:49 INFO - 'SHELL': '/bin/bash', 12:06:49 INFO - 'SHLVL': '1', 12:06:49 INFO - 'TERM': 'linux', 12:06:49 INFO - 'TMOUT': '86400', 12:06:49 INFO - 'USER': 'cltbld', 12:06:49 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465239505.617646-1388006960', 12:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:49 INFO - '_': '/tools/buildbot/bin/python'} 12:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:06:50 INFO - Running setup.py (path:/tmp/pip-nwhIZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:06:50 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)) 12:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:06:50 INFO - Running setup.py (path:/tmp/pip-4XIULX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:06:50 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)) 12:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:06:50 INFO - Running setup.py (path:/tmp/pip-m93J0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:06:50 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)) 12:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:06:50 INFO - Running setup.py (path:/tmp/pip-FGI4gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:06:50 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)) 12:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:06:50 INFO - Running setup.py (path:/tmp/pip-NHn8P6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:06:50 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)) 12:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:06:50 INFO - Running setup.py (path:/tmp/pip-JyAl9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:06:50 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)) 12:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:06:50 INFO - Running setup.py (path:/tmp/pip-ivsdMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:06:50 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)) 12:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:06:50 INFO - Running setup.py (path:/tmp/pip-V_HpLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:06:50 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)) 12:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:06:50 INFO - Running setup.py (path:/tmp/pip-7Pi3tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:06:50 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)) 12:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:06:50 INFO - Running setup.py (path:/tmp/pip-Y5a1Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:06:50 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)) 12:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:06:50 INFO - Running setup.py (path:/tmp/pip-ptZBit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:06:50 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)) 12:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:06:50 INFO - Running setup.py (path:/tmp/pip-WHZnXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:06:50 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)) 12:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:06:50 INFO - Running setup.py (path:/tmp/pip-YCyT41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:06:51 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)) 12:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:06:51 INFO - Running setup.py (path:/tmp/pip-xxfH9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:06:51 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)) 12:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:51 INFO - Running setup.py (path:/tmp/pip-JAexhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:51 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)) 12:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:06:51 INFO - Running setup.py (path:/tmp/pip-cc_jHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:06:51 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)) 12:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:06:51 INFO - Running setup.py (path:/tmp/pip-By4LDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:06:51 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)) 12:06:51 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)) 12:06:51 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)) 12:06:51 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)) 12:06:51 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)) 12:06:51 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)) 12:06:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:53 INFO - Downloading blessings-1.6.tar.gz 12:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:06:53 INFO - Installing collected packages: blessings 12:06:53 INFO - Running setup.py install for blessings 12:06:53 INFO - Successfully installed blessings 12:06:53 INFO - Cleaning up... 12:06:53 INFO - Return code: 0 12:06:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:06:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:06:53 INFO - Reading from file tmpfile_stdout 12:06:53 INFO - Current package versions: 12:06:53 INFO - argparse == 1.2.1 12:06:53 INFO - blessings == 1.6 12:06:53 INFO - blobuploader == 1.2.4 12:06:53 INFO - docopt == 0.6.1 12:06:53 INFO - functools32 == 3.2.3-2 12:06:53 INFO - jsonschema == 2.5.1 12:06:53 INFO - manifestparser == 1.1 12:06:53 INFO - mozInstall == 1.12 12:06:53 INFO - mozcrash == 0.17 12:06:53 INFO - mozdebug == 0.1 12:06:53 INFO - mozdevice == 0.48 12:06:53 INFO - mozfile == 1.2 12:06:53 INFO - mozhttpd == 0.7 12:06:53 INFO - mozinfo == 0.9 12:06:53 INFO - mozleak == 0.1 12:06:53 INFO - mozlog == 3.2 12:06:53 INFO - moznetwork == 0.27 12:06:53 INFO - mozprocess == 0.22 12:06:53 INFO - mozprofile == 0.28 12:06:53 INFO - mozrunner == 6.11 12:06:53 INFO - mozscreenshot == 0.1 12:06:53 INFO - mozsystemmonitor == 0.3 12:06:53 INFO - moztest == 0.7 12:06:53 INFO - mozversion == 1.4 12:06:53 INFO - psutil == 3.1.1 12:06:53 INFO - requests == 1.2.3 12:06:53 INFO - wsgiref == 0.1.2 12:06:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:53 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 0x7f434c0c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa1c0>, '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 0x1afb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb550>, '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-1465239505.617646-1388006960', '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 12:06:53 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 12:06:53 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 12:06:53 INFO - Using env: {'DISPLAY': ':0', 12:06:53 INFO - 'HOME': '/home/cltbld', 12:06:53 INFO - 'LANG': 'en_US.UTF-8', 12:06:53 INFO - 'LANGUAGE': 'en_US:en', 12:06:53 INFO - 'LOGNAME': 'cltbld', 12:06:53 INFO - 'MAIL': '/var/mail/cltbld', 12:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:53 INFO - 'MOZ_NO_REMOTE': '1', 12:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:53 INFO - 'NO_EM_RESTART': '1', 12:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:53 INFO - 'PWD': '/builds/slave/test', 12:06:53 INFO - 'SHELL': '/bin/bash', 12:06:53 INFO - 'SHLVL': '1', 12:06:53 INFO - 'TERM': 'linux', 12:06:53 INFO - 'TMOUT': '86400', 12:06:53 INFO - 'USER': 'cltbld', 12:06:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465239505.617646-1388006960', 12:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:53 INFO - '_': '/tools/buildbot/bin/python'} 12:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:53 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)) 12:06:53 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)) 12:06:53 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)) 12:06:53 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)) 12:06:53 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)) 12:06:53 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)) 12:06:53 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)) 12:06:53 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)) 12:06:53 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)) 12:06:53 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)) 12:06:53 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)) 12:06:53 INFO - Cleaning up... 12:06:53 INFO - Return code: 0 12:06:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f434c0c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa1c0>, '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 0x1afb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb550>, '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-1465239505.617646-1388006960', '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 12:06:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:06:53 INFO - Using env: {'DISPLAY': ':0', 12:06:53 INFO - 'HOME': '/home/cltbld', 12:06:53 INFO - 'LANG': 'en_US.UTF-8', 12:06:53 INFO - 'LANGUAGE': 'en_US:en', 12:06:53 INFO - 'LOGNAME': 'cltbld', 12:06:53 INFO - 'MAIL': '/var/mail/cltbld', 12:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:53 INFO - 'MOZ_NO_REMOTE': '1', 12:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:53 INFO - 'NO_EM_RESTART': '1', 12:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:53 INFO - 'PWD': '/builds/slave/test', 12:06:53 INFO - 'SHELL': '/bin/bash', 12:06:53 INFO - 'SHLVL': '1', 12:06:53 INFO - 'TERM': 'linux', 12:06:53 INFO - 'TMOUT': '86400', 12:06:53 INFO - 'USER': 'cltbld', 12:06:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465239505.617646-1388006960', 12:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:53 INFO - '_': '/tools/buildbot/bin/python'} 12:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:06:54 INFO - Cleaning up... 12:06:54 INFO - Return code: 0 12:06:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:06:54 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')]} 12:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:54 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')]} 12:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:54 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 0x7f434c0c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afa1c0>, '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 0x1afb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb550>, '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-1465239505.617646-1388006960', '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 12:06:54 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 12:06:54 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 12:06:54 INFO - Using env: {'DISPLAY': ':0', 12:06:54 INFO - 'HOME': '/home/cltbld', 12:06:54 INFO - 'LANG': 'en_US.UTF-8', 12:06:54 INFO - 'LANGUAGE': 'en_US:en', 12:06:54 INFO - 'LOGNAME': 'cltbld', 12:06:54 INFO - 'MAIL': '/var/mail/cltbld', 12:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:54 INFO - 'MOZ_NO_REMOTE': '1', 12:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:54 INFO - 'NO_EM_RESTART': '1', 12:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:54 INFO - 'PWD': '/builds/slave/test', 12:06:54 INFO - 'SHELL': '/bin/bash', 12:06:54 INFO - 'SHLVL': '1', 12:06:54 INFO - 'TERM': 'linux', 12:06:54 INFO - 'TMOUT': '86400', 12:06:54 INFO - 'USER': 'cltbld', 12:06:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465239505.617646-1388006960', 12:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:54 INFO - '_': '/tools/buildbot/bin/python'} 12:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:54 INFO - Downloading/unpacking flake8 12:06:54 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 12:06:54 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 12:06:54 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 12:06:54 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 12:06:54 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 12:06:54 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 12:06:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:06:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:06:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:06:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:06:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:06:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:06:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:06:56 INFO - no previously-included directories found matching 'docs/_build' 12:06:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:06:56 INFO - Running setup.py install for pep8 12:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:06:57 INFO - no previously-included directories found matching 'docs/_build' 12:06:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:06:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:06:57 INFO - Cleaning up... 12:06:57 INFO - Return code: 0 12:06:57 INFO - Running post-action listener: _resource_record_post_action 12:06:57 INFO - Running post-action listener: _start_resource_monitoring 12:06:57 INFO - Starting resource monitoring. 12:06:57 INFO - ##### 12:06:57 INFO - ##### Finished create-virtualenv step (success) 12:06:57 INFO - ##### 12:06:57 INFO - ##### 12:06:57 INFO - ##### Running install step. 12:06:57 INFO - ##### 12:06:57 INFO - Running pre-action listener: _resource_record_pre_action 12:06:57 INFO - Running main action method: install 12:06:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:06:57 INFO - Reading from file tmpfile_stdout 12:06:57 INFO - Detecting whether we're running mozinstall >=1.0... 12:06:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:06:57 INFO - Reading from file tmpfile_stdout 12:06:57 INFO - Output received: 12:06:57 INFO - Usage: mozinstall [options] installer 12:06:57 INFO - Options: 12:06:57 INFO - -h, --help show this help message and exit 12:06:57 INFO - -d DEST, --destination=DEST 12:06:57 INFO - Directory to install application into. [default: 12:06:57 INFO - "/builds/slave/test"] 12:06:57 INFO - --app=APP Application being installed. [default: firefox] 12:06:57 INFO - mkdir: /builds/slave/test/build/application 12:06:57 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'] 12:06:57 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 12:07:13 INFO - Reading from file tmpfile_stdout 12:07:13 INFO - Output received: 12:07:13 INFO - /builds/slave/test/build/application/firefox/firefox 12:07:13 INFO - Running post-action listener: _resource_record_post_action 12:07:13 INFO - ##### 12:07:13 INFO - ##### Finished install step (success) 12:07:13 INFO - ##### 12:07:13 INFO - ##### 12:07:13 INFO - ##### Running run-tests step. 12:07:13 INFO - ##### 12:07:13 INFO - Running pre-action listener: _resource_record_pre_action 12:07:13 INFO - Running main action method: run_tests 12:07:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:07:13 INFO - Python 2.7.3 12:07:13 INFO - Return code: 0 12:07:13 INFO - grabbing minidump binary from tooltool 12:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:07:13 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 0x1afa1c0>, '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 0x1afb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afb550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:07:13 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 12:07:13 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 12:07:13 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 12:07:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:07:13 INFO - Return code: 0 12:07:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:07:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:07:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:07:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:07:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:07:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:07:14 INFO - Return code: 0 12:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RThiU7WhTB-M9PhVdWX3yg/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RThiU7WhTB-M9PhVdWX3yg/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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:07:14 INFO - Using env: {'DISPLAY': ':0', 12:07:14 INFO - 'HOME': '/home/cltbld', 12:07:14 INFO - 'LANG': 'en_US.UTF-8', 12:07:14 INFO - 'LANGUAGE': 'en_US:en', 12:07:14 INFO - 'LOGNAME': 'cltbld', 12:07:14 INFO - 'MAIL': '/var/mail/cltbld', 12:07:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:07:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:07:14 INFO - 'MOZ_NO_REMOTE': '1', 12:07:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:07:14 INFO - 'NO_EM_RESTART': '1', 12:07:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:07:14 INFO - 'PWD': '/builds/slave/test', 12:07:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:07:14 INFO - 'SHELL': '/bin/bash', 12:07:14 INFO - 'SHLVL': '1', 12:07:14 INFO - 'TERM': 'linux', 12:07:14 INFO - 'TMOUT': '86400', 12:07:14 INFO - 'USER': 'cltbld', 12:07:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465239505.617646-1388006960', 12:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:07:14 INFO - '_': '/tools/buildbot/bin/python'} 12:07:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RThiU7WhTB-M9PhVdWX3yg/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:07:14 INFO - mozversion application_buildid: 20160606111526 12:07:14 INFO - mozversion application_changeset: 728c00d3640817a4d41823cc5516fbde396a01ef 12:07:14 INFO - mozversion application_display_name: Nightly 12:07:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:07:14 INFO - mozversion application_name: Firefox 12:07:14 INFO - mozversion application_remotingname: firefox 12:07:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:07:14 INFO - mozversion application_vendor: Mozilla 12:07:14 INFO - mozversion application_version: 49.0a1 12:07:14 INFO - mozversion platform_buildid: 20160606111526 12:07:14 INFO - mozversion platform_changeset: 728c00d3640817a4d41823cc5516fbde396a01ef 12:07:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:07:14 INFO - mozversion platform_version: 49.0a1 12:07:14 INFO - using testdate: 1465240034 12:07:14 INFO - actual date: 1465240034 12:07:14 INFO - starting webserver on 'localhost:39005' 12:07:14 INFO - SUITE-START | Running 2 tests 12:07:14 INFO - TEST-START | dromaeo_css 12:07:14 INFO - operating with platform_type : linux_ 12:07:14 INFO - Initialising browser for dromaeo_css test... 12:07:14 INFO - TEST-INFO | started process 21915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyQzIGo/profile http://localhost:39005/getInfo.html) 12:07:18 INFO - PROCESS | 21915 | __metrics Screen width/height:1600/1200 12:07:18 INFO - PROCESS | 21915 | colorDepth:24 12:07:18 INFO - PROCESS | 21915 | Browser inner width/height: 1024/697 12:07:18 INFO - PROCESS | 21915 | __metrics 12:07:19 ERROR - PROCESS | 21915 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:07:19 INFO - PROCESS | 21915 | console.error: PushService: 12:07:19 INFO - PROCESS | 21915 | stateChangeProcessEnqueue: Error transitioning state 12:07:19 INFO - PROCESS | 21915 | UnknownError 12:07:20 INFO - TEST-INFO | 21915: exit 0 12:07:20 INFO - Browser initialized. 12:07:20 INFO - Running cycle 1/1 for dromaeo_css test... 12:07:20 INFO - TEST-INFO | started process 21994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyQzIGo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:07:32 INFO - PROCESS | 21994 | RSS: Main: 157876224 12:07:32 INFO - PROCESS | 21994 | 12:08:24 INFO - PROCESS | 21994 | 1465240104310 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] 12:10:35 INFO - PROCESS | 21994 | Cycle 1(1): loaded http://localhost:39005/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39005/tests/dromaeo/cssquery-ext.html) 12:10:36 INFO - PROCESS | 21994 | RSS: Main: 271876096 12:10:36 INFO - PROCESS | 21994 | 12:13:39 INFO - PROCESS | 21994 | Cycle 1(1): loaded http://localhost:39005/tests/dromaeo/cssquery-ext.html (next: http://localhost:39005/tests/dromaeo/cssquery-jquery.html) 12:13:40 INFO - PROCESS | 21994 | RSS: Main: 237060096 12:13:40 INFO - PROCESS | 21994 | 12:16:42 INFO - PROCESS | 21994 | Cycle 1(1): loaded http://localhost:39005/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39005/tests/dromaeo/cssquery-mootools.html) 12:16:42 INFO - PROCESS | 21994 | RSS: Main: 249155584 12:16:42 INFO - PROCESS | 21994 | 12:19:45 INFO - PROCESS | 21994 | Cycle 1(1): loaded http://localhost:39005/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39005/tests/dromaeo/cssquery-prototype.html) 12:19:45 INFO - PROCESS | 21994 | RSS: Main: 238559232 12:19:45 INFO - PROCESS | 21994 | 12:22:48 INFO - PROCESS | 21994 | Cycle 1(1): loaded http://localhost:39005/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39005/tests/dromaeo/cssquery-yui.html) 12:22:49 INFO - PROCESS | 21994 | RSS: Main: 215384064 12:22:49 INFO - PROCESS | 21994 | 12:25:52 INFO - PROCESS | 21994 | Cycle 1(1): loaded http://localhost:39005/tests/dromaeo/cssquery-yui.html (next: http://localhost:39005/tests/dromaeo/cssquery-dojo.html) 12:25:52 INFO - PROCESS | 21994 | RSS: Main: 272465920 12:25:52 INFO - PROCESS | 21994 | 12:25:52 INFO - PROCESS | 21994 | __start_tp_report 12:25:52 INFO - PROCESS | 21994 | _x_x_mozilla_page_load 12:25:52 INFO - PROCESS | 21994 | _x_x_mozilla_page_load_details 12:25:52 INFO - PROCESS | 21994 | |i|pagename|runs| 12:25:52 INFO - PROCESS | 21994 | |0;dojo.html;2701.6487856578647;2734.6308248386463;2740.438210166916;2766.2807670005805;2789.525780617295;4654.488006319302;4724.787384567694;4731.172044892139;4816.7109973401575;4877.219644856824;4694.29585562165;4729.621630269578;4738.360321356616;4747.1692453820615;4785.90428191436;4319.589638984299;4361.171377438277;4416.183006143858;4451.087527056946;4569.360289559464;4495.415595972519;4520.660950428731;4520.751358675271;4556.04323092151;4582.518835522272;4245.066085461193;4292;4301.5698430157045;4328.718633288858;4398.384226208349;4338.349247612883;4351.717138385995;4355.128974205171;4361.302191649321;4402.295632698753;4398.8900277493;4412.8676139715535;4442.64458843295;4452.599266066037;4454.621357184643;4585.472670642852;4627.9074418511445;4732.503087175865;4775.617950563947;4786.664933454659;5101.081805275049;5170.1986192140275;5171.327727395452;5177.197534382177;5178.689278643294;5146.073706732786;5146.536811686966;5182.455842136559;5188.818391356284;5209.374875014984;4658.045100754337;4831.202851529493;4834.903301933941;4837.709737415731;4851.514848515191;5348.438413966555;5353.7590808413715;5389.299391079213;5404.594655400861;5405.351357837006;5126.231065340229;5176.249443830623;5179.48205179479;5180.171172612364;5182.4299327073995;4909.361782968192;4958.330625365602;4972.328735620717;5245.527902488794;5264.9736751315995;4944.431390390079;4948.183549714328;4964.354633897642;4985.750712464363;5018.4730603286125;4980.726060066659;4996.575291100225;5000.224965130411;5004.324416203839;5017.473165317662;4180.665546756252;4210.789460526961;4212.705110642287;4245.915081698348;4256.34026725858;3746.7002639788752;3754.737168398186;3754.9436758448646;3771.5662698789442;3824.5984171661576;4405.3612226227015;4415.51429342772;4420.58004489573;4458.9554104459185;4466.419365482467;4870.0746858096845;4910.459849416561;5109.310243117206;5131.820386286462;5141.562967147759;4408.470983481939;4421;4425.845095421645;4470.1059788041875;4494.303382975579;4564.863054108382;4568.406107206042;4571.794269257892;4573.428321459817;4612.95387046132;4540.591346778806;4765.166095933268;4806.567408933212;4852.053849499384;4859.562639362474;5093.92359114621;5118.846434606968;5120.769565369493;5126.051680439131;5144.279800827962;4825.758712064453;4827.734474603931;4828.565429111397;4836.226203807374;4880.707157570557;4867.975660121677;5031.496850314939;5038.470960549236;5060.418051923929;5115.590752739698;5165.61257905651;5177.7670004849115;5188.481151884781;5191.584673226208;5193.402758682649;5045.192769156917;5048.621353398583;5051.797928082836;5052.989402119517;5088.669236499616;4847.587955023862;4921.975390123026;4942.8764280893265;4972.657382506775;4998.775055122601;4872.074305881871;4920.975395123001;4922.778474968707;4969;4973.676711013773;4862.927056094232;5025.572826309804;5031.823886163967;5070.771815268248;5082.440931497458;4869.87825304356;4930.753462326941;4940.75296235194;4941.851744447672;5006.249062640633 12:25:52 INFO - PROCESS | 21994 | |1;ext.html;544.2815483561698;586.1998372221918;588.5938702295418;602.8372339468343;616.805706202546;39680.206395872105;41237.58762412375;41279.38080928788;41298.17403651925;44983;41204.38193427101;41675.58324416755;41711.165776684524;41721;41817.790911045406;7789.727359542403;7975.680972761083;7976.122626511079;7977.242161994601;7981.201879812031;7799.883001754978;7877.842443151134;7889.211078892094;7894.3289820365335;7899.328557072656;7865.606719664022;7932.405069619773;7934;7935.603219839014;7938.40461965352;7855;7888.25061619151;7891.368690504774;7911.090224624127;7918.643661035209;7845.490043147177;7874.133845277015;7913;7921.445498815086;7924.454731327393;38244.617553824384;38565.61434385648;38638.227235455415;38668.80665596654;38702.225955481015;3219.2434777827193;3241.659625739287;3266.8856590019236;3315.624209414105;3793.6206379361843;29333.853330733422;29672.851635741685;29939.550906736415;30203;30892;3526.312369088029;3538.062413460435;3551.8401671924826;3562.4834399011997;3595.7303202259673;233855;234179;235430;236442.8177859117;237962;32318.192045198586;33143.3371332572;33235.169120772174;54630;55154.44845551573;33041.834790825895;33044.339113217604;33158;33207.3358532828;33223.50164747531;12519.624411267676;12580.685482862818;12583.874161258453;12595.118341715992;12602.684932876567;10163.644272450576;10187.388756674474;10194.745131371626;10204.081632652948;10206.795864082676;7901.802454938673;7996.24035716606;8008.679652813822;8074.071481779553;8074.183308755483;3120.953185702216;3157.3053928135773;3161.541576471399;3179.3959147761852;3187.10760986924;871.6077765005773;913.8492148795507;917.8623206519076;957.363353370015;1014.2697257974247;26326.868365658433;27183.592246116325;27616;27764.72235277662;27849.58225626617;806.8587997100484;988.7083310423442;992.6376872441651;1000.8048430556117;1052.6999805055675;15105.773413398807;15345.769813452807;15438.614034649;15648;15721.292541835644;363842;365097;366190;366219;367325;50310.496895030585;50748.492515075115;50795.74602126966;50850.237246441335;51009;1101.366714139373;1163.6916217202447;1193.2899924544708;1223.1071317937956;1231.2735486063266;27935.580966285117;29502.409951801274;29673.85163074171;29868.253293667833;30182.84908575443;41916;42081.36877946895;42603.7869810649;42622;42633.786831066885;286710;288563;290941;291990;292162;22945.88527057354;23516.412089697893;24977.375565610277;25558.74441255638;25559.23322300334;42231.7888410556;42242.9308482984;42303.15393692048;43107.353389698554;43172.13655726805;35549;36262.27475450529;37618.811905940296;37677;37756.24487510289;36065.27869442649;36291.45562816613;36334;36351.27297453983;36767;36028.4595731059;36766.080847977944;37523;37676.43485347667;40837.79581102194;30617.693823062375;33585.664143358255;34148.31703365968;34478.65521344754;34520.30959380849;25606.615900761877;25794.871025644752;25802.870985644953;26325.21024369272;26343.868280658473 12:25:52 INFO - PROCESS | 21994 | |2;jquery.html;347.69924015726394;351.29039340532125;361.8407900523771;371.9851205951762;376.33764574349135;15876.126813025294;16212.51362459125;16579.585510362216;17249.310027598898;18034.368797092087;15678.296983412505;15781.526554203392;15838.208089595502;15859.920700396511;16491.67016659666;4811.470738218802;5069.74651267437;5081.339425874631;5082.618803589746;5083.212102124176;3717.405215165574;3900.921981560367;4970.155073637472;5050.696958182502;5540.445955404448;5888.205092312547;5901.5278777697895;5907.5864689471755;5909.940900591004;5912.201852749867;5671.914921276184;5786.450287222707;5854.824355269348;5858.736356863951;5861.8827623447505;3337.5494308268317;4744.833930812405;5041.546260836542;5060.5951523878;5073.162928116856;19851.709638873428;20578.588428231502;20664.586708265902;20665.380038598865;20748.79251207499;2020.5958808238265;2157.2880949286855;2467.6915385576804;2477.6283557466522;2535.1253817432957;12731;12906;12940.57653658097;12976.480940762358;13319;1651.174412793603;1795.3267524678245;1812.4472036029006;1825.525363405511;1835.4310163849116;65282.3471765281;66394.33605663978;66730.66634666844;66949.66525167391;67721.66139169323;8763.780905477413;8818.51498167607;8895.866562001574;9060.728178154666;9183.219426348702;12150.5139794409;12333.753324933452;12367.62897113088;12387.876121238853;12395.93802031002;6952.833507583659;7116.857662846714;7172.928270717331;7328.853422931618;7486;6741.730330786713;6876.381125698711;6933.445324374038;6934.133233345832;7461.962690186514;5802.721462373745;5931.822045338647;5996.970015149984;6023.939760602426;6057.273127224761;1575.1415478563981;1628.275417439252;1665.258959762894;1733.298014304209;1783.2153852304943;842.1536355962342;898.5417437107122;919.5540163020929;938.4838338913706;999.7350702063959;16660.250288737036;16857.578560536083;17497;17545.473635790946;17946.461606151835;882.7307671160229;913.8766266554063;928.4614923344444;940.7130825098411;940.9858852117223;9968.202543796478;10234.232432567587;10243.334183278062;10260.846087308697;10288.948555257175;295424;300493;301283;380209;382156;84005;89007;89267;89526.55236723906;89692.99999999869;883.8188171424842;929.1544694328264;933.9953300233591;946.5740416812324;970.2529052629436;15883.126428046568;16082.758758618864;16086.67826643484;16185.838141618433;16265.837341626906;36581;37212;37364.6263537372;37604;38062.61937380591;47848.760756195996;53633.463665364405;54823.177652336046;55013.449865500836;55065.44934550764;7627.733029343946;7669.654865531176;7680.731174408869;7727.536347818924;7729.265719756614;10996.890031099587;11087.889121109009;11254.38100904458;12181.817272741093;12221;10011;10185.013922285083;10316.973262085652;10415.114715248985;10488.947555262175;9995.150412215044;10667.253292269466;10684.46577671129;10845.837312440162;11186;10924.071453926505;10984.725381865517;11027.117830573696;11186.10511159089;11513.194076414571;7637.847243055219;7680.193579674054;7869.291763741291;7877.212278772077;7904.288614024766;9199.816003680024;10376.792464150825;10452.634157804441;10634.361938283728;10730.624428144978 12:25:52 INFO - PROCESS | 21994 | |3;mootools.html;1297.1438850358766;1419.3045407750199;1458.4603696632244;1579.494561740243;1765.5497848048747;6793.660316984149;7441.553506789596;7631.046119235096;7649.885251721229;7659.770206893802;7268.854622907552;7476.738314159005;7501.174870764212;7667.654955527;7671.539707617547;2221.700070490483;2266.784655457729;2267.85258958168;2271.0802125139344;2275.0899640143994;2179.4442417183677;2221.8444708870384;2223.2552095048177;2224.5773303072447;2227.6324406472913;2214.2914267434426;2219.289827255279;2231.497912969577;2233.7319521657423;2236.586231547161;2164.8159906407973;2172.0334451169238;2202.053117159621;2202.273249827553;2203.867767933929;2078.896055197249;2102.2536999365157;2102.37979795959;2104.684297355409;2105.715728376665;7565.621718914087;7617.46677732559;7685.769426917202;7705.730299439493;7707.306342429209;4402.163588918095;4482.5069242383315;4490.416245888046;4509.7970591323465;4522.7060241084555;2780.1242608578436;2898.2899189698446;2927.6779554249015;2934.046434908642;2942.5439056946207;921.3277900610437;921.3553806455445;932.1936524905908;945.5508633399149;947.8672985781996;10757.139428845674;10965.671029869116;10978.176636752276;10998.12015038795;11002.394868282321;4243.915121697549;4348.543402942645;4419.558044195554;4421.336799480104;4433;9284.72145835626;9355.719328420158;9357.20463760588;9369.344145909858;9382.296327775444;4828.66199366041;4836.226203807374;4839.782209800497;4843.0313937212695;4845.030993801254;3635.0912271932016;3741.064733816546;4249.065205654751;4300.225959327351;4303.4190384298345;3718.2563487302646;3750.643688849555;3799.7530160540027;3802.980985095057;3839.040239940015;1194.8386967759416;1198.7722332756923;1203.9277643341427;1205.6744678936639;1221.9816702749465;914.3827916156567;917.9678711245074;928.2388441478058;930.4681138408336;937.6624415210518;5469.316335458067;5611.579131565149;5626.606137570413;5658.858528536737;5716.857078572986;837.9203975622306;882.9735107946772;888.7600347906158;906.7823722306731;921.8064206516573;3753.868614598476;3875.8837234882435;3909.550401703784;3911.9437751806854;3950.288947989332;9540.666076687283;9821;9858.80282394348;9871.358361706467;9886.060824221688;9489.715308540755;9894.55474503649;9912.950435247922;9913.107820296063;9915.702528924145;7334.193238743734;7437.702491900372;7497.475176737685;7511.699532018767;7547.660355283915;5155.690658560498;5207.609429292743;5239.554637855825;5263.105272103675;5263.526282634582;8762.649494020423;8957.328200384867;9189.310801689766;9199.632014719336;9234.95382523083;9056.683016094405;9248.907510925073;9254.028327025566;9332.626694932398;9341.532923353669;6177.598456100339;6290.716917738804;6488.545801793829;6489.513286503437;6627.834304142435;7508.662110204945;7787.4548781584745;7794.532328060334;7805.33654639362;7823.726169584037;6987.895181572382;7008.159020917523;7043.542169758949;7062.15254169503;7088.751893683696;6522.6412547308455;6586.275509693834;6586.308437614173;6680.83297917556;6730.8653826924165;6354.650494222862;6521.152250207443;6562.376574225441;6566.967165164144;6593.274739778716;4550.726956382628;4578.175928332932;4609.469910960149;4652.534746525321;4658.93011604833;4484.730916145042;4555.589996900295;4614.377059096979;4630.120277147331;4647.744374059459 12:25:52 INFO - PROCESS | 21994 | |4;prototype.html;285.45710435098295;286.2500249346712;289.7725285650764;296.9896053638123;297.5150504677377;4762.1665109259975;4794.952050479495;4813.855584332471;4816.783244753986;4827.927581086277;4714.774158718732;4751.049790041988;4755.595774359175;4759.8810029749275;4771.28430735389;3563.5367402237803;3596.604373518911;3617.5658920929395;3717.256548690259;3753.6539662710807;3693.686036686885;3725.590185079639;3726.4721464199547;3732.3841566141555;3735.4957080794015;3526.612072672004;3691.870784522542;3694.371956767356;3701.81490925454;3704.8703295384666;3611.747177697549;3685.63143685632;3690.5571331440133;3698.0939669780805;3709.2581483703366;3254.332861763333;3257.7719559630837;3260.7228385587255;3265.248992731685;3265.6407795142513;4527.977360113211;4600.907981840378;4601.28680054592;4618.49196588375;4619.838305659319;3964.117044403914;4197.811098500575;4207.768572728499;4233.111046680201;4256.2338779019765;4936.5063493650705;4938.160512712848;4959.132151873444;4970.751462426864;4977.850664480072;3406.608240052401;3490.5287786148797;3490.5462289902403;3502.6689857854108;3503.667151620592;5164.612654050961;5168.198929165986;5184.248283998799;5191.987562425328;5197.27238186658;3552.502649629054;3553.573571171476;3554.8578056877955;3588.9004932114485;3591.2278860044694;3648.2521083177885;3648.85404583819;3656.067702735785;3656.634336566322;3662.212624285791;3918.74528155669;4119.970007498126;4125.071858831739;4153.6677065834665;4172.457580514514;4910.459849416561;4917.582005529499;4945.752712364368;4964.950350496521;4979.925301120486;1214.9635510934686;1216.1365430544413;1221.5541327415428;1222.5598784437595;1228.4042239513828;774.8411575626983;785.4266385538589;806.3025482957199;833.4499230507836;833.6373677450329;4418.138462999748;4418.5802348776815;4432.667549933768;4444.8444304449185;4459.397981272552;5070.188769796815;5081.974590127025;5095.898082038412;5119.718415487109;5126.333576635088;4329.870103896888;4428.468583769968;4441.067375851043;4446.977765111218;4465.888352791206;2676.919692409192;2691.8788654510595;2700.51390749663;2700.9054683085997;2730.5494593392264;4852.199387101159;4874.5856602189215;4874.731889746027;4888.364512613409;4898.363212782316;5091.439941606421;5223.171889838526;5223.869403264949;5245.580353571705;5264.473552644781;4857.295692124622;4867.780949857336;4881.51184881509;4884.4871288514905;4884.682495637772;5110.744462776921;5133.358330208724;5133.897322053613;5138.665986710852;5157.200633901752;4753;4977.71025328353;4987.501249874984;5036;5039.2944987702485;4752.738599377068;4784.928226076542;4786.7845946931775;4802.830132112789;4813.614910807057;3470.878519251814;3472.9305413892084;3518.1028837646236;3526.4357702767434;3541.11472131967;4833.564979151753;5023.547880690755;5032.572231360376;5075.695458272516;5077.92383114261;4907.730074845917;4924.507549245047;4926.926096108489;4932.8520144395725;4939.382577177853;4909.4354149273295;4922.4339200992345;4928.482509336468;4964.156093464192;4990.581451705593;4594.5864872161665;4837.201861692922;4847.515248475124;4859.562639362474;4868.2940973557925;4751.954569994596;4866.537678920497;5003.449620541664;5023.372078490189;5027.723475208899;4880.999395124062;4881.829135980223;4882.36529251195;4885.169521181479;4930.975345123252 12:25:52 INFO - PROCESS | 21994 | |5;yui.html;697.1425147069104;702.9472789540786;710.8151880511067;722.6459035072816;728.1226122522361;10969.835452468209;11642.126840486966;12766.744665106704;13161.40773665185;13246.93376533116;13583.04918655692;13583.185008899449;13671.111377760464;13687.315634218274;13707.588772336821;625.2746813696114;774.3340726974825;783.373301358912;797.0156856282487;803.4135081390559;788.8106854354971;811.7199566149699;812.743985644523;813.276184196063;813.5891374855689;839.1314988986401;840.8024114333127;844.0588743550927;844.5692696724684;845.2646197807885;635.4312889963456;805.4040010392267;825.8554752918216;839.8908141941539;841.7727213652341;613.310026220502;613.7422282641302;614.0390289197392;614.2966303582373;614.6373639552685;12427.813582796265;12492.687682807911;12515.74968500634;12532.81200781989;12542.372881355896;11579.826302605468;12122.515099396102;12186;12204.389780510939;12372;11267.54929802815;11461.770764584662;11612.071034317234;11702.122340824388;12078.094142939315;4124.287024849442;4154.065335299563;4198.286291330481;4214.157168566299;4274.252005898987;58631;59147.112793308566;59164.704176479274;59174.704126479526;59351.10973335403;9230.907690923139;9304.581293841793;9431.90568094324;9708.223342132613;9717.514124293757;15880.60298492547;15883.444079457164;16016.199190040452;16078.115703636413;16108.436204732778;6800.931990680129;6848.897266541006;6913.10129683138;6953;7004.719811207597;3666.6699997000396;3689.9631003690156;3696.4085746281003;3701.722370822199;3713.6100709425123;2798.2864369585627;2851.344190836078;2857.7570906472765;2861.270376054093;2904.695007024274;531.9361676598755;562.131506821961;565.9547236221092;577.1890493856139;582.484501216418;599.9820005399845;602.5683731151053;614.3487902823022;643.3887806583764;656.592912394309;8540.530270835165;8551;8560.871586926201;8763.123687631185;9069.637214511478;506.07991886812886;598.7096258314714;610.8411812928671;625.9593126446766;632.1750116098443;4314.913701725948;4364.307446755462;4617.58441740245;4640.443146822403;4685.601723853442;61312.386876130666;92922;97230.51384743031;100218.49890750645;100336;55993.7200314004;63584.68207658932;68251.31748682549;74981.62509187419;77652.61173694095;48482;48935.26597101046;69419.3058069423;70026;70123;8498.53258070812;8730.912690873263;8778.604962776562;8779.25376343018;8823.69117080899;42213;43038;43722.781386092865;43838.56161438345;43988.12023759571;61069.69465152646;62692;62940;62994.370056300686;63179;10424.03791281034;10744.731381715206;10893.074088702231;10926.125909927347;11102.833457498306;12386.81419778722;12461.439235234255;12698.238105713686;12754.107212495408;13194.340282986004;12107.81838272409;12145.69635759113;12197.939010304892;12296.323702196107;12313.26120432777;11832.960536826942;11994.580189693319;12397.070219733376;12586.496540138292;12596.622101336974;11764.764704706029;12055.698607534881;12267.079969002181;12402.06984476186;12455.626331210078;9849.556769945226;9893.406395616286;10317.845232321672;10406.895931040895;10562.524686389284;9903.801923961337;10086.234908890769;10478;10489.580416783549;10620.309679870783 12:25:52 INFO - PROCESS | 21994 | __end_tp_report 12:25:52 INFO - PROCESS | 21994 | __start_cc_report 12:25:52 INFO - PROCESS | 21994 | _x_x_mozilla_cycle_collect,1068 12:25:52 INFO - PROCESS | 21994 | __end_cc_report 12:25:52 INFO - PROCESS | 21994 | __startTimestamp1465241152466__endTimestamp 12:25:52 INFO - PROCESS | 21994 | 12:25:52 INFO - PROCESS | 21994 | ------- Summary: start ------- 12:25:52 INFO - PROCESS | 21994 | Number of tests: 6 12:25:52 INFO - PROCESS | 21994 | 12:25:52 INFO - PROCESS | 21994 | [#0] dojo.html Cycles:165 Average:4728.25 Median:4852.05 stddev:495.76 (10.2%) stddev-sans-first:471.10 12:25:52 INFO - PROCESS | 21994 | Values: 2701.6 2734.6 2740.4 2766.3 2789.5 4654.5 4724.8 4731.2 4816.7 4877.2 4694.3 4729.6 4738.4 4747.2 4785.9 4319.6 4361.2 4416.2 4451.1 4569.4 4495.4 4520.7 4520.8 4556.0 4582.5 4245.1 4292.0 4301.6 4328.7 4398.4 4338.3 4351.7 4355.1 4361.3 4402.3 4398.9 4412.9 4442.6 4452.6 4454.6 4585.5 4627.9 4732.5 4775.6 4786.7 5101.1 5170.2 5171.3 5177.2 5178.7 5146.1 5146.5 5182.5 5188.8 5209.4 4658.0 4831.2 4834.9 4837.7 4851.5 5348.4 5353.8 5389.3 5404.6 5405.4 5126.2 5176.2 5179.5 5180.2 5182.4 4909.4 4958.3 4972.3 5245.5 5265.0 4944.4 4948.2 4964.4 4985.8 5018.5 4980.7 4996.6 5000.2 5004.3 5017.5 4180.7 4210.8 4212.7 4245.9 4256.3 3746.7 3754.7 3754.9 3771.6 3824.6 4405.4 4415.5 4420.6 4459.0 4466.4 4870.1 4910.5 5109.3 5131.8 5141.6 4408.5 4421.0 4425.8 4470.1 4494.3 4564.9 4568.4 4571.8 4573.4 4613.0 4540.6 4765.2 4806.6 4852.1 4859.6 5093.9 5118.8 5120.8 5126.1 5144.3 4825.8 4827.7 4828.6 4836.2 4880.7 4868.0 5031.5 5038.5 5060.4 5115.6 5165.6 5177.8 5188.5 5191.6 5193.4 5045.2 5048.6 5051.8 5053.0 5088.7 4847.6 4922.0 4942.9 4972.7 4998.8 4872.1 4921.0 4922.8 4969.0 4973.7 4862.9 5025.6 5031.8 5070.8 5082.4 4869.9 4930.8 4940.8 4941.9 5006.2 12:25:52 INFO - PROCESS | 21994 | 12:25:52 INFO - PROCESS | 21994 | [#1] ext.html Cycles:180 Average:44588.33 Median:36342.64 stddev:79433.18 (218.6%) stddev-sans-first:79587.17 12:25:52 INFO - PROCESS | 21994 | Values: 544.3 586.2 588.6 602.8 616.8 39680.2 41237.6 41279.4 41298.2 44983.0 41204.4 41675.6 41711.2 41721.0 41817.8 7789.7 7975.7 7976.1 7977.2 7981.2 7799.9 7877.8 7889.2 7894.3 7899.3 7865.6 7932.4 7934.0 7935.6 7938.4 7855.0 7888.3 7891.4 7911.1 7918.6 7845.5 7874.1 7913.0 7921.4 7924.5 38244.6 38565.6 38638.2 38668.8 38702.2 3219.2 3241.7 3266.9 3315.6 3793.6 29333.9 29672.9 29939.6 30203.0 30892.0 3526.3 3538.1 3551.8 3562.5 3595.7 233855.0 234179.0 235430.0 236442.8 237962.0 32318.2 33143.3 33235.2 54630.0 55154.4 33041.8 33044.3 33158.0 33207.3 33223.5 12519.6 12580.7 12583.9 12595.1 12602.7 10163.6 10187.4 10194.7 10204.1 10206.8 7901.8 7996.2 8008.7 8074.1 8074.2 3121.0 3157.3 3161.5 3179.4 3187.1 871.6 913.8 917.9 957.4 1014.3 26326.9 27183.6 27616.0 27764.7 27849.6 806.9 988.7 992.6 1000.8 1052.7 15105.8 15345.8 15438.6 15648.0 15721.3 363842.0 365097.0 366190.0 366219.0 367325.0 50310.5 50748.5 50795.7 50850.2 51009.0 1101.4 1163.7 1193.3 1223.1 1231.3 27935.6 29502.4 29673.9 29868.3 30182.8 41916.0 42081.4 42603.8 42622.0 42633.8 286710.0 288563.0 290941.0 291990.0 292162.0 22945.9 23516.4 24977.4 25558.7 25559.2 42231.8 42242.9 42303.2 43107.4 43172.1 35549.0 36262.3 37618.8 37677.0 37756.2 36065.3 36291.5 36334.0 36351.3 36767.0 36028.5 36766.1 37523.0 37676.4 40837.8 30617.7 33585.7 34148.3 34478.7 34520.3 25606.6 25794.9 25802.9 26325.2 26343.9 12:25:52 INFO - PROCESS | 21994 | 12:25:52 INFO - PROCESS | 21994 | [#2] jquery.html Cycles:180 Average:23140.27 Median:208906.50 stddev:55934.44 (26.8%) stddev-sans-first:56065.17 12:25:52 INFO - PROCESS | 21994 | Values: 347.7 351.3 361.8 372.0 376.3 15876.1 16212.5 16579.6 17249.3 18034.4 15678.3 15781.5 15838.2 15859.9 16491.7 4811.5 5069.7 5081.3 5082.6 5083.2 3717.4 3900.9 4970.2 5050.7 5540.4 5888.2 5901.5 5907.6 5909.9 5912.2 5671.9 5786.5 5854.8 5858.7 5861.9 3337.5 4744.8 5041.5 5060.6 5073.2 19851.7 20578.6 20664.6 20665.4 20748.8 2020.6 2157.3 2467.7 2477.6 2535.1 12731.0 12906.0 12940.6 12976.5 13319.0 1651.2 1795.3 1812.4 1825.5 1835.4 65282.3 66394.3 66730.7 66949.7 67721.7 8763.8 8818.5 8895.9 9060.7 9183.2 12150.5 12333.8 12367.6 12387.9 12395.9 6952.8 7116.9 7172.9 7328.9 7486.0 6741.7 6876.4 6933.4 6934.1 7462.0 5802.7 5931.8 5997.0 6023.9 6057.3 1575.1 1628.3 1665.3 1733.3 1783.2 842.2 898.5 919.6 938.5 999.7 16660.3 16857.6 17497.0 17545.5 17946.5 882.7 913.9 928.5 940.7 941.0 9968.2 10234.2 10243.3 10260.8 10288.9 295424.0 300493.0 301283.0 380209.0 382156.0 84005.0 89007.0 89267.0 89526.6 89693.0 883.8 929.2 934.0 946.6 970.3 15883.1 16082.8 16086.7 16185.8 16265.8 36581.0 37212.0 37364.6 37604.0 38062.6 47848.8 53633.5 54823.2 55013.4 55065.4 7627.7 7669.7 7680.7 7727.5 7729.3 10996.9 11087.9 11254.4 12181.8 12221.0 10011.0 10185.0 10317.0 10415.1 10488.9 9995.2 10667.3 10684.5 10845.8 11186.0 10924.1 10984.7 11027.1 11186.1 11513.2 7637.8 7680.2 7869.3 7877.2 7904.3 9199.8 10376.8 10452.6 10634.4 10730.6 12:25:52 INFO - PROCESS | 21994 | 12:25:52 INFO - PROCESS | 21994 | [#3] mootools.html Cycles:180 Average:5206.19 Median:5540.45 stddev:2911.46 (52.5%) stddev-sans-first:2904.80 12:25:52 INFO - PROCESS | 21994 | Values: 1297.1 1419.3 1458.5 1579.5 1765.5 6793.7 7441.6 7631.0 7649.9 7659.8 7268.9 7476.7 7501.2 7667.7 7671.5 2221.7 2266.8 2267.9 2271.1 2275.1 2179.4 2221.8 2223.3 2224.6 2227.6 2214.3 2219.3 2231.5 2233.7 2236.6 2164.8 2172.0 2202.1 2202.3 2203.9 2078.9 2102.3 2102.4 2104.7 2105.7 7565.6 7617.5 7685.8 7705.7 7707.3 4402.2 4482.5 4490.4 4509.8 4522.7 2780.1 2898.3 2927.7 2934.0 2942.5 921.3 921.4 932.2 945.6 947.9 10757.1 10965.7 10978.2 10998.1 11002.4 4243.9 4348.5 4419.6 4421.3 4433.0 9284.7 9355.7 9357.2 9369.3 9382.3 4828.7 4836.2 4839.8 4843.0 4845.0 3635.1 3741.1 4249.1 4300.2 4303.4 3718.3 3750.6 3799.8 3803.0 3839.0 1194.8 1198.8 1203.9 1205.7 1222.0 914.4 918.0 928.2 930.5 937.7 5469.3 5611.6 5626.6 5658.9 5716.9 837.9 883.0 888.8 906.8 921.8 3753.9 3875.9 3909.6 3911.9 3950.3 9540.7 9821.0 9858.8 9871.4 9886.1 9489.7 9894.6 9913.0 9913.1 9915.7 7334.2 7437.7 7497.5 7511.7 7547.7 5155.7 5207.6 5239.6 5263.1 5263.5 8762.6 8957.3 9189.3 9199.6 9235.0 9056.7 9248.9 9254.0 9332.6 9341.5 6177.6 6290.7 6488.5 6489.5 6627.8 7508.7 7787.5 7794.5 7805.3 7823.7 6987.9 7008.2 7043.5 7062.2 7088.8 6522.6 6586.3 6586.3 6680.8 6730.9 6354.7 6521.2 6562.4 6567.0 6593.3 4550.7 4578.2 4609.5 4652.5 4658.9 4484.7 4555.6 4614.4 4630.1 4647.7 12:25:52 INFO - PROCESS | 21994 | 12:25:52 INFO - PROCESS | 21994 | [#4] prototype.html Cycles:180 Average:4111.31 Median:4754.30 stddev:1206.04 (25.4%) stddev-sans-first:1174.74 12:25:52 INFO - PROCESS | 21994 | Values: 285.5 286.3 289.8 297.0 297.5 4762.2 4795.0 4813.9 4816.8 4827.9 4714.8 4751.0 4755.6 4759.9 4771.3 3563.5 3596.6 3617.6 3717.3 3753.7 3693.7 3725.6 3726.5 3732.4 3735.5 3526.6 3691.9 3694.4 3701.8 3704.9 3611.7 3685.6 3690.6 3698.1 3709.3 3254.3 3257.8 3260.7 3265.2 3265.6 4528.0 4600.9 4601.3 4618.5 4619.8 3964.1 4197.8 4207.8 4233.1 4256.2 4936.5 4938.2 4959.1 4970.8 4977.9 3406.6 3490.5 3490.5 3502.7 3503.7 5164.6 5168.2 5184.2 5192.0 5197.3 3552.5 3553.6 3554.9 3588.9 3591.2 3648.3 3648.9 3656.1 3656.6 3662.2 3918.7 4120.0 4125.1 4153.7 4172.5 4910.5 4917.6 4945.8 4965.0 4979.9 1215.0 1216.1 1221.6 1222.6 1228.4 774.8 785.4 806.3 833.4 833.6 4418.1 4418.6 4432.7 4444.8 4459.4 5070.2 5082.0 5095.9 5119.7 5126.3 4329.9 4428.5 4441.1 4447.0 4465.9 2676.9 2691.9 2700.5 2700.9 2730.5 4852.2 4874.6 4874.7 4888.4 4898.4 5091.4 5223.2 5223.9 5245.6 5264.5 4857.3 4867.8 4881.5 4884.5 4884.7 5110.7 5133.4 5133.9 5138.7 5157.2 4753.0 4977.7 4987.5 5036.0 5039.3 4752.7 4784.9 4786.8 4802.8 4813.6 3470.9 3472.9 3518.1 3526.4 3541.1 4833.6 5023.5 5032.6 5075.7 5077.9 4907.7 4924.5 4926.9 4932.9 4939.4 4909.4 4922.4 4928.5 4964.2 4990.6 4594.6 4837.2 4847.5 4859.6 4868.3 4752.0 4866.5 5003.4 5023.4 5027.7 4881.0 4881.8 4882.4 4885.2 4931.0 12:25:52 INFO - PROCESS | 21994 | 12:25:52 INFO - PROCESS | 21994 | [#5] yui.html Cycles:180 Average:16645.40 Median:24720.67 stddev:22797.26 (92.2%) stddev-sans-first:22829.76 12:25:52 INFO - PROCESS | 21994 | Values: 697.1 702.9 710.8 722.6 728.1 10969.8 11642.1 12766.7 13161.4 13246.9 13583.0 13583.2 13671.1 13687.3 13707.6 625.3 774.3 783.4 797.0 803.4 788.8 811.7 812.7 813.3 813.6 839.1 840.8 844.1 844.6 845.3 635.4 805.4 825.9 839.9 841.8 613.3 613.7 614.0 614.3 614.6 12427.8 12492.7 12515.7 12532.8 12542.4 11579.8 12122.5 12186.0 12204.4 12372.0 11267.5 11461.8 11612.1 11702.1 12078.1 4124.3 4154.1 4198.3 4214.2 4274.3 58631.0 59147.1 59164.7 59174.7 59351.1 9230.9 9304.6 9431.9 9708.2 9717.5 15880.6 15883.4 16016.2 16078.1 16108.4 6800.9 6848.9 6913.1 6953.0 7004.7 3666.7 3690.0 3696.4 3701.7 3713.6 2798.3 2851.3 2857.8 2861.3 2904.7 531.9 562.1 566.0 577.2 582.5 600.0 602.6 614.3 643.4 656.6 8540.5 8551.0 8560.9 8763.1 9069.6 506.1 598.7 610.8 626.0 632.2 4314.9 4364.3 4617.6 4640.4 4685.6 61312.4 92922.0 97230.5 100218.5 100336.0 55993.7 63584.7 68251.3 74981.6 77652.6 48482.0 48935.3 69419.3 70026.0 70123.0 8498.5 8730.9 8778.6 8779.3 8823.7 42213.0 43038.0 43722.8 43838.6 43988.1 61069.7 62692.0 62940.0 62994.4 63179.0 10424.0 10744.7 10893.1 10926.1 11102.8 12386.8 12461.4 12698.2 12754.1 13194.3 12107.8 12145.7 12197.9 12296.3 12313.3 11833.0 11994.6 12397.1 12586.5 12596.6 11764.8 12055.7 12267.1 12402.1 12455.6 9849.6 9893.4 10317.8 10406.9 10562.5 9903.8 10086.2 10478.0 10489.6 10620.3 12:25:52 INFO - PROCESS | 21994 | -------- Summary: end -------- 12:25:52 INFO - PROCESS | 21994 | 12:25:53 INFO - TEST-INFO | 21994: exit 0 12:25:53 INFO - TEST-OK | dromaeo_css | took 1118649ms 12:25:53 INFO - TEST-START | kraken 12:25:53 INFO - operating with platform_type : linux_ 12:25:53 INFO - Initialising browser for kraken test... 12:25:53 INFO - TEST-INFO | started process 22173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJoRdOv/profile http://localhost:39005/getInfo.html) 12:25:57 INFO - PROCESS | 22173 | __metrics Screen width/height:1600/1200 12:25:57 INFO - PROCESS | 22173 | colorDepth:24 12:25:57 INFO - PROCESS | 22173 | Browser inner width/height: 1024/697 12:25:57 INFO - PROCESS | 22173 | __metrics 12:25:58 ERROR - PROCESS | 22173 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:25:58 INFO - PROCESS | 22173 | console.error: PushService: 12:25:58 INFO - PROCESS | 22173 | stateChangeProcessEnqueue: Error transitioning state 12:25:58 INFO - PROCESS | 22173 | UnknownError 12:25:59 INFO - TEST-INFO | 22173: exit 0 12:25:59 INFO - Browser initialized. 12:25:59 INFO - Running cycle 1/1 for kraken test... 12:25:59 INFO - TEST-INFO | started process 22252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJoRdOv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:26:11 INFO - PROCESS | 22252 | RSS: Main: 157646848 12:26:11 INFO - PROCESS | 22252 | 12:26:14 INFO - PROCESS | 22252 | Cycle 1(1): loaded http://localhost:39005/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39005/tests/kraken/driver.html?testName=audio-beat-detection) 12:26:14 INFO - PROCESS | 22252 | RSS: Main: 215531520 12:26:14 INFO - PROCESS | 22252 | 12:26:17 INFO - PROCESS | 22252 | Cycle 1(1): loaded http://localhost:39005/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39005/tests/kraken/driver.html?testName=audio-dft) 12:26:18 INFO - PROCESS | 22252 | RSS: Main: 201728000 12:26:18 INFO - PROCESS | 22252 | 12:26:21 INFO - PROCESS | 22252 | Cycle 1(1): loaded http://localhost:39005/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39005/tests/kraken/driver.html?testName=audio-fft) 12:26:22 INFO - PROCESS | 22252 | RSS: Main: 270585856 12:26:22 INFO - PROCESS | 22252 | 12:26:24 INFO - PROCESS | 22252 | Cycle 1(1): loaded http://localhost:39005/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39005/tests/kraken/driver.html?testName=audio-oscillator) 12:26:25 INFO - PROCESS | 22252 | RSS: Main: 180436992 12:26:25 INFO - PROCESS | 22252 | 12:26:27 INFO - PROCESS | 22252 | Cycle 1(1): loaded http://localhost:39005/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39005/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:26:27 INFO - PROCESS | 22252 | RSS: Main: 184606720 12:26:27 INFO - PROCESS | 22252 | 12:26:31 INFO - PROCESS | 22252 | Cycle 1(1): loaded http://localhost:39005/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39005/tests/kraken/driver.html?testName=imaging-darkroom) 12:26:31 INFO - PROCESS | 22252 | RSS: Main: 220495872 12:26:31 INFO - PROCESS | 22252 | 12:26:35 INFO - PROCESS | 22252 | Cycle 1(1): loaded http://localhost:39005/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39005/tests/kraken/driver.html?testName=imaging-desaturate) 12:26:35 INFO - PROCESS | 22252 | RSS: Main: 221052928 12:26:35 INFO - PROCESS | 22252 | 12:26:38 INFO - PROCESS | 22252 | Cycle 1(1): loaded http://localhost:39005/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39005/tests/kraken/driver.html?testName=json-parse-financial) 12:26:39 INFO - PROCESS | 22252 | RSS: Main: 221892608 12:26:39 INFO - PROCESS | 22252 | 12:26:40 INFO - PROCESS | 22252 | Cycle 1(1): loaded http://localhost:39005/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39005/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:26:41 INFO - PROCESS | 22252 | RSS: Main: 204308480 12:26:41 INFO - PROCESS | 22252 | 12:26:43 INFO - PROCESS | 22252 | Cycle 1(1): loaded http://localhost:39005/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39005/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:26:44 INFO - PROCESS | 22252 | RSS: Main: 209817600 12:26:44 INFO - PROCESS | 22252 | 12:26:46 INFO - PROCESS | 22252 | Cycle 1(1): loaded http://localhost:39005/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39005/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:26:47 INFO - PROCESS | 22252 | RSS: Main: 216846336 12:26:47 INFO - PROCESS | 22252 | 12:26:49 INFO - PROCESS | 22252 | Cycle 1(1): loaded http://localhost:39005/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:26:50 INFO - PROCESS | 22252 | RSS: Main: 223875072 12:26:50 INFO - PROCESS | 22252 | 12:26:53 INFO - PROCESS | 22252 | Cycle 1(1): loaded http://localhost:39005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:26:53 INFO - PROCESS | 22252 | RSS: Main: 221032448 12:26:53 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | Cycle 1(1): loaded http://localhost:39005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39005/tests/kraken/driver.html?testName=ai-astar) 12:26:55 INFO - PROCESS | 22252 | RSS: Main: 263262208 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | __start_tp_report 12:26:55 INFO - PROCESS | 22252 | _x_x_mozilla_page_load 12:26:55 INFO - PROCESS | 22252 | _x_x_mozilla_page_load_details 12:26:55 INFO - PROCESS | 22252 | |i|pagename|runs| 12:26:55 INFO - PROCESS | 22252 | |0;ai-astar;113;109;115;113;113;114;113;112;113;113 12:26:55 INFO - PROCESS | 22252 | |1;audio-beat-detection;162;129;133;188;137;132;152;131;191;139 12:26:55 INFO - PROCESS | 22252 | |2;audio-dft;162;162;162;161;164;161;162;161;162;162 12:26:55 INFO - PROCESS | 22252 | |3;audio-fft;75;76;78;108;75;76;76;76;105;75 12:26:55 INFO - PROCESS | 22252 | |4;audio-oscillator;85;87;116;86;84;85;119;85;87;135 12:26:55 INFO - PROCESS | 22252 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 12:26:55 INFO - PROCESS | 22252 | |6;imaging-darkroom;147;148;146;146;146;148;147;147;146;147 12:26:55 INFO - PROCESS | 22252 | |7;imaging-desaturate;94;94;95;95;95;95;94;95;95;95 12:26:55 INFO - PROCESS | 22252 | |8;json-parse-financial;64;65;65;64;65;65;66;65;65;66 12:26:55 INFO - PROCESS | 22252 | |9;json-stringify-tinderbox;65;66;66;66;66;65;67;65;65;65 12:26:55 INFO - PROCESS | 22252 | |10;stanford-crypto-aes;84;83;82;88;86;85;85;84;120;91 12:26:55 INFO - PROCESS | 22252 | |11;stanford-crypto-ccm;138;145;136;131;142;148;132;134;133;132 12:26:55 INFO - PROCESS | 22252 | |12;stanford-crypto-pbkdf2;172;174;174;175;171;171;171;173;168;177 12:26:55 INFO - PROCESS | 22252 | |13;stanford-crypto-sha256-iterative;71;67;71;66;68;67;67;67;68;66 12:26:55 INFO - PROCESS | 22252 | __end_tp_report 12:26:55 INFO - PROCESS | 22252 | __start_cc_report 12:26:55 INFO - PROCESS | 22252 | _x_x_mozilla_cycle_collect,1843 12:26:55 INFO - PROCESS | 22252 | __end_cc_report 12:26:55 INFO - PROCESS | 22252 | __startTimestamp1465241215933__endTimestamp 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | ------- Summary: start ------- 12:26:55 INFO - PROCESS | 22252 | Number of tests: 14 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.55 (1.4%) stddev-sans-first:1.64 12:26:55 INFO - PROCESS | 22252 | Values: 113.0 109.0 115.0 113.0 113.0 114.0 113.0 112.0 113.0 113.0 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:145.50 stddev:23.51 (16.2%) stddev-sans-first:24.49 12:26:55 INFO - PROCESS | 22252 | Values: 162.0 129.0 133.0 188.0 137.0 132.0 152.0 131.0 191.0 139.0 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 12:26:55 INFO - PROCESS | 22252 | Values: 162.0 162.0 162.0 161.0 164.0 161.0 162.0 161.0 162.0 162.0 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:12.96 (17.1%) stddev-sans-first:13.50 12:26:55 INFO - PROCESS | 22252 | Values: 75.0 76.0 78.0 108.0 75.0 76.0 76.0 76.0 105.0 75.0 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:85.00 stddev:18.89 (22.2%) stddev-sans-first:19.54 12:26:55 INFO - PROCESS | 22252 | Values: 85.0 87.0 116.0 86.0 84.0 85.0 119.0 85.0 87.0 135.0 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:26:55 INFO - PROCESS | 22252 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 12:26:55 INFO - PROCESS | 22252 | Values: 147.0 148.0 146.0 146.0 146.0 148.0 147.0 147.0 146.0 147.0 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 12:26:55 INFO - PROCESS | 22252 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 12:26:55 INFO - PROCESS | 22252 | Values: 64.0 65.0 65.0 64.0 65.0 65.0 66.0 65.0 65.0 66.0 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 12:26:55 INFO - PROCESS | 22252 | Values: 65.0 66.0 66.0 66.0 66.0 65.0 67.0 65.0 65.0 65.0 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:85.00 stddev:11.26 (13.3%) stddev-sans-first:11.81 12:26:55 INFO - PROCESS | 22252 | Values: 84.0 83.0 82.0 88.0 86.0 85.0 85.0 84.0 120.0 91.0 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:137.00 stddev:5.99 (4.4%) stddev-sans-first:6.34 12:26:55 INFO - PROCESS | 22252 | Values: 138.0 145.0 136.0 131.0 142.0 148.0 132.0 134.0 133.0 132.0 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:173.50 stddev:2.55 (1.5%) stddev-sans-first:2.69 12:26:55 INFO - PROCESS | 22252 | Values: 172.0 174.0 174.0 175.0 171.0 171.0 171.0 173.0 168.0 177.0 12:26:55 INFO - PROCESS | 22252 | 12:26:55 INFO - PROCESS | 22252 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:1.81 (2.7%) stddev-sans-first:1.51 12:26:55 INFO - PROCESS | 22252 | Values: 71.0 67.0 71.0 66.0 68.0 67.0 67.0 67.0 68.0 66.0 12:26:55 INFO - PROCESS | 22252 | -------- Summary: end -------- 12:26:55 INFO - PROCESS | 22252 | 12:26:56 INFO - TEST-INFO | 22252: exit 0 12:26:56 INFO - TEST-OK | kraken | took 63692ms 12:26:56 INFO - SUITE-END | took 1182s 12:26:57 INFO - Completed test suite (00:19:42) 12:26:57 INFO - javascript benchmark 12:26:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2701.6487856578647, 2734.6308248386463, 2740.438210166916, 2766.2807670005805, 2789.525780617295, 4654.488006319302, 4724.787384567694, 4731.172044892139, 4816.7109973401575, 4877.219644856824, 4694.29585562165, 4729.621630269578, 4738.360321356616, 4747.1692453820615, 4785.90428191436, 4319.589638984299, 4361.171377438277, 4416.183006143858, 4451.087527056946, 4569.360289559464, 4495.415595972519, 4520.660950428731, 4520.751358675271, 4556.04323092151, 4582.518835522272, 4245.066085461193, 4292.0, 4301.5698430157045, 4328.718633288858, 4398.384226208349, 4338.349247612883, 4351.717138385995, 4355.128974205171, 4361.302191649321, 4402.295632698753, 4398.8900277493, 4412.8676139715535, 4442.64458843295, 4452.599266066037, 4454.621357184643, 4585.472670642852, 4627.9074418511445, 4732.503087175865, 4775.617950563947, 4786.664933454659, 5101.081805275049, 5170.1986192140275, 5171.327727395452, 5177.197534382177, 5178.689278643294, 5146.073706732786, 5146.536811686966, 5182.455842136559, 5188.818391356284, 5209.374875014984, 4658.045100754337, 4831.202851529493, 4834.903301933941, 4837.709737415731, 4851.514848515191, 5348.438413966555, 5353.7590808413715, 5389.299391079213, 5404.594655400861, 5405.351357837006, 5126.231065340229, 5176.249443830623, 5179.48205179479, 5180.171172612364, 5182.4299327073995, 4909.361782968192, 4958.330625365602, 4972.328735620717, 5245.527902488794, 5264.9736751315995, 4944.431390390079, 4948.183549714328, 4964.354633897642, 4985.750712464363, 5018.4730603286125, 4980.726060066659, 4996.575291100225, 5000.224965130411, 5004.324416203839, 5017.473165317662, 4180.665546756252, 4210.789460526961, 4212.705110642287, 4245.915081698348, 4256.34026725858, 3746.7002639788752, 3754.737168398186, 3754.9436758448646, 3771.5662698789442, 3824.5984171661576, 4405.3612226227015, 4415.51429342772, 4420.58004489573, 4458.9554104459185, 4466.419365482467, 4870.0746858096845, 4910.459849416561, 5109.310243117206, 5131.820386286462, 5141.562967147759, 4408.470983481939, 4421.0, 4425.845095421645, 4470.1059788041875, 4494.303382975579, 4564.863054108382, 4568.406107206042, 4571.794269257892, 4573.428321459817, 4612.95387046132, 4540.591346778806, 4765.166095933268, 4806.567408933212, 4852.053849499384, 4859.562639362474, 5093.92359114621, 5118.846434606968, 5120.769565369493, 5126.051680439131, 5144.279800827962, 4825.758712064453, 4827.734474603931, 4828.565429111397, 4836.226203807374, 4880.707157570557, 4867.975660121677, 5031.496850314939, 5038.470960549236, 5060.418051923929, 5115.590752739698, 5165.61257905651, 5177.7670004849115, 5188.481151884781, 5191.584673226208, 5193.402758682649, 5045.192769156917, 5048.621353398583, 5051.797928082836, 5052.989402119517, 5088.669236499616, 4847.587955023862, 4921.975390123026, 4942.8764280893265, 4972.657382506775, 4998.775055122601, 4872.074305881871, 4920.975395123001, 4922.778474968707, 4969.0, 4973.676711013773, 4862.927056094232, 5025.572826309804, 5031.823886163967, 5070.771815268248, 5082.440931497458, 4869.87825304356, 4930.753462326941, 4940.75296235194, 4941.851744447672, 5006.249062640633], "value": 4697.420207634563, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.2815483561698, 586.1998372221918, 588.5938702295418, 602.8372339468343, 616.805706202546, 39680.206395872105, 41237.58762412375, 41279.38080928788, 41298.17403651925, 44983.0, 41204.38193427101, 41675.58324416755, 41711.165776684524, 41721.0, 41817.790911045406, 7789.727359542403, 7975.680972761083, 7976.122626511079, 7977.242161994601, 7981.201879812031, 7799.883001754978, 7877.842443151134, 7889.211078892094, 7894.3289820365335, 7899.328557072656, 7865.606719664022, 7932.405069619773, 7934.0, 7935.603219839014, 7938.40461965352, 7855.0, 7888.25061619151, 7891.368690504774, 7911.090224624127, 7918.643661035209, 7845.490043147177, 7874.133845277015, 7913.0, 7921.445498815086, 7924.454731327393, 38244.617553824384, 38565.61434385648, 38638.227235455415, 38668.80665596654, 38702.225955481015, 3219.2434777827193, 3241.659625739287, 3266.8856590019236, 3315.624209414105, 3793.6206379361843, 29333.853330733422, 29672.851635741685, 29939.550906736415, 30203.0, 30892.0, 3526.312369088029, 3538.062413460435, 3551.8401671924826, 3562.4834399011997, 3595.7303202259673, 233855.0, 234179.0, 235430.0, 236442.8177859117, 237962.0, 32318.192045198586, 33143.3371332572, 33235.169120772174, 54630.0, 55154.44845551573, 33041.834790825895, 33044.339113217604, 33158.0, 33207.3358532828, 33223.50164747531, 12519.624411267676, 12580.685482862818, 12583.874161258453, 12595.118341715992, 12602.684932876567, 10163.644272450576, 10187.388756674474, 10194.745131371626, 10204.081632652948, 10206.795864082676, 7901.802454938673, 7996.24035716606, 8008.679652813822, 8074.071481779553, 8074.183308755483, 3120.953185702216, 3157.3053928135773, 3161.541576471399, 3179.3959147761852, 3187.10760986924, 871.6077765005773, 913.8492148795507, 917.8623206519076, 957.363353370015, 1014.2697257974247, 26326.868365658433, 27183.592246116325, 27616.0, 27764.72235277662, 27849.58225626617, 806.8587997100484, 988.7083310423442, 992.6376872441651, 1000.8048430556117, 1052.6999805055675, 15105.773413398807, 15345.769813452807, 15438.614034649, 15648.0, 15721.292541835644, 363842.0, 365097.0, 366190.0, 366219.0, 367325.0, 50310.496895030585, 50748.492515075115, 50795.74602126966, 50850.237246441335, 51009.0, 1101.366714139373, 1163.6916217202447, 1193.2899924544708, 1223.1071317937956, 1231.2735486063266, 27935.580966285117, 29502.409951801274, 29673.85163074171, 29868.253293667833, 30182.84908575443, 41916.0, 42081.36877946895, 42603.7869810649, 42622.0, 42633.786831066885, 286710.0, 288563.0, 290941.0, 291990.0, 292162.0, 22945.88527057354, 23516.412089697893, 24977.375565610277, 25558.74441255638, 25559.23322300334, 42231.7888410556, 42242.9308482984, 42303.15393692048, 43107.353389698554, 43172.13655726805, 35549.0, 36262.27475450529, 37618.811905940296, 37677.0, 37756.24487510289, 36065.27869442649, 36291.45562816613, 36334.0, 36351.27297453983, 36767.0, 36028.4595731059, 36766.080847977944, 37523.0, 37676.43485347667, 40837.79581102194, 30617.693823062375, 33585.664143358255, 34148.31703365968, 34478.65521344754, 34520.30959380849, 25606.615900761877, 25794.871025644752, 25802.870985644953, 26325.21024369272, 26343.868280658473], "value": 16481.32585579276, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.69924015726394, 351.29039340532125, 361.8407900523771, 371.9851205951762, 376.33764574349135, 15876.126813025294, 16212.51362459125, 16579.585510362216, 17249.310027598898, 18034.368797092087, 15678.296983412505, 15781.526554203392, 15838.208089595502, 15859.920700396511, 16491.67016659666, 4811.470738218802, 5069.74651267437, 5081.339425874631, 5082.618803589746, 5083.212102124176, 3717.405215165574, 3900.921981560367, 4970.155073637472, 5050.696958182502, 5540.445955404448, 5888.205092312547, 5901.5278777697895, 5907.5864689471755, 5909.940900591004, 5912.201852749867, 5671.914921276184, 5786.450287222707, 5854.824355269348, 5858.736356863951, 5861.8827623447505, 3337.5494308268317, 4744.833930812405, 5041.546260836542, 5060.5951523878, 5073.162928116856, 19851.709638873428, 20578.588428231502, 20664.586708265902, 20665.380038598865, 20748.79251207499, 2020.5958808238265, 2157.2880949286855, 2467.6915385576804, 2477.6283557466522, 2535.1253817432957, 12731.0, 12906.0, 12940.57653658097, 12976.480940762358, 13319.0, 1651.174412793603, 1795.3267524678245, 1812.4472036029006, 1825.525363405511, 1835.4310163849116, 65282.3471765281, 66394.33605663978, 66730.66634666844, 66949.66525167391, 67721.66139169323, 8763.780905477413, 8818.51498167607, 8895.866562001574, 9060.728178154666, 9183.219426348702, 12150.5139794409, 12333.753324933452, 12367.62897113088, 12387.876121238853, 12395.93802031002, 6952.833507583659, 7116.857662846714, 7172.928270717331, 7328.853422931618, 7486.0, 6741.730330786713, 6876.381125698711, 6933.445324374038, 6934.133233345832, 7461.962690186514, 5802.721462373745, 5931.822045338647, 5996.970015149984, 6023.939760602426, 6057.273127224761, 1575.1415478563981, 1628.275417439252, 1665.258959762894, 1733.298014304209, 1783.2153852304943, 842.1536355962342, 898.5417437107122, 919.5540163020929, 938.4838338913706, 999.7350702063959, 16660.250288737036, 16857.578560536083, 17497.0, 17545.473635790946, 17946.461606151835, 882.7307671160229, 913.8766266554063, 928.4614923344444, 940.7130825098411, 940.9858852117223, 9968.202543796478, 10234.232432567587, 10243.334183278062, 10260.846087308697, 10288.948555257175, 295424.0, 300493.0, 301283.0, 380209.0, 382156.0, 84005.0, 89007.0, 89267.0, 89526.55236723906, 89692.99999999869, 883.8188171424842, 929.1544694328264, 933.9953300233591, 946.5740416812324, 970.2529052629436, 15883.126428046568, 16082.758758618864, 16086.67826643484, 16185.838141618433, 16265.837341626906, 36581.0, 37212.0, 37364.6263537372, 37604.0, 38062.61937380591, 47848.760756195996, 53633.463665364405, 54823.177652336046, 55013.449865500836, 55065.44934550764, 7627.733029343946, 7669.654865531176, 7680.731174408869, 7727.536347818924, 7729.265719756614, 10996.890031099587, 11087.889121109009, 11254.38100904458, 12181.817272741093, 12221.0, 10011.0, 10185.013922285083, 10316.973262085652, 10415.114715248985, 10488.947555262175, 9995.150412215044, 10667.253292269466, 10684.46577671129, 10845.837312440162, 11186.0, 10924.071453926505, 10984.725381865517, 11027.117830573696, 11186.10511159089, 11513.194076414571, 7637.847243055219, 7680.193579674054, 7869.291763741291, 7877.212278772077, 7904.288614024766, 9199.816003680024, 10376.792464150825, 10452.634157804441, 10634.361938283728, 10730.624428144978], "value": 8374.778835900233, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.1438850358766, 1419.3045407750199, 1458.4603696632244, 1579.494561740243, 1765.5497848048747, 6793.660316984149, 7441.553506789596, 7631.046119235096, 7649.885251721229, 7659.770206893802, 7268.854622907552, 7476.738314159005, 7501.174870764212, 7667.654955527, 7671.539707617547, 2221.700070490483, 2266.784655457729, 2267.85258958168, 2271.0802125139344, 2275.0899640143994, 2179.4442417183677, 2221.8444708870384, 2223.2552095048177, 2224.5773303072447, 2227.6324406472913, 2214.2914267434426, 2219.289827255279, 2231.497912969577, 2233.7319521657423, 2236.586231547161, 2164.8159906407973, 2172.0334451169238, 2202.053117159621, 2202.273249827553, 2203.867767933929, 2078.896055197249, 2102.2536999365157, 2102.37979795959, 2104.684297355409, 2105.715728376665, 7565.621718914087, 7617.46677732559, 7685.769426917202, 7705.730299439493, 7707.306342429209, 4402.163588918095, 4482.5069242383315, 4490.416245888046, 4509.7970591323465, 4522.7060241084555, 2780.1242608578436, 2898.2899189698446, 2927.6779554249015, 2934.046434908642, 2942.5439056946207, 921.3277900610437, 921.3553806455445, 932.1936524905908, 945.5508633399149, 947.8672985781996, 10757.139428845674, 10965.671029869116, 10978.176636752276, 10998.12015038795, 11002.394868282321, 4243.915121697549, 4348.543402942645, 4419.558044195554, 4421.336799480104, 4433.0, 9284.72145835626, 9355.719328420158, 9357.20463760588, 9369.344145909858, 9382.296327775444, 4828.66199366041, 4836.226203807374, 4839.782209800497, 4843.0313937212695, 4845.030993801254, 3635.0912271932016, 3741.064733816546, 4249.065205654751, 4300.225959327351, 4303.4190384298345, 3718.2563487302646, 3750.643688849555, 3799.7530160540027, 3802.980985095057, 3839.040239940015, 1194.8386967759416, 1198.7722332756923, 1203.9277643341427, 1205.6744678936639, 1221.9816702749465, 914.3827916156567, 917.9678711245074, 928.2388441478058, 930.4681138408336, 937.6624415210518, 5469.316335458067, 5611.579131565149, 5626.606137570413, 5658.858528536737, 5716.857078572986, 837.9203975622306, 882.9735107946772, 888.7600347906158, 906.7823722306731, 921.8064206516573, 3753.868614598476, 3875.8837234882435, 3909.550401703784, 3911.9437751806854, 3950.288947989332, 9540.666076687283, 9821.0, 9858.80282394348, 9871.358361706467, 9886.060824221688, 9489.715308540755, 9894.55474503649, 9912.950435247922, 9913.107820296063, 9915.702528924145, 7334.193238743734, 7437.702491900372, 7497.475176737685, 7511.699532018767, 7547.660355283915, 5155.690658560498, 5207.609429292743, 5239.554637855825, 5263.105272103675, 5263.526282634582, 8762.649494020423, 8957.328200384867, 9189.310801689766, 9199.632014719336, 9234.95382523083, 9056.683016094405, 9248.907510925073, 9254.028327025566, 9332.626694932398, 9341.532923353669, 6177.598456100339, 6290.716917738804, 6488.545801793829, 6489.513286503437, 6627.834304142435, 7508.662110204945, 7787.4548781584745, 7794.532328060334, 7805.33654639362, 7823.726169584037, 6987.895181572382, 7008.159020917523, 7043.542169758949, 7062.15254169503, 7088.751893683696, 6522.6412547308455, 6586.275509693834, 6586.308437614173, 6680.83297917556, 6730.8653826924165, 6354.650494222862, 6521.152250207443, 6562.376574225441, 6566.967165164144, 6593.274739778716, 4550.726956382628, 4578.175928332932, 4609.469910960149, 4652.534746525321, 4658.93011604833, 4484.730916145042, 4555.589996900295, 4614.377059096979, 4630.120277147331, 4647.744374059459], "value": 4205.991157406793, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.45710435098295, 286.2500249346712, 289.7725285650764, 296.9896053638123, 297.5150504677377, 4762.1665109259975, 4794.952050479495, 4813.855584332471, 4816.783244753986, 4827.927581086277, 4714.774158718732, 4751.049790041988, 4755.595774359175, 4759.8810029749275, 4771.28430735389, 3563.5367402237803, 3596.604373518911, 3617.5658920929395, 3717.256548690259, 3753.6539662710807, 3693.686036686885, 3725.590185079639, 3726.4721464199547, 3732.3841566141555, 3735.4957080794015, 3526.612072672004, 3691.870784522542, 3694.371956767356, 3701.81490925454, 3704.8703295384666, 3611.747177697549, 3685.63143685632, 3690.5571331440133, 3698.0939669780805, 3709.2581483703366, 3254.332861763333, 3257.7719559630837, 3260.7228385587255, 3265.248992731685, 3265.6407795142513, 4527.977360113211, 4600.907981840378, 4601.28680054592, 4618.49196588375, 4619.838305659319, 3964.117044403914, 4197.811098500575, 4207.768572728499, 4233.111046680201, 4256.2338779019765, 4936.5063493650705, 4938.160512712848, 4959.132151873444, 4970.751462426864, 4977.850664480072, 3406.608240052401, 3490.5287786148797, 3490.5462289902403, 3502.6689857854108, 3503.667151620592, 5164.612654050961, 5168.198929165986, 5184.248283998799, 5191.987562425328, 5197.27238186658, 3552.502649629054, 3553.573571171476, 3554.8578056877955, 3588.9004932114485, 3591.2278860044694, 3648.2521083177885, 3648.85404583819, 3656.067702735785, 3656.634336566322, 3662.212624285791, 3918.74528155669, 4119.970007498126, 4125.071858831739, 4153.6677065834665, 4172.457580514514, 4910.459849416561, 4917.582005529499, 4945.752712364368, 4964.950350496521, 4979.925301120486, 1214.9635510934686, 1216.1365430544413, 1221.5541327415428, 1222.5598784437595, 1228.4042239513828, 774.8411575626983, 785.4266385538589, 806.3025482957199, 833.4499230507836, 833.6373677450329, 4418.138462999748, 4418.5802348776815, 4432.667549933768, 4444.8444304449185, 4459.397981272552, 5070.188769796815, 5081.974590127025, 5095.898082038412, 5119.718415487109, 5126.333576635088, 4329.870103896888, 4428.468583769968, 4441.067375851043, 4446.977765111218, 4465.888352791206, 2676.919692409192, 2691.8788654510595, 2700.51390749663, 2700.9054683085997, 2730.5494593392264, 4852.199387101159, 4874.5856602189215, 4874.731889746027, 4888.364512613409, 4898.363212782316, 5091.439941606421, 5223.171889838526, 5223.869403264949, 5245.580353571705, 5264.473552644781, 4857.295692124622, 4867.780949857336, 4881.51184881509, 4884.4871288514905, 4884.682495637772, 5110.744462776921, 5133.358330208724, 5133.897322053613, 5138.665986710852, 5157.200633901752, 4753.0, 4977.71025328353, 4987.501249874984, 5036.0, 5039.2944987702485, 4752.738599377068, 4784.928226076542, 4786.7845946931775, 4802.830132112789, 4813.614910807057, 3470.878519251814, 3472.9305413892084, 3518.1028837646236, 3526.4357702767434, 3541.11472131967, 4833.564979151753, 5023.547880690755, 5032.572231360376, 5075.695458272516, 5077.92383114261, 4907.730074845917, 4924.507549245047, 4926.926096108489, 4932.8520144395725, 4939.382577177853, 4909.4354149273295, 4922.4339200992345, 4928.482509336468, 4964.156093464192, 4990.581451705593, 4594.5864872161665, 4837.201861692922, 4847.515248475124, 4859.562639362474, 4868.2940973557925, 4751.954569994596, 4866.537678920497, 5003.449620541664, 5023.372078490189, 5027.723475208899, 4880.999395124062, 4881.829135980223, 4882.36529251195, 4885.169521181479, 4930.975345123252], "value": 3723.555547225129, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.1425147069104, 702.9472789540786, 710.8151880511067, 722.6459035072816, 728.1226122522361, 10969.835452468209, 11642.126840486966, 12766.744665106704, 13161.40773665185, 13246.93376533116, 13583.04918655692, 13583.185008899449, 13671.111377760464, 13687.315634218274, 13707.588772336821, 625.2746813696114, 774.3340726974825, 783.373301358912, 797.0156856282487, 803.4135081390559, 788.8106854354971, 811.7199566149699, 812.743985644523, 813.276184196063, 813.5891374855689, 839.1314988986401, 840.8024114333127, 844.0588743550927, 844.5692696724684, 845.2646197807885, 635.4312889963456, 805.4040010392267, 825.8554752918216, 839.8908141941539, 841.7727213652341, 613.310026220502, 613.7422282641302, 614.0390289197392, 614.2966303582373, 614.6373639552685, 12427.813582796265, 12492.687682807911, 12515.74968500634, 12532.81200781989, 12542.372881355896, 11579.826302605468, 12122.515099396102, 12186.0, 12204.389780510939, 12372.0, 11267.54929802815, 11461.770764584662, 11612.071034317234, 11702.122340824388, 12078.094142939315, 4124.287024849442, 4154.065335299563, 4198.286291330481, 4214.157168566299, 4274.252005898987, 58631.0, 59147.112793308566, 59164.704176479274, 59174.704126479526, 59351.10973335403, 9230.907690923139, 9304.581293841793, 9431.90568094324, 9708.223342132613, 9717.514124293757, 15880.60298492547, 15883.444079457164, 16016.199190040452, 16078.115703636413, 16108.436204732778, 6800.931990680129, 6848.897266541006, 6913.10129683138, 6953.0, 7004.719811207597, 3666.6699997000396, 3689.9631003690156, 3696.4085746281003, 3701.722370822199, 3713.6100709425123, 2798.2864369585627, 2851.344190836078, 2857.7570906472765, 2861.270376054093, 2904.695007024274, 531.9361676598755, 562.131506821961, 565.9547236221092, 577.1890493856139, 582.484501216418, 599.9820005399845, 602.5683731151053, 614.3487902823022, 643.3887806583764, 656.592912394309, 8540.530270835165, 8551.0, 8560.871586926201, 8763.123687631185, 9069.637214511478, 506.07991886812886, 598.7096258314714, 610.8411812928671, 625.9593126446766, 632.1750116098443, 4314.913701725948, 4364.307446755462, 4617.58441740245, 4640.443146822403, 4685.601723853442, 61312.386876130666, 92922.0, 97230.51384743031, 100218.49890750645, 100336.0, 55993.7200314004, 63584.68207658932, 68251.31748682549, 74981.62509187419, 77652.61173694095, 48482.0, 48935.26597101046, 69419.3058069423, 70026.0, 70123.0, 8498.53258070812, 8730.912690873263, 8778.604962776562, 8779.25376343018, 8823.69117080899, 42213.0, 43038.0, 43722.781386092865, 43838.56161438345, 43988.12023759571, 61069.69465152646, 62692.0, 62940.0, 62994.370056300686, 63179.0, 10424.03791281034, 10744.731381715206, 10893.074088702231, 10926.125909927347, 11102.833457498306, 12386.81419778722, 12461.439235234255, 12698.238105713686, 12754.107212495408, 13194.340282986004, 12107.81838272409, 12145.69635759113, 12197.939010304892, 12296.323702196107, 12313.26120432777, 11832.960536826942, 11994.580189693319, 12397.070219733376, 12586.496540138292, 12596.622101336974, 11764.764704706029, 12055.698607534881, 12267.079969002181, 12402.06984476186, 12455.626331210078, 9849.556769945226, 9893.406395616286, 10317.845232321672, 10406.895931040895, 10562.524686389284, 9903.801923961337, 10086.234908890769, 10478.0, 10489.580416783549, 10620.309679870783], "value": 6578.54339598841, "unit": "score"}], "name": "dromaeo_css", "value": 6369.979787104267, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 115.0, 113.0, 113.0, 114.0, 113.0, 112.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 129.0, 133.0, 188.0, 137.0, 132.0, 152.0, 131.0, 191.0, 139.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 164.0, 161.0, 162.0, 161.0, 162.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 108.0, 75.0, 76.0, 76.0, 76.0, 105.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 116.0, 86.0, 84.0, 85.0, 119.0, 85.0, 87.0, 135.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 146.0, 148.0, 147.0, 147.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 67.0, 65.0, 65.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 88.0, 86.0, 85.0, 85.0, 84.0, 120.0, 91.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 145.0, 136.0, 131.0, 142.0, 148.0, 132.0, 134.0, 133.0, 132.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 174.0, 175.0, 171.0, 171.0, 171.0, 173.0, 168.0, 177.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 71.0, 66.0, 68.0, 67.0, 67.0, 67.0, 68.0, 66.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1558.2999999999997, "alertThreshold": 2.0}]} 12:26:57 INFO - Return code: 0 12:26:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:26:57 ERROR - # TBPL SUCCESS # 12:26:57 INFO - Running post-action listener: _resource_record_post_action 12:26:57 INFO - ##### 12:26:57 INFO - ##### Finished run-tests step (success) 12:26:57 INFO - ##### 12:26:57 INFO - Running post-run listener: _resource_record_post_run 12:26:57 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294969344; Read time: 16; Write time: 166048 12:26:57 INFO - TinderboxPrint: CPU usage
13.1% 12:26:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:26:57 INFO - TinderboxPrint: I/O write bytes / time
294,969,344 / 166,048 12:26:57 INFO - TinderboxPrint: CPU idle
8,315.2 (86.9%) 12:26:57 INFO - TinderboxPrint: CPU user
1,212.9 (12.7%) 12:26:57 INFO - TinderboxPrint: Swap in / out
0 / 0 12:26:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14147584; Read time: 0; Write time: 6908 12:26:57 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280821760; Read time: 16; Write time: 159140 12:26:57 INFO - Running post-run listener: _upload_blobber_files 12:26:57 INFO - Blob upload gear active. 12:26:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:26:57 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 12:26:57 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'] 12:26:57 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 12:26:58 INFO - (blobuploader) - INFO - Open directory for files ... 12:26:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:26:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:26:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:58 INFO - (blobuploader) - INFO - Done attempting. 12:26:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:26:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:27:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:27:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:27:05 INFO - (blobuploader) - INFO - Done attempting. 12:27:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:27:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:27:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:27:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:27:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:27:09 INFO - (blobuploader) - INFO - Done attempting. 12:27:09 INFO - (blobuploader) - INFO - Iteration through files over. 12:27:09 INFO - Return code: 0 12:27:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:27:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:27:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b68e72c87453896f7bad2f3f2391d4125ad9209491be88c14e894f8b5be87b05fcb09564726242d321aa549fc6cb67d1eada50a618d1bc7211032da073c24fde", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a4e6b0cc3aa5add0b0fa0143aed30c06d4d6ab0861706ef7ec15f6b792c3b3157d8d2dcfba3181ed1e2e1a73fb2201826dd957e51b3ccc85762d9fa6192ea90e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8db3fae230c3930aaf5181c9636d700b65351205dfbce2d1c204fd885b8afa2db6d1c128a36f72668072c8b1780e69c1434884be7940732bc4f09d59083d7058"} 12:27:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:27:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:27:09 INFO - Contents: 12:27:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b68e72c87453896f7bad2f3f2391d4125ad9209491be88c14e894f8b5be87b05fcb09564726242d321aa549fc6cb67d1eada50a618d1bc7211032da073c24fde", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a4e6b0cc3aa5add0b0fa0143aed30c06d4d6ab0861706ef7ec15f6b792c3b3157d8d2dcfba3181ed1e2e1a73fb2201826dd957e51b3ccc85762d9fa6192ea90e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8db3fae230c3930aaf5181c9636d700b65351205dfbce2d1c204fd885b8afa2db6d1c128a36f72668072c8b1780e69c1434884be7940732bc4f09d59083d7058"} 12:27:09 INFO - Running post-run listener: copy_logs_to_upload_dir 12:27:09 INFO - Copying logs to upload dir... 12:27:09 INFO - mkdir: /builds/slave/test/build/upload/logs 12:27:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1721.785480 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 41 secs) (at 2016-06-06 12:27:09.827027) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 12:27:09.833278) ========= 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-1465239505.617646-1388006960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b68e72c87453896f7bad2f3f2391d4125ad9209491be88c14e894f8b5be87b05fcb09564726242d321aa549fc6cb67d1eada50a618d1bc7211032da073c24fde", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a4e6b0cc3aa5add0b0fa0143aed30c06d4d6ab0861706ef7ec15f6b792c3b3157d8d2dcfba3181ed1e2e1a73fb2201826dd957e51b3ccc85762d9fa6192ea90e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8db3fae230c3930aaf5181c9636d700b65351205dfbce2d1c204fd885b8afa2db6d1c128a36f72668072c8b1780e69c1434884be7940732bc4f09d59083d7058"} build_url:https://queue.taskcluster.net/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/RThiU7WhTB-M9PhVdWX3yg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b68e72c87453896f7bad2f3f2391d4125ad9209491be88c14e894f8b5be87b05fcb09564726242d321aa549fc6cb67d1eada50a618d1bc7211032da073c24fde", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a4e6b0cc3aa5add0b0fa0143aed30c06d4d6ab0861706ef7ec15f6b792c3b3157d8d2dcfba3181ed1e2e1a73fb2201826dd957e51b3ccc85762d9fa6192ea90e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8db3fae230c3930aaf5181c9636d700b65351205dfbce2d1c204fd885b8afa2db6d1c128a36f72668072c8b1780e69c1434884be7940732bc4f09d59083d7058"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 12:27:09.864164) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 12:27:09.864714) ========= 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-1465239505.617646-1388006960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 12:27:09.947515) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 12:27:09.947846) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 12:27:09.948295) ========= ========= Total master_lag: 0.20 =========