builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1466522139.05 results: success (0) buildid: 20160621053017 builduid: 075dc87d889e47ae8458fcd6531781d7 revision: eb945fc547afc9a4254ef339335fe831c0f68db2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 08:15:39.053394) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 08:15:39.053852) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 08:15:39.054195) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 08:15:39.071804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:15:39.072290) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 08:15:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.0M=0s 2016-06-21 08:15:39 (25.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072628 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:15:39.159050) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:15:39.159396) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017740 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:15:39.209385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:15:39.209778) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb945fc547afc9a4254ef339335fe831c0f68db2 --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 eb945fc547afc9a4254ef339335fe831c0f68db2 --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=2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 08:15:39,254 truncating revision to first 12 chars 2016-06-21 08:15:39,254 Setting DEBUG logging. 2016-06-21 08:15:39,254 attempt 1/10 2016-06-21 08:15:39,254 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb945fc547af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 08:15:39,597 unpacking tar archive at: fx-team-eb945fc547af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685904 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:15:39.909716) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 08:15:39.910091) ========= script_repo_revision: eb945fc547afc9a4254ef339335fe831c0f68db2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 08:15:39.910555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 08:15:39.910871) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 08:15:39.925341) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-21 08:15:39.925672) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:15:40 INFO - MultiFileLogger online at 20160621 08:15:40 in /builds/slave/test 08:15:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:15:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:15:40 INFO - {'append_to_log': False, 08:15:40 INFO - 'base_work_dir': '/builds/slave/test', 08:15:40 INFO - 'blob_upload_branch': 'Fx-Team', 08:15:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:15:40 INFO - 'branch': 'Fx-Team', 08:15:40 INFO - 'buildbot_json_path': 'buildprops.json', 08:15:40 INFO - 'config_files': ('talos/linux_config.py',), 08:15:40 INFO - 'default_actions': ('clobber', 08:15:40 INFO - 'read-buildbot-config', 08:15:40 INFO - 'download-and-extract', 08:15:40 INFO - 'populate-webroot', 08:15:40 INFO - 'create-virtualenv', 08:15:40 INFO - 'install', 08:15:40 INFO - 'run-tests'), 08:15:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:15:40 INFO - 'download_minidump_stackwalk': True, 08:15:40 INFO - 'download_symbols': 'ondemand', 08:15:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:15:40 INFO - 'tooltool.py': '/tools/tooltool.py', 08:15:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:15:40 INFO - '/tools/misc-python/virtualenv.py')}, 08:15:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:15:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:15:40 INFO - 'installer_path': 'installer.exe', 08:15:40 INFO - 'log_level': 'info', 08:15:40 INFO - 'log_name': 'talos', 08:15:40 INFO - 'log_to_console': True, 08:15:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:15:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:15:40 INFO - 'opt_config_files': (), 08:15:40 INFO - 'pip_index': False, 08:15:40 INFO - 'sps_profile': False, 08:15:40 INFO - 'sps_profile_interval': 0, 08:15:40 INFO - 'suite': 'dromaeojs', 08:15:40 INFO - 'system_bits': '32', 08:15:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:15:40 INFO - 'title': 'talos-linux64-ix-012', 08:15:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:15:40 INFO - 'use_talos_json': True, 08:15:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:15:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:15:40 INFO - 'work_dir': 'build'} 08:15:40 INFO - ##### 08:15:40 INFO - ##### Running clobber step. 08:15:40 INFO - ##### 08:15:40 INFO - Running pre-action listener: _resource_record_pre_action 08:15:40 INFO - Running main action method: clobber 08:15:40 INFO - rmtree: /builds/slave/test/build 08:15:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:15:40 INFO - Running post-action listener: _resource_record_post_action 08:15:40 INFO - ##### 08:15:40 INFO - ##### Finished clobber step (success) 08:15:40 INFO - ##### 08:15:40 INFO - ##### 08:15:40 INFO - ##### Running read-buildbot-config step. 08:15:40 INFO - ##### 08:15:40 INFO - Running pre-action listener: _resource_record_pre_action 08:15:40 INFO - Running main action method: read_buildbot_config 08:15:40 INFO - Using buildbot properties: 08:15:40 INFO - { 08:15:40 INFO - "project": "", 08:15:40 INFO - "product": "firefox", 08:15:40 INFO - "script_repo_revision": "production", 08:15:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:15:40 INFO - "repository": "", 08:15:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:15:40 INFO - "buildid": "20160621053017", 08:15:40 INFO - "pgo_build": "True", 08:15:40 INFO - "basedir": "/builds/slave/test", 08:15:40 INFO - "buildnumber": 1268, 08:15:40 INFO - "slavename": "talos-linux64-ix-012", 08:15:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:15:40 INFO - "platform": "ubuntu64_hw", 08:15:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:15:40 INFO - "branch": "fx-team", 08:15:40 INFO - "repo_path": "integration/fx-team", 08:15:40 INFO - "revision": "eb945fc547afc9a4254ef339335fe831c0f68db2", 08:15:40 INFO - "stage_platform": "linux64-pgo", 08:15:40 INFO - "builduid": "075dc87d889e47ae8458fcd6531781d7", 08:15:40 INFO - "slavebuilddir": "test" 08:15:40 INFO - } 08:15:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:15:40 INFO - Running post-action listener: _resource_record_post_action 08:15:40 INFO - ##### 08:15:40 INFO - ##### Finished read-buildbot-config step (success) 08:15:40 INFO - ##### 08:15:40 INFO - ##### 08:15:40 INFO - ##### Running download-and-extract step. 08:15:40 INFO - ##### 08:15:40 INFO - Running pre-action listener: _resource_record_pre_action 08:15:40 INFO - Running main action method: download_and_extract 08:15:40 INFO - mkdir: /builds/slave/test/build/tests 08:15: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')]} 08:15:40 INFO - https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:15:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:15:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:15:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:15:41 INFO - Downloaded 1361 bytes. 08:15:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:15:41 INFO - Using the following test package requirements: 08:15:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:15:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:15:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:15:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:41 INFO - u'jsshell-linux-x86_64.zip'], 08:15:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:15:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:15:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:15:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:15:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:15:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:15:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:15:41 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')]} 08:15:41 INFO - https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:15:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:15:42 INFO - Downloaded 24225158 bytes. 08:15:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:15:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:15:43 INFO - Return code: 0 08:15:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:15: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')]} 08:15:43 INFO - https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:15:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:15:44 INFO - Downloaded 24225158 bytes. 08:15:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:15:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:15:46 INFO - Return code: 0 08:15: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')]} 08:15:46 INFO - https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:15:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:15:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:15:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:15:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:15:47 INFO - Downloaded 14405384 bytes. 08:15:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:15:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:15:47 INFO - Return code: 0 08:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:47 INFO - https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:15:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:15:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:15:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:15:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:15:49 INFO - Downloaded 60119633 bytes. 08:15:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:15:49 INFO - mkdir: /builds/slave/test/properties 08:15:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:15:49 INFO - Writing to file /builds/slave/test/properties/build_url 08:15:49 INFO - Contents: 08:15:49 INFO - build_url:https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:15:50 INFO - Running post-action listener: _resource_record_post_action 08:15:50 INFO - Running post-action listener: set_extra_try_arguments 08:15:50 INFO - ##### 08:15:50 INFO - ##### Finished download-and-extract step (success) 08:15:50 INFO - ##### 08:15:50 INFO - ##### 08:15:50 INFO - ##### Running populate-webroot step. 08:15:50 INFO - ##### 08:15:50 INFO - Running pre-action listener: _resource_record_pre_action 08:15:50 INFO - Running main action method: populate_webroot 08:15:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:15:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:15:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:15:50 INFO - '--tppagecycles', 08:15:50 INFO - '7'], 08:15:50 INFO - 'tests': ['tsvgm']}}, 08:15:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:15:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:15:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:15:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:15:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:15:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:15:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:50 INFO - 'talos_options': ['--disable-e10s'], 08:15:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:50 INFO - 'talos_options': ['--disable-e10s'], 08:15:50 INFO - 'tests': ['damp', 'tps']}, 08:15:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:50 INFO - 'tests': ['damp', 'tps']}, 08:15:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:15:50 INFO - 'tests': ['dromaeo_dom']}, 08:15:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:15:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:15:50 INFO - 'tests': ['basic_compositor_video']}, 08:15:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:15:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:15:50 INFO - 'tests': ['a11yr', 08:15:50 INFO - 'ts_paint', 08:15:50 INFO - 'tpaint', 08:15:50 INFO - 'sessionrestore', 08:15:50 INFO - 'sessionrestore_no_auto_restore', 08:15:50 INFO - 'tabpaint']}, 08:15:50 INFO - 'other-e10s': {'tests': ['a11yr', 08:15:50 INFO - 'ts_paint', 08:15:50 INFO - 'tpaint', 08:15:50 INFO - 'sessionrestore', 08:15:50 INFO - 'sessionrestore_no_auto_restore', 08:15:50 INFO - 'tabpaint']}, 08:15:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:15:50 INFO - 'ts_paint', 08:15:50 INFO - 'tpaint', 08:15:50 INFO - 'sessionrestore', 08:15:50 INFO - 'sessionrestore_no_auto_restore', 08:15:50 INFO - 'tabpaint']}, 08:15:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:15:50 INFO - 'ts_paint', 08:15:50 INFO - 'tpaint', 08:15:50 INFO - 'sessionrestore', 08:15:50 INFO - 'sessionrestore_no_auto_restore', 08:15:50 INFO - 'tabpaint']}, 08:15:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:15:50 INFO - 'tests': ['a11yr', 08:15:50 INFO - 'ts_paint', 08:15:50 INFO - 'tpaint', 08:15:50 INFO - 'sessionrestore', 08:15:50 INFO - 'sessionrestore_no_auto_restore', 08:15:50 INFO - 'tabpaint']}, 08:15:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:15:50 INFO - 'tests': ['a11yr', 08:15:50 INFO - 'ts_paint', 08:15:50 INFO - 'tpaint', 08:15:50 INFO - 'sessionrestore', 08:15:50 INFO - 'sessionrestore_no_auto_restore', 08:15:50 INFO - 'tabpaint']}, 08:15:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:15:50 INFO - 'tests': ['tsvgx', 08:15:50 INFO - 'tsvgr_opacity', 08:15:50 INFO - 'tart', 08:15:50 INFO - 'tscrollx', 08:15:50 INFO - 'cart']}, 08:15:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:15:50 INFO - 'tsvgr_opacity', 08:15:50 INFO - 'tart', 08:15:50 INFO - 'tscrollx', 08:15:50 INFO - 'cart']}, 08:15:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:50 INFO - 'talos_options': ['--disable-e10s'], 08:15:50 INFO - 'tests': ['tp5o']}, 08:15:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:50 INFO - 'tests': ['tp5o']}, 08:15:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:50 INFO - 'talos_options': ['--disable-e10s', 08:15:50 INFO - '--xperf_path', 08:15:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:50 INFO - 'tests': ['tp5n']}, 08:15:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:15:50 INFO - 'talos_options': ['--xperf_path', 08:15:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:50 INFO - 'tests': ['tp5n']}}, 08:15:50 INFO - 'talos.zip': {'path': '', 08:15:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:15:50 INFO - Running post-action listener: _resource_record_post_action 08:15:50 INFO - ##### 08:15:50 INFO - ##### Finished populate-webroot step (success) 08:15:50 INFO - ##### 08:15:50 INFO - ##### 08:15:50 INFO - ##### Running create-virtualenv step. 08:15:50 INFO - ##### 08:15:50 INFO - Running pre-action listener: _resource_record_pre_action 08:15:50 INFO - Running main action method: create_virtualenv 08:15:50 INFO - Creating virtualenv /builds/slave/test/build/venv 08:15:50 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 08:15:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:15:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:15:50 INFO - Using real prefix '/usr' 08:15:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:15:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:15:52 INFO - Installing pip.................done. 08:15:52 INFO - Return code: 0 08:15:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13cef1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2766990>, '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 0x26d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', '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 08:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:15:52 INFO - Using env: {'DISPLAY': ':0', 08:15:52 INFO - 'HOME': '/home/cltbld', 08:15:52 INFO - 'LANG': 'en_US.UTF-8', 08:15:52 INFO - 'LANGUAGE': 'en_US:en', 08:15:52 INFO - 'LOGNAME': 'cltbld', 08:15:52 INFO - 'MAIL': '/var/mail/cltbld', 08:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:52 INFO - 'MOZ_NO_REMOTE': '1', 08:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:52 INFO - 'NO_EM_RESTART': '1', 08:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:52 INFO - 'PWD': '/builds/slave/test', 08:15:52 INFO - 'SHELL': '/bin/bash', 08:15:52 INFO - 'SHLVL': '1', 08:15:52 INFO - 'TERM': 'linux', 08:15:52 INFO - 'TMOUT': '86400', 08:15:52 INFO - 'USER': 'cltbld', 08:15:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', 08:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:52 INFO - '_': '/tools/buildbot/bin/python'} 08:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:52 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 08:15:52 INFO - Cleaning up... 08:15:52 INFO - Return code: 0 08:15:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f13cef1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2766990>, '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 0x26d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', '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 08:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:15:52 INFO - Using env: {'DISPLAY': ':0', 08:15:52 INFO - 'HOME': '/home/cltbld', 08:15:52 INFO - 'LANG': 'en_US.UTF-8', 08:15:52 INFO - 'LANGUAGE': 'en_US:en', 08:15:52 INFO - 'LOGNAME': 'cltbld', 08:15:52 INFO - 'MAIL': '/var/mail/cltbld', 08:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:52 INFO - 'MOZ_NO_REMOTE': '1', 08:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:52 INFO - 'NO_EM_RESTART': '1', 08:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:52 INFO - 'PWD': '/builds/slave/test', 08:15:52 INFO - 'SHELL': '/bin/bash', 08:15:52 INFO - 'SHLVL': '1', 08:15:52 INFO - 'TERM': 'linux', 08:15:52 INFO - 'TMOUT': '86400', 08:15:52 INFO - 'USER': 'cltbld', 08:15:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', 08:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:52 INFO - '_': '/tools/buildbot/bin/python'} 08:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:53 INFO - Downloading/unpacking psutil>=3.1.1 08:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:15:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:55 INFO - Installing collected packages: psutil 08:15:55 INFO - Running setup.py install for psutil 08:15:55 INFO - building 'psutil._psutil_linux' extension 08:15:55 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 08:15:55 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 08:15:55 INFO - building 'psutil._psutil_posix' extension 08:15:55 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 08:15:55 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 08:15:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:55 INFO - Successfully installed psutil 08:15:55 INFO - Cleaning up... 08:15:55 INFO - Return code: 0 08:15:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13cef1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2766990>, '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 0x26d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', '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 08:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:15:55 INFO - Using env: {'DISPLAY': ':0', 08:15:55 INFO - 'HOME': '/home/cltbld', 08:15:55 INFO - 'LANG': 'en_US.UTF-8', 08:15:55 INFO - 'LANGUAGE': 'en_US:en', 08:15:55 INFO - 'LOGNAME': 'cltbld', 08:15:55 INFO - 'MAIL': '/var/mail/cltbld', 08:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:55 INFO - 'MOZ_NO_REMOTE': '1', 08:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:55 INFO - 'NO_EM_RESTART': '1', 08:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:55 INFO - 'PWD': '/builds/slave/test', 08:15:55 INFO - 'SHELL': '/bin/bash', 08:15:55 INFO - 'SHLVL': '1', 08:15:55 INFO - 'TERM': 'linux', 08:15:55 INFO - 'TMOUT': '86400', 08:15:55 INFO - 'USER': 'cltbld', 08:15:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', 08:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:55 INFO - '_': '/tools/buildbot/bin/python'} 08:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:15:57 INFO - Installing collected packages: mozsystemmonitor 08:15:57 INFO - Running setup.py install for mozsystemmonitor 08:15:57 INFO - Successfully installed mozsystemmonitor 08:15:57 INFO - Cleaning up... 08:15:58 INFO - Return code: 0 08:15:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f13cef1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2766990>, '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 0x26d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', '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 08:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:15:58 INFO - Using env: {'DISPLAY': ':0', 08:15:58 INFO - 'HOME': '/home/cltbld', 08:15:58 INFO - 'LANG': 'en_US.UTF-8', 08:15:58 INFO - 'LANGUAGE': 'en_US:en', 08:15:58 INFO - 'LOGNAME': 'cltbld', 08:15:58 INFO - 'MAIL': '/var/mail/cltbld', 08:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:58 INFO - 'MOZ_NO_REMOTE': '1', 08:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:58 INFO - 'NO_EM_RESTART': '1', 08:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:58 INFO - 'PWD': '/builds/slave/test', 08:15:58 INFO - 'SHELL': '/bin/bash', 08:15:58 INFO - 'SHLVL': '1', 08:15:58 INFO - 'TERM': 'linux', 08:15:58 INFO - 'TMOUT': '86400', 08:15:58 INFO - 'USER': 'cltbld', 08:15:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', 08:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:58 INFO - '_': '/tools/buildbot/bin/python'} 08:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:58 INFO - Downloading/unpacking jsonschema==2.5.1 08:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:16:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:00 INFO - Downloading functools32-3.2.3-2.tar.gz 08:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:16:00 INFO - warning: no files found matching '*.txt' 08:16:00 INFO - no previously-included directories found matching 'build' 08:16:00 INFO - no previously-included directories found matching 'dist' 08:16:00 INFO - no previously-included directories found matching '.git*' 08:16:00 INFO - Installing collected packages: jsonschema, functools32 08:16:00 INFO - Running setup.py install for functools32 08:16:00 INFO - warning: no files found matching '*.txt' 08:16:00 INFO - no previously-included directories found matching 'build' 08:16:00 INFO - no previously-included directories found matching 'dist' 08:16:00 INFO - no previously-included directories found matching '.git*' 08:16:00 INFO - Successfully installed jsonschema functools32 08:16:00 INFO - Cleaning up... 08:16:00 INFO - Return code: 0 08:16:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:16:00 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')]} 08:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:00 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')]} 08:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:00 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 0x7f13cef1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2766990>, '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 0x26d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', '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 08:16:00 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 08:16:00 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 08:16:00 INFO - Using env: {'DISPLAY': ':0', 08:16:00 INFO - 'HOME': '/home/cltbld', 08:16:00 INFO - 'LANG': 'en_US.UTF-8', 08:16:00 INFO - 'LANGUAGE': 'en_US:en', 08:16:00 INFO - 'LOGNAME': 'cltbld', 08:16:00 INFO - 'MAIL': '/var/mail/cltbld', 08:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:00 INFO - 'MOZ_NO_REMOTE': '1', 08:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:00 INFO - 'NO_EM_RESTART': '1', 08:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:00 INFO - 'PWD': '/builds/slave/test', 08:16:00 INFO - 'SHELL': '/bin/bash', 08:16:00 INFO - 'SHLVL': '1', 08:16:00 INFO - 'TERM': 'linux', 08:16:00 INFO - 'TMOUT': '86400', 08:16:00 INFO - 'USER': 'cltbld', 08:16:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', 08:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:00 INFO - '_': '/tools/buildbot/bin/python'} 08:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:00 INFO - Downloading/unpacking blobuploader==1.2.4 08:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:02 INFO - Downloading blobuploader-1.2.4.tar.gz 08:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:16:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:16:02 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 08:16:02 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 08:16:02 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 08:16:02 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 08:16:02 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 08:16:02 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 08:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:16:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:03 INFO - Downloading docopt-0.6.1.tar.gz 08:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:16:03 INFO - Installing collected packages: blobuploader, requests, docopt 08:16:03 INFO - Running setup.py install for blobuploader 08:16:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:16:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:16:03 INFO - Running setup.py install for requests 08:16:03 INFO - Running setup.py install for docopt 08:16:04 INFO - Successfully installed blobuploader requests docopt 08:16:04 INFO - Cleaning up... 08:16:04 INFO - Return code: 0 08:16:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:04 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 0x7f13cef1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2766990>, '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 0x26d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', '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 08:16:04 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 08:16:04 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 08:16:04 INFO - Using env: {'DISPLAY': ':0', 08:16:04 INFO - 'HOME': '/home/cltbld', 08:16:04 INFO - 'LANG': 'en_US.UTF-8', 08:16:04 INFO - 'LANGUAGE': 'en_US:en', 08:16:04 INFO - 'LOGNAME': 'cltbld', 08:16:04 INFO - 'MAIL': '/var/mail/cltbld', 08:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:04 INFO - 'MOZ_NO_REMOTE': '1', 08:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:04 INFO - 'NO_EM_RESTART': '1', 08:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:04 INFO - 'PWD': '/builds/slave/test', 08:16:04 INFO - 'SHELL': '/bin/bash', 08:16:04 INFO - 'SHLVL': '1', 08:16:04 INFO - 'TERM': 'linux', 08:16:04 INFO - 'TMOUT': '86400', 08:16:04 INFO - 'USER': 'cltbld', 08:16:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', 08:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:04 INFO - '_': '/tools/buildbot/bin/python'} 08:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:04 INFO - Running setup.py (path:/tmp/pip-qQcvVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:04 INFO - Running setup.py (path:/tmp/pip-olbgZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:04 INFO - Running setup.py (path:/tmp/pip-J4NA7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:04 INFO - Running setup.py (path:/tmp/pip-ZlmBDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:04 INFO - Running setup.py (path:/tmp/pip-AUnvbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:04 INFO - Running setup.py (path:/tmp/pip-6xxPyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:04 INFO - Running setup.py (path:/tmp/pip-DtPyKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:04 INFO - Running setup.py (path:/tmp/pip-9e4SfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:04 INFO - Running setup.py (path:/tmp/pip-LJDGq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:04 INFO - Running setup.py (path:/tmp/pip-XsZqmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:05 INFO - Running setup.py (path:/tmp/pip-tkk4cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:05 INFO - Running setup.py (path:/tmp/pip-cQexoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:05 INFO - Running setup.py (path:/tmp/pip-vh1F8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:05 INFO - Running setup.py (path:/tmp/pip-gSPmjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:05 INFO - Running setup.py (path:/tmp/pip-M9gk3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:05 INFO - Running setup.py (path:/tmp/pip-oytmi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:05 INFO - Running setup.py (path:/tmp/pip-b8VfvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:16:05 INFO - Running setup.py install for manifestparser 08:16:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:16:05 INFO - Running setup.py install for mozcrash 08:16:05 INFO - Running setup.py install for mozdebug 08:16:05 INFO - Running setup.py install for mozdevice 08:16:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:16:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:16:05 INFO - Running setup.py install for mozfile 08:16:06 INFO - Running setup.py install for mozhttpd 08:16:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:16:06 INFO - Running setup.py install for mozinfo 08:16:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:16:06 INFO - Running setup.py install for mozInstall 08:16:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:16:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:16:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:16:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:16:06 INFO - Running setup.py install for mozleak 08:16:06 INFO - Running setup.py install for mozlog 08:16:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:16:06 INFO - Running setup.py install for moznetwork 08:16:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:16:06 INFO - Running setup.py install for mozprocess 08:16:06 INFO - Running setup.py install for mozprofile 08:16:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:16:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:16:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:16:06 INFO - Running setup.py install for mozrunner 08:16:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:16:07 INFO - Running setup.py install for mozscreenshot 08:16:07 INFO - Running setup.py install for moztest 08:16:07 INFO - Running setup.py install for mozversion 08:16:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:16:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:16:07 INFO - Cleaning up... 08:16:07 INFO - Return code: 0 08:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:07 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 0x7f13cef1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2766990>, '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 0x26d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', '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 08:16:07 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 08:16:07 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 08:16:07 INFO - Using env: {'DISPLAY': ':0', 08:16:07 INFO - 'HOME': '/home/cltbld', 08:16:07 INFO - 'LANG': 'en_US.UTF-8', 08:16:07 INFO - 'LANGUAGE': 'en_US:en', 08:16:07 INFO - 'LOGNAME': 'cltbld', 08:16:07 INFO - 'MAIL': '/var/mail/cltbld', 08:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:07 INFO - 'MOZ_NO_REMOTE': '1', 08:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:07 INFO - 'NO_EM_RESTART': '1', 08:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:07 INFO - 'PWD': '/builds/slave/test', 08:16:07 INFO - 'SHELL': '/bin/bash', 08:16:07 INFO - 'SHLVL': '1', 08:16:07 INFO - 'TERM': 'linux', 08:16:07 INFO - 'TMOUT': '86400', 08:16:07 INFO - 'USER': 'cltbld', 08:16:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', 08:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:07 INFO - '_': '/tools/buildbot/bin/python'} 08:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:07 INFO - Running setup.py (path:/tmp/pip-mkLxoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:07 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)) 08:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:07 INFO - Running setup.py (path:/tmp/pip-a12jTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:07 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)) 08:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:07 INFO - Running setup.py (path:/tmp/pip-LRyYQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:07 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)) 08:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:07 INFO - Running setup.py (path:/tmp/pip-OaNuXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:07 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)) 08:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:07 INFO - Running setup.py (path:/tmp/pip-ZWz8sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:07 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)) 08:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:07 INFO - Running setup.py (path:/tmp/pip-cTunUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:08 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)) 08:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:08 INFO - Running setup.py (path:/tmp/pip-Wl12ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:08 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)) 08:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:08 INFO - Running setup.py (path:/tmp/pip-zI61ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:08 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)) 08:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:08 INFO - Running setup.py (path:/tmp/pip-TH3U8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:08 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)) 08:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:08 INFO - Running setup.py (path:/tmp/pip-hMLYc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:08 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)) 08:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:08 INFO - Running setup.py (path:/tmp/pip-Lle8Jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:08 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)) 08:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:08 INFO - Running setup.py (path:/tmp/pip-92eSFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:08 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)) 08:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:08 INFO - Running setup.py (path:/tmp/pip-KCPObi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:08 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)) 08:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:08 INFO - Running setup.py (path:/tmp/pip-txETRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:08 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)) 08:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:08 INFO - Running setup.py (path:/tmp/pip-1j9tXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:08 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)) 08:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:08 INFO - Running setup.py (path:/tmp/pip-fidHXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:08 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)) 08:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:08 INFO - Running setup.py (path:/tmp/pip-FakGTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:08 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)) 08:16:08 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)) 08:16:08 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)) 08:16:08 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)) 08:16:08 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)) 08:16:08 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)) 08:16:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:10 INFO - Downloading blessings-1.6.tar.gz 08:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:16:10 INFO - Installing collected packages: blessings 08:16:10 INFO - Running setup.py install for blessings 08:16:10 INFO - Successfully installed blessings 08:16:10 INFO - Cleaning up... 08:16:10 INFO - Return code: 0 08:16:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:11 INFO - Reading from file tmpfile_stdout 08:16:11 INFO - Current package versions: 08:16:11 INFO - argparse == 1.2.1 08:16:11 INFO - blessings == 1.6 08:16:11 INFO - blobuploader == 1.2.4 08:16:11 INFO - docopt == 0.6.1 08:16:11 INFO - functools32 == 3.2.3-2 08:16:11 INFO - jsonschema == 2.5.1 08:16:11 INFO - manifestparser == 1.1 08:16:11 INFO - mozInstall == 1.12 08:16:11 INFO - mozcrash == 0.17 08:16:11 INFO - mozdebug == 0.1 08:16:11 INFO - mozdevice == 0.48 08:16:11 INFO - mozfile == 1.2 08:16:11 INFO - mozhttpd == 0.7 08:16:11 INFO - mozinfo == 0.9 08:16:11 INFO - mozleak == 0.1 08:16:11 INFO - mozlog == 3.2 08:16:11 INFO - moznetwork == 0.27 08:16:11 INFO - mozprocess == 0.22 08:16:11 INFO - mozprofile == 0.28 08:16:11 INFO - mozrunner == 6.11 08:16:11 INFO - mozscreenshot == 0.1 08:16:11 INFO - mozsystemmonitor == 0.3 08:16:11 INFO - moztest == 0.7 08:16:11 INFO - mozversion == 1.4 08:16:11 INFO - psutil == 3.1.1 08:16:11 INFO - requests == 1.2.3 08:16:11 INFO - wsgiref == 0.1.2 08:16:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:11 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 0x7f13cef1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2766990>, '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 0x26d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', '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 08:16:11 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 08:16:11 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 08:16:11 INFO - Using env: {'DISPLAY': ':0', 08:16:11 INFO - 'HOME': '/home/cltbld', 08:16:11 INFO - 'LANG': 'en_US.UTF-8', 08:16:11 INFO - 'LANGUAGE': 'en_US:en', 08:16:11 INFO - 'LOGNAME': 'cltbld', 08:16:11 INFO - 'MAIL': '/var/mail/cltbld', 08:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:11 INFO - 'MOZ_NO_REMOTE': '1', 08:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:11 INFO - 'NO_EM_RESTART': '1', 08:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:11 INFO - 'PWD': '/builds/slave/test', 08:16:11 INFO - 'SHELL': '/bin/bash', 08:16:11 INFO - 'SHLVL': '1', 08:16:11 INFO - 'TERM': 'linux', 08:16:11 INFO - 'TMOUT': '86400', 08:16:11 INFO - 'USER': 'cltbld', 08:16:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', 08:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:11 INFO - '_': '/tools/buildbot/bin/python'} 08:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:11 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)) 08:16:11 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)) 08:16:11 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)) 08:16:11 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)) 08:16:11 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)) 08:16:11 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)) 08:16:11 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)) 08:16:11 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)) 08:16:11 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)) 08:16:11 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)) 08:16:11 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)) 08:16:11 INFO - Cleaning up... 08:16:11 INFO - Return code: 0 08:16:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:11 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 0x7f13cef1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2766990>, '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 0x26d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', '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 08:16:11 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 08:16:11 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 08:16:11 INFO - Using env: {'DISPLAY': ':0', 08:16:11 INFO - 'HOME': '/home/cltbld', 08:16:11 INFO - 'LANG': 'en_US.UTF-8', 08:16:11 INFO - 'LANGUAGE': 'en_US:en', 08:16:11 INFO - 'LOGNAME': 'cltbld', 08:16:11 INFO - 'MAIL': '/var/mail/cltbld', 08:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:11 INFO - 'MOZ_NO_REMOTE': '1', 08:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:11 INFO - 'NO_EM_RESTART': '1', 08:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:11 INFO - 'PWD': '/builds/slave/test', 08:16:11 INFO - 'SHELL': '/bin/bash', 08:16:11 INFO - 'SHLVL': '1', 08:16:11 INFO - 'TERM': 'linux', 08:16:11 INFO - 'TMOUT': '86400', 08:16:11 INFO - 'USER': 'cltbld', 08:16:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', 08:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:11 INFO - '_': '/tools/buildbot/bin/python'} 08:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:16:11 INFO - Cleaning up... 08:16:11 INFO - Return code: 0 08:16:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:11 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 0x7f13cef1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2766990>, '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 0x26d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', '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 08:16:11 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 08:16:11 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 08:16:11 INFO - Using env: {'DISPLAY': ':0', 08:16:11 INFO - 'HOME': '/home/cltbld', 08:16:11 INFO - 'LANG': 'en_US.UTF-8', 08:16:11 INFO - 'LANGUAGE': 'en_US:en', 08:16:11 INFO - 'LOGNAME': 'cltbld', 08:16:11 INFO - 'MAIL': '/var/mail/cltbld', 08:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:11 INFO - 'MOZ_NO_REMOTE': '1', 08:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:11 INFO - 'NO_EM_RESTART': '1', 08:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:11 INFO - 'PWD': '/builds/slave/test', 08:16:11 INFO - 'SHELL': '/bin/bash', 08:16:11 INFO - 'SHLVL': '1', 08:16:11 INFO - 'TERM': 'linux', 08:16:11 INFO - 'TMOUT': '86400', 08:16:11 INFO - 'USER': 'cltbld', 08:16:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', 08:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:11 INFO - '_': '/tools/buildbot/bin/python'} 08:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:11 INFO - Downloading/unpacking flake8 08:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:16:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:16:13 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 08:16:13 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 08:16:13 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 08:16:13 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 08:16:13 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 08:16:13 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 08:16:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:16:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:16:13 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 08:16:13 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 08:16:13 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 08:16:13 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 08:16:13 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 08:16:13 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 08:16:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:16:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:16:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:16:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:16:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:16:14 INFO - no previously-included directories found matching 'docs/_build' 08:16:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:16:14 INFO - Running setup.py install for pep8 08:16:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:16:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:16:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:16:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:16:14 INFO - no previously-included directories found matching 'docs/_build' 08:16:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:16:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:16:14 INFO - Cleaning up... 08:16:14 INFO - Return code: 0 08:16:14 INFO - Running post-action listener: _resource_record_post_action 08:16:14 INFO - Running post-action listener: _start_resource_monitoring 08:16:14 INFO - Starting resource monitoring. 08:16:14 INFO - ##### 08:16:14 INFO - ##### Finished create-virtualenv step (success) 08:16:14 INFO - ##### 08:16:14 INFO - ##### 08:16:14 INFO - ##### Running install step. 08:16:14 INFO - ##### 08:16:14 INFO - Running pre-action listener: _resource_record_pre_action 08:16:14 INFO - Running main action method: install 08:16:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:14 INFO - Reading from file tmpfile_stdout 08:16:14 INFO - Detecting whether we're running mozinstall >=1.0... 08:16:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:16:15 INFO - Reading from file tmpfile_stdout 08:16:15 INFO - Output received: 08:16:15 INFO - Usage: mozinstall [options] installer 08:16:15 INFO - Options: 08:16:15 INFO - -h, --help show this help message and exit 08:16:15 INFO - -d DEST, --destination=DEST 08:16:15 INFO - Directory to install application into. [default: 08:16:15 INFO - "/builds/slave/test"] 08:16:15 INFO - --app=APP Application being installed. [default: firefox] 08:16:15 INFO - mkdir: /builds/slave/test/build/application 08:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:16:32 INFO - Reading from file tmpfile_stdout 08:16:32 INFO - Output received: 08:16:32 INFO - /builds/slave/test/build/application/firefox/firefox 08:16:32 INFO - Running post-action listener: _resource_record_post_action 08:16:32 INFO - ##### 08:16:32 INFO - ##### Finished install step (success) 08:16:32 INFO - ##### 08:16:32 INFO - ##### 08:16:32 INFO - ##### Running run-tests step. 08:16:32 INFO - ##### 08:16:32 INFO - Running pre-action listener: _resource_record_pre_action 08:16:32 INFO - Running main action method: run_tests 08:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:16:32 INFO - Python 2.7.3 08:16:32 INFO - Return code: 0 08:16:32 INFO - grabbing minidump binary from tooltool 08:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:32 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 0x2766990>, '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 0x26d2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d2900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:16:32 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 08:16:32 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 08:16:32 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 08:16:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:16:32 INFO - Return code: 0 08:16:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:16:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:16:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:16:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:16:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:16:33 INFO - Return code: 0 08:16:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 08:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 08:16:33 INFO - Using env: {'DISPLAY': ':0', 08:16:33 INFO - 'HOME': '/home/cltbld', 08:16:33 INFO - 'LANG': 'en_US.UTF-8', 08:16:33 INFO - 'LANGUAGE': 'en_US:en', 08:16:33 INFO - 'LOGNAME': 'cltbld', 08:16:33 INFO - 'MAIL': '/var/mail/cltbld', 08:16:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:16:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:33 INFO - 'MOZ_NO_REMOTE': '1', 08:16:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:33 INFO - 'NO_EM_RESTART': '1', 08:16:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:33 INFO - 'PWD': '/builds/slave/test', 08:16:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:16:33 INFO - 'SHELL': '/bin/bash', 08:16:33 INFO - 'SHLVL': '1', 08:16:33 INFO - 'TERM': 'linux', 08:16:33 INFO - 'TMOUT': '86400', 08:16:33 INFO - 'USER': 'cltbld', 08:16:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490', 08:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:33 INFO - '_': '/tools/buildbot/bin/python'} 08:16:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 08:16:33 INFO - mozversion application_buildid: 20160621053017 08:16:33 INFO - mozversion application_changeset: eb945fc547afc9a4254ef339335fe831c0f68db2 08:16:33 INFO - mozversion application_display_name: Nightly 08:16:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:16:33 INFO - mozversion application_name: Firefox 08:16:33 INFO - mozversion application_remotingname: firefox 08:16:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:16:33 INFO - mozversion application_vendor: Mozilla 08:16:33 INFO - mozversion application_version: 50.0a1 08:16:33 INFO - mozversion platform_buildid: 20160621053017 08:16:33 INFO - mozversion platform_changeset: eb945fc547afc9a4254ef339335fe831c0f68db2 08:16:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:16:33 INFO - mozversion platform_version: 50.0a1 08:16:33 INFO - using testdate: 1466522193 08:16:33 INFO - actual date: 1466522193 08:16:33 INFO - starting webserver on 'localhost:43868' 08:16:33 INFO - SUITE-START | Running 2 tests 08:16:33 INFO - TEST-START | dromaeo_css 08:16:33 INFO - operating with platform_type : linux_ 08:16:33 INFO - Initialising browser for dromaeo_css test... 08:16:33 INFO - TEST-INFO | started process 29898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCw_m9D/profile http://localhost:43868/getInfo.html) 08:16:37 INFO - PROCESS | 29898 | __metrics Screen width/height:1600/1200 08:16:37 INFO - PROCESS | 29898 | colorDepth:24 08:16:37 INFO - PROCESS | 29898 | Browser inner width/height: 1024/697 08:16:37 INFO - PROCESS | 29898 | __metrics 08:16:38 INFO - PROCESS | 29898 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:16:39 INFO - TEST-INFO | 29898: exit 0 08:16:39 INFO - Browser initialized. 08:16:39 INFO - Running cycle 1/1 for dromaeo_css test... 08:16:39 INFO - TEST-INFO | started process 29983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCw_m9D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:51 INFO - PROCESS | 29983 | RSS: Main: 174182400 08:16:51 INFO - PROCESS | 29983 | 08:17:42 INFO - PROCESS | 29983 | 1466522262107 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] 08:19:50 INFO - PROCESS | 29983 | Cycle 1(1): loaded http://localhost:43868/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43868/tests/dromaeo/cssquery-ext.html) 08:19:51 INFO - PROCESS | 29983 | RSS: Main: 278814720 08:19:51 INFO - PROCESS | 29983 | 08:22:53 INFO - PROCESS | 29983 | Cycle 1(1): loaded http://localhost:43868/tests/dromaeo/cssquery-ext.html (next: http://localhost:43868/tests/dromaeo/cssquery-jquery.html) 08:22:54 INFO - PROCESS | 29983 | RSS: Main: 258379776 08:22:54 INFO - PROCESS | 29983 | 08:25:56 INFO - PROCESS | 29983 | Cycle 1(1): loaded http://localhost:43868/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43868/tests/dromaeo/cssquery-mootools.html) 08:25:56 INFO - PROCESS | 29983 | RSS: Main: 256823296 08:25:56 INFO - PROCESS | 29983 | 08:28:58 INFO - PROCESS | 29983 | Cycle 1(1): loaded http://localhost:43868/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43868/tests/dromaeo/cssquery-prototype.html) 08:28:59 INFO - PROCESS | 29983 | RSS: Main: 259813376 08:28:59 INFO - PROCESS | 29983 | 08:32:02 INFO - PROCESS | 29983 | Cycle 1(1): loaded http://localhost:43868/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43868/tests/dromaeo/cssquery-yui.html) 08:32:02 INFO - PROCESS | 29983 | RSS: Main: 237854720 08:32:02 INFO - PROCESS | 29983 | 08:35:05 INFO - PROCESS | 29983 | Cycle 1(1): loaded http://localhost:43868/tests/dromaeo/cssquery-yui.html (next: http://localhost:43868/tests/dromaeo/cssquery-dojo.html) 08:35:05 INFO - PROCESS | 29983 | RSS: Main: 288985088 08:35:05 INFO - PROCESS | 29983 | 08:35:05 INFO - PROCESS | 29983 | __start_tp_report 08:35:05 INFO - PROCESS | 29983 | _x_x_mozilla_page_load 08:35:05 INFO - PROCESS | 29983 | _x_x_mozilla_page_load_details 08:35:05 INFO - PROCESS | 29983 | |i|pagename|runs| 08:35:05 INFO - PROCESS | 29983 | |0;dojo.html;3034.120105169501;3036.301650620357;3037.0736925237793;3047.5123980163166;3093.938121237575;5103.413107492639;5168.664036837603;5175.637705360617;5221.112410890149;5262.842114736559;5199.14214154664;5249.107651699211;5256.973715131428;5267.26258323835;5339.786408543654;4718.882027949295;4771.665983381165;4792.520747925215;4796.952030479702;4874.488178741234;4827.541383568555;4829;4884.853454396374;4894.583960363373;4936.3829521309835;4581.1753884300815;4617.561331673485;4636;4733.715977041371;4738.6446016548725;4685.906281874343;4690.413698287714;4691.15559199344;4695.5304469552775;4703.035877645075;4665.2768820832825;4666.23007203811;4672.719636821767;4675.579197872174;4692.882677933045;5206.557442617382;5229.686218826882;5252.6323157379;5271.787488877541;5284.339457567804;5619.185218143346;5660.915086273709;5667.914981275284;5674.744636491368;5680.4319568043275;5494.752736126884;5583.637063590853;5601.383847776741;5715.2855893013375;5728.799492017801;5275.577953763728;5300.072487314743;5304.734763261821;5314.867128321785;5314.97342513285;5687.658740475585;5708;5730.484256416859;5752.07966725322;5788.971055144697;5339.973300133553;5531.585131115183;5549;5576.888462230732;5618.803341883015;5621.943780562224;5630.211770352154;5670.206171136044;5683.062294721325;5685.317761868602;5601.663900166003;5606.85982850432;5613.971930140323;5615.691136987423;5617.662940223599;5449.972750136224;5546.445355464502;5555.694436805934;5559.805406810823;5561.165825126263;4289.206496798102;4307.719998200107;4308.267594508941;4313.202057619288;4346.543612920661;3819;3866.7873266970587;3875.7093218008763;3886.436466712311;3921.2353591049473;5161.122609156378;5248.422673505911;5283.049051170826;5292.311999440049;5326.307580014573;5626.634268772516;5638.577106717013;5638.605297629127;5642.23829782974;5657.80197693087;5159.819406320761;5314.7608357624;5316.973415132899;5318.601104917147;5321.920171197435;4812.663113582015;4857.4171099467585;4871.610271178297;4878.707277563358;4880.877978050577;5848.181254624356;5855.765769369177;5856.853578660568;5857.355690874;5865.501432378295;5392.892142157057;5539.639923405127;5581.6371935824045;5608.747606357805;5695.629784064023;5749.482546570829;5793.91309130355;5803.158542011301;5809.883802323845;5865.149553314831;5486.945130548644;5488.945110548843;5493.340799104133;5494.423085575957;5501.312335958005;5407.080796264723;5525.861853453695;5557.472040156179;5572.247746554163;5584.776608935597;5422.810201642924;5422.810201642924;5435.592330575302;5437;5484.341878974548;5423.837284881302;5424.83725488236;5438.45615438453;5448.427915068861;5505.476979686923;5159.613029022913;5345.839624811262;5351.545118664957;5351.652142610717;5366.087765080024;5540.085885828954;5592.356878958972;5599.552035837205;5601.887962240651;5611.859703507445;5410.080286351251;5422.783088676409;5424.159255315432;5432.022235997559;5437.646552974044 08:35:05 INFO - PROCESS | 29983 | |1;ext.html;586.7594286342597;616.8272883592596;624.7219987105739;635.2821311917533;639.264845427758;31293.21766955827;34859.65140348596;41672.16655666889;42428.363574546405;42452;43652.56347436525;44244;44276.557234427644;44367.3344899826;44372.3344149838;8818.51498167599;8945.507997060158;8979.640814367418;9006.819863602725;9011.27909767217;8838.116188381142;8927.241184499326;8933.374663773538;8940.32947528938;8943.284537237005;8904.243139333132;8947.105289471034;8949.105089491064;8974.192322690957;9009.95495022524;8864.556772161399;8882.911170888274;8895.199432051082;8908.465492070432;8910;8842.778930526789;8869.911300886974;8919;8952.104789521061;8958.507282099481;41241.38137927934;41565.01219853607;41638.1672366551;41652.79173604143;41674.79162604198;3638.5451818522683;3737.3459644562363;3752.81235938202;3784.526934133233;4024.979875100635;31718;32260.677393226;32462;33786.1553461163;33835.32329353424;4305.935410968838;4327.17783621111;4342.522322544518;4363.934540981888;4389.758563279019;334926;336570;336684;337025;337338;47995;52995.47004529982;54827;55789;55802.162967555516;54014;54570;54574;54630;54671.72664136654;15179.468718594797;15360;15364.539063828102;15368;15368.154751488775;10723.356598604109;11426.143039272089;11654.18420710559;11724.120690948213;11829;15539.689206215813;15583;15726.370945162065;15740;15741.527754167393;5982.461578457873;6170.969145154246;6173.81478555644;6327.209098862642;6473.546851720429;1003.7390278527636;1036.1192985961873;1080.400377790334;1138.2373809547623;1154.3016475032484;31248.531272030938;31894;32004.519932201034;32332.191695207806;32627.67372326294;1080.3193987787643;1100.6753007862699;1125.5705254327122;1141.0814294493014;1150.7928572856965;16521.504354869372;16878.493645190665;16931.238094285785;17066.57333566646;17213.483595492155;534725;538638;538937;539299;543135;56912;56990.43009569934;57020;57186;57401.712991434775;1294.6245588779148;1336.6334168314227;1340.879320861127;1347.4408120630026;1357.9660508487366;30827.383452331276;31378.372432551678;31630.892918747733;31635.89274375386;31791.36417271688;50108;50667.23999139942;50727.74636126796;50784.98430031453;50796.49203507917;430911;433801;440876;442098;445786;43043.13913721771;44184.33723494215;44310.55689443193;44711.65865024055;45359;47434.76282618565;48030.279545806145;48127;49071;49306.26040609322;40262.39606405965;40462.1907561853;41847.005911973305;41969.16061678688;42069.57930420779;40512.59487405206;40789.796051019555;41010.1797964045;41184.79407603063;41371;40528.1894362117;40555.59444405518;41222.38166427446;41457.37813932854;44237.33643995407;31878.52182217222;35825.820870896525;35975.460368095024;36634.26731465409;36650.8167459161;27516.58725119085;27843.303917402227;27940.58089128624;27977.44045119127;28377.43245135127 08:35:05 INFO - PROCESS | 29983 | |2;jquery.html;379.8100949525238;381.4678523459775;392.4936831487381;398.5038626909498;409.16530278232386;17554.561135971606;19255.51861203467;20073.59852802943;20207.49481262969;20218.39344819656;18392;18777.624447511076;19090.23639054436;19092.33176838811;19101.42695719127;5562.332520097594;5600.52395546378;5774.971125144369;5812.447817457356;5830.533557315404;5637.774489020434;5692;5713.14302854571;5729;5751.856203594923;5500.779968801243;5704.916065947477;5717.828465146053;5784.768609255625;5790.305163380401;5677.914831277534;5705.25831641886;5716.485516303553;5721.313442386899;5732.79935202268;5055.6713813602;5063.0380227756605;5068.543831055223;5104.412992505835;5115.283860259567;18933.242670293173;19122.617547649108;20604.690929636068;22754.88622556893;22760.089596416125;2218.8003079722903;2278.316505048479;2497.4131079196372;2539.619057141425;2892.739653431201;13934.51229206983;14086.084404513675;14406;14425.422983080663;14988;1943.2129987355002;1958.128632758423;1960.2159136345576;2004.8095430934184;2094.1309356616985;79350.20649793487;79643.6017819913;79695.20304796936;79985.60007199927;80923;10294.588216471408;10506.317089389166;10654.414007229676;10681.679549613524;10880.12958963281;14805.333759980827;14894;14921.463351230317;14925;14928.925355373154;7523.661435235427;7536.7362142324755;7544.735934242385;7595.240475952471;7676.769696909102;7181.461390395742;7245.710171593183;7334.889976650355;7478.663460144307;7520.849583008309;6404.775832845921;6520.771772988018;6609;6631.801045968628;6633.933660663428;1884.9434516964513;1903.790583035865;1905.771307443088;1925.419937284046;1973.6842105263377;912.8904531456135;1007.2143727892255;1007.29992655104;1041.037040737315;1062.8937106289309;19379.224831006883;19440.61118777645;19448.70826937597;19478.318258860872;19897.900510497646;998.8801343838786;1009.2733232072895;1010.6816352848829;1057.4395570347729;1085.6308854989184;10764.246502744889;11308.208425410143;11334.716632084099;11435.542578296774;11506.252093613888;356985;364118;365371;470456;517107;60967.390326096174;61217.693911531045;95802;98131;100055;991.2367477042637;999.5901680311038;1038.8182068138046;1041.385582506325;1044.5926088825365;11735;16330.265138068578;16892.40876569363;16921.830781692024;17863;38518.80740596279;39617.40573891452;39748;39773.801130995314;42291.36562951496;48762.5123748758;54720.17919731128;55100;55448;56008;7656.885146722692;7665.118511371264;7676.078870535348;8130.105688374156;8653.350998674998;9380.624775008922;12910.67723306925;13322.33388330599;13656.248906310248;14112.50606228777;11666.416679166177;11880.287182769061;12081.637550873487;12156.513739450324;12359.443825028075;11344.376059316817;11682.47428865686;12206.81689774672;12213.511459541875;12443.253404795742;12352.4441400139;12509.18690285165;12633.178843375152;12694.492220311453;12712.491500339884;7292.927070729437;7534.924650753423;7636.389088872988;8306.04480484752;8559.186877246651;11658;11839.704007399883;11890.34603096838;11996.58011969577;12056.336901470153 08:35:05 INFO - PROCESS | 29983 | |3;mootools.html;1252.405107573902;1406.5991192510132;1433.104309806371;1499.7600383938566;1701.8893771904834;7445.776626701194;7834.843303133941;7855.018122734666;8016.038075430956;8021;7768.805779855506;7929.92070079299;7936.801579960504;7948.801279968004;7953.204679532058;2008.6183625111255;2155.536559639673;2186.8578542394694;2204.691343211952;2280.270313499681;2271.8523295985706;2306.9077236910503;2308.088305119477;2309.180241014441;2310.9075636974585;2262.049939025613;2269.6595510673365;2293.8967746451367;2294.3117064880553;2296.7358753743283;1971.447994561525;2137.551114266006;2168.111074459472;2203.151786562185;2208.9889550552307;2202.427368884086;2218.7559368469456;2221.7222847144108;2224.154821167946;2226.265332440291;7836.451448398614;7948.046234451845;7949.1653376395225;7954.920450795534;7956.045274567031;4667.486576476585;4785.066911952171;4787.8563643090765;4790.856274311776;4793.7363445010515;3075.6463006754284;3179.77741558091;3209.486482162866;3245.610526736783;3264.135004223883;1074.4305518075432;1099.1371773158112;1123.5449642894641;1134.8297755336682;1135.9772804543945;10131.949340253252;10221.33561318512;10237.9488102559;10273.972602739741;10327.122194613392;4177.811998460016;4227.7463352198965;4302.720323178984;4348.108637729258;4354.346847972766;8960.372773905894;9029.729108126767;9032.096790320915;9033.457992520469;9045.366824322235;4846.80612775485;4847.054824309226;4849.4908034656555;4852.102361063215;4853.39332583427;4024.778637174925;4325.891852703645;4451.710638808467;4457.64338852891;4540.704854184468;3665.2119794244363;3736.3834967230105;3757.7181711371754;3846.1346197105427;3881.6802287221917;1191.53530123252;1235.6540168752763;1240.2558464920976;1257.220523275575;1258.3205069262679;829.850626887154;844.4595458906305;849.2823564088335;916.326500022483;947.3510645208055;5607.803726869622;5608.1587761835235;5767.336756272998;5874.118882167709;5960.6721630309885;433.97179183352984;436.4871276250393;438.95829896159813;445.29643163801114;462.4058085360296;4012.237674841829;4116.115035267372;4116.876493705194;4125.463689720317;4254.042840360894;9325.533723313807;9542.188913942255;9591.760205994906;9666.275029372826;9673.467959262309;9549;9595.520223988773;9602.567884445216;9608.807823843485;9633.518324083769;7084.25615310385;7305.671244793997;7378.96310518444;7440.9627951860975;7456.1798202197715;5421.918671219856;5467.890642187054;5474.452554744494;5513.944860551504;5606.299212598426;8905;8960.238379737535;9044.819103618023;9067.773305667411;9075.13786190311;8935.419197752126;8967.686130985385;9227.953860230657;9238.399504032217;9243.722688319362;6463.870722585616;6771.864562708817;6931.272216417204;7123.180834204133;7210.351068403869;7633.084029916446;7685.346745526693;7702.961485192763;7747.070351557849;7755.650995705094;6933.757318493828;6968.581885086911;7091.539049961736;7191.8561628768175;7211.3870321023305;6860.6912688930115;6942.340477654615;6994.195667498303;7051.153861536648;7057.50597458173;6366.458850997532;6395.401149712572;6487.253965793994;6509.121268628674;6538.444232240313;4733.715977041388;4947;4966.701997880139;4979.800807967786;5048.772805223847;4859;4934.259861020875;4937.28409380645;4944.1100601892;4971.552560269593 08:35:05 INFO - PROCESS | 29983 | |4;prototype.html;301.24387786655495;307.472684346346;308.4032397311203;308.86255616250764;314.8882146837874;5333;5348.465153484654;5377.274068000819;5395.568354531638;5431.674099554019;5274.156135018397;5282.656627319221;5290.153575427932;5333.813316533912;5339.946600533994;3905.960940390595;3918.275119102975;4027.8319287406616;4031;4042.019410488854;4028.415879697442;4042.43405923171;4042.4744783178144;4073.2464494068545;4077.9592204077876;3949;3950.940735888964;3968.56345801963;3992.421098940652;4021.718479706422;3898.200868821885;4030.4684219996507;4048.716589838727;4055.7972101395108;4084.5711200323835;3535.5757309122814;3548.574171099459;3561.71506279497;3571.1786289153642;3576.856925722968;5090.694558326475;5148.897022059576;5202.141646628302;5203.505666961671;5209.8017455984955;4424.889377765549;4601.631869450436;4639.791209395586;4643.489216186217;4681.391419115494;5431.2396264522995;5472.181826359428;5489.258950041733;5508.669479831183;5523.889522209533;3851.9037024074623;3881.359575670011;3888.6111388861173;3890.358090915024;3902.1610353774076;5542.307211598551;5734.684592347419;5760.423957604206;5792.68140252286;5804.796832110856;3940.940885886714;3945.704072194597;3955.367141257385;3962.583928687504;3963.504561929759;3971.205758848242;3998.8600398985895;4008.518977722692;4018.9148929788794;4020.3165461871554;4606.019411652955;4625.791839367236;4632.62938964882;4633.328167415706;4636.9536304637195;5417.133258678593;5494.697791621419;5540.889182216333;5562.3591040643105;5578.609497335228;1329.1094966372555;1367.596559015093;1371.6776557508977;1376.0711519724146;1385.5981765288154;873.7815546113471;889.5374405309203;889.5596679643618;895.6686026170358;919.7240827751648;5236.188390799432;5236.607254455931;5251.6061295403;5263.894722105613;5281.788728450896;5504.926539324873;5523.28197334344;5532.6680399176175;5540.36285827127;5559.63862348946;5060.291559181717;5152.0726269271145;5205.9219111713355;5234.816781412708;5254.264402983586;2948.189247956786;2953.8818447262297;2973.36072744361;2980.672126066131;2985.4178435205363;5815.354013923655;5826.591444005219;5831.446012628793;5854.795082172103;5865.149553314831;5460.208269800856;5673.744681489343;5680.488756011979;5681.159420289855;5682.630629009184;5786.218860453869;5790.654784812158;5820.650760954356;5827.621204621686;5856.502197313276;5360.41035486104;5597.440255974533;5607.915881261702;5621.3698027571545;5708.828735137952;5634.549236061187;5635.267415235993;5702.51528620072;5704.229928959538;5711.771529138788;5850.765969361348;5879.176915231957;5880.206172166702;5895.410458954242;5955.880882382241;3854.730168888263;3937.92124157521;3940.5468371137686;3941.704372172156;3945.2109578083923;5622.690752008679;5643.830685079454;5662.47113279404;5665.433456654301;5704.885902282014;5511.22842802;5537.9169312459535;5541.503793975685;5542.473465020817;5565;5236.528712415901;5505.6696598204235;5520.889582208413;5527.640703354269;5529.585281103853;5203.060270946903;5456.918146227889;5457.181422786613;5473.917891231715;5481.917771233355;5397.109476936419;5547.972260138674;5553.500184983371;5602.775888964559;5606.607537472338;5406.621536492407;5465.316835395575;5468.781248750164;5469.398366179637;5480.424555421623 08:35:05 INFO - PROCESS | 29983 | |5;yui.html;717.2863001313693;733.9722898147687;762.1882694929899;778.7352300217925;784.6469088909989;14740.926295368521;15377.615559611015;15513.379464821393;16099.919500402497;16205.270762815688;14543.927280363583;14708.852911470882;14766.63083422915;14876.107433553994;14885.25573721315;686.2999740264927;785.19909692114;810.6392655268407;824.7113510271387;825.0594322472386;768.8347005393839;776.6311002273903;788.5938741548107;805.7059173401695;806.04483686831;857.4640849469082;858.6908712863365;859.6002858670716;860.2601762484259;860.6256278518864;707.3386383731176;712.6828561290228;855.5551113421018;855.9400841941098;856.5032281276845;583.9970800145973;602.4246844263718;610.1793088296234;615.1879519034876;615.3231445410013;14718.852811471963;14824;15398.153101579408;15422.383104675911;15450.9227453862;13880.236586987712;14152.85847141536;14222.041536730045;14549.817527370978;14694.412223511046;12545;12630.368481575977;12727.87272127276;12923.612291631172;13251.602451926457;4399.934000989988;4485.753283569403;4563.429571303587;4634.39752832133;4661.720296782204;72575;72963;73026.63486682586;73081.26918730851;73086.26913730848;11197.72005699864;11417;11569.479373428048;11739.647810565697;11941.164118511795;20497.692534611993;20641.277555285495;20690.068946897427;20699.172033118808;20701.27545535899;8403.285720713686;8438.282745966662;8617.655293788304;8651.178138076873;8721;4732;4750.477447480775;4798.1123492154065;4840.661153719206;5068.214426763858;3444.2422667013216;3527.188746588299;3539.5398598182587;3546.078019714893;3556.893293201208;627.4290395739855;634.1027446163627;638.4796390941368;638.8658381739793;640.3820313397594;661.9172603424572;662.8442316055723;665.6904539389208;674.4705406256163;677.2550194785795;8906.910930890608;9041.457512549268;9079.68221112258;9230.35387522867;9612.51937403127;624.8281722526342;708.8298808285974;709.2446544430165;756.1115689065326;779.2713812585138;4369.816505540679;4642.65180111493;4682.695624784378;4712;4819.975900120477;108590.72202021797;109425;111932;113683.43158284322;114664.42667786774;96679.51660241654;100552;100790;101410;102566.48716756368;70824.64587677029;73014.63492682608;78138.21861781423;82188.58905705553;82407;9905.851412228678;10284.588616455558;10294.639687610897;10305.896941030494;10472.68581942543;47595.81254436901;47862.76068619634;49459;49711.75144124256;50498.74750626223;67676.323236767;74346.62826686048;75644;76612.2338776605;76757.23242767724;12480.625581232578;12686.238825670489;12692.809607855705;12731.490740370651;13649.38577763983;14880.7767883484;15094;15170.620734481727;15997.1201583914;16058.919705401866;9955.751106222402;13552.267112519889;13998.790018149939;14088.577342679737;14389.928050359682;13918.58244252674;14371;14473;14776.77834832457;15379.769303460233;13900.652483687989;13951;14142.22217778032;14314.427422902967;14812.259387030821;11029.61396351124;11291.491882865126;11928.284302941851;12053.469456665045;12530.833254750956;11348.432578371214;12183.573574924834;12283.815742763687;12323.44544495482;12421 08:35:05 INFO - PROCESS | 29983 | __end_tp_report 08:35:05 INFO - PROCESS | 29983 | __start_cc_report 08:35:05 INFO - PROCESS | 29983 | _x_x_mozilla_cycle_collect,898 08:35:05 INFO - PROCESS | 29983 | __end_cc_report 08:35:05 INFO - PROCESS | 29983 | __startTimestamp1466523305873__endTimestamp 08:35:05 INFO - PROCESS | 29983 | 08:35:05 INFO - PROCESS | 29983 | ------- Summary: start ------- 08:35:05 INFO - PROCESS | 29983 | Number of tests: 6 08:35:05 INFO - PROCESS | 29983 | 08:35:05 INFO - PROCESS | 29983 | [#0] dojo.html Cycles:165 Average:5205.82 Median:5407.08 stddev:589.59 (10.9%) stddev-sans-first:566.25 08:35:05 INFO - PROCESS | 29983 | Values: 3034.1 3036.3 3037.1 3047.5 3093.9 5103.4 5168.7 5175.6 5221.1 5262.8 5199.1 5249.1 5257.0 5267.3 5339.8 4718.9 4771.7 4792.5 4797.0 4874.5 4827.5 4829.0 4884.9 4894.6 4936.4 4581.2 4617.6 4636.0 4733.7 4738.6 4685.9 4690.4 4691.2 4695.5 4703.0 4665.3 4666.2 4672.7 4675.6 4692.9 5206.6 5229.7 5252.6 5271.8 5284.3 5619.2 5660.9 5667.9 5674.7 5680.4 5494.8 5583.6 5601.4 5715.3 5728.8 5275.6 5300.1 5304.7 5314.9 5315.0 5687.7 5708.0 5730.5 5752.1 5789.0 5340.0 5531.6 5549.0 5576.9 5618.8 5621.9 5630.2 5670.2 5683.1 5685.3 5601.7 5606.9 5614.0 5615.7 5617.7 5450.0 5546.4 5555.7 5559.8 5561.2 4289.2 4307.7 4308.3 4313.2 4346.5 3819.0 3866.8 3875.7 3886.4 3921.2 5161.1 5248.4 5283.0 5292.3 5326.3 5626.6 5638.6 5638.6 5642.2 5657.8 5159.8 5314.8 5317.0 5318.6 5321.9 4812.7 4857.4 4871.6 4878.7 4880.9 5848.2 5855.8 5856.9 5857.4 5865.5 5392.9 5539.6 5581.6 5608.7 5695.6 5749.5 5793.9 5803.2 5809.9 5865.1 5486.9 5488.9 5493.3 5494.4 5501.3 5407.1 5525.9 5557.5 5572.2 5584.8 5422.8 5422.8 5435.6 5437.0 5484.3 5423.8 5424.8 5438.5 5448.4 5505.5 5159.6 5345.8 5351.5 5351.7 5366.1 5540.1 5592.4 5599.6 5601.9 5611.9 5410.1 5422.8 5424.2 5432.0 5437.6 08:35:05 INFO - PROCESS | 29983 | 08:35:05 INFO - PROCESS | 29983 | [#1] ext.html Cycles:180 Average:59802.06 Median:42019.37 stddev:118206.08 (281.3%) stddev-sans-first:118454.07 08:35:05 INFO - PROCESS | 29983 | Values: 586.8 616.8 624.7 635.3 639.3 31293.2 34859.7 41672.2 42428.4 42452.0 43652.6 44244.0 44276.6 44367.3 44372.3 8818.5 8945.5 8979.6 9006.8 9011.3 8838.1 8927.2 8933.4 8940.3 8943.3 8904.2 8947.1 8949.1 8974.2 9010.0 8864.6 8882.9 8895.2 8908.5 8910.0 8842.8 8869.9 8919.0 8952.1 8958.5 41241.4 41565.0 41638.2 41652.8 41674.8 3638.5 3737.3 3752.8 3784.5 4025.0 31718.0 32260.7 32462.0 33786.2 33835.3 4305.9 4327.2 4342.5 4363.9 4389.8 334926.0 336570.0 336684.0 337025.0 337338.0 47995.0 52995.5 54827.0 55789.0 55802.2 54014.0 54570.0 54574.0 54630.0 54671.7 15179.5 15360.0 15364.5 15368.0 15368.2 10723.4 11426.1 11654.2 11724.1 11829.0 15539.7 15583.0 15726.4 15740.0 15741.5 5982.5 6171.0 6173.8 6327.2 6473.5 1003.7 1036.1 1080.4 1138.2 1154.3 31248.5 31894.0 32004.5 32332.2 32627.7 1080.3 1100.7 1125.6 1141.1 1150.8 16521.5 16878.5 16931.2 17066.6 17213.5 534725.0 538638.0 538937.0 539299.0 543135.0 56912.0 56990.4 57020.0 57186.0 57401.7 1294.6 1336.6 1340.9 1347.4 1358.0 30827.4 31378.4 31630.9 31635.9 31791.4 50108.0 50667.2 50727.7 50785.0 50796.5 430911.0 433801.0 440876.0 442098.0 445786.0 43043.1 44184.3 44310.6 44711.7 45359.0 47434.8 48030.3 48127.0 49071.0 49306.3 40262.4 40462.2 41847.0 41969.2 42069.6 40512.6 40789.8 41010.2 41184.8 41371.0 40528.2 40555.6 41222.4 41457.4 44237.3 31878.5 35825.8 35975.5 36634.3 36650.8 27516.6 27843.3 27940.6 27977.4 28377.4 08:35:05 INFO - PROCESS | 29983 | 08:35:05 INFO - PROCESS | 29983 | [#2] jquery.html Cycles:180 Average:26499.60 Median:22757.49 stddev:69520.40 (305.5%) stddev-sans-first:69687.76 08:35:05 INFO - PROCESS | 29983 | Values: 379.8 381.5 392.5 398.5 409.2 17554.6 19255.5 20073.6 20207.5 20218.4 18392.0 18777.6 19090.2 19092.3 19101.4 5562.3 5600.5 5775.0 5812.4 5830.5 5637.8 5692.0 5713.1 5729.0 5751.9 5500.8 5704.9 5717.8 5784.8 5790.3 5677.9 5705.3 5716.5 5721.3 5732.8 5055.7 5063.0 5068.5 5104.4 5115.3 18933.2 19122.6 20604.7 22754.9 22760.1 2218.8 2278.3 2497.4 2539.6 2892.7 13934.5 14086.1 14406.0 14425.4 14988.0 1943.2 1958.1 1960.2 2004.8 2094.1 79350.2 79643.6 79695.2 79985.6 80923.0 10294.6 10506.3 10654.4 10681.7 10880.1 14805.3 14894.0 14921.5 14925.0 14928.9 7523.7 7536.7 7544.7 7595.2 7676.8 7181.5 7245.7 7334.9 7478.7 7520.8 6404.8 6520.8 6609.0 6631.8 6633.9 1884.9 1903.8 1905.8 1925.4 1973.7 912.9 1007.2 1007.3 1041.0 1062.9 19379.2 19440.6 19448.7 19478.3 19897.9 998.9 1009.3 1010.7 1057.4 1085.6 10764.2 11308.2 11334.7 11435.5 11506.3 356985.0 364118.0 365371.0 470456.0 517107.0 60967.4 61217.7 95802.0 98131.0 100055.0 991.2 999.6 1038.8 1041.4 1044.6 11735.0 16330.3 16892.4 16921.8 17863.0 38518.8 39617.4 39748.0 39773.8 42291.4 48762.5 54720.2 55100.0 55448.0 56008.0 7656.9 7665.1 7676.1 8130.1 8653.4 9380.6 12910.7 13322.3 13656.2 14112.5 11666.4 11880.3 12081.6 12156.5 12359.4 11344.4 11682.5 12206.8 12213.5 12443.3 12352.4 12509.2 12633.2 12694.5 12712.5 7292.9 7534.9 7636.4 8306.0 8559.2 11658.0 11839.7 11890.3 11996.6 12056.3 08:35:05 INFO - PROCESS | 29983 | 08:35:05 INFO - PROCESS | 29983 | [#3] mootools.html Cycles:180 Average:5261.01 Median:4956.85 stddev:2865.06 (57.8%) stddev-sans-first:2857.25 08:35:05 INFO - PROCESS | 29983 | Values: 1252.4 1406.6 1433.1 1499.8 1701.9 7445.8 7834.8 7855.0 8016.0 8021.0 7768.8 7929.9 7936.8 7948.8 7953.2 2008.6 2155.5 2186.9 2204.7 2280.3 2271.9 2306.9 2308.1 2309.2 2310.9 2262.0 2269.7 2293.9 2294.3 2296.7 1971.4 2137.6 2168.1 2203.2 2209.0 2202.4 2218.8 2221.7 2224.2 2226.3 7836.5 7948.0 7949.2 7954.9 7956.0 4667.5 4785.1 4787.9 4790.9 4793.7 3075.6 3179.8 3209.5 3245.6 3264.1 1074.4 1099.1 1123.5 1134.8 1136.0 10131.9 10221.3 10237.9 10274.0 10327.1 4177.8 4227.7 4302.7 4348.1 4354.3 8960.4 9029.7 9032.1 9033.5 9045.4 4846.8 4847.1 4849.5 4852.1 4853.4 4024.8 4325.9 4451.7 4457.6 4540.7 3665.2 3736.4 3757.7 3846.1 3881.7 1191.5 1235.7 1240.3 1257.2 1258.3 829.9 844.5 849.3 916.3 947.4 5607.8 5608.2 5767.3 5874.1 5960.7 434.0 436.5 439.0 445.3 462.4 4012.2 4116.1 4116.9 4125.5 4254.0 9325.5 9542.2 9591.8 9666.3 9673.5 9549.0 9595.5 9602.6 9608.8 9633.5 7084.3 7305.7 7379.0 7441.0 7456.2 5421.9 5467.9 5474.5 5513.9 5606.3 8905.0 8960.2 9044.8 9067.8 9075.1 8935.4 8967.7 9228.0 9238.4 9243.7 6463.9 6771.9 6931.3 7123.2 7210.4 7633.1 7685.3 7703.0 7747.1 7755.7 6933.8 6968.6 7091.5 7191.9 7211.4 6860.7 6942.3 6994.2 7051.2 7057.5 6366.5 6395.4 6487.3 6509.1 6538.4 4733.7 4947.0 4966.7 4979.8 5048.8 4859.0 4934.3 4937.3 4944.1 4971.6 08:35:05 INFO - PROCESS | 29983 | 08:35:05 INFO - PROCESS | 29983 | [#4] prototype.html Cycles:180 Average:4616.41 Median:5333.41 stddev:1382.96 (25.9%) stddev-sans-first:1348.38 08:35:05 INFO - PROCESS | 29983 | Values: 301.2 307.5 308.4 308.9 314.9 5333.0 5348.5 5377.3 5395.6 5431.7 5274.2 5282.7 5290.2 5333.8 5339.9 3906.0 3918.3 4027.8 4031.0 4042.0 4028.4 4042.4 4042.5 4073.2 4078.0 3949.0 3950.9 3968.6 3992.4 4021.7 3898.2 4030.5 4048.7 4055.8 4084.6 3535.6 3548.6 3561.7 3571.2 3576.9 5090.7 5148.9 5202.1 5203.5 5209.8 4424.9 4601.6 4639.8 4643.5 4681.4 5431.2 5472.2 5489.3 5508.7 5523.9 3851.9 3881.4 3888.6 3890.4 3902.2 5542.3 5734.7 5760.4 5792.7 5804.8 3940.9 3945.7 3955.4 3962.6 3963.5 3971.2 3998.9 4008.5 4018.9 4020.3 4606.0 4625.8 4632.6 4633.3 4637.0 5417.1 5494.7 5540.9 5562.4 5578.6 1329.1 1367.6 1371.7 1376.1 1385.6 873.8 889.5 889.6 895.7 919.7 5236.2 5236.6 5251.6 5263.9 5281.8 5504.9 5523.3 5532.7 5540.4 5559.6 5060.3 5152.1 5205.9 5234.8 5254.3 2948.2 2953.9 2973.4 2980.7 2985.4 5815.4 5826.6 5831.4 5854.8 5865.1 5460.2 5673.7 5680.5 5681.2 5682.6 5786.2 5790.7 5820.7 5827.6 5856.5 5360.4 5597.4 5607.9 5621.4 5708.8 5634.5 5635.3 5702.5 5704.2 5711.8 5850.8 5879.2 5880.2 5895.4 5955.9 3854.7 3937.9 3940.5 3941.7 3945.2 5622.7 5643.8 5662.5 5665.4 5704.9 5511.2 5537.9 5541.5 5542.5 5565.0 5236.5 5505.7 5520.9 5527.6 5529.6 5203.1 5456.9 5457.2 5473.9 5481.9 5397.1 5548.0 5553.5 5602.8 5606.6 5406.6 5465.3 5468.8 5469.4 5480.4 08:35:05 INFO - PROCESS | 29983 | 08:35:05 INFO - PROCESS | 29983 | [#5] yui.html Cycles:180 Average:20464.65 Median:4598.91 stddev:28934.52 (629.2%) stddev-sans-first:28977.69 08:35:05 INFO - PROCESS | 29983 | Values: 717.3 734.0 762.2 778.7 784.6 14740.9 15377.6 15513.4 16099.9 16205.3 14543.9 14708.9 14766.6 14876.1 14885.3 686.3 785.2 810.6 824.7 825.1 768.8 776.6 788.6 805.7 806.0 857.5 858.7 859.6 860.3 860.6 707.3 712.7 855.6 855.9 856.5 584.0 602.4 610.2 615.2 615.3 14718.9 14824.0 15398.2 15422.4 15450.9 13880.2 14152.9 14222.0 14549.8 14694.4 12545.0 12630.4 12727.9 12923.6 13251.6 4399.9 4485.8 4563.4 4634.4 4661.7 72575.0 72963.0 73026.6 73081.3 73086.3 11197.7 11417.0 11569.5 11739.6 11941.2 20497.7 20641.3 20690.1 20699.2 20701.3 8403.3 8438.3 8617.7 8651.2 8721.0 4732.0 4750.5 4798.1 4840.7 5068.2 3444.2 3527.2 3539.5 3546.1 3556.9 627.4 634.1 638.5 638.9 640.4 661.9 662.8 665.7 674.5 677.3 8906.9 9041.5 9079.7 9230.4 9612.5 624.8 708.8 709.2 756.1 779.3 4369.8 4642.7 4682.7 4712.0 4820.0 108590.7 109425.0 111932.0 113683.4 114664.4 96679.5 100552.0 100790.0 101410.0 102566.5 70824.6 73014.6 78138.2 82188.6 82407.0 9905.9 10284.6 10294.6 10305.9 10472.7 47595.8 47862.8 49459.0 49711.8 50498.7 67676.3 74346.6 75644.0 76612.2 76757.2 12480.6 12686.2 12692.8 12731.5 13649.4 14880.8 15094.0 15170.6 15997.1 16058.9 9955.8 13552.3 13998.8 14088.6 14389.9 13918.6 14371.0 14473.0 14776.8 15379.8 13900.7 13951.0 14142.2 14314.4 14812.3 11029.6 11291.5 11928.3 12053.5 12530.8 11348.4 12183.6 12283.8 12323.4 12421.0 08:35:05 INFO - PROCESS | 29983 | -------- Summary: end -------- 08:35:05 INFO - PROCESS | 29983 | 08:35:06 INFO - TEST-INFO | 29983: exit 0 08:35:06 INFO - TEST-OK | dromaeo_css | took 1113355ms 08:35:06 INFO - TEST-START | kraken 08:35:06 INFO - operating with platform_type : linux_ 08:35:06 INFO - Initialising browser for kraken test... 08:35:06 INFO - TEST-INFO | started process 30175 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5N5yjA/profile http://localhost:43868/getInfo.html) 08:35:10 INFO - PROCESS | 30175 | __metrics Screen width/height:1600/1200 08:35:10 INFO - PROCESS | 30175 | colorDepth:24 08:35:10 INFO - PROCESS | 30175 | Browser inner width/height: 1024/697 08:35:10 INFO - PROCESS | 30175 | __metrics 08:35:11 INFO - PROCESS | 30175 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:35:12 INFO - TEST-INFO | 30175: exit 0 08:35:12 INFO - Browser initialized. 08:35:12 INFO - Running cycle 1/1 for kraken test... 08:35:12 INFO - TEST-INFO | started process 30259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5N5yjA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:24 INFO - PROCESS | 30259 | RSS: Main: 173924352 08:35:24 INFO - PROCESS | 30259 | 08:35:26 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:43868/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43868/tests/kraken/driver.html?testName=audio-beat-detection) 08:35:27 INFO - PROCESS | 30259 | RSS: Main: 232742912 08:35:27 INFO - PROCESS | 30259 | 08:35:30 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:43868/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43868/tests/kraken/driver.html?testName=audio-dft) 08:35:30 INFO - PROCESS | 30259 | RSS: Main: 220467200 08:35:30 INFO - PROCESS | 30259 | 08:35:33 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:43868/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43868/tests/kraken/driver.html?testName=audio-fft) 08:35:34 INFO - PROCESS | 30259 | RSS: Main: 287449088 08:35:34 INFO - PROCESS | 30259 | 08:35:36 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:43868/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43868/tests/kraken/driver.html?testName=audio-oscillator) 08:35:37 INFO - PROCESS | 30259 | RSS: Main: 198000640 08:35:37 INFO - PROCESS | 30259 | 08:35:39 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:43868/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43868/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:35:39 INFO - PROCESS | 30259 | RSS: Main: 202510336 08:35:39 INFO - PROCESS | 30259 | 08:35:42 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:43868/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43868/tests/kraken/driver.html?testName=imaging-darkroom) 08:35:43 INFO - PROCESS | 30259 | RSS: Main: 236449792 08:35:43 INFO - PROCESS | 30259 | 08:35:46 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:43868/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43868/tests/kraken/driver.html?testName=imaging-desaturate) 08:35:47 INFO - PROCESS | 30259 | RSS: Main: 238895104 08:35:47 INFO - PROCESS | 30259 | 08:35:50 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:43868/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43868/tests/kraken/driver.html?testName=json-parse-financial) 08:35:51 INFO - PROCESS | 30259 | RSS: Main: 238706688 08:35:51 INFO - PROCESS | 30259 | 08:35:52 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:43868/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43868/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:35:53 INFO - PROCESS | 30259 | RSS: Main: 226091008 08:35:53 INFO - PROCESS | 30259 | 08:35:54 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:43868/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43868/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:35:55 INFO - PROCESS | 30259 | RSS: Main: 230461440 08:35:55 INFO - PROCESS | 30259 | 08:35:57 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:43868/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43868/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:35:58 INFO - PROCESS | 30259 | RSS: Main: 239411200 08:35:58 INFO - PROCESS | 30259 | 08:36:00 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:43868/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:36:01 INFO - PROCESS | 30259 | RSS: Main: 242663424 08:36:01 INFO - PROCESS | 30259 | 08:36:04 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:43868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:36:04 INFO - PROCESS | 30259 | RSS: Main: 243544064 08:36:04 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | Cycle 1(1): loaded http://localhost:43868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43868/tests/kraken/driver.html?testName=ai-astar) 08:36:06 INFO - PROCESS | 30259 | RSS: Main: 286724096 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | __start_tp_report 08:36:06 INFO - PROCESS | 30259 | _x_x_mozilla_page_load 08:36:06 INFO - PROCESS | 30259 | _x_x_mozilla_page_load_details 08:36:06 INFO - PROCESS | 30259 | |i|pagename|runs| 08:36:06 INFO - PROCESS | 30259 | |0;ai-astar;110;106;110;109;110;111;109;109;110;110 08:36:06 INFO - PROCESS | 30259 | |1;audio-beat-detection;155;129;125;187;129;130;152;124;187;125 08:36:06 INFO - PROCESS | 30259 | |2;audio-dft;159;160;161;158;159;160;160;161;161;162 08:36:06 INFO - PROCESS | 30259 | |3;audio-fft;74;75;75;125;75;76;75;75;102;74 08:36:06 INFO - PROCESS | 30259 | |4;audio-oscillator;85;95;116;85;85;86;131;87;86;130 08:36:06 INFO - PROCESS | 30259 | |5;imaging-gaussian-blur;116;117;117;116;117;117;118;117;117;117 08:36:06 INFO - PROCESS | 30259 | |6;imaging-darkroom;146;146;147;149;147;146;146;148;146;147 08:36:06 INFO - PROCESS | 30259 | |7;imaging-desaturate;95;95;96;95;94;94;95;95;95;95 08:36:06 INFO - PROCESS | 30259 | |8;json-parse-financial;54;53;52;54;53;53;55;53;53;53 08:36:06 INFO - PROCESS | 30259 | |9;json-stringify-tinderbox;62;62;63;62;62;62;62;63;63;62 08:36:06 INFO - PROCESS | 30259 | |10;stanford-crypto-aes;81;87;80;80;80;82;81;82;110;82 08:36:06 INFO - PROCESS | 30259 | |11;stanford-crypto-ccm;129;122;120;118;120;120;119;120;148;124 08:36:06 INFO - PROCESS | 30259 | |12;stanford-crypto-pbkdf2;162;163;164;161;164;180;166;163;163;162 08:36:06 INFO - PROCESS | 30259 | |13;stanford-crypto-sha256-iterative;62;63;63;63;62;64;63;66;65;61 08:36:06 INFO - PROCESS | 30259 | __end_tp_report 08:36:06 INFO - PROCESS | 30259 | __start_cc_report 08:36:06 INFO - PROCESS | 30259 | _x_x_mozilla_cycle_collect,1663 08:36:06 INFO - PROCESS | 30259 | __end_cc_report 08:36:06 INFO - PROCESS | 30259 | __startTimestamp1466523366669__endTimestamp 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | ------- Summary: start ------- 08:36:06 INFO - PROCESS | 30259 | Number of tests: 14 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.35 (1.2%) stddev-sans-first:1.41 08:36:06 INFO - PROCESS | 30259 | Values: 110.0 106.0 110.0 109.0 110.0 111.0 109.0 109.0 110.0 110.0 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:141.00 stddev:25.06 (17.8%) stddev-sans-first:26.27 08:36:06 INFO - PROCESS | 30259 | Values: 155.0 129.0 125.0 187.0 129.0 130.0 152.0 124.0 187.0 125.0 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:1.20 (0.7%) stddev-sans-first:1.20 08:36:06 INFO - PROCESS | 30259 | Values: 159.0 160.0 161.0 158.0 159.0 160.0 160.0 161.0 161.0 162.0 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:17.17 (22.9%) stddev-sans-first:17.93 08:36:06 INFO - PROCESS | 30259 | Values: 74.0 75.0 75.0 125.0 75.0 76.0 75.0 75.0 102.0 74.0 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:85.50 stddev:19.32 (22.6%) stddev-sans-first:19.85 08:36:06 INFO - PROCESS | 30259 | Values: 85.0 95.0 116.0 85.0 85.0 86.0 131.0 87.0 86.0 130.0 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 08:36:06 INFO - PROCESS | 30259 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 08:36:06 INFO - PROCESS | 30259 | Values: 146.0 146.0 147.0 149.0 147.0 146.0 146.0 148.0 146.0 147.0 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:36:06 INFO - PROCESS | 30259 | Values: 95.0 95.0 96.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:0.82 (1.6%) stddev-sans-first:0.83 08:36:06 INFO - PROCESS | 30259 | Values: 54.0 53.0 52.0 54.0 53.0 53.0 55.0 53.0 53.0 53.0 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 08:36:06 INFO - PROCESS | 30259 | Values: 62.0 62.0 63.0 62.0 62.0 62.0 62.0 63.0 63.0 62.0 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:81.50 stddev:9.19 (11.3%) stddev-sans-first:9.66 08:36:06 INFO - PROCESS | 30259 | Values: 81.0 87.0 80.0 80.0 80.0 82.0 81.0 82.0 110.0 82.0 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:121.00 stddev:9.01 (7.4%) stddev-sans-first:9.37 08:36:06 INFO - PROCESS | 30259 | Values: 129.0 122.0 120.0 118.0 120.0 120.0 119.0 120.0 148.0 124.0 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:163.50 stddev:5.51 (3.4%) stddev-sans-first:5.75 08:36:06 INFO - PROCESS | 30259 | Values: 162.0 163.0 164.0 161.0 164.0 180.0 166.0 163.0 163.0 162.0 08:36:06 INFO - PROCESS | 30259 | 08:36:06 INFO - PROCESS | 30259 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.48 (2.3%) stddev-sans-first:1.50 08:36:06 INFO - PROCESS | 30259 | Values: 62.0 63.0 63.0 63.0 62.0 64.0 63.0 66.0 65.0 61.0 08:36:06 INFO - PROCESS | 30259 | -------- Summary: end -------- 08:36:06 INFO - PROCESS | 30259 | 08:36:07 INFO - TEST-INFO | 30259: exit 0 08:36:07 INFO - TEST-OK | kraken | took 61064ms 08:36:07 INFO - SUITE-END | took 1174s 08:36:07 INFO - Completed test suite (00:19:34) 08:36:07 INFO - javascript benchmark 08:36:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3034.120105169501, 3036.301650620357, 3037.0736925237793, 3047.5123980163166, 3093.938121237575, 5103.413107492639, 5168.664036837603, 5175.637705360617, 5221.112410890149, 5262.842114736559, 5199.14214154664, 5249.107651699211, 5256.973715131428, 5267.26258323835, 5339.786408543654, 4718.882027949295, 4771.665983381165, 4792.520747925215, 4796.952030479702, 4874.488178741234, 4827.541383568555, 4829.0, 4884.853454396374, 4894.583960363373, 4936.3829521309835, 4581.1753884300815, 4617.561331673485, 4636.0, 4733.715977041371, 4738.6446016548725, 4685.906281874343, 4690.413698287714, 4691.15559199344, 4695.5304469552775, 4703.035877645075, 4665.2768820832825, 4666.23007203811, 4672.719636821767, 4675.579197872174, 4692.882677933045, 5206.557442617382, 5229.686218826882, 5252.6323157379, 5271.787488877541, 5284.339457567804, 5619.185218143346, 5660.915086273709, 5667.914981275284, 5674.744636491368, 5680.4319568043275, 5494.752736126884, 5583.637063590853, 5601.383847776741, 5715.2855893013375, 5728.799492017801, 5275.577953763728, 5300.072487314743, 5304.734763261821, 5314.867128321785, 5314.97342513285, 5687.658740475585, 5708.0, 5730.484256416859, 5752.07966725322, 5788.971055144697, 5339.973300133553, 5531.585131115183, 5549.0, 5576.888462230732, 5618.803341883015, 5621.943780562224, 5630.211770352154, 5670.206171136044, 5683.062294721325, 5685.317761868602, 5601.663900166003, 5606.85982850432, 5613.971930140323, 5615.691136987423, 5617.662940223599, 5449.972750136224, 5546.445355464502, 5555.694436805934, 5559.805406810823, 5561.165825126263, 4289.206496798102, 4307.719998200107, 4308.267594508941, 4313.202057619288, 4346.543612920661, 3819.0, 3866.7873266970587, 3875.7093218008763, 3886.436466712311, 3921.2353591049473, 5161.122609156378, 5248.422673505911, 5283.049051170826, 5292.311999440049, 5326.307580014573, 5626.634268772516, 5638.577106717013, 5638.605297629127, 5642.23829782974, 5657.80197693087, 5159.819406320761, 5314.7608357624, 5316.973415132899, 5318.601104917147, 5321.920171197435, 4812.663113582015, 4857.4171099467585, 4871.610271178297, 4878.707277563358, 4880.877978050577, 5848.181254624356, 5855.765769369177, 5856.853578660568, 5857.355690874, 5865.501432378295, 5392.892142157057, 5539.639923405127, 5581.6371935824045, 5608.747606357805, 5695.629784064023, 5749.482546570829, 5793.91309130355, 5803.158542011301, 5809.883802323845, 5865.149553314831, 5486.945130548644, 5488.945110548843, 5493.340799104133, 5494.423085575957, 5501.312335958005, 5407.080796264723, 5525.861853453695, 5557.472040156179, 5572.247746554163, 5584.776608935597, 5422.810201642924, 5422.810201642924, 5435.592330575302, 5437.0, 5484.341878974548, 5423.837284881302, 5424.83725488236, 5438.45615438453, 5448.427915068861, 5505.476979686923, 5159.613029022913, 5345.839624811262, 5351.545118664957, 5351.652142610717, 5366.087765080024, 5540.085885828954, 5592.356878958972, 5599.552035837205, 5601.887962240651, 5611.859703507445, 5410.080286351251, 5422.783088676409, 5424.159255315432, 5432.022235997559, 5437.646552974044], "value": 5166.329853807942, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.7594286342597, 616.8272883592596, 624.7219987105739, 635.2821311917533, 639.264845427758, 31293.21766955827, 34859.65140348596, 41672.16655666889, 42428.363574546405, 42452.0, 43652.56347436525, 44244.0, 44276.557234427644, 44367.3344899826, 44372.3344149838, 8818.51498167599, 8945.507997060158, 8979.640814367418, 9006.819863602725, 9011.27909767217, 8838.116188381142, 8927.241184499326, 8933.374663773538, 8940.32947528938, 8943.284537237005, 8904.243139333132, 8947.105289471034, 8949.105089491064, 8974.192322690957, 9009.95495022524, 8864.556772161399, 8882.911170888274, 8895.199432051082, 8908.465492070432, 8910.0, 8842.778930526789, 8869.911300886974, 8919.0, 8952.104789521061, 8958.507282099481, 41241.38137927934, 41565.01219853607, 41638.1672366551, 41652.79173604143, 41674.79162604198, 3638.5451818522683, 3737.3459644562363, 3752.81235938202, 3784.526934133233, 4024.979875100635, 31718.0, 32260.677393226, 32462.0, 33786.1553461163, 33835.32329353424, 4305.935410968838, 4327.17783621111, 4342.522322544518, 4363.934540981888, 4389.758563279019, 334926.0, 336570.0, 336684.0, 337025.0, 337338.0, 47995.0, 52995.47004529982, 54827.0, 55789.0, 55802.162967555516, 54014.0, 54570.0, 54574.0, 54630.0, 54671.72664136654, 15179.468718594797, 15360.0, 15364.539063828102, 15368.0, 15368.154751488775, 10723.356598604109, 11426.143039272089, 11654.18420710559, 11724.120690948213, 11829.0, 15539.689206215813, 15583.0, 15726.370945162065, 15740.0, 15741.527754167393, 5982.461578457873, 6170.969145154246, 6173.81478555644, 6327.209098862642, 6473.546851720429, 1003.7390278527636, 1036.1192985961873, 1080.400377790334, 1138.2373809547623, 1154.3016475032484, 31248.531272030938, 31894.0, 32004.519932201034, 32332.191695207806, 32627.67372326294, 1080.3193987787643, 1100.6753007862699, 1125.5705254327122, 1141.0814294493014, 1150.7928572856965, 16521.504354869372, 16878.493645190665, 16931.238094285785, 17066.57333566646, 17213.483595492155, 534725.0, 538638.0, 538937.0, 539299.0, 543135.0, 56912.0, 56990.43009569934, 57020.0, 57186.0, 57401.712991434775, 1294.6245588779148, 1336.6334168314227, 1340.879320861127, 1347.4408120630026, 1357.9660508487366, 30827.383452331276, 31378.372432551678, 31630.892918747733, 31635.89274375386, 31791.36417271688, 50108.0, 50667.23999139942, 50727.74636126796, 50784.98430031453, 50796.49203507917, 430911.0, 433801.0, 440876.0, 442098.0, 445786.0, 43043.13913721771, 44184.33723494215, 44310.55689443193, 44711.65865024055, 45359.0, 47434.76282618565, 48030.279545806145, 48127.0, 49071.0, 49306.26040609322, 40262.39606405965, 40462.1907561853, 41847.005911973305, 41969.16061678688, 42069.57930420779, 40512.59487405206, 40789.796051019555, 41010.1797964045, 41184.79407603063, 41371.0, 40528.1894362117, 40555.59444405518, 41222.38166427446, 41457.37813932854, 44237.33643995407, 31878.52182217222, 35825.820870896525, 35975.460368095024, 36634.26731465409, 36650.8167459161, 27516.58725119085, 27843.303917402227, 27940.58089128624, 27977.44045119127, 28377.43245135127], "value": 19959.530416213172, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.8100949525238, 381.4678523459775, 392.4936831487381, 398.5038626909498, 409.16530278232386, 17554.561135971606, 19255.51861203467, 20073.59852802943, 20207.49481262969, 20218.39344819656, 18392.0, 18777.624447511076, 19090.23639054436, 19092.33176838811, 19101.42695719127, 5562.332520097594, 5600.52395546378, 5774.971125144369, 5812.447817457356, 5830.533557315404, 5637.774489020434, 5692.0, 5713.14302854571, 5729.0, 5751.856203594923, 5500.779968801243, 5704.916065947477, 5717.828465146053, 5784.768609255625, 5790.305163380401, 5677.914831277534, 5705.25831641886, 5716.485516303553, 5721.313442386899, 5732.79935202268, 5055.6713813602, 5063.0380227756605, 5068.543831055223, 5104.412992505835, 5115.283860259567, 18933.242670293173, 19122.617547649108, 20604.690929636068, 22754.88622556893, 22760.089596416125, 2218.8003079722903, 2278.316505048479, 2497.4131079196372, 2539.619057141425, 2892.739653431201, 13934.51229206983, 14086.084404513675, 14406.0, 14425.422983080663, 14988.0, 1943.2129987355002, 1958.128632758423, 1960.2159136345576, 2004.8095430934184, 2094.1309356616985, 79350.20649793487, 79643.6017819913, 79695.20304796936, 79985.60007199927, 80923.0, 10294.588216471408, 10506.317089389166, 10654.414007229676, 10681.679549613524, 10880.12958963281, 14805.333759980827, 14894.0, 14921.463351230317, 14925.0, 14928.925355373154, 7523.661435235427, 7536.7362142324755, 7544.735934242385, 7595.240475952471, 7676.769696909102, 7181.461390395742, 7245.710171593183, 7334.889976650355, 7478.663460144307, 7520.849583008309, 6404.775832845921, 6520.771772988018, 6609.0, 6631.801045968628, 6633.933660663428, 1884.9434516964513, 1903.790583035865, 1905.771307443088, 1925.419937284046, 1973.6842105263377, 912.8904531456135, 1007.2143727892255, 1007.29992655104, 1041.037040737315, 1062.8937106289309, 19379.224831006883, 19440.61118777645, 19448.70826937597, 19478.318258860872, 19897.900510497646, 998.8801343838786, 1009.2733232072895, 1010.6816352848829, 1057.4395570347729, 1085.6308854989184, 10764.246502744889, 11308.208425410143, 11334.716632084099, 11435.542578296774, 11506.252093613888, 356985.0, 364118.0, 365371.0, 470456.0, 517107.0, 60967.390326096174, 61217.693911531045, 95802.0, 98131.0, 100055.0, 991.2367477042637, 999.5901680311038, 1038.8182068138046, 1041.385582506325, 1044.5926088825365, 11735.0, 16330.265138068578, 16892.40876569363, 16921.830781692024, 17863.0, 38518.80740596279, 39617.40573891452, 39748.0, 39773.801130995314, 42291.36562951496, 48762.5123748758, 54720.17919731128, 55100.0, 55448.0, 56008.0, 7656.885146722692, 7665.118511371264, 7676.078870535348, 8130.105688374156, 8653.350998674998, 9380.624775008922, 12910.67723306925, 13322.33388330599, 13656.248906310248, 14112.50606228777, 11666.416679166177, 11880.287182769061, 12081.637550873487, 12156.513739450324, 12359.443825028075, 11344.376059316817, 11682.47428865686, 12206.81689774672, 12213.511459541875, 12443.253404795742, 12352.4441400139, 12509.18690285165, 12633.178843375152, 12694.492220311453, 12712.491500339884, 7292.927070729437, 7534.924650753423, 7636.389088872988, 8306.04480484752, 8559.186877246651, 11658.0, 11839.704007399883, 11890.34603096838, 11996.58011969577, 12056.336901470153], "value": 9195.300023835707, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.405107573902, 1406.5991192510132, 1433.104309806371, 1499.7600383938566, 1701.8893771904834, 7445.776626701194, 7834.843303133941, 7855.018122734666, 8016.038075430956, 8021.0, 7768.805779855506, 7929.92070079299, 7936.801579960504, 7948.801279968004, 7953.204679532058, 2008.6183625111255, 2155.536559639673, 2186.8578542394694, 2204.691343211952, 2280.270313499681, 2271.8523295985706, 2306.9077236910503, 2308.088305119477, 2309.180241014441, 2310.9075636974585, 2262.049939025613, 2269.6595510673365, 2293.8967746451367, 2294.3117064880553, 2296.7358753743283, 1971.447994561525, 2137.551114266006, 2168.111074459472, 2203.151786562185, 2208.9889550552307, 2202.427368884086, 2218.7559368469456, 2221.7222847144108, 2224.154821167946, 2226.265332440291, 7836.451448398614, 7948.046234451845, 7949.1653376395225, 7954.920450795534, 7956.045274567031, 4667.486576476585, 4785.066911952171, 4787.8563643090765, 4790.856274311776, 4793.7363445010515, 3075.6463006754284, 3179.77741558091, 3209.486482162866, 3245.610526736783, 3264.135004223883, 1074.4305518075432, 1099.1371773158112, 1123.5449642894641, 1134.8297755336682, 1135.9772804543945, 10131.949340253252, 10221.33561318512, 10237.9488102559, 10273.972602739741, 10327.122194613392, 4177.811998460016, 4227.7463352198965, 4302.720323178984, 4348.108637729258, 4354.346847972766, 8960.372773905894, 9029.729108126767, 9032.096790320915, 9033.457992520469, 9045.366824322235, 4846.80612775485, 4847.054824309226, 4849.4908034656555, 4852.102361063215, 4853.39332583427, 4024.778637174925, 4325.891852703645, 4451.710638808467, 4457.64338852891, 4540.704854184468, 3665.2119794244363, 3736.3834967230105, 3757.7181711371754, 3846.1346197105427, 3881.6802287221917, 1191.53530123252, 1235.6540168752763, 1240.2558464920976, 1257.220523275575, 1258.3205069262679, 829.850626887154, 844.4595458906305, 849.2823564088335, 916.326500022483, 947.3510645208055, 5607.803726869622, 5608.1587761835235, 5767.336756272998, 5874.118882167709, 5960.6721630309885, 433.97179183352984, 436.4871276250393, 438.95829896159813, 445.29643163801114, 462.4058085360296, 4012.237674841829, 4116.115035267372, 4116.876493705194, 4125.463689720317, 4254.042840360894, 9325.533723313807, 9542.188913942255, 9591.760205994906, 9666.275029372826, 9673.467959262309, 9549.0, 9595.520223988773, 9602.567884445216, 9608.807823843485, 9633.518324083769, 7084.25615310385, 7305.671244793997, 7378.96310518444, 7440.9627951860975, 7456.1798202197715, 5421.918671219856, 5467.890642187054, 5474.452554744494, 5513.944860551504, 5606.299212598426, 8905.0, 8960.238379737535, 9044.819103618023, 9067.773305667411, 9075.13786190311, 8935.419197752126, 8967.686130985385, 9227.953860230657, 9238.399504032217, 9243.722688319362, 6463.870722585616, 6771.864562708817, 6931.272216417204, 7123.180834204133, 7210.351068403869, 7633.084029916446, 7685.346745526693, 7702.961485192763, 7747.070351557849, 7755.650995705094, 6933.757318493828, 6968.581885086911, 7091.539049961736, 7191.8561628768175, 7211.3870321023305, 6860.6912688930115, 6942.340477654615, 6994.195667498303, 7051.153861536648, 7057.50597458173, 6366.458850997532, 6395.401149712572, 6487.253965793994, 6509.121268628674, 6538.444232240313, 4733.715977041388, 4947.0, 4966.701997880139, 4979.800807967786, 5048.772805223847, 4859.0, 4934.259861020875, 4937.28409380645, 4944.1100601892, 4971.552560269593], "value": 4210.314521747876, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.24387786655495, 307.472684346346, 308.4032397311203, 308.86255616250764, 314.8882146837874, 5333.0, 5348.465153484654, 5377.274068000819, 5395.568354531638, 5431.674099554019, 5274.156135018397, 5282.656627319221, 5290.153575427932, 5333.813316533912, 5339.946600533994, 3905.960940390595, 3918.275119102975, 4027.8319287406616, 4031.0, 4042.019410488854, 4028.415879697442, 4042.43405923171, 4042.4744783178144, 4073.2464494068545, 4077.9592204077876, 3949.0, 3950.940735888964, 3968.56345801963, 3992.421098940652, 4021.718479706422, 3898.200868821885, 4030.4684219996507, 4048.716589838727, 4055.7972101395108, 4084.5711200323835, 3535.5757309122814, 3548.574171099459, 3561.71506279497, 3571.1786289153642, 3576.856925722968, 5090.694558326475, 5148.897022059576, 5202.141646628302, 5203.505666961671, 5209.8017455984955, 4424.889377765549, 4601.631869450436, 4639.791209395586, 4643.489216186217, 4681.391419115494, 5431.2396264522995, 5472.181826359428, 5489.258950041733, 5508.669479831183, 5523.889522209533, 3851.9037024074623, 3881.359575670011, 3888.6111388861173, 3890.358090915024, 3902.1610353774076, 5542.307211598551, 5734.684592347419, 5760.423957604206, 5792.68140252286, 5804.796832110856, 3940.940885886714, 3945.704072194597, 3955.367141257385, 3962.583928687504, 3963.504561929759, 3971.205758848242, 3998.8600398985895, 4008.518977722692, 4018.9148929788794, 4020.3165461871554, 4606.019411652955, 4625.791839367236, 4632.62938964882, 4633.328167415706, 4636.9536304637195, 5417.133258678593, 5494.697791621419, 5540.889182216333, 5562.3591040643105, 5578.609497335228, 1329.1094966372555, 1367.596559015093, 1371.6776557508977, 1376.0711519724146, 1385.5981765288154, 873.7815546113471, 889.5374405309203, 889.5596679643618, 895.6686026170358, 919.7240827751648, 5236.188390799432, 5236.607254455931, 5251.6061295403, 5263.894722105613, 5281.788728450896, 5504.926539324873, 5523.28197334344, 5532.6680399176175, 5540.36285827127, 5559.63862348946, 5060.291559181717, 5152.0726269271145, 5205.9219111713355, 5234.816781412708, 5254.264402983586, 2948.189247956786, 2953.8818447262297, 2973.36072744361, 2980.672126066131, 2985.4178435205363, 5815.354013923655, 5826.591444005219, 5831.446012628793, 5854.795082172103, 5865.149553314831, 5460.208269800856, 5673.744681489343, 5680.488756011979, 5681.159420289855, 5682.630629009184, 5786.218860453869, 5790.654784812158, 5820.650760954356, 5827.621204621686, 5856.502197313276, 5360.41035486104, 5597.440255974533, 5607.915881261702, 5621.3698027571545, 5708.828735137952, 5634.549236061187, 5635.267415235993, 5702.51528620072, 5704.229928959538, 5711.771529138788, 5850.765969361348, 5879.176915231957, 5880.206172166702, 5895.410458954242, 5955.880882382241, 3854.730168888263, 3937.92124157521, 3940.5468371137686, 3941.704372172156, 3945.2109578083923, 5622.690752008679, 5643.830685079454, 5662.47113279404, 5665.433456654301, 5704.885902282014, 5511.22842802, 5537.9169312459535, 5541.503793975685, 5542.473465020817, 5565.0, 5236.528712415901, 5505.6696598204235, 5520.889582208413, 5527.640703354269, 5529.585281103853, 5203.060270946903, 5456.918146227889, 5457.181422786613, 5473.917891231715, 5481.917771233355, 5397.109476936419, 5547.972260138674, 5553.500184983371, 5602.775888964559, 5606.607537472338, 5406.621536492407, 5465.316835395575, 5468.781248750164, 5469.398366179637, 5480.424555421623], "value": 4165.9491879634925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.2863001313693, 733.9722898147687, 762.1882694929899, 778.7352300217925, 784.6469088909989, 14740.926295368521, 15377.615559611015, 15513.379464821393, 16099.919500402497, 16205.270762815688, 14543.927280363583, 14708.852911470882, 14766.63083422915, 14876.107433553994, 14885.25573721315, 686.2999740264927, 785.19909692114, 810.6392655268407, 824.7113510271387, 825.0594322472386, 768.8347005393839, 776.6311002273903, 788.5938741548107, 805.7059173401695, 806.04483686831, 857.4640849469082, 858.6908712863365, 859.6002858670716, 860.2601762484259, 860.6256278518864, 707.3386383731176, 712.6828561290228, 855.5551113421018, 855.9400841941098, 856.5032281276845, 583.9970800145973, 602.4246844263718, 610.1793088296234, 615.1879519034876, 615.3231445410013, 14718.852811471963, 14824.0, 15398.153101579408, 15422.383104675911, 15450.9227453862, 13880.236586987712, 14152.85847141536, 14222.041536730045, 14549.817527370978, 14694.412223511046, 12545.0, 12630.368481575977, 12727.87272127276, 12923.612291631172, 13251.602451926457, 4399.934000989988, 4485.753283569403, 4563.429571303587, 4634.39752832133, 4661.720296782204, 72575.0, 72963.0, 73026.63486682586, 73081.26918730851, 73086.26913730848, 11197.72005699864, 11417.0, 11569.479373428048, 11739.647810565697, 11941.164118511795, 20497.692534611993, 20641.277555285495, 20690.068946897427, 20699.172033118808, 20701.27545535899, 8403.285720713686, 8438.282745966662, 8617.655293788304, 8651.178138076873, 8721.0, 4732.0, 4750.477447480775, 4798.1123492154065, 4840.661153719206, 5068.214426763858, 3444.2422667013216, 3527.188746588299, 3539.5398598182587, 3546.078019714893, 3556.893293201208, 627.4290395739855, 634.1027446163627, 638.4796390941368, 638.8658381739793, 640.3820313397594, 661.9172603424572, 662.8442316055723, 665.6904539389208, 674.4705406256163, 677.2550194785795, 8906.910930890608, 9041.457512549268, 9079.68221112258, 9230.35387522867, 9612.51937403127, 624.8281722526342, 708.8298808285974, 709.2446544430165, 756.1115689065326, 779.2713812585138, 4369.816505540679, 4642.65180111493, 4682.695624784378, 4712.0, 4819.975900120477, 108590.72202021797, 109425.0, 111932.0, 113683.43158284322, 114664.42667786774, 96679.51660241654, 100552.0, 100790.0, 101410.0, 102566.48716756368, 70824.64587677029, 73014.63492682608, 78138.21861781423, 82188.58905705553, 82407.0, 9905.851412228678, 10284.588616455558, 10294.639687610897, 10305.896941030494, 10472.68581942543, 47595.81254436901, 47862.76068619634, 49459.0, 49711.75144124256, 50498.74750626223, 67676.323236767, 74346.62826686048, 75644.0, 76612.2338776605, 76757.23242767724, 12480.625581232578, 12686.238825670489, 12692.809607855705, 12731.490740370651, 13649.38577763983, 14880.7767883484, 15094.0, 15170.620734481727, 15997.1201583914, 16058.919705401866, 9955.751106222402, 13552.267112519889, 13998.790018149939, 14088.577342679737, 14389.928050359682, 13918.58244252674, 14371.0, 14473.0, 14776.77834832457, 15379.769303460233, 13900.652483687989, 13951.0, 14142.22217778032, 14314.427422902967, 14812.259387030821, 11029.61396351124, 11291.491882865126, 11928.284302941851, 12053.469456665045, 12530.833254750956, 11348.432578371214, 12183.573574924834, 12283.815742763687, 12323.44544495482, 12421.0], "value": 7582.617637932325, "unit": "score"}], "name": "dromaeo_css", "value": 7081.620153168549, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 110.0, 109.0, 110.0, 111.0, 109.0, 109.0, 110.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 125.0, 187.0, 129.0, 130.0, 152.0, 124.0, 187.0, 125.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 161.0, 158.0, 159.0, 160.0, 160.0, 161.0, 161.0, 162.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 125.0, 75.0, 76.0, 75.0, 75.0, 102.0, 74.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 95.0, 116.0, 85.0, 85.0, 86.0, 131.0, 87.0, 86.0, 130.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 149.0, 147.0, 146.0, 146.0, 148.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 54.0, 53.0, 53.0, 55.0, 53.0, 53.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 87.0, 80.0, 80.0, 80.0, 82.0, 81.0, 82.0, 110.0, 82.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 122.0, 120.0, 118.0, 120.0, 120.0, 119.0, 120.0, 148.0, 124.0], "value": 124.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 161.0, 164.0, 180.0, 166.0, 163.0, 163.0, 162.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 62.0, 64.0, 63.0, 66.0, 65.0, 61.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1505.7, "alertThreshold": 2.0}]} 08:36:07 INFO - Return code: 0 08:36:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:36:07 INFO - # TBPL SUCCESS # 08:36:07 INFO - Running post-action listener: _resource_record_post_action 08:36:07 INFO - ##### 08:36:07 INFO - ##### Finished run-tests step (success) 08:36:07 INFO - ##### 08:36:07 INFO - Running post-run listener: _resource_record_post_run 08:36:08 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 561692672; Read time: 36; Write time: 490852 08:36:08 INFO - TinderboxPrint: CPU usage
13.2% 08:36:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 36 08:36:08 INFO - TinderboxPrint: I/O write bytes / time
561,692,672 / 490,852 08:36:08 INFO - TinderboxPrint: CPU idle
8,265.8 (86.8%) 08:36:08 INFO - TinderboxPrint: CPU user
1,207.5 (12.7%) 08:36:08 INFO - TinderboxPrint: Swap in / out
0 / 0 08:36:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 266235904; Read time: 0; Write time: 289732 08:36:08 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295456768; Read time: 36; Write time: 201120 08:36:08 INFO - Running post-run listener: _upload_blobber_files 08:36:08 INFO - Blob upload gear active. 08:36:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:36:08 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 08:36:08 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:36:08 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:36:09 INFO - (blobuploader) - INFO - Open directory for files ... 08:36:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:36:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:36:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:09 INFO - (blobuploader) - INFO - Done attempting. 08:36:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:36:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:36:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:13 INFO - (blobuploader) - INFO - Done attempting. 08:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:14 INFO - (blobuploader) - INFO - Done attempting. 08:36:14 INFO - (blobuploader) - INFO - Iteration through files over. 08:36:14 INFO - Return code: 0 08:36:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:36:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:36:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba5bb2735aa678f8c6b1e922bec5ee8a010619a029499fba3c888d75a1734c540a81e693eaf847c74e9113d290a2a8266bdf49f50f6a2fdd6aea24dec8fd43f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dbc25475f925f971a9e6da719a10c6df5106a06a39e1d3ba0fbfe5e34955794632a9d45904319830e26879ca1ce80806161402ff420e1ca1ddfb1c50c727250", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f890814efd5b678dc6e7fcd18d9b7711bbe8203166ff2845f4444068cb62bd4d05870519c50eab0ead6740f1565a758d92e582bc164defb24d089664f7031d48"} 08:36:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:36:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:36:14 INFO - Contents: 08:36:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba5bb2735aa678f8c6b1e922bec5ee8a010619a029499fba3c888d75a1734c540a81e693eaf847c74e9113d290a2a8266bdf49f50f6a2fdd6aea24dec8fd43f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dbc25475f925f971a9e6da719a10c6df5106a06a39e1d3ba0fbfe5e34955794632a9d45904319830e26879ca1ce80806161402ff420e1ca1ddfb1c50c727250", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f890814efd5b678dc6e7fcd18d9b7711bbe8203166ff2845f4444068cb62bd4d05870519c50eab0ead6740f1565a758d92e582bc164defb24d089664f7031d48"} 08:36:14 INFO - Running post-run listener: copy_logs_to_upload_dir 08:36:14 INFO - Copying logs to upload dir... 08:36:14 INFO - mkdir: /builds/slave/test/build/upload/logs 08:36:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.720577 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-21 08:36:14.672211) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 08:36:14.675467) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490 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/sha512/ba5bb2735aa678f8c6b1e922bec5ee8a010619a029499fba3c888d75a1734c540a81e693eaf847c74e9113d290a2a8266bdf49f50f6a2fdd6aea24dec8fd43f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dbc25475f925f971a9e6da719a10c6df5106a06a39e1d3ba0fbfe5e34955794632a9d45904319830e26879ca1ce80806161402ff420e1ca1ddfb1c50c727250", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f890814efd5b678dc6e7fcd18d9b7711bbe8203166ff2845f4444068cb62bd4d05870519c50eab0ead6740f1565a758d92e582bc164defb24d089664f7031d48"} build_url:https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/PI7LepIuRdKpv2_htn7L3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba5bb2735aa678f8c6b1e922bec5ee8a010619a029499fba3c888d75a1734c540a81e693eaf847c74e9113d290a2a8266bdf49f50f6a2fdd6aea24dec8fd43f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dbc25475f925f971a9e6da719a10c6df5106a06a39e1d3ba0fbfe5e34955794632a9d45904319830e26879ca1ce80806161402ff420e1ca1ddfb1c50c727250", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f890814efd5b678dc6e7fcd18d9b7711bbe8203166ff2845f4444068cb62bd4d05870519c50eab0ead6740f1565a758d92e582bc164defb24d089664f7031d48"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 08:36:14.704400) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:36:14.705066) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466520475.706-1282979490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:36:14.786429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 08:36:14.786926) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 08:36:14.787369) ========= ========= Total master_lag: 0.18 =========