builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1465505073.88 results: success (0) buildid: 20160609031135 builduid: b7e12a9c3411425faa1664d3e023b6f5 revision: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:33.878183) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:33.878683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:33.878961) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:33.893634) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:33.894232) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 13:44:34-- 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% 226M=0s 2016-06-09 13:44:34 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076937 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:33.985962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:33.986295) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014963 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:34.036395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:34.036778) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 --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=a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 13:44:34,345 truncating revision to first 12 chars 2016-06-09 13:44:34,345 Setting DEBUG logging. 2016-06-09 13:44:34,345 attempt 1/10 2016-06-09 13:44:34,345 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1ae7a82e2b1d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 13:44:34,647 unpacking tar archive at: mozilla-aurora-1ae7a82e2b1d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638844 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:34.689075) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:34.689410) ========= script_repo_revision: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:34.689808) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:34.690074) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 13:44:34.697829) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-09 13:44:34.698150) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:44:35 INFO - MultiFileLogger online at 20160609 13:44:35 in /builds/slave/test 13:44:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:44:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:44:35 INFO - {'append_to_log': False, 13:44:35 INFO - 'base_work_dir': '/builds/slave/test', 13:44:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:44:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:44:35 INFO - 'branch': 'Mozilla-Aurora', 13:44:35 INFO - 'buildbot_json_path': 'buildprops.json', 13:44:35 INFO - 'config_files': ('talos/linux_config.py',), 13:44:35 INFO - 'default_actions': ('clobber', 13:44:35 INFO - 'read-buildbot-config', 13:44:35 INFO - 'download-and-extract', 13:44:35 INFO - 'populate-webroot', 13:44:35 INFO - 'create-virtualenv', 13:44:35 INFO - 'install', 13:44:35 INFO - 'run-tests'), 13:44:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:44:35 INFO - 'download_minidump_stackwalk': True, 13:44:35 INFO - 'download_symbols': 'ondemand', 13:44:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:44:35 INFO - 'tooltool.py': '/tools/tooltool.py', 13:44:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:44:35 INFO - '/tools/misc-python/virtualenv.py')}, 13:44:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:44:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:44:35 INFO - 'installer_path': 'installer.exe', 13:44:35 INFO - 'log_level': 'info', 13:44:35 INFO - 'log_name': 'talos', 13:44:35 INFO - 'log_to_console': True, 13:44:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:44:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:44:35 INFO - 'opt_config_files': (), 13:44:35 INFO - 'pip_index': False, 13:44:35 INFO - 'sps_profile': False, 13:44:35 INFO - 'sps_profile_interval': 0, 13:44:35 INFO - 'suite': 'dromaeojs-e10s', 13:44:35 INFO - 'system_bits': '32', 13:44:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:44:35 INFO - 'title': 'talos-linux64-ix-062', 13:44:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:44:35 INFO - 'use_talos_json': True, 13:44:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:44:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:44:35 INFO - 'work_dir': 'build'} 13:44:35 INFO - ##### 13:44:35 INFO - ##### Running clobber step. 13:44:35 INFO - ##### 13:44:35 INFO - Running pre-action listener: _resource_record_pre_action 13:44:35 INFO - Running main action method: clobber 13:44:35 INFO - rmtree: /builds/slave/test/build 13:44:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:44:35 INFO - Running post-action listener: _resource_record_post_action 13:44:35 INFO - ##### 13:44:35 INFO - ##### Finished clobber step (success) 13:44:35 INFO - ##### 13:44:35 INFO - ##### 13:44:35 INFO - ##### Running read-buildbot-config step. 13:44:35 INFO - ##### 13:44:35 INFO - Running pre-action listener: _resource_record_pre_action 13:44:35 INFO - Running main action method: read_buildbot_config 13:44:35 INFO - Using buildbot properties: 13:44:35 INFO - { 13:44:35 INFO - "project": "", 13:44:35 INFO - "product": "firefox", 13:44:35 INFO - "script_repo_revision": "production", 13:44:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:44:35 INFO - "repository": "", 13:44:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:44:35 INFO - "buildid": "20160609031135", 13:44:35 INFO - "pgo_build": "True", 13:44:35 INFO - "basedir": "/builds/slave/test", 13:44:35 INFO - "buildnumber": 360, 13:44:35 INFO - "slavename": "talos-linux64-ix-062", 13:44:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:44:35 INFO - "platform": "ubuntu64_hw", 13:44:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:44:35 INFO - "branch": "mozilla-aurora", 13:44:35 INFO - "repo_path": "releases/mozilla-aurora", 13:44:35 INFO - "revision": "1ae7a82e2b1d2b18ccfa9a578040b46c774bc501", 13:44:35 INFO - "stage_platform": "linux64-pgo", 13:44:35 INFO - "builduid": "b7e12a9c3411425faa1664d3e023b6f5", 13:44:35 INFO - "slavebuilddir": "test" 13:44:35 INFO - } 13:44:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 13:44:35 INFO - Running post-action listener: _resource_record_post_action 13:44:35 INFO - ##### 13:44:35 INFO - ##### Finished read-buildbot-config step (success) 13:44:35 INFO - ##### 13:44:35 INFO - ##### 13:44:35 INFO - ##### Running download-and-extract step. 13:44:35 INFO - ##### 13:44:35 INFO - Running pre-action listener: _resource_record_pre_action 13:44:35 INFO - Running main action method: download_and_extract 13:44:35 INFO - mkdir: /builds/slave/test/build/tests 13:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:35 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:44:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:44:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:44:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:44:36 INFO - Downloaded 1361 bytes. 13:44:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:44:36 INFO - Using the following test package requirements: 13:44:36 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 13:44:36 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:36 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:44:36 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:36 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:44:36 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:36 INFO - u'jsshell-linux-x86_64.zip'], 13:44:36 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:36 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:44:36 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 13:44:36 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:36 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:44:36 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:36 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:44:36 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:36 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:44:36 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:44:36 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:44:36 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:44:36 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')]} 13:44:36 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:44:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:44:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:44:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:44:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:44:37 INFO - Downloaded 24472728 bytes. 13:44:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:44:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:44:38 INFO - Return code: 0 13:44:38 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:38 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:44:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:44:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:44:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:44:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:44:39 INFO - Downloaded 24472728 bytes. 13:44:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:44:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:44:41 INFO - Return code: 0 13:44: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')]} 13:44:41 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:44:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 13:44:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 13:44:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 13:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:44:42 INFO - Downloaded 10833369 bytes. 13:44:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:44:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:44:42 INFO - Return code: 0 13:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:42 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:44:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:44:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:44:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:44:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:44:46 INFO - Downloaded 63540841 bytes. 13:44:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:44:46 INFO - mkdir: /builds/slave/test/properties 13:44:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:44:46 INFO - Writing to file /builds/slave/test/properties/build_url 13:44:46 INFO - Contents: 13:44:46 INFO - build_url:https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:44:46 INFO - Running post-action listener: _resource_record_post_action 13:44:46 INFO - Running post-action listener: set_extra_try_arguments 13:44:46 INFO - ##### 13:44:46 INFO - ##### Finished download-and-extract step (success) 13:44:46 INFO - ##### 13:44:46 INFO - ##### 13:44:46 INFO - ##### Running populate-webroot step. 13:44:46 INFO - ##### 13:44:46 INFO - Running pre-action listener: _resource_record_pre_action 13:44:46 INFO - Running main action method: populate_webroot 13:44:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:44:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:44:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:44:46 INFO - '--tppagecycles', 13:44:46 INFO - '7'], 13:44:46 INFO - 'tests': ['tsvgm']}}, 13:44:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:44:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:44:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:44:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:44:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:44:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:44:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:46 INFO - 'talos_options': ['--disable-e10s'], 13:44:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:44:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:44:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:46 INFO - 'talos_options': ['--disable-e10s'], 13:44:46 INFO - 'tests': ['damp', 'tps']}, 13:44:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:46 INFO - 'tests': ['damp', 'tps']}, 13:44:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:44:46 INFO - 'tests': ['dromaeo_dom']}, 13:44:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:44:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:44:46 INFO - 'tests': ['a11yr', 13:44:46 INFO - 'ts_paint', 13:44:46 INFO - 'tpaint', 13:44:46 INFO - 'sessionrestore', 13:44:46 INFO - 'sessionrestore_no_auto_restore', 13:44:46 INFO - 'tabpaint']}, 13:44:46 INFO - 'other-e10s': {'tests': ['a11yr', 13:44:46 INFO - 'ts_paint', 13:44:46 INFO - 'tpaint', 13:44:46 INFO - 'sessionrestore', 13:44:46 INFO - 'sessionrestore_no_auto_restore', 13:44:46 INFO - 'tabpaint']}, 13:44:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:44:46 INFO - 'ts_paint', 13:44:46 INFO - 'tpaint', 13:44:46 INFO - 'sessionrestore', 13:44:46 INFO - 'sessionrestore_no_auto_restore', 13:44:46 INFO - 'tabpaint']}, 13:44:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:44:46 INFO - 'ts_paint', 13:44:46 INFO - 'tpaint', 13:44:46 INFO - 'sessionrestore', 13:44:46 INFO - 'sessionrestore_no_auto_restore', 13:44:46 INFO - 'tabpaint']}, 13:44:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:44:46 INFO - 'tests': ['a11yr', 13:44:46 INFO - 'ts_paint', 13:44:46 INFO - 'tpaint', 13:44:46 INFO - 'sessionrestore', 13:44:46 INFO - 'sessionrestore_no_auto_restore', 13:44:46 INFO - 'tabpaint']}, 13:44:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:44:46 INFO - 'tests': ['a11yr', 13:44:46 INFO - 'ts_paint', 13:44:46 INFO - 'tpaint', 13:44:46 INFO - 'sessionrestore', 13:44:46 INFO - 'sessionrestore_no_auto_restore', 13:44:46 INFO - 'tabpaint']}, 13:44:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:44:46 INFO - 'tests': ['tsvgx', 13:44:46 INFO - 'tsvgr_opacity', 13:44:46 INFO - 'tart', 13:44:46 INFO - 'tscrollx', 13:44:46 INFO - 'cart']}, 13:44:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:44:46 INFO - 'tsvgr_opacity', 13:44:46 INFO - 'tart', 13:44:46 INFO - 'tscrollx', 13:44:46 INFO - 'cart']}, 13:44:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:46 INFO - 'talos_options': ['--disable-e10s'], 13:44:46 INFO - 'tests': ['tp5o']}, 13:44:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:46 INFO - 'tests': ['tp5o']}, 13:44:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:46 INFO - 'talos_options': ['--disable-e10s', 13:44:46 INFO - '--xperf_path', 13:44:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:44:46 INFO - 'tests': ['tp5n']}, 13:44:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:44:46 INFO - 'talos_options': ['--xperf_path', 13:44:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:44:46 INFO - 'tests': ['tp5n']}}, 13:44:46 INFO - 'talos.zip': {'path': '', 13:44:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:44:46 INFO - Running post-action listener: _resource_record_post_action 13:44:46 INFO - ##### 13:44:46 INFO - ##### Finished populate-webroot step (success) 13:44:46 INFO - ##### 13:44:46 INFO - ##### 13:44:46 INFO - ##### Running create-virtualenv step. 13:44:46 INFO - ##### 13:44:46 INFO - Running pre-action listener: _resource_record_pre_action 13:44:46 INFO - Running main action method: create_virtualenv 13:44:46 INFO - Creating virtualenv /builds/slave/test/build/venv 13:44:46 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 13:44:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:44:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:44:46 INFO - Using real prefix '/usr' 13:44:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:44:47 INFO - Installing distribute.............................................................................................................................................................................................done. 13:44:49 INFO - Installing pip.................done. 13:44:49 INFO - Return code: 0 13:44:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f126eefaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c1c0>, '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 0x203d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203d550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', '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 13:44:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:44:49 INFO - Using env: {'DISPLAY': ':0', 13:44:49 INFO - 'HOME': '/home/cltbld', 13:44:49 INFO - 'LANG': 'en_US.UTF-8', 13:44:49 INFO - 'LANGUAGE': 'en_US:en', 13:44:49 INFO - 'LOGNAME': 'cltbld', 13:44:49 INFO - 'MAIL': '/var/mail/cltbld', 13:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:49 INFO - 'MOZ_NO_REMOTE': '1', 13:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:49 INFO - 'NO_EM_RESTART': '1', 13:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:49 INFO - 'PWD': '/builds/slave/test', 13:44:49 INFO - 'SHELL': '/bin/bash', 13:44:49 INFO - 'SHLVL': '1', 13:44:49 INFO - 'TERM': 'linux', 13:44:49 INFO - 'TMOUT': '86400', 13:44:49 INFO - 'USER': 'cltbld', 13:44:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', 13:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:49 INFO - '_': '/tools/buildbot/bin/python'} 13:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:49 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 13:44:49 INFO - Cleaning up... 13:44:49 INFO - Return code: 0 13:44:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f126eefaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c1c0>, '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 0x203d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203d550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', '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 13:44:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:44:49 INFO - Using env: {'DISPLAY': ':0', 13:44:49 INFO - 'HOME': '/home/cltbld', 13:44:49 INFO - 'LANG': 'en_US.UTF-8', 13:44:49 INFO - 'LANGUAGE': 'en_US:en', 13:44:49 INFO - 'LOGNAME': 'cltbld', 13:44:49 INFO - 'MAIL': '/var/mail/cltbld', 13:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:49 INFO - 'MOZ_NO_REMOTE': '1', 13:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:49 INFO - 'NO_EM_RESTART': '1', 13:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:49 INFO - 'PWD': '/builds/slave/test', 13:44:49 INFO - 'SHELL': '/bin/bash', 13:44:49 INFO - 'SHLVL': '1', 13:44:49 INFO - 'TERM': 'linux', 13:44:49 INFO - 'TMOUT': '86400', 13:44:49 INFO - 'USER': 'cltbld', 13:44:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', 13:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:49 INFO - '_': '/tools/buildbot/bin/python'} 13:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:49 INFO - Downloading/unpacking psutil>=3.1.1 13:44:49 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 13:44:49 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 13:44:49 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 13:44:49 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 13:44:49 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 13:44:49 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 13:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:44:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:52 INFO - Installing collected packages: psutil 13:44:52 INFO - Running setup.py install for psutil 13:44:52 INFO - building 'psutil._psutil_linux' extension 13:44:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:44:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:44:52 INFO - building 'psutil._psutil_posix' extension 13:44:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:44:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:44:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:52 INFO - Successfully installed psutil 13:44:52 INFO - Cleaning up... 13:44:52 INFO - Return code: 0 13:44:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:44: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')]} 13:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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')]} 13:44:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f126eefaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c1c0>, '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 0x203d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203d550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', '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 13:44:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:44:52 INFO - Using env: {'DISPLAY': ':0', 13:44:52 INFO - 'HOME': '/home/cltbld', 13:44:52 INFO - 'LANG': 'en_US.UTF-8', 13:44:52 INFO - 'LANGUAGE': 'en_US:en', 13:44:52 INFO - 'LOGNAME': 'cltbld', 13:44:52 INFO - 'MAIL': '/var/mail/cltbld', 13:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:52 INFO - 'MOZ_NO_REMOTE': '1', 13:44:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:52 INFO - 'NO_EM_RESTART': '1', 13:44:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:52 INFO - 'PWD': '/builds/slave/test', 13:44:52 INFO - 'SHELL': '/bin/bash', 13:44:52 INFO - 'SHLVL': '1', 13:44:52 INFO - 'TERM': 'linux', 13:44:52 INFO - 'TMOUT': '86400', 13:44:52 INFO - 'USER': 'cltbld', 13:44:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', 13:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:52 INFO - '_': '/tools/buildbot/bin/python'} 13:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:44:52 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 13:44:52 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 13:44:52 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 13:44:52 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 13:44:52 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 13:44:52 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 13:44:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:44:54 INFO - Installing collected packages: mozsystemmonitor 13:44:54 INFO - Running setup.py install for mozsystemmonitor 13:44:54 INFO - Successfully installed mozsystemmonitor 13:44:54 INFO - Cleaning up... 13:44:54 INFO - Return code: 0 13:44:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f126eefaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c1c0>, '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 0x203d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203d550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', '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 13:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:44:54 INFO - Using env: {'DISPLAY': ':0', 13:44:54 INFO - 'HOME': '/home/cltbld', 13:44:54 INFO - 'LANG': 'en_US.UTF-8', 13:44:54 INFO - 'LANGUAGE': 'en_US:en', 13:44:54 INFO - 'LOGNAME': 'cltbld', 13:44:54 INFO - 'MAIL': '/var/mail/cltbld', 13:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:54 INFO - 'MOZ_NO_REMOTE': '1', 13:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:54 INFO - 'NO_EM_RESTART': '1', 13:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:54 INFO - 'PWD': '/builds/slave/test', 13:44:54 INFO - 'SHELL': '/bin/bash', 13:44:54 INFO - 'SHLVL': '1', 13:44:54 INFO - 'TERM': 'linux', 13:44:54 INFO - 'TMOUT': '86400', 13:44:54 INFO - 'USER': 'cltbld', 13:44:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', 13:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:54 INFO - '_': '/tools/buildbot/bin/python'} 13:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:55 INFO - Downloading/unpacking jsonschema==2.5.1 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:44:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:57 INFO - Downloading functools32-3.2.3-2.tar.gz 13:44:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:44:57 INFO - warning: no files found matching '*.txt' 13:44:57 INFO - no previously-included directories found matching 'build' 13:44:57 INFO - no previously-included directories found matching 'dist' 13:44:57 INFO - no previously-included directories found matching '.git*' 13:44:57 INFO - Installing collected packages: jsonschema, functools32 13:44:57 INFO - Running setup.py install for functools32 13:44:57 INFO - warning: no files found matching '*.txt' 13:44:57 INFO - no previously-included directories found matching 'build' 13:44:57 INFO - no previously-included directories found matching 'dist' 13:44:57 INFO - no previously-included directories found matching '.git*' 13:44:57 INFO - Successfully installed jsonschema functools32 13:44:57 INFO - Cleaning up... 13:44:57 INFO - Return code: 0 13:44:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f126eefaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c1c0>, '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 0x203d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203d550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', '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 13:44:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:44:57 INFO - Using env: {'DISPLAY': ':0', 13:44:57 INFO - 'HOME': '/home/cltbld', 13:44:57 INFO - 'LANG': 'en_US.UTF-8', 13:44:57 INFO - 'LANGUAGE': 'en_US:en', 13:44:57 INFO - 'LOGNAME': 'cltbld', 13:44:57 INFO - 'MAIL': '/var/mail/cltbld', 13:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:57 INFO - 'MOZ_NO_REMOTE': '1', 13:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:57 INFO - 'NO_EM_RESTART': '1', 13:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:57 INFO - 'PWD': '/builds/slave/test', 13:44:57 INFO - 'SHELL': '/bin/bash', 13:44:57 INFO - 'SHLVL': '1', 13:44:57 INFO - 'TERM': 'linux', 13:44:57 INFO - 'TMOUT': '86400', 13:44:57 INFO - 'USER': 'cltbld', 13:44:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', 13:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:57 INFO - '_': '/tools/buildbot/bin/python'} 13:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:57 INFO - Downloading/unpacking blobuploader==1.2.4 13:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:59 INFO - Downloading blobuploader-1.2.4.tar.gz 13:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:44:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:45:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45:00 INFO - Downloading docopt-0.6.1.tar.gz 13:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:45:00 INFO - Installing collected packages: blobuploader, requests, docopt 13:45:00 INFO - Running setup.py install for blobuploader 13:45:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:45:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:45:00 INFO - Running setup.py install for requests 13:45:00 INFO - Running setup.py install for docopt 13:45:00 INFO - Successfully installed blobuploader requests docopt 13:45:00 INFO - Cleaning up... 13:45:00 INFO - Return code: 0 13:45:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45: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')]} 13:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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')]} 13:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:00 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 0x7f126eefaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c1c0>, '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 0x203d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203d550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', '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 13:45:00 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 13:45:00 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 13:45:00 INFO - Using env: {'DISPLAY': ':0', 13:45:00 INFO - 'HOME': '/home/cltbld', 13:45:00 INFO - 'LANG': 'en_US.UTF-8', 13:45:00 INFO - 'LANGUAGE': 'en_US:en', 13:45:00 INFO - 'LOGNAME': 'cltbld', 13:45:00 INFO - 'MAIL': '/var/mail/cltbld', 13:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:00 INFO - 'MOZ_NO_REMOTE': '1', 13:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:00 INFO - 'NO_EM_RESTART': '1', 13:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:00 INFO - 'PWD': '/builds/slave/test', 13:45:00 INFO - 'SHELL': '/bin/bash', 13:45:00 INFO - 'SHLVL': '1', 13:45:00 INFO - 'TERM': 'linux', 13:45:00 INFO - 'TMOUT': '86400', 13:45:00 INFO - 'USER': 'cltbld', 13:45:00 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', 13:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:00 INFO - '_': '/tools/buildbot/bin/python'} 13:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:45:01 INFO - Running setup.py (path:/tmp/pip-KifIza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:45:01 INFO - Running setup.py (path:/tmp/pip-aeivEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:45:01 INFO - Running setup.py (path:/tmp/pip-JnPFs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:45:01 INFO - Running setup.py (path:/tmp/pip-WJddFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:45:01 INFO - Running setup.py (path:/tmp/pip-xYDLx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:45:01 INFO - Running setup.py (path:/tmp/pip-BWGhWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:45:01 INFO - Running setup.py (path:/tmp/pip-nDD7Hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:45:01 INFO - Running setup.py (path:/tmp/pip-9YZLEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:45:01 INFO - Running setup.py (path:/tmp/pip-i9OpNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:45:01 INFO - Running setup.py (path:/tmp/pip-HdCOdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:45:01 INFO - Running setup.py (path:/tmp/pip-GWuTjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:45:01 INFO - Running setup.py (path:/tmp/pip-GVzyfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:45:02 INFO - Running setup.py (path:/tmp/pip-QKHMAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:45:02 INFO - Running setup.py (path:/tmp/pip-SVg621-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:02 INFO - Running setup.py (path:/tmp/pip-88UsK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:45:02 INFO - Running setup.py (path:/tmp/pip-t3iyKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:45:02 INFO - Running setup.py (path:/tmp/pip-cTM2xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:45:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:45:02 INFO - Running setup.py install for manifestparser 13:45:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:45:02 INFO - Running setup.py install for mozcrash 13:45:02 INFO - Running setup.py install for mozdebug 13:45:02 INFO - Running setup.py install for mozdevice 13:45:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:45:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:45:02 INFO - Running setup.py install for mozfile 13:45:02 INFO - Running setup.py install for mozhttpd 13:45:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Running setup.py install for mozinfo 13:45:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Running setup.py install for mozInstall 13:45:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Running setup.py install for mozleak 13:45:03 INFO - Running setup.py install for mozlog 13:45:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Running setup.py install for moznetwork 13:45:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Running setup.py install for mozprocess 13:45:03 INFO - Running setup.py install for mozprofile 13:45:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Running setup.py install for mozrunner 13:45:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:45:03 INFO - Running setup.py install for mozscreenshot 13:45:04 INFO - Running setup.py install for moztest 13:45:04 INFO - Running setup.py install for mozversion 13:45:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:45:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:45:04 INFO - Cleaning up... 13:45:04 INFO - Return code: 0 13:45:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45: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')]} 13:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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')]} 13:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f126eefaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c1c0>, '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 0x203d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203d550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', '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 13:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:45:04 INFO - Using env: {'DISPLAY': ':0', 13:45:04 INFO - 'HOME': '/home/cltbld', 13:45:04 INFO - 'LANG': 'en_US.UTF-8', 13:45:04 INFO - 'LANGUAGE': 'en_US:en', 13:45:04 INFO - 'LOGNAME': 'cltbld', 13:45:04 INFO - 'MAIL': '/var/mail/cltbld', 13:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:04 INFO - 'MOZ_NO_REMOTE': '1', 13:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:04 INFO - 'NO_EM_RESTART': '1', 13:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:04 INFO - 'PWD': '/builds/slave/test', 13:45:04 INFO - 'SHELL': '/bin/bash', 13:45:04 INFO - 'SHLVL': '1', 13:45:04 INFO - 'TERM': 'linux', 13:45:04 INFO - 'TMOUT': '86400', 13:45:04 INFO - 'USER': 'cltbld', 13:45:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', 13:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:04 INFO - '_': '/tools/buildbot/bin/python'} 13:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:45:04 INFO - Running setup.py (path:/tmp/pip-mLeQ8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:45:04 INFO - Running setup.py (path:/tmp/pip-Tn173p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:45:04 INFO - Running setup.py (path:/tmp/pip-UPWheH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:45:04 INFO - Running setup.py (path:/tmp/pip-xTjPPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:45:04 INFO - Running setup.py (path:/tmp/pip-BvSOyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:45:04 INFO - Running setup.py (path:/tmp/pip-1BWN92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:45:04 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)) 13:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:45:04 INFO - Running setup.py (path:/tmp/pip-ssYGeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:45:04 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)) 13:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:45:04 INFO - Running setup.py (path:/tmp/pip-D1tavr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:45:05 INFO - Running setup.py (path:/tmp/pip-EQKWZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:45:05 INFO - Running setup.py (path:/tmp/pip-o9D6B1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:45:05 INFO - Running setup.py (path:/tmp/pip-ZCIF0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:45:05 INFO - Running setup.py (path:/tmp/pip-2FMqay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:45:05 INFO - Running setup.py (path:/tmp/pip-xZSPjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:45:05 INFO - Running setup.py (path:/tmp/pip-KJcyQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:05 INFO - Running setup.py (path:/tmp/pip-MpNBT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:45:05 INFO - Running setup.py (path:/tmp/pip-DKLDTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:45:05 INFO - Running setup.py (path:/tmp/pip-vfTcJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:45:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:07 INFO - Downloading blessings-1.6.tar.gz 13:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:45:07 INFO - Installing collected packages: blessings 13:45:07 INFO - Running setup.py install for blessings 13:45:07 INFO - Successfully installed blessings 13:45:07 INFO - Cleaning up... 13:45:07 INFO - Return code: 0 13:45:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:45:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:08 INFO - Reading from file tmpfile_stdout 13:45:08 INFO - Current package versions: 13:45:08 INFO - argparse == 1.2.1 13:45:08 INFO - blessings == 1.6 13:45:08 INFO - blobuploader == 1.2.4 13:45:08 INFO - docopt == 0.6.1 13:45:08 INFO - functools32 == 3.2.3-2 13:45:08 INFO - jsonschema == 2.5.1 13:45:08 INFO - manifestparser == 1.1 13:45:08 INFO - mozInstall == 1.12 13:45:08 INFO - mozcrash == 0.17 13:45:08 INFO - mozdebug == 0.1 13:45:08 INFO - mozdevice == 0.48 13:45:08 INFO - mozfile == 1.2 13:45:08 INFO - mozhttpd == 0.7 13:45:08 INFO - mozinfo == 0.9 13:45:08 INFO - mozleak == 0.1 13:45:08 INFO - mozlog == 3.2 13:45:08 INFO - moznetwork == 0.27 13:45:08 INFO - mozprocess == 0.22 13:45:08 INFO - mozprofile == 0.28 13:45:08 INFO - mozrunner == 6.11 13:45:08 INFO - mozscreenshot == 0.1 13:45:08 INFO - mozsystemmonitor == 0.3 13:45:08 INFO - moztest == 0.7 13:45:08 INFO - mozversion == 1.4 13:45:08 INFO - psutil == 3.1.1 13:45:08 INFO - requests == 1.2.3 13:45:08 INFO - wsgiref == 0.1.2 13:45:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f126eefaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c1c0>, '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 0x203d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203d550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', '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 13:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:45:08 INFO - Using env: {'DISPLAY': ':0', 13:45:08 INFO - 'HOME': '/home/cltbld', 13:45:08 INFO - 'LANG': 'en_US.UTF-8', 13:45:08 INFO - 'LANGUAGE': 'en_US:en', 13:45:08 INFO - 'LOGNAME': 'cltbld', 13:45:08 INFO - 'MAIL': '/var/mail/cltbld', 13:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:08 INFO - 'MOZ_NO_REMOTE': '1', 13:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:08 INFO - 'NO_EM_RESTART': '1', 13:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:08 INFO - 'PWD': '/builds/slave/test', 13:45:08 INFO - 'SHELL': '/bin/bash', 13:45:08 INFO - 'SHLVL': '1', 13:45:08 INFO - 'TERM': 'linux', 13:45:08 INFO - 'TMOUT': '86400', 13:45:08 INFO - 'USER': 'cltbld', 13:45:08 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', 13:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:08 INFO - '_': '/tools/buildbot/bin/python'} 13:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:45:08 INFO - Cleaning up... 13:45:08 INFO - Return code: 0 13:45:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f126eefaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c1c0>, '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 0x203d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203d550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', '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 13:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:45:08 INFO - Using env: {'DISPLAY': ':0', 13:45:08 INFO - 'HOME': '/home/cltbld', 13:45:08 INFO - 'LANG': 'en_US.UTF-8', 13:45:08 INFO - 'LANGUAGE': 'en_US:en', 13:45:08 INFO - 'LOGNAME': 'cltbld', 13:45:08 INFO - 'MAIL': '/var/mail/cltbld', 13:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:08 INFO - 'MOZ_NO_REMOTE': '1', 13:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:08 INFO - 'NO_EM_RESTART': '1', 13:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:08 INFO - 'PWD': '/builds/slave/test', 13:45:08 INFO - 'SHELL': '/bin/bash', 13:45:08 INFO - 'SHLVL': '1', 13:45:08 INFO - 'TERM': 'linux', 13:45:08 INFO - 'TMOUT': '86400', 13:45:08 INFO - 'USER': 'cltbld', 13:45:08 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', 13:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:08 INFO - '_': '/tools/buildbot/bin/python'} 13:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:45:08 INFO - Cleaning up... 13:45:08 INFO - Return code: 0 13:45:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f126eefaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fad350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c1c0>, '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 0x203d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203d550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', '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 13:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:45:08 INFO - Using env: {'DISPLAY': ':0', 13:45:08 INFO - 'HOME': '/home/cltbld', 13:45:08 INFO - 'LANG': 'en_US.UTF-8', 13:45:08 INFO - 'LANGUAGE': 'en_US:en', 13:45:08 INFO - 'LOGNAME': 'cltbld', 13:45:08 INFO - 'MAIL': '/var/mail/cltbld', 13:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:08 INFO - 'MOZ_NO_REMOTE': '1', 13:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:08 INFO - 'NO_EM_RESTART': '1', 13:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:08 INFO - 'PWD': '/builds/slave/test', 13:45:08 INFO - 'SHELL': '/bin/bash', 13:45:08 INFO - 'SHLVL': '1', 13:45:08 INFO - 'TERM': 'linux', 13:45:08 INFO - 'TMOUT': '86400', 13:45:08 INFO - 'USER': 'cltbld', 13:45:08 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', 13:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:08 INFO - '_': '/tools/buildbot/bin/python'} 13:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:08 INFO - Downloading/unpacking flake8 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:45:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:45:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:45:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:45:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:45:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:45:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:45:11 INFO - no previously-included directories found matching 'docs/_build' 13:45:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:45:11 INFO - Running setup.py install for pep8 13:45:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:45:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:45:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:45:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:45:11 INFO - no previously-included directories found matching 'docs/_build' 13:45:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:45:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:45:11 INFO - Cleaning up... 13:45:12 INFO - Return code: 0 13:45:12 INFO - Running post-action listener: _resource_record_post_action 13:45:12 INFO - Running post-action listener: _start_resource_monitoring 13:45:12 INFO - Starting resource monitoring. 13:45:12 INFO - ##### 13:45:12 INFO - ##### Finished create-virtualenv step (success) 13:45:12 INFO - ##### 13:45:12 INFO - ##### 13:45:12 INFO - ##### Running install step. 13:45:12 INFO - ##### 13:45:12 INFO - Running pre-action listener: _resource_record_pre_action 13:45:12 INFO - Running main action method: install 13:45:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:12 INFO - Reading from file tmpfile_stdout 13:45:12 INFO - Detecting whether we're running mozinstall >=1.0... 13:45:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:45:12 INFO - Reading from file tmpfile_stdout 13:45:12 INFO - Output received: 13:45:12 INFO - Usage: mozinstall [options] installer 13:45:12 INFO - Options: 13:45:12 INFO - -h, --help show this help message and exit 13:45:12 INFO - -d DEST, --destination=DEST 13:45:12 INFO - Directory to install application into. [default: 13:45:12 INFO - "/builds/slave/test"] 13:45:12 INFO - --app=APP Application being installed. [default: firefox] 13:45:12 INFO - mkdir: /builds/slave/test/build/application 13:45:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:45:28 INFO - Reading from file tmpfile_stdout 13:45:28 INFO - Output received: 13:45:28 INFO - /builds/slave/test/build/application/firefox/firefox 13:45:28 INFO - Running post-action listener: _resource_record_post_action 13:45:28 INFO - ##### 13:45:28 INFO - ##### Finished install step (success) 13:45:28 INFO - ##### 13:45:28 INFO - ##### 13:45:28 INFO - ##### Running run-tests step. 13:45:28 INFO - ##### 13:45:28 INFO - Running pre-action listener: _resource_record_pre_action 13:45:28 INFO - Running main action method: run_tests 13:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:45:28 INFO - Python 2.7.3 13:45:28 INFO - Return code: 0 13:45:28 INFO - grabbing minidump binary from tooltool 13:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203c1c0>, '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 0x203d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:45:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:45:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:45:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:45:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:45:28 INFO - Return code: 0 13:45:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:45:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:45:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:45:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:45:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:45:29 INFO - Return code: 0 13:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:45:29 INFO - Using env: {'DISPLAY': ':0', 13:45:29 INFO - 'HOME': '/home/cltbld', 13:45:29 INFO - 'LANG': 'en_US.UTF-8', 13:45:29 INFO - 'LANGUAGE': 'en_US:en', 13:45:29 INFO - 'LOGNAME': 'cltbld', 13:45:29 INFO - 'MAIL': '/var/mail/cltbld', 13:45:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:45:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:29 INFO - 'MOZ_NO_REMOTE': '1', 13:45:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:45:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:29 INFO - 'NO_EM_RESTART': '1', 13:45:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:29 INFO - 'PWD': '/builds/slave/test', 13:45:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:45:29 INFO - 'SHELL': '/bin/bash', 13:45:29 INFO - 'SHLVL': '1', 13:45:29 INFO - 'TERM': 'linux', 13:45:29 INFO - 'TMOUT': '86400', 13:45:29 INFO - 'USER': 'cltbld', 13:45:29 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229', 13:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:29 INFO - '_': '/tools/buildbot/bin/python'} 13:45:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:45:29 INFO - mozversion application_buildid: 20160609031135 13:45:29 INFO - mozversion application_changeset: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 13:45:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:45:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:45:29 INFO - mozversion application_name: Firefox 13:45:29 INFO - mozversion application_remotingname: firefox-dev 13:45:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:45:29 INFO - mozversion application_vendor: Mozilla 13:45:29 INFO - mozversion application_version: 49.0a2 13:45:29 INFO - mozversion platform_buildid: 20160609031135 13:45:29 INFO - mozversion platform_changeset: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 13:45:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:45:29 INFO - mozversion platform_version: 49.0a2 13:45:29 INFO - using testdate: 1465505129 13:45:29 INFO - actual date: 1465505129 13:45:29 INFO - starting webserver on 'localhost:55807' 13:45:29 INFO - SUITE-START | Running 2 tests 13:45:29 INFO - TEST-START | dromaeo_css 13:45:29 INFO - operating with platform_type : linux_ 13:45:29 INFO - Initialising browser for dromaeo_css test... 13:45:29 INFO - TEST-INFO | started process 20084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ6VJFt/profile http://localhost:55807/getInfo.html) 13:45:33 INFO - PROCESS | 20084 | __metrics Screen width/height:1600/1200 13:45:33 INFO - PROCESS | 20084 | colorDepth:24 13:45:33 INFO - PROCESS | 20084 | Browser inner width/height: 1024/697 13:45:33 INFO - PROCESS | 20084 | __metrics 13:45:34 ERROR - PROCESS | 20084 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 13:45:35 INFO - TEST-INFO | 20084: exit 0 13:45:35 INFO - Browser initialized. 13:45:35 INFO - Running cycle 1/1 for dromaeo_css test... 13:45:35 INFO - TEST-INFO | started process 20215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ6VJFt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:46 INFO - PROCESS | 20215 | RSS: Main: 156123136 13:45:46 INFO - PROCESS | 20215 | 13:46:36 INFO - PROCESS | 20215 | 1465505196478 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] 13:48:44 INFO - PROCESS | 20215 | Cycle 1(1): loaded http://localhost:55807/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55807/tests/dromaeo/cssquery-ext.html) 13:48:45 INFO - PROCESS | 20215 | RSS: Main: 159350784 13:48:45 INFO - PROCESS | 20215 | 13:51:47 INFO - PROCESS | 20215 | Cycle 1(1): loaded http://localhost:55807/tests/dromaeo/cssquery-ext.html (next: http://localhost:55807/tests/dromaeo/cssquery-jquery.html) 13:51:48 INFO - PROCESS | 20215 | RSS: Main: 157147136 13:51:48 INFO - PROCESS | 20215 | 13:54:50 INFO - PROCESS | 20215 | Cycle 1(1): loaded http://localhost:55807/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55807/tests/dromaeo/cssquery-mootools.html) 13:54:50 INFO - PROCESS | 20215 | RSS: Main: 156860416 13:54:50 INFO - PROCESS | 20215 | 13:57:52 INFO - PROCESS | 20215 | Cycle 1(1): loaded http://localhost:55807/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55807/tests/dromaeo/cssquery-prototype.html) 13:57:53 INFO - PROCESS | 20215 | RSS: Main: 156782592 13:57:53 INFO - PROCESS | 20215 | 14:00:55 INFO - PROCESS | 20215 | Cycle 1(1): loaded http://localhost:55807/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55807/tests/dromaeo/cssquery-yui.html) 14:00:56 INFO - PROCESS | 20215 | RSS: Main: 158892032 14:00:56 INFO - PROCESS | 20215 | 14:03:58 INFO - PROCESS | 20215 | Cycle 1(1): loaded http://localhost:55807/tests/dromaeo/cssquery-yui.html (next: http://localhost:55807/tests/dromaeo/cssquery-dojo.html) 14:03:58 INFO - PROCESS | 20215 | RSS: Main: 159072256 14:03:58 INFO - PROCESS | 20215 | 14:03:58 INFO - PROCESS | 20215 | __start_tp_report 14:03:58 INFO - PROCESS | 20215 | _x_x_mozilla_page_load 14:03:58 INFO - PROCESS | 20215 | _x_x_mozilla_page_load_details 14:03:58 INFO - PROCESS | 20215 | |i|pagename|runs| 14:03:58 INFO - PROCESS | 20215 | |0;dojo.html;3418.8119653419058;3437.432823584109;3451.102713294543;3457.4986626939085;3460.53282806821;5826.417358264177;5833.970830145849;5900.321463031742;5921.911171332434;5923.733431995554;5819.592628516006;5829.329627092886;5830.854228644286;5840.853978650536;5856.590038697293;5278.788848446067;5310.575153987672;5348.973255133719;5349.7057661828585;5354.759035843377;5222.503862133091;5234.790608375661;5291.047611429941;5370.167624018283;5391.32608423947;5275.472452754713;5289.391719952217;5299.5230429261355;5349.598780091489;5352.357717073937;5333.253344531769;5364.356277246736;5407.053765591006;5409.702466364349;5417.566594672456;5134.1528647773075;5148.819791307324;5244.763985620656;5298.894022119536;5394.838154855361;5603.691796951166;5648.983183027053;5685.232493613351;5706.942930570683;5729;6106.908396374058;6121.632702037848;6171.567990240685;6212.720427580724;6238.220222472191;6094.9390506094815;6166.105914642397;6209;6268.65522396268;6290.9685451572905;5820.82537523875;5842.766289348378;5876.55925805562;5881.85295367615;5896.675682837442;6353.078803573456;6383.9361606383345;6403.96798016007;6410.455111315498;6418.903716444257;6003.21958145447;6072.149899014142;6089.025755879126;6124.173236613089;6152.415520525543;6238.157848690459;6247.5939063960695;6257.655828929362;6268.09112678659;6301.306856245809;6187.010078387527;6197.4732147767945;6229.127922090911;6242.687865606792;6272.372762723691;6090.421409966046;6108.877822443526;6141.477974372139;6141.556734167467;6243.594166379171;4712.198926182557;4728.881777955578;4732.905341893212;4733.14803335396;4738.1708201064675;4202.663786897041;4223.978880105641;4227;4234.06850492891;4264.850730224489;5896.705164741746;5908.379620139909;5975.641461512323;5997.400259974055;6022.036474164201;6230.875382492325;6329.905051424233;6337.207849018872;6396.808095757135;6433.646149461824;5935.910961335583;6120.755169793248;6136.079588061826;6136.386361363917;6149.661768602769;5348.973255133699;5396.595255355864;5407.45925407464;5409.350877894678;5451.509364157245;6551.860155083632;6556.0493728410065;6577.112089867902;6582.17722784652;6613.702383392662;6057.606255593372;6127.922628246602;6376.266729326094;6401.615903045832;6425;6397.296297407374;6423.618921931807;6432.388923052303;6517.967410162919;6519.054737063194;6177.876442471215;6178.104174894705;6184.505239580732;6188;6198.287196972406;6061.7575296987625;6175.135481032569;6185.752569897334;6210.441060304594;6253.843653908689;6073.605215660968;6119.743648523402;6145.832291864532;6151.784687535915;6157.26112866441;6053.788117415869;6096.695165241809;6116.091931071693;6118.261146750579;6129.816105516663;5782.5663075268685;5920.526357891445;5963.880722385441;6004.759809607567;6008.098785182257;6116.14373987651;6129.693515324305;6141.109539116893;6143.32423433413;6175.9382406177165;6040.214772079602;6050;6054.424829641177;6055.061465472859;6055.72749226277 14:03:58 INFO - PROCESS | 20215 | |1;ext.html;552.2516989479255;603.5624172474955;616.4451993206116;651.843557546189;659.1595715462785;45738.77130614346;47489.525104748944;47601.76199119004;51277;52172.47827521724;49580.75209623956;49635;50123.24815127776;50347;50438.49561504384;8933.955330223356;9178.311626627996;9238.769030774218;9246.260299176083;9273.86089208659;9029.593668284942;9065.818683626323;9085.409448385866;9101.180893719564;9117.68088116916;9091.04544022878;9123.863142052875;9161.679341223058;9164.633414663438;9180.632774689038;9067.546622668906;9104.908950910505;9154.809874716311;9165.816683666357;9169.862452063224;9037.593308301142;9154.450732956044;9195.678151264674;9196.586153623102;9209.723708288762;45308;45356;45372.319415208796;45434.77282613599;45668;3638.1450359165574;3832.7317087803863;4028.637422631977;4255.489341279035;4346.826126954918;33544.329113417836;34492.6550734492;35215.82392088049;35328.47007294893;35365.1158721034;4592.7014744041535;4622.976885115587;4671.299305104228;4729.101470720552;4752.714837109785;356453;358195;358827;360027;360071.9999999974;65320;65944.34055659382;66335.33664663388;66369;66568.66715666391;39698.206035879695;40488.59511404907;40543.39184912229;42487.57512424898;62731.37268627255;17786.644267114843;17826.10869456548;17875.73186402205;17925.28298868031;18024.188911499015;13297.601071967856;13377.130486518345;13448.462061517625;13474.393652285671;13591.660208494866;21834;22054.77945220527;22135;22274.99762510691;22282.77717222807;7374.778756637309;7588.544687318778;7651.770446886602;7720.498167619199;7754.961225193838;1036.1142720249225;1061.4321338084087;1065.9893401066045;1145.954161833534;1151.5393842463081;34265.828670856485;34297;34507;34545.82727086348;34616.30767384689;1105.8672959244782;1157.6411312493153;1171.1509155861932;1182.9763404731857;1228.3305598448867;16699.165041747863;16818;17180.484585462455;17359.39242126545;17363.739543906853;589565;651672;661214;666650;1028669;61228.69385653043;61322;61619;61722;61920;1441.9495317663832;1464.633841539615;1465.846086160959;1474.321811966486;1493.2011373914904;31810.681893180772;32111.197220069684;32541.837290813393;33232.833835830665;33428.331433371684;52288.73855630698;53376;53390;53451;53475;397181;399718;401263;402198;402370;30476.695233047387;30993;31013;31396.215094621904;31829;54837.56974273003;55232.72383638217;55389.723051384484;55548.16677749918;56546.717266413405;43895.36627802342;44478.55521444744;44962.55037449714;45385;46171;43712.78143609261;44149.33775993427;44532.77733611311;44685;46175.76912115418;44036.779816100716;44810.327845083004;44836;44992.32511512395;45944.31083533683;38580.228395432496;38669.6133038666;38761;39089.80455097706;39384.6061539381;29579.704202957695;29752.553711694774;29994.700053000062;30114.247143820703;30123 14:03:58 INFO - PROCESS | 20215 | |2;jquery.html;407.78183671735616;410.1161995898837;412.13657387772616;415.8648439257242;425.64671322802076;18373.265069397225;19557.706634400496;20046.198152073917;20158.294459693894;20604.1758329667;12426.875731242684;12443.751124977494;12672.239665620045;13037.152585081987;13076.346182690851;5299.761510732017;5408.972955135238;5409.377921539014;5421.701806400646;5457.317835270591;5535.58483113768;5818.0400233961345;5849.151872978416;5862.32583252925;5872.823815285548;5734.770609175628;5846.795362162326;6108.389161083878;6119.908201376983;6127.938720612804;5980.43185897339;6060.090986352038;6074.058520929263;6080.695965201767;6094.1772860663905;5925.051991681354;5981.8803623927715;5988.670623115727;6003.279606447254;6006.909896351558;13080.41138148776;13981.231032293219;14023.64940876476;14346.354414051393;14692.412303507846;2204.1624182810588;2296.59809533331;2460.1512478194995;2539.5301869154264;2655.49545586338;10594.788104237949;11003.724906877393;11526.596569120124;11549.769004619944;15820.525384238492;1731.2784978993702;1836.7612210412694;1844.3070930301817;1915.6647586672277;1922.80771922808;83311.583442083;84935.575322123;85452.14547854503;86469.56765216133;87792.56103719505;10504.474776261157;11100.666979990614;11973.640790776291;11980.341081240615;12105.273683579013;16893.66212675764;17002.404915827887;17027.829721702874;17141.91429042872;17163.313467461412;7814.921850781419;8269.338452923752;8429.4942303462;8717.389782715149;8773.166549177946;7771.261730135628;7790.727324543614;8033.517988920684;8112.067112282045;8211.753647390588;5014.197728363444;5095.337606111182;5143.202803565453;5168.61235407346;5214.243934629533;2079.480129967508;2114.6193685136514;2125.5005073807642;2135.8107939361967;2146.3131797824544;1010.5200029985845;1045.534737042009;1089.6676513663251;1091.170710260208;1124.2860783402598;17837.286508539513;19270.22919083221;19347.903260483607;19363.225470981284;20120.89939550322;1020.2195320579763;1039.4802598700649;1040.6305761454726;1096.8025755363951;1101.6639924822846;10801.891981080245;11202.327860328407;11383;11384.203105782515;11492.942535287437;463372;477752;481730;483400;484973;69588.65205673939;81731.59134204291;95447.04552954382;96126;96758;1013.2096964367805;1029.4029462911642;1032.4992378696327;1046.2780681329857;1054.7363159210197;17699;17910.641787163924;17947.5513112168;17978.820211797716;18195.45413637593;41620.37569436521;42149.1570168601;42824;43074;43870.780646096566;58720;59209.70395147997;59887.1016934755;60178;60500.697496512235;8747.38173437916;8775.956120219613;8828;8936.106389361012;9105.908940910505;10292.742681432725;13414.262215578237;13470.461181552628;13515.256660883746;13633.79549306781;11669.416529173337;11720.413979301171;11773.882261177621;11795.705107372385;12098.637040888787;10535.73660658459;11109.888901110886;11538.76922461563;11723.120765942418;12066.155369124428;10910.345379277269;11169.162312826733;11381.43092845338;11575.88424115748;11919.284842909454;8648.78378040554;8746;8892.066333035196;9115;9194.448333100036;9010.098990100938;11580.36308003068;11714.062874969812;11766.294022358687;11767.470463829319 14:03:58 INFO - PROCESS | 20215 | |3;mootools.html;1550.155165434838;1573.6380632454536;1703;1833.3858157517232;1870.279942222245;8344.332453403727;8898.688545900895;8986.730398088068;9533.713988580344;9543.14111729945;9284.721458356244;9311.813763724722;9382.953085234565;9403.294752893526;9427.57575909084;2506.147909710698;2544.821862469628;2547.1721690450586;2547.223096955428;2553.042609021617;2470.28361775085;2533.3160046787357;2535.4422027153996;2535.5816290312077;2552.157787929988;2482.3173627252468;2508.8871000804916;2522.924312270635;2524.179641616473;2526.987365063181;2455.3002394317623;2461.8399804012683;2474.3071939856777;2503.436726736488;2510.874456277179;2427.684401027855;2443.169322430382;2453.0187924830034;2455.5702752018324;2488.962665560018;9441.480718560477;9503.524823758784;9509.286803489696;9529.047095290485;9535.52322383878;5591.776328946838;5707.086866101404;5735.913961290584;5745.88508229833;5760.6255593386295;3514.859405623772;3595.9101022474388;3661.011526887752;3702.7037836973245;3707.2400157967554;1167.7956357637465;1203.6519098609613;1212.0545974140184;1226.9754604907941;1227.613301809936;13199.274039927801;13207.801882971764;13254.138480998705;13305.268210248432;13449.125806822525;4938.259261110862;4997.800087996512;4999.525045120708;5041.672291301127;5053.84838454847;11150.944245278884;11199.72000699989;11214.271072380268;11267.830982535268;11298.265612735146;5645.802396916089;5656.2929633795775;5661;5684.919865225594;5728.312602487728;4525.366448697185;5110.744462776846;5206.453322401093;5237.3453318335205;5242.082635538765;4270.252705776476;4287.335463003239;4333.371661109121;4343.326784348431;4377.956220437819;1359.7688392973218;1368.9589312320647;1391.902566820333;1407.331517529186;1412.632715493979;869.6347534035593;974.5614473486959;1040.7770869228625;1067.4822710985165;1070.9089727373262;6143.293521245114;6229.221347331583;6286.591371560834;6354.26925903527;6366.448814746262;486.5766782898901;497.16972655665126;499.19131007767646;507.0897738559295;509.297169905528;4423.248047831877;4470.240059189946;4494.977525112354;4506.481754598198;4510.503844577094;11406.201565890307;11796.705082372837;11887.821682674767;11941.582044628396;11954.043676505858;11648;11801.704957375963;11806.40967951599;11821.586244481401;11837.76324473523;8335.916640833513;8708.95645521781;8752.737417877473;8757.124287571192;8839.60221790021;6245.781397651061;6494.6103233806125;6503.804885853432;6535;6569.211694596679;10737.409442480739;10752.892471075189;10862.837057444303;10892.237543372205;10951.233413660968;10854.240203185702;10872.456377180952;11087.833682494607;11142.387168705798;11167.38579378142;7660.502067365604;8092.71675491355;8145.104038555873;8283.473540570183;8336.12470690593;9188.127127922837;9198.908010919806;9202.171804537624;9252.121048500381;9301.488418137067;8040.919590804017;8182.67269309221;8227.71203007892;8273.710420135267;8369.66521339164;8111.83776324482;8161.632726527439;8165.836683266421;8239.093699693149;8321.41750077513;7476.5887876167335;7526.924730752841;7528.962355188189;7599.658015389431;7647.120581133241;5041.369828771403;5247.763850626655;5299.814506492255;5466.34403871538;5494.670319780826;5349.705766182741;5437.211604317273;5510.889782204414;5513.2005859151;5660.886782264414 14:03:58 INFO - PROCESS | 20215 | |4;prototype.html;345.99308013839726;350.7089116033692;353.52450953467576;358.63598447575697;363.7163012849975;5674.375818659949;5747.655140691561;5773.383452633269;5774.249347584819;5867.442592953673;5665.461781130796;5757.215263268379;5784.363719990798;5798.768049278024;5810.651360918338;4006.83972641094;4432.224360736858;4460.79926403311;4490.989527356343;4503.392042074327;4459.152760975404;4476.462824461069;4480.283154695249;4483.148201841656;4486.439195100613;4417.293233082707;4436.223660859353;4478.843240486583;4480.126375356806;4494.213512635276;4322.178786030644;4446.622037126848;4491.730496170224;4500.032493014001;4505.324201369788;3846.576876543578;3927.19492504036;3929.390944403622;3931.5871833457363;3936.4095385692376;5515.531179849718;5521.420250873641;5533.9485497755295;5568.415316391761;5572.749226284827;4963.759060234941;5121.795128194905;5134.767655762627;5174.560162386202;5205.375354957391;5968.37332080134;6030.849228769272;6034.547408944347;6049.364816694228;6079.939200607982;4292.806823692941;4359.455068116486;4405.801738921757;4406.317020861771;4412.933805992912;6026.252386807821;6316.294600457896;6325.399087086719;6369.681515924185;6393.520485963571;4380.342948557742;4390.407295015196;4399.714018588781;4408.955910440919;4444.333349997526;4467.932981005288;4480.215962206601;4480.955190448054;4493.123840851068;4504.752238626907;4856.17445034345;5107.821226257063;5134.204198349262;5147.760724085035;5152.175651895679;6013.909791353133;6038.486728628028;6080.878382432326;6109.694515274218;6110.594563250477;1526.4275896538797;1535.3244572388114;1541.221683050075;1541.6300087978805;1548.5276990518;970.8495183246608;999.1656966432964;1005.4118340770585;1045.310095337089;1049.186880167876;5745.540356771448;5802.361740208574;5874.970625146847;5883.588148829626;5904.940950590525;6112.786052488231;6125.2649682037545;6179.3202747698615;6181.381861813783;6191.380861913863;5738.713064346766;5873.471387575139;5889.440503152194;5907.763689452374;5922.141289512996;3240.141362538929;3294.3081952789703;3296.175956010997;3298.3073554553334;3304.289577740797;6162.5378096642935;6370.617762934146;6372.171617689671;6404.1674582304;6448.9375839965405;6202.472789812917;6235.750569977241;6241.282252540925;6244.687765611701;6346.365363463617;6204.279084401833;6263.3736626337;6293.402126797947;6334.588251763621;6386.563023319716;6093.482054025458;6178.536609754196;6195.473384762346;6200.193974783249;6221.3156552780065;6080.331163571915;6081.6924361262545;6092.208012958465;6094.146819445193;6105.542084343603;6180.196574445294;6423.518236132402;6464.41820236181;6466.676666166579;6472.320406357265;4327.740335579875;4342.826286948487;4385.890352741207;4394.846180383671;4398.186335527937;5998.550108741774;6086.6348019119;6121.877562448815;6199.876002480015;6206.193194884636;5922.822315330547;5999.170253072854;6014.849628759316;6061.424164704346;6068.605540639845;5931.5847890648965;5975.551833612583;5980.940190598212;6004.639721616717;6026.276846778239;5661.150827375762;5816;5874.500667443315;5891.617044892068;6086.3305036446845;6241.626842094732;6256.968715156395;6258.43674069336;6270.216222972129;6285.43431091204;5819.5344372450945;6016.669083200466;6062.454379105901;6132.47873930703;6151.200343955257 14:03:58 INFO - PROCESS | 20215 | |5;yui.html;778.666136961812;804.0712976512127;885.7785553611598;890.5814267294369;915.1749116871115;16424.753628695566;17815;17926.73109903351;17968.371107011226;17970.371037013676;15464.922675386608;16139.677206455865;16191.271392787323;16216.432424865132;16216.513504594852;739.7706710919632;861.2937391339104;873.9650413983433;880.810905277873;887.6715615222377;859.0764927702713;860.7805009722543;861.5046348349724;867.6442658510013;870.5603670146567;908.2506931781306;914.2137761525083;915.2129168914728;917.1882883647986;917.2570218123308;904.8868891388577;908.4458480326995;909.9727008189765;910.1808372464768;911.3438324406417;660.2539130782185;666.516775337881;667.3460009190972;667.4493542827187;668.4585485756504;16798.664026719518;16849.663006739796;17027.829721702747;17051.147442627942;17062.14689265544;14693.971422000464;14704.632384190374;14979.775303370458;14990.993859902346;15421.15183664898;14089.577312680636;14612.488562900353;14649.34077966494;14724.852751472563;14762.630934226623;3582.677559019675;3601.351756683796;3605.9362488066085;3635.563732352108;3672.155404257009;86847.13152868453;86969.56515217447;87080.5645971766;88058.5597072017;88558.5572072142;12199.146059775909;12199.817002744965;12343.567975121006;12377;12454;22399.776002240094;22420.215292464687;22479.32562023142;22492.662610060863;22519.211827585958;8519;8585.356098292654;8744.825103497895;8779.473231605996;9021.233195178484;4790.808367665324;5007.949920500749;5062.924056139161;5075.162598171334;5172.146595811724;3676.9080772980888;3834.9041273967814;3835.4055121456217;3837.424386342015;3852.8266228019806;719.4244604316526;725.6480606905646;726.8291951391419;731.0934441292759;764.0754686828889;757.6211894052974;770.3067239484509;776.3362325211975;779.0987962528094;810.6433169405443;10562.630307939186;10718;10850.348979061282;10884.455777211107;11049.39228342449;707.4022451028975;749.539033494397;764.9235076492306;767.5202998126172;774.9147593764682;5113.565346945476;5158.329417175743;5199.506046925536;5239.607029472729;5297.125974214288;83056.58471707602;103358;136072;137380;138105;109413.45293273641;113522;113545;115019.42490287495;115027;90051.54974225217;91878.54060729787;92848.53575732079;93804.53097734605;95464;9927.652532161339;9990.850137248093;10016.348937319051;10080.243981701255;10099.899001009895;56537;56556.71721641366;58086;58391.4160858403;59426.70286648539;83472.58263708885;86296.56851715701;86471;88411.11588884286;90156;13094.476220951055;13094.738105238033;13492;13599.184048957095;13607.387667555182;15426.614334641723;16179.27193276329;16380.180990950643;16536.75194872054;16625.66748665044;15047.774283385977;15301.923490382922;15483.380664773284;15688.450904218298;16021.919890400473;15121.546353609408;15227.390904364145;15320.310586023434;15519.813635349896;15713.528594142193;14762.48331308399;14960.625984350478;14979.625509361917;15244.695106098037;15330.463433779763;12503.187292825936;12587;12699.301538415475;12857.421416036113;13267.071305008943;12676.619701408972;12695.93652031734;12778.698177608201;12909.870901290868;13055.738885222432 14:03:58 INFO - PROCESS | 20215 | __end_tp_report 14:03:58 INFO - PROCESS | 20215 | __start_cc_report 14:03:58 INFO - PROCESS | 20215 | _x_x_mozilla_cycle_collect,324 14:03:58 INFO - PROCESS | 20215 | __end_cc_report 14:03:58 INFO - PROCESS | 20215 | __startTimestamp1465506238711__endTimestamp 14:03:58 INFO - PROCESS | 20215 | 14:03:58 INFO - PROCESS | 20215 | ------- Summary: start ------- 14:03:58 INFO - PROCESS | 20215 | Number of tests: 6 14:03:58 INFO - PROCESS | 20215 | 14:03:58 INFO - PROCESS | 20215 | [#0] dojo.html Cycles:165 Average:5805.03 Median:6055.73 stddev:658.79 (10.9%) stddev-sans-first:633.66 14:03:58 INFO - PROCESS | 20215 | Values: 3418.8 3437.4 3451.1 3457.5 3460.5 5826.4 5834.0 5900.3 5921.9 5923.7 5819.6 5829.3 5830.9 5840.9 5856.6 5278.8 5310.6 5349.0 5349.7 5354.8 5222.5 5234.8 5291.0 5370.2 5391.3 5275.5 5289.4 5299.5 5349.6 5352.4 5333.3 5364.4 5407.1 5409.7 5417.6 5134.2 5148.8 5244.8 5298.9 5394.8 5603.7 5649.0 5685.2 5706.9 5729.0 6106.9 6121.6 6171.6 6212.7 6238.2 6094.9 6166.1 6209.0 6268.7 6291.0 5820.8 5842.8 5876.6 5881.9 5896.7 6353.1 6383.9 6404.0 6410.5 6418.9 6003.2 6072.1 6089.0 6124.2 6152.4 6238.2 6247.6 6257.7 6268.1 6301.3 6187.0 6197.5 6229.1 6242.7 6272.4 6090.4 6108.9 6141.5 6141.6 6243.6 4712.2 4728.9 4732.9 4733.1 4738.2 4202.7 4224.0 4227.0 4234.1 4264.9 5896.7 5908.4 5975.6 5997.4 6022.0 6230.9 6329.9 6337.2 6396.8 6433.6 5935.9 6120.8 6136.1 6136.4 6149.7 5349.0 5396.6 5407.5 5409.4 5451.5 6551.9 6556.0 6577.1 6582.2 6613.7 6057.6 6127.9 6376.3 6401.6 6425.0 6397.3 6423.6 6432.4 6518.0 6519.1 6177.9 6178.1 6184.5 6188.0 6198.3 6061.8 6175.1 6185.8 6210.4 6253.8 6073.6 6119.7 6145.8 6151.8 6157.3 6053.8 6096.7 6116.1 6118.3 6129.8 5782.6 5920.5 5963.9 6004.8 6008.1 6116.1 6129.7 6141.1 6143.3 6175.9 6040.2 6050.0 6054.4 6055.1 6055.7 14:03:58 INFO - PROCESS | 20215 | 14:03:58 INFO - PROCESS | 20215 | [#1] ext.html Cycles:180 Average:66053.61 Median:44608.89 stddev:141054.13 (316.2%) stddev-sans-first:141364.09 14:03:58 INFO - PROCESS | 20215 | Values: 552.3 603.6 616.4 651.8 659.2 45738.8 47489.5 47601.8 51277.0 52172.5 49580.8 49635.0 50123.2 50347.0 50438.5 8934.0 9178.3 9238.8 9246.3 9273.9 9029.6 9065.8 9085.4 9101.2 9117.7 9091.0 9123.9 9161.7 9164.6 9180.6 9067.5 9104.9 9154.8 9165.8 9169.9 9037.6 9154.5 9195.7 9196.6 9209.7 45308.0 45356.0 45372.3 45434.8 45668.0 3638.1 3832.7 4028.6 4255.5 4346.8 33544.3 34492.7 35215.8 35328.5 35365.1 4592.7 4623.0 4671.3 4729.1 4752.7 356453.0 358195.0 358827.0 360027.0 360072.0 65320.0 65944.3 66335.3 66369.0 66568.7 39698.2 40488.6 40543.4 42487.6 62731.4 17786.6 17826.1 17875.7 17925.3 18024.2 13297.6 13377.1 13448.5 13474.4 13591.7 21834.0 22054.8 22135.0 22275.0 22282.8 7374.8 7588.5 7651.8 7720.5 7755.0 1036.1 1061.4 1066.0 1146.0 1151.5 34265.8 34297.0 34507.0 34545.8 34616.3 1105.9 1157.6 1171.2 1183.0 1228.3 16699.2 16818.0 17180.5 17359.4 17363.7 589565.0 651672.0 661214.0 666650.0 1028669.0 61228.7 61322.0 61619.0 61722.0 61920.0 1441.9 1464.6 1465.8 1474.3 1493.2 31810.7 32111.2 32541.8 33232.8 33428.3 52288.7 53376.0 53390.0 53451.0 53475.0 397181.0 399718.0 401263.0 402198.0 402370.0 30476.7 30993.0 31013.0 31396.2 31829.0 54837.6 55232.7 55389.7 55548.2 56546.7 43895.4 44478.6 44962.6 45385.0 46171.0 43712.8 44149.3 44532.8 44685.0 46175.8 44036.8 44810.3 44836.0 44992.3 45944.3 38580.2 38669.6 38761.0 39089.8 39384.6 29579.7 29752.6 29994.7 30114.2 30123.0 14:03:58 INFO - PROCESS | 20215 | 14:03:58 INFO - PROCESS | 20215 | [#2] jquery.html Cycles:180 Average:28524.46 Median:2120.06 stddev:78994.05 (3726.0%) stddev-sans-first:79187.44 14:03:58 INFO - PROCESS | 20215 | Values: 407.8 410.1 412.1 415.9 425.6 18373.3 19557.7 20046.2 20158.3 20604.2 12426.9 12443.8 12672.2 13037.2 13076.3 5299.8 5409.0 5409.4 5421.7 5457.3 5535.6 5818.0 5849.2 5862.3 5872.8 5734.8 5846.8 6108.4 6119.9 6127.9 5980.4 6060.1 6074.1 6080.7 6094.2 5925.1 5981.9 5988.7 6003.3 6006.9 13080.4 13981.2 14023.6 14346.4 14692.4 2204.2 2296.6 2460.2 2539.5 2655.5 10594.8 11003.7 11526.6 11549.8 15820.5 1731.3 1836.8 1844.3 1915.7 1922.8 83311.6 84935.6 85452.1 86469.6 87792.6 10504.5 11100.7 11973.6 11980.3 12105.3 16893.7 17002.4 17027.8 17141.9 17163.3 7814.9 8269.3 8429.5 8717.4 8773.2 7771.3 7790.7 8033.5 8112.1 8211.8 5014.2 5095.3 5143.2 5168.6 5214.2 2079.5 2114.6 2125.5 2135.8 2146.3 1010.5 1045.5 1089.7 1091.2 1124.3 17837.3 19270.2 19347.9 19363.2 20120.9 1020.2 1039.5 1040.6 1096.8 1101.7 10801.9 11202.3 11383.0 11384.2 11492.9 463372.0 477752.0 481730.0 483400.0 484973.0 69588.7 81731.6 95447.0 96126.0 96758.0 1013.2 1029.4 1032.5 1046.3 1054.7 17699.0 17910.6 17947.6 17978.8 18195.5 41620.4 42149.2 42824.0 43074.0 43870.8 58720.0 59209.7 59887.1 60178.0 60500.7 8747.4 8776.0 8828.0 8936.1 9105.9 10292.7 13414.3 13470.5 13515.3 13633.8 11669.4 11720.4 11773.9 11795.7 12098.6 10535.7 11109.9 11538.8 11723.1 12066.2 10910.3 11169.2 11381.4 11575.9 11919.3 8648.8 8746.0 8892.1 9115.0 9194.4 9010.1 11580.4 11714.1 11766.3 11767.5 14:03:58 INFO - PROCESS | 20215 | 14:03:58 INFO - PROCESS | 20215 | [#3] mootools.html Cycles:180 Average:6211.95 Median:2717.71 stddev:3565.13 (131.2%) stddev-sans-first:3557.92 14:03:58 INFO - PROCESS | 20215 | Values: 1550.2 1573.6 1703.0 1833.4 1870.3 8344.3 8898.7 8986.7 9533.7 9543.1 9284.7 9311.8 9383.0 9403.3 9427.6 2506.1 2544.8 2547.2 2547.2 2553.0 2470.3 2533.3 2535.4 2535.6 2552.2 2482.3 2508.9 2522.9 2524.2 2527.0 2455.3 2461.8 2474.3 2503.4 2510.9 2427.7 2443.2 2453.0 2455.6 2489.0 9441.5 9503.5 9509.3 9529.0 9535.5 5591.8 5707.1 5735.9 5745.9 5760.6 3514.9 3595.9 3661.0 3702.7 3707.2 1167.8 1203.7 1212.1 1227.0 1227.6 13199.3 13207.8 13254.1 13305.3 13449.1 4938.3 4997.8 4999.5 5041.7 5053.8 11150.9 11199.7 11214.3 11267.8 11298.3 5645.8 5656.3 5661.0 5684.9 5728.3 4525.4 5110.7 5206.5 5237.3 5242.1 4270.3 4287.3 4333.4 4343.3 4378.0 1359.8 1369.0 1391.9 1407.3 1412.6 869.6 974.6 1040.8 1067.5 1070.9 6143.3 6229.2 6286.6 6354.3 6366.4 486.6 497.2 499.2 507.1 509.3 4423.2 4470.2 4495.0 4506.5 4510.5 11406.2 11796.7 11887.8 11941.6 11954.0 11648.0 11801.7 11806.4 11821.6 11837.8 8335.9 8709.0 8752.7 8757.1 8839.6 6245.8 6494.6 6503.8 6535.0 6569.2 10737.4 10752.9 10862.8 10892.2 10951.2 10854.2 10872.5 11087.8 11142.4 11167.4 7660.5 8092.7 8145.1 8283.5 8336.1 9188.1 9198.9 9202.2 9252.1 9301.5 8040.9 8182.7 8227.7 8273.7 8369.7 8111.8 8161.6 8165.8 8239.1 8321.4 7476.6 7526.9 7529.0 7599.7 7647.1 5041.4 5247.8 5299.8 5466.3 5494.7 5349.7 5437.2 5510.9 5513.2 5660.9 14:03:58 INFO - PROCESS | 20215 | 14:03:58 INFO - PROCESS | 20215 | [#4] prototype.html Cycles:180 Average:5080.55 Median:5813.33 stddev:1500.57 (25.8%) stddev-sans-first:1462.10 14:03:58 INFO - PROCESS | 20215 | Values: 346.0 350.7 353.5 358.6 363.7 5674.4 5747.7 5773.4 5774.2 5867.4 5665.5 5757.2 5784.4 5798.8 5810.7 4006.8 4432.2 4460.8 4491.0 4503.4 4459.2 4476.5 4480.3 4483.1 4486.4 4417.3 4436.2 4478.8 4480.1 4494.2 4322.2 4446.6 4491.7 4500.0 4505.3 3846.6 3927.2 3929.4 3931.6 3936.4 5515.5 5521.4 5533.9 5568.4 5572.7 4963.8 5121.8 5134.8 5174.6 5205.4 5968.4 6030.8 6034.5 6049.4 6079.9 4292.8 4359.5 4405.8 4406.3 4412.9 6026.3 6316.3 6325.4 6369.7 6393.5 4380.3 4390.4 4399.7 4409.0 4444.3 4467.9 4480.2 4481.0 4493.1 4504.8 4856.2 5107.8 5134.2 5147.8 5152.2 6013.9 6038.5 6080.9 6109.7 6110.6 1526.4 1535.3 1541.2 1541.6 1548.5 970.8 999.2 1005.4 1045.3 1049.2 5745.5 5802.4 5875.0 5883.6 5904.9 6112.8 6125.3 6179.3 6181.4 6191.4 5738.7 5873.5 5889.4 5907.8 5922.1 3240.1 3294.3 3296.2 3298.3 3304.3 6162.5 6370.6 6372.2 6404.2 6448.9 6202.5 6235.8 6241.3 6244.7 6346.4 6204.3 6263.4 6293.4 6334.6 6386.6 6093.5 6178.5 6195.5 6200.2 6221.3 6080.3 6081.7 6092.2 6094.1 6105.5 6180.2 6423.5 6464.4 6466.7 6472.3 4327.7 4342.8 4385.9 4394.8 4398.2 5998.6 6086.6 6121.9 6199.9 6206.2 5922.8 5999.2 6014.8 6061.4 6068.6 5931.6 5975.6 5980.9 6004.6 6026.3 5661.2 5816.0 5874.5 5891.6 6086.3 6241.6 6257.0 6258.4 6270.2 6285.4 5819.5 6016.7 6062.5 6132.5 6151.2 14:03:58 INFO - PROCESS | 20215 | 14:03:58 INFO - PROCESS | 20215 | [#5] yui.html Cycles:180 Average:23016.59 Median:3653.86 stddev:33244.20 (909.8%) stddev-sans-first:33295.52 14:03:58 INFO - PROCESS | 20215 | Values: 778.7 804.1 885.8 890.6 915.2 16424.8 17815.0 17926.7 17968.4 17970.4 15464.9 16139.7 16191.3 16216.4 16216.5 739.8 861.3 874.0 880.8 887.7 859.1 860.8 861.5 867.6 870.6 908.3 914.2 915.2 917.2 917.3 904.9 908.4 910.0 910.2 911.3 660.3 666.5 667.3 667.4 668.5 16798.7 16849.7 17027.8 17051.1 17062.1 14694.0 14704.6 14979.8 14991.0 15421.2 14089.6 14612.5 14649.3 14724.9 14762.6 3582.7 3601.4 3605.9 3635.6 3672.2 86847.1 86969.6 87080.6 88058.6 88558.6 12199.1 12199.8 12343.6 12377.0 12454.0 22399.8 22420.2 22479.3 22492.7 22519.2 8519.0 8585.4 8744.8 8779.5 9021.2 4790.8 5007.9 5062.9 5075.2 5172.1 3676.9 3834.9 3835.4 3837.4 3852.8 719.4 725.6 726.8 731.1 764.1 757.6 770.3 776.3 779.1 810.6 10562.6 10718.0 10850.3 10884.5 11049.4 707.4 749.5 764.9 767.5 774.9 5113.6 5158.3 5199.5 5239.6 5297.1 83056.6 103358.0 136072.0 137380.0 138105.0 109413.5 113522.0 113545.0 115019.4 115027.0 90051.5 91878.5 92848.5 93804.5 95464.0 9927.7 9990.9 10016.3 10080.2 10099.9 56537.0 56556.7 58086.0 58391.4 59426.7 83472.6 86296.6 86471.0 88411.1 90156.0 13094.5 13094.7 13492.0 13599.2 13607.4 15426.6 16179.3 16380.2 16536.8 16625.7 15047.8 15301.9 15483.4 15688.5 16021.9 15121.5 15227.4 15320.3 15519.8 15713.5 14762.5 14960.6 14979.6 15244.7 15330.5 12503.2 12587.0 12699.3 12857.4 13267.1 12676.6 12695.9 12778.7 12909.9 13055.7 14:03:58 INFO - PROCESS | 20215 | -------- Summary: end -------- 14:03:58 INFO - PROCESS | 20215 | 14:03:59 INFO - TEST-INFO | 20215: exit 0 14:03:59 INFO - TEST-OK | dromaeo_css | took 1109418ms 14:03:59 INFO - TEST-START | kraken 14:03:59 INFO - operating with platform_type : linux_ 14:03:59 INFO - Initialising browser for kraken test... 14:03:59 INFO - TEST-INFO | started process 20462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI5j1LS/profile http://localhost:55807/getInfo.html) 14:04:03 INFO - PROCESS | 20462 | __metrics Screen width/height:1600/1200 14:04:03 INFO - PROCESS | 20462 | colorDepth:24 14:04:03 INFO - PROCESS | 20462 | Browser inner width/height: 1024/697 14:04:03 INFO - PROCESS | 20462 | __metrics 14:04:03 ERROR - PROCESS | 20462 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:04:04 INFO - TEST-INFO | 20462: exit 0 14:04:04 INFO - Browser initialized. 14:04:04 INFO - Running cycle 1/1 for kraken test... 14:04:04 INFO - TEST-INFO | started process 20591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI5j1LS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:04:16 INFO - PROCESS | 20591 | RSS: Main: 156528640 14:04:16 INFO - PROCESS | 20591 | 14:04:18 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55807/tests/kraken/driver.html?testName=audio-beat-detection) 14:04:19 INFO - PROCESS | 20591 | RSS: Main: 161517568 14:04:19 INFO - PROCESS | 20591 | 14:04:22 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55807/tests/kraken/driver.html?testName=audio-dft) 14:04:23 INFO - PROCESS | 20591 | RSS: Main: 160923648 14:04:23 INFO - PROCESS | 20591 | 14:04:25 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55807/tests/kraken/driver.html?testName=audio-fft) 14:04:26 INFO - PROCESS | 20591 | RSS: Main: 161636352 14:04:26 INFO - PROCESS | 20591 | 14:04:28 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55807/tests/kraken/driver.html?testName=audio-oscillator) 14:04:29 INFO - PROCESS | 20591 | RSS: Main: 160915456 14:04:29 INFO - PROCESS | 20591 | 14:04:31 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55807/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:04:32 INFO - PROCESS | 20591 | RSS: Main: 160821248 14:04:32 INFO - PROCESS | 20591 | 14:04:35 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55807/tests/kraken/driver.html?testName=imaging-darkroom) 14:04:35 INFO - PROCESS | 20591 | RSS: Main: 161046528 14:04:35 INFO - PROCESS | 20591 | 14:04:39 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55807/tests/kraken/driver.html?testName=imaging-desaturate) 14:04:39 INFO - PROCESS | 20591 | RSS: Main: 161308672 14:04:39 INFO - PROCESS | 20591 | 14:04:42 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55807/tests/kraken/driver.html?testName=json-parse-financial) 14:04:43 INFO - PROCESS | 20591 | RSS: Main: 161124352 14:04:43 INFO - PROCESS | 20591 | 14:04:44 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55807/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:04:45 INFO - PROCESS | 20591 | RSS: Main: 160890880 14:04:45 INFO - PROCESS | 20591 | 14:04:47 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:04:47 INFO - PROCESS | 20591 | RSS: Main: 161218560 14:04:47 INFO - PROCESS | 20591 | 14:04:49 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:04:50 INFO - PROCESS | 20591 | RSS: Main: 161280000 14:04:50 INFO - PROCESS | 20591 | 14:04:53 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:04:53 INFO - PROCESS | 20591 | RSS: Main: 161476608 14:04:53 INFO - PROCESS | 20591 | 14:04:56 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:04:57 INFO - PROCESS | 20591 | RSS: Main: 161472512 14:04:57 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | Cycle 1(1): loaded http://localhost:55807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55807/tests/kraken/driver.html?testName=ai-astar) 14:04:58 INFO - PROCESS | 20591 | RSS: Main: 162189312 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | __start_tp_report 14:04:58 INFO - PROCESS | 20591 | _x_x_mozilla_page_load 14:04:58 INFO - PROCESS | 20591 | _x_x_mozilla_page_load_details 14:04:58 INFO - PROCESS | 20591 | |i|pagename|runs| 14:04:58 INFO - PROCESS | 20591 | |0;ai-astar;114;106;110;111;111;113;111;111;111;111 14:04:58 INFO - PROCESS | 20591 | |1;audio-beat-detection;159;124;155;176;140;154;154;128;174;128 14:04:58 INFO - PROCESS | 20591 | |2;audio-dft;164;163;165;167;162;163;161;162;162;161 14:04:58 INFO - PROCESS | 20591 | |3;audio-fft;76;75;77;172;78;77;77;87;174;75 14:04:58 INFO - PROCESS | 20591 | |4;audio-oscillator;86;85;155;85;85;85;134;85;84;151 14:04:58 INFO - PROCESS | 20591 | |5;imaging-gaussian-blur;118;118;117;118;117;117;119;118;118;118 14:04:58 INFO - PROCESS | 20591 | |6;imaging-darkroom;148;149;147;147;148;146;147;149;149;150 14:04:58 INFO - PROCESS | 20591 | |7;imaging-desaturate;97;98;96;97;96;96;97;96;96;96 14:04:58 INFO - PROCESS | 20591 | |8;json-parse-financial;55;53;53;53;53;56;54;53;54;54 14:04:58 INFO - PROCESS | 20591 | |9;json-stringify-tinderbox;61;61;60;61;61;61;62;61;60;61 14:04:58 INFO - PROCESS | 20591 | |10;stanford-crypto-aes;77;76;76;77;77;78;78;84;112;79 14:04:58 INFO - PROCESS | 20591 | |11;stanford-crypto-ccm;151;126;118;130;121;124;127;121;130;120 14:04:58 INFO - PROCESS | 20591 | |12;stanford-crypto-pbkdf2;157;163;155;154;155;165;156;156;157;163 14:04:58 INFO - PROCESS | 20591 | |13;stanford-crypto-sha256-iterative;60;65;62;63;61;60;61;60;61;61 14:04:58 INFO - PROCESS | 20591 | __end_tp_report 14:04:58 INFO - PROCESS | 20591 | __start_cc_report 14:04:58 INFO - PROCESS | 20591 | _x_x_mozilla_cycle_collect,850 14:04:58 INFO - PROCESS | 20591 | __end_cc_report 14:04:58 INFO - PROCESS | 20591 | __startTimestamp1465506298933__endTimestamp 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | ------- Summary: start ------- 14:04:58 INFO - PROCESS | 20591 | Number of tests: 14 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.08 (1.9%) stddev-sans-first:1.88 14:04:58 INFO - PROCESS | 20591 | Values: 114.0 106.0 110.0 111.0 111.0 113.0 111.0 111.0 111.0 111.0 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:154.50 stddev:18.64 (12.1%) stddev-sans-first:19.43 14:04:58 INFO - PROCESS | 20591 | Values: 159.0 124.0 155.0 176.0 140.0 154.0 154.0 128.0 174.0 128.0 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.89 (1.2%) stddev-sans-first:1.96 14:04:58 INFO - PROCESS | 20591 | Values: 164.0 163.0 165.0 167.0 162.0 163.0 161.0 162.0 162.0 161.0 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | [#3] audio-fft Cycles:10 Average:96.80 Median:77.00 stddev:40.31 (52.3%) stddev-sans-first:42.05 14:04:58 INFO - PROCESS | 20591 | Values: 76.0 75.0 77.0 172.0 78.0 77.0 77.0 87.0 174.0 75.0 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:85.00 stddev:30.25 (35.6%) stddev-sans-first:31.42 14:04:58 INFO - PROCESS | 20591 | Values: 86.0 85.0 155.0 85.0 85.0 85.0 134.0 85.0 84.0 151.0 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 14:04:58 INFO - PROCESS | 20591 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 119.0 118.0 118.0 118.0 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 14:04:58 INFO - PROCESS | 20591 | Values: 148.0 149.0 147.0 147.0 148.0 146.0 147.0 149.0 149.0 150.0 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 14:04:58 INFO - PROCESS | 20591 | Values: 97.0 98.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 96.0 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.03 (1.9%) stddev-sans-first:1.00 14:04:58 INFO - PROCESS | 20591 | Values: 55.0 53.0 53.0 53.0 53.0 56.0 54.0 53.0 54.0 54.0 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 14:04:58 INFO - PROCESS | 20591 | Values: 61.0 61.0 60.0 61.0 61.0 61.0 62.0 61.0 60.0 61.0 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:77.50 stddev:11.00 (14.2%) stddev-sans-first:11.55 14:04:58 INFO - PROCESS | 20591 | Values: 77.0 76.0 76.0 77.0 77.0 78.0 78.0 84.0 112.0 79.0 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:126.50 stddev:9.46 (7.5%) stddev-sans-first:4.40 14:04:58 INFO - PROCESS | 20591 | Values: 151.0 126.0 118.0 130.0 121.0 124.0 127.0 121.0 130.0 120.0 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:157.00 stddev:3.98 (2.5%) stddev-sans-first:4.21 14:04:58 INFO - PROCESS | 20591 | Values: 157.0 163.0 155.0 154.0 155.0 165.0 156.0 156.0 157.0 163.0 14:04:58 INFO - PROCESS | 20591 | 14:04:58 INFO - PROCESS | 20591 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.00 stddev:1.58 (2.6%) stddev-sans-first:1.59 14:04:58 INFO - PROCESS | 20591 | Values: 60.0 65.0 62.0 63.0 61.0 60.0 61.0 60.0 61.0 61.0 14:04:58 INFO - PROCESS | 20591 | -------- Summary: end -------- 14:04:58 INFO - PROCESS | 20591 | 14:04:59 INFO - TEST-INFO | 20591: exit 0 14:04:59 INFO - TEST-OK | kraken | took 60488ms 14:04:59 INFO - SUITE-END | took 1169s 14:05:00 INFO - Completed test suite (00:19:30) 14:05:00 INFO - javascript benchmark 14:05:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7717.931962267188, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3418.8119653419058, 3437.432823584109, 3451.102713294543, 3457.4986626939085, 3460.53282806821, 5826.417358264177, 5833.970830145849, 5900.321463031742, 5921.911171332434, 5923.733431995554, 5819.592628516006, 5829.329627092886, 5830.854228644286, 5840.853978650536, 5856.590038697293, 5278.788848446067, 5310.575153987672, 5348.973255133719, 5349.7057661828585, 5354.759035843377, 5222.503862133091, 5234.790608375661, 5291.047611429941, 5370.167624018283, 5391.32608423947, 5275.472452754713, 5289.391719952217, 5299.5230429261355, 5349.598780091489, 5352.357717073937, 5333.253344531769, 5364.356277246736, 5407.053765591006, 5409.702466364349, 5417.566594672456, 5134.1528647773075, 5148.819791307324, 5244.763985620656, 5298.894022119536, 5394.838154855361, 5603.691796951166, 5648.983183027053, 5685.232493613351, 5706.942930570683, 5729.0, 6106.908396374058, 6121.632702037848, 6171.567990240685, 6212.720427580724, 6238.220222472191, 6094.9390506094815, 6166.105914642397, 6209.0, 6268.65522396268, 6290.9685451572905, 5820.82537523875, 5842.766289348378, 5876.55925805562, 5881.85295367615, 5896.675682837442, 6353.078803573456, 6383.9361606383345, 6403.96798016007, 6410.455111315498, 6418.903716444257, 6003.21958145447, 6072.149899014142, 6089.025755879126, 6124.173236613089, 6152.415520525543, 6238.157848690459, 6247.5939063960695, 6257.655828929362, 6268.09112678659, 6301.306856245809, 6187.010078387527, 6197.4732147767945, 6229.127922090911, 6242.687865606792, 6272.372762723691, 6090.421409966046, 6108.877822443526, 6141.477974372139, 6141.556734167467, 6243.594166379171, 4712.198926182557, 4728.881777955578, 4732.905341893212, 4733.14803335396, 4738.1708201064675, 4202.663786897041, 4223.978880105641, 4227.0, 4234.06850492891, 4264.850730224489, 5896.705164741746, 5908.379620139909, 5975.641461512323, 5997.400259974055, 6022.036474164201, 6230.875382492325, 6329.905051424233, 6337.207849018872, 6396.808095757135, 6433.646149461824, 5935.910961335583, 6120.755169793248, 6136.079588061826, 6136.386361363917, 6149.661768602769, 5348.973255133699, 5396.595255355864, 5407.45925407464, 5409.350877894678, 5451.509364157245, 6551.860155083632, 6556.0493728410065, 6577.112089867902, 6582.17722784652, 6613.702383392662, 6057.606255593372, 6127.922628246602, 6376.266729326094, 6401.615903045832, 6425.0, 6397.296297407374, 6423.618921931807, 6432.388923052303, 6517.967410162919, 6519.054737063194, 6177.876442471215, 6178.104174894705, 6184.505239580732, 6188.0, 6198.287196972406, 6061.7575296987625, 6175.135481032569, 6185.752569897334, 6210.441060304594, 6253.843653908689, 6073.605215660968, 6119.743648523402, 6145.832291864532, 6151.784687535915, 6157.26112866441, 6053.788117415869, 6096.695165241809, 6116.091931071693, 6118.261146750579, 6129.816105516663, 5782.5663075268685, 5920.526357891445, 5963.880722385441, 6004.759809607567, 6008.098785182257, 6116.14373987651, 6129.693515324305, 6141.109539116893, 6143.32423433413, 6175.9382406177165, 6040.214772079602, 6050.0, 6054.424829641177, 6055.061465472859, 6055.72749226277], "value": 5760.937057137682, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.2516989479255, 603.5624172474955, 616.4451993206116, 651.843557546189, 659.1595715462785, 45738.77130614346, 47489.525104748944, 47601.76199119004, 51277.0, 52172.47827521724, 49580.75209623956, 49635.0, 50123.24815127776, 50347.0, 50438.49561504384, 8933.955330223356, 9178.311626627996, 9238.769030774218, 9246.260299176083, 9273.86089208659, 9029.593668284942, 9065.818683626323, 9085.409448385866, 9101.180893719564, 9117.68088116916, 9091.04544022878, 9123.863142052875, 9161.679341223058, 9164.633414663438, 9180.632774689038, 9067.546622668906, 9104.908950910505, 9154.809874716311, 9165.816683666357, 9169.862452063224, 9037.593308301142, 9154.450732956044, 9195.678151264674, 9196.586153623102, 9209.723708288762, 45308.0, 45356.0, 45372.319415208796, 45434.77282613599, 45668.0, 3638.1450359165574, 3832.7317087803863, 4028.637422631977, 4255.489341279035, 4346.826126954918, 33544.329113417836, 34492.6550734492, 35215.82392088049, 35328.47007294893, 35365.1158721034, 4592.7014744041535, 4622.976885115587, 4671.299305104228, 4729.101470720552, 4752.714837109785, 356453.0, 358195.0, 358827.0, 360027.0, 360071.9999999974, 65320.0, 65944.34055659382, 66335.33664663388, 66369.0, 66568.66715666391, 39698.206035879695, 40488.59511404907, 40543.39184912229, 42487.57512424898, 62731.37268627255, 17786.644267114843, 17826.10869456548, 17875.73186402205, 17925.28298868031, 18024.188911499015, 13297.601071967856, 13377.130486518345, 13448.462061517625, 13474.393652285671, 13591.660208494866, 21834.0, 22054.77945220527, 22135.0, 22274.99762510691, 22282.77717222807, 7374.778756637309, 7588.544687318778, 7651.770446886602, 7720.498167619199, 7754.961225193838, 1036.1142720249225, 1061.4321338084087, 1065.9893401066045, 1145.954161833534, 1151.5393842463081, 34265.828670856485, 34297.0, 34507.0, 34545.82727086348, 34616.30767384689, 1105.8672959244782, 1157.6411312493153, 1171.1509155861932, 1182.9763404731857, 1228.3305598448867, 16699.165041747863, 16818.0, 17180.484585462455, 17359.39242126545, 17363.739543906853, 589565.0, 651672.0, 661214.0, 666650.0, 1028669.0, 61228.69385653043, 61322.0, 61619.0, 61722.0, 61920.0, 1441.9495317663832, 1464.633841539615, 1465.846086160959, 1474.321811966486, 1493.2011373914904, 31810.681893180772, 32111.197220069684, 32541.837290813393, 33232.833835830665, 33428.331433371684, 52288.73855630698, 53376.0, 53390.0, 53451.0, 53475.0, 397181.0, 399718.0, 401263.0, 402198.0, 402370.0, 30476.695233047387, 30993.0, 31013.0, 31396.215094621904, 31829.0, 54837.56974273003, 55232.72383638217, 55389.723051384484, 55548.16677749918, 56546.717266413405, 43895.36627802342, 44478.55521444744, 44962.55037449714, 45385.0, 46171.0, 43712.78143609261, 44149.33775993427, 44532.77733611311, 44685.0, 46175.76912115418, 44036.779816100716, 44810.327845083004, 44836.0, 44992.32511512395, 45944.31083533683, 38580.228395432496, 38669.6133038666, 38761.0, 39089.80455097706, 39384.6061539381, 29579.704202957695, 29752.553711694774, 29994.700053000062, 30114.247143820703, 30123.0], "value": 21385.497268364423, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.78183671735616, 410.1161995898837, 412.13657387772616, 415.8648439257242, 425.64671322802076, 18373.265069397225, 19557.706634400496, 20046.198152073917, 20158.294459693894, 20604.1758329667, 12426.875731242684, 12443.751124977494, 12672.239665620045, 13037.152585081987, 13076.346182690851, 5299.761510732017, 5408.972955135238, 5409.377921539014, 5421.701806400646, 5457.317835270591, 5535.58483113768, 5818.0400233961345, 5849.151872978416, 5862.32583252925, 5872.823815285548, 5734.770609175628, 5846.795362162326, 6108.389161083878, 6119.908201376983, 6127.938720612804, 5980.43185897339, 6060.090986352038, 6074.058520929263, 6080.695965201767, 6094.1772860663905, 5925.051991681354, 5981.8803623927715, 5988.670623115727, 6003.279606447254, 6006.909896351558, 13080.41138148776, 13981.231032293219, 14023.64940876476, 14346.354414051393, 14692.412303507846, 2204.1624182810588, 2296.59809533331, 2460.1512478194995, 2539.5301869154264, 2655.49545586338, 10594.788104237949, 11003.724906877393, 11526.596569120124, 11549.769004619944, 15820.525384238492, 1731.2784978993702, 1836.7612210412694, 1844.3070930301817, 1915.6647586672277, 1922.80771922808, 83311.583442083, 84935.575322123, 85452.14547854503, 86469.56765216133, 87792.56103719505, 10504.474776261157, 11100.666979990614, 11973.640790776291, 11980.341081240615, 12105.273683579013, 16893.66212675764, 17002.404915827887, 17027.829721702874, 17141.91429042872, 17163.313467461412, 7814.921850781419, 8269.338452923752, 8429.4942303462, 8717.389782715149, 8773.166549177946, 7771.261730135628, 7790.727324543614, 8033.517988920684, 8112.067112282045, 8211.753647390588, 5014.197728363444, 5095.337606111182, 5143.202803565453, 5168.61235407346, 5214.243934629533, 2079.480129967508, 2114.6193685136514, 2125.5005073807642, 2135.8107939361967, 2146.3131797824544, 1010.5200029985845, 1045.534737042009, 1089.6676513663251, 1091.170710260208, 1124.2860783402598, 17837.286508539513, 19270.22919083221, 19347.903260483607, 19363.225470981284, 20120.89939550322, 1020.2195320579763, 1039.4802598700649, 1040.6305761454726, 1096.8025755363951, 1101.6639924822846, 10801.891981080245, 11202.327860328407, 11383.0, 11384.203105782515, 11492.942535287437, 463372.0, 477752.0, 481730.0, 483400.0, 484973.0, 69588.65205673939, 81731.59134204291, 95447.04552954382, 96126.0, 96758.0, 1013.2096964367805, 1029.4029462911642, 1032.4992378696327, 1046.2780681329857, 1054.7363159210197, 17699.0, 17910.641787163924, 17947.5513112168, 17978.820211797716, 18195.45413637593, 41620.37569436521, 42149.1570168601, 42824.0, 43074.0, 43870.780646096566, 58720.0, 59209.70395147997, 59887.1016934755, 60178.0, 60500.697496512235, 8747.38173437916, 8775.956120219613, 8828.0, 8936.106389361012, 9105.908940910505, 10292.742681432725, 13414.262215578237, 13470.461181552628, 13515.256660883746, 13633.79549306781, 11669.416529173337, 11720.413979301171, 11773.882261177621, 11795.705107372385, 12098.637040888787, 10535.73660658459, 11109.888901110886, 11538.76922461563, 11723.120765942418, 12066.155369124428, 10910.345379277269, 11169.162312826733, 11381.43092845338, 11575.88424115748, 11919.284842909454, 8648.78378040554, 8746.0, 8892.066333035196, 9115.0, 9194.448333100036, 9010.098990100938, 11580.36308003068, 11714.062874969812, 11766.294022358687, 11767.470463829319], "value": 9233.660500647045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1550.155165434838, 1573.6380632454536, 1703.0, 1833.3858157517232, 1870.279942222245, 8344.332453403727, 8898.688545900895, 8986.730398088068, 9533.713988580344, 9543.14111729945, 9284.721458356244, 9311.813763724722, 9382.953085234565, 9403.294752893526, 9427.57575909084, 2506.147909710698, 2544.821862469628, 2547.1721690450586, 2547.223096955428, 2553.042609021617, 2470.28361775085, 2533.3160046787357, 2535.4422027153996, 2535.5816290312077, 2552.157787929988, 2482.3173627252468, 2508.8871000804916, 2522.924312270635, 2524.179641616473, 2526.987365063181, 2455.3002394317623, 2461.8399804012683, 2474.3071939856777, 2503.436726736488, 2510.874456277179, 2427.684401027855, 2443.169322430382, 2453.0187924830034, 2455.5702752018324, 2488.962665560018, 9441.480718560477, 9503.524823758784, 9509.286803489696, 9529.047095290485, 9535.52322383878, 5591.776328946838, 5707.086866101404, 5735.913961290584, 5745.88508229833, 5760.6255593386295, 3514.859405623772, 3595.9101022474388, 3661.011526887752, 3702.7037836973245, 3707.2400157967554, 1167.7956357637465, 1203.6519098609613, 1212.0545974140184, 1226.9754604907941, 1227.613301809936, 13199.274039927801, 13207.801882971764, 13254.138480998705, 13305.268210248432, 13449.125806822525, 4938.259261110862, 4997.800087996512, 4999.525045120708, 5041.672291301127, 5053.84838454847, 11150.944245278884, 11199.72000699989, 11214.271072380268, 11267.830982535268, 11298.265612735146, 5645.802396916089, 5656.2929633795775, 5661.0, 5684.919865225594, 5728.312602487728, 4525.366448697185, 5110.744462776846, 5206.453322401093, 5237.3453318335205, 5242.082635538765, 4270.252705776476, 4287.335463003239, 4333.371661109121, 4343.326784348431, 4377.956220437819, 1359.7688392973218, 1368.9589312320647, 1391.902566820333, 1407.331517529186, 1412.632715493979, 869.6347534035593, 974.5614473486959, 1040.7770869228625, 1067.4822710985165, 1070.9089727373262, 6143.293521245114, 6229.221347331583, 6286.591371560834, 6354.26925903527, 6366.448814746262, 486.5766782898901, 497.16972655665126, 499.19131007767646, 507.0897738559295, 509.297169905528, 4423.248047831877, 4470.240059189946, 4494.977525112354, 4506.481754598198, 4510.503844577094, 11406.201565890307, 11796.705082372837, 11887.821682674767, 11941.582044628396, 11954.043676505858, 11648.0, 11801.704957375963, 11806.40967951599, 11821.586244481401, 11837.76324473523, 8335.916640833513, 8708.95645521781, 8752.737417877473, 8757.124287571192, 8839.60221790021, 6245.781397651061, 6494.6103233806125, 6503.804885853432, 6535.0, 6569.211694596679, 10737.409442480739, 10752.892471075189, 10862.837057444303, 10892.237543372205, 10951.233413660968, 10854.240203185702, 10872.456377180952, 11087.833682494607, 11142.387168705798, 11167.38579378142, 7660.502067365604, 8092.71675491355, 8145.104038555873, 8283.473540570183, 8336.12470690593, 9188.127127922837, 9198.908010919806, 9202.171804537624, 9252.121048500381, 9301.488418137067, 8040.919590804017, 8182.67269309221, 8227.71203007892, 8273.710420135267, 8369.66521339164, 8111.83776324482, 8161.632726527439, 8165.836683266421, 8239.093699693149, 8321.41750077513, 7476.5887876167335, 7526.924730752841, 7528.962355188189, 7599.658015389431, 7647.120581133241, 5041.369828771403, 5247.763850626655, 5299.814506492255, 5466.34403871538, 5494.670319780826, 5349.705766182741, 5437.211604317273, 5510.889782204414, 5513.2005859151, 5660.886782264414], "value": 4887.14913766574, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.99308013839726, 350.7089116033692, 353.52450953467576, 358.63598447575697, 363.7163012849975, 5674.375818659949, 5747.655140691561, 5773.383452633269, 5774.249347584819, 5867.442592953673, 5665.461781130796, 5757.215263268379, 5784.363719990798, 5798.768049278024, 5810.651360918338, 4006.83972641094, 4432.224360736858, 4460.79926403311, 4490.989527356343, 4503.392042074327, 4459.152760975404, 4476.462824461069, 4480.283154695249, 4483.148201841656, 4486.439195100613, 4417.293233082707, 4436.223660859353, 4478.843240486583, 4480.126375356806, 4494.213512635276, 4322.178786030644, 4446.622037126848, 4491.730496170224, 4500.032493014001, 4505.324201369788, 3846.576876543578, 3927.19492504036, 3929.390944403622, 3931.5871833457363, 3936.4095385692376, 5515.531179849718, 5521.420250873641, 5533.9485497755295, 5568.415316391761, 5572.749226284827, 4963.759060234941, 5121.795128194905, 5134.767655762627, 5174.560162386202, 5205.375354957391, 5968.37332080134, 6030.849228769272, 6034.547408944347, 6049.364816694228, 6079.939200607982, 4292.806823692941, 4359.455068116486, 4405.801738921757, 4406.317020861771, 4412.933805992912, 6026.252386807821, 6316.294600457896, 6325.399087086719, 6369.681515924185, 6393.520485963571, 4380.342948557742, 4390.407295015196, 4399.714018588781, 4408.955910440919, 4444.333349997526, 4467.932981005288, 4480.215962206601, 4480.955190448054, 4493.123840851068, 4504.752238626907, 4856.17445034345, 5107.821226257063, 5134.204198349262, 5147.760724085035, 5152.175651895679, 6013.909791353133, 6038.486728628028, 6080.878382432326, 6109.694515274218, 6110.594563250477, 1526.4275896538797, 1535.3244572388114, 1541.221683050075, 1541.6300087978805, 1548.5276990518, 970.8495183246608, 999.1656966432964, 1005.4118340770585, 1045.310095337089, 1049.186880167876, 5745.540356771448, 5802.361740208574, 5874.970625146847, 5883.588148829626, 5904.940950590525, 6112.786052488231, 6125.2649682037545, 6179.3202747698615, 6181.381861813783, 6191.380861913863, 5738.713064346766, 5873.471387575139, 5889.440503152194, 5907.763689452374, 5922.141289512996, 3240.141362538929, 3294.3081952789703, 3296.175956010997, 3298.3073554553334, 3304.289577740797, 6162.5378096642935, 6370.617762934146, 6372.171617689671, 6404.1674582304, 6448.9375839965405, 6202.472789812917, 6235.750569977241, 6241.282252540925, 6244.687765611701, 6346.365363463617, 6204.279084401833, 6263.3736626337, 6293.402126797947, 6334.588251763621, 6386.563023319716, 6093.482054025458, 6178.536609754196, 6195.473384762346, 6200.193974783249, 6221.3156552780065, 6080.331163571915, 6081.6924361262545, 6092.208012958465, 6094.146819445193, 6105.542084343603, 6180.196574445294, 6423.518236132402, 6464.41820236181, 6466.676666166579, 6472.320406357265, 4327.740335579875, 4342.826286948487, 4385.890352741207, 4394.846180383671, 4398.186335527937, 5998.550108741774, 6086.6348019119, 6121.877562448815, 6199.876002480015, 6206.193194884636, 5922.822315330547, 5999.170253072854, 6014.849628759316, 6061.424164704346, 6068.605540639845, 5931.5847890648965, 5975.551833612583, 5980.940190598212, 6004.639721616717, 6026.276846778239, 5661.150827375762, 5816.0, 5874.500667443315, 5891.617044892068, 6086.3305036446845, 6241.626842094732, 6256.968715156395, 6258.43674069336, 6270.216222972129, 6285.43431091204, 5819.5344372450945, 6016.669083200466, 6062.454379105901, 6132.47873930703, 6151.200343955257], "value": 4599.318892707261, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.666136961812, 804.0712976512127, 885.7785553611598, 890.5814267294369, 915.1749116871115, 16424.753628695566, 17815.0, 17926.73109903351, 17968.371107011226, 17970.371037013676, 15464.922675386608, 16139.677206455865, 16191.271392787323, 16216.432424865132, 16216.513504594852, 739.7706710919632, 861.2937391339104, 873.9650413983433, 880.810905277873, 887.6715615222377, 859.0764927702713, 860.7805009722543, 861.5046348349724, 867.6442658510013, 870.5603670146567, 908.2506931781306, 914.2137761525083, 915.2129168914728, 917.1882883647986, 917.2570218123308, 904.8868891388577, 908.4458480326995, 909.9727008189765, 910.1808372464768, 911.3438324406417, 660.2539130782185, 666.516775337881, 667.3460009190972, 667.4493542827187, 668.4585485756504, 16798.664026719518, 16849.663006739796, 17027.829721702747, 17051.147442627942, 17062.14689265544, 14693.971422000464, 14704.632384190374, 14979.775303370458, 14990.993859902346, 15421.15183664898, 14089.577312680636, 14612.488562900353, 14649.34077966494, 14724.852751472563, 14762.630934226623, 3582.677559019675, 3601.351756683796, 3605.9362488066085, 3635.563732352108, 3672.155404257009, 86847.13152868453, 86969.56515217447, 87080.5645971766, 88058.5597072017, 88558.5572072142, 12199.146059775909, 12199.817002744965, 12343.567975121006, 12377.0, 12454.0, 22399.776002240094, 22420.215292464687, 22479.32562023142, 22492.662610060863, 22519.211827585958, 8519.0, 8585.356098292654, 8744.825103497895, 8779.473231605996, 9021.233195178484, 4790.808367665324, 5007.949920500749, 5062.924056139161, 5075.162598171334, 5172.146595811724, 3676.9080772980888, 3834.9041273967814, 3835.4055121456217, 3837.424386342015, 3852.8266228019806, 719.4244604316526, 725.6480606905646, 726.8291951391419, 731.0934441292759, 764.0754686828889, 757.6211894052974, 770.3067239484509, 776.3362325211975, 779.0987962528094, 810.6433169405443, 10562.630307939186, 10718.0, 10850.348979061282, 10884.455777211107, 11049.39228342449, 707.4022451028975, 749.539033494397, 764.9235076492306, 767.5202998126172, 774.9147593764682, 5113.565346945476, 5158.329417175743, 5199.506046925536, 5239.607029472729, 5297.125974214288, 83056.58471707602, 103358.0, 136072.0, 137380.0, 138105.0, 109413.45293273641, 113522.0, 113545.0, 115019.42490287495, 115027.0, 90051.54974225217, 91878.54060729787, 92848.53575732079, 93804.53097734605, 95464.0, 9927.652532161339, 9990.850137248093, 10016.348937319051, 10080.243981701255, 10099.899001009895, 56537.0, 56556.71721641366, 58086.0, 58391.4160858403, 59426.70286648539, 83472.58263708885, 86296.56851715701, 86471.0, 88411.11588884286, 90156.0, 13094.476220951055, 13094.738105238033, 13492.0, 13599.184048957095, 13607.387667555182, 15426.614334641723, 16179.27193276329, 16380.180990950643, 16536.75194872054, 16625.66748665044, 15047.774283385977, 15301.923490382922, 15483.380664773284, 15688.450904218298, 16021.919890400473, 15121.546353609408, 15227.390904364145, 15320.310586023434, 15519.813635349896, 15713.528594142193, 14762.48331308399, 14960.625984350478, 14979.625509361917, 15244.695106098037, 15330.463433779763, 12503.187292825936, 12587.0, 12699.301538415475, 12857.421416036113, 13267.071305008943, 12676.619701408972, 12695.93652031734, 12778.698177608201, 12909.870901290868, 13055.738885222432], "value": 8264.740897451693, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 110.0, 111.0, 111.0, 113.0, 111.0, 111.0, 111.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 155.0, 176.0, 140.0, 154.0, 154.0, 128.0, 174.0, 128.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 167.0, 162.0, 163.0, 161.0, 162.0, 162.0, 161.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 172.0, 78.0, 77.0, 77.0, 87.0, 174.0, 75.0], "value": 96.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 155.0, 85.0, 85.0, 85.0, 134.0, 85.0, 84.0, 151.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 119.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 147.0, 148.0, 146.0, 147.0, 149.0, 149.0, 150.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 53.0, 53.0, 56.0, 54.0, 53.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 62.0, 61.0, 60.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 77.0, 77.0, 78.0, 78.0, 84.0, 112.0, 79.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 118.0, 130.0, 121.0, 124.0, 127.0, 121.0, 130.0, 120.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 163.0, 155.0, 154.0, 155.0, 165.0, 156.0, 156.0, 157.0, 163.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 65.0, 62.0, 63.0, 61.0, 60.0, 61.0, 60.0, 61.0, 61.0], "value": 61.4, "unit": "score"}]}]} 14:05:00 INFO - Return code: 0 14:05:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:05:00 ERROR - # TBPL SUCCESS # 14:05:00 INFO - Running post-action listener: _resource_record_post_action 14:05:00 INFO - ##### 14:05:00 INFO - ##### Finished run-tests step (success) 14:05:00 INFO - ##### 14:05:00 INFO - Running post-run listener: _resource_record_post_run 14:05:00 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 385576960; Read time: 0; Write time: 339668 14:05:00 INFO - TinderboxPrint: CPU usage
13.4% 14:05:00 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:05:00 INFO - TinderboxPrint: I/O write bytes / time
385,576,960 / 339,668 14:05:00 INFO - TinderboxPrint: CPU idle
8,200.9 (86.6%) 14:05:00 INFO - TinderboxPrint: CPU user
1,213.4 (12.8%) 14:05:00 INFO - TinderboxPrint: Swap in / out
0 / 0 14:05:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 120958976; Read time: 0; Write time: 122160 14:05:00 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 249393152; Read time: 0; Write time: 196696 14:05:00 INFO - Running post-run listener: _upload_blobber_files 14:05:00 INFO - Blob upload gear active. 14:05:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:05:00 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 14:05:00 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:05:00 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:05:01 INFO - (blobuploader) - INFO - Open directory for files ... 14:05:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:05:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:05:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:05:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:05:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:05:02 INFO - (blobuploader) - INFO - Done attempting. 14:05:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:05:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:05:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:05:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:05:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:05:07 INFO - (blobuploader) - INFO - Done attempting. 14:05:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:05:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:05:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:05:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:05:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:05:08 INFO - (blobuploader) - INFO - Done attempting. 14:05:08 INFO - (blobuploader) - INFO - Iteration through files over. 14:05:08 INFO - Return code: 0 14:05:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:05:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:05:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99c3e31836391ef19a20a3988be0282e31471e206d8d316e6c9d68a001ce9c68d48d2b0c48b9b5f6eb3193dba9c55955e3a735b71ae31116a3e906b87b0bc3c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a10d869218ae81f8d6772ab020bf686a1fb495500c328e00cbcdcc800f1fbed2583338d8d2a3be8d7ed2e079119039879897354d1be33ba10af1cf8a2b1ace34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3764dd41f23744a43a35df22e381da1d1811fb233448600bce041defbdc300394d62a4968c259146014f53991ab672a55b699e5377175e9d8943613b9f678fc"} 14:05:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:05:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:05:08 INFO - Contents: 14:05:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99c3e31836391ef19a20a3988be0282e31471e206d8d316e6c9d68a001ce9c68d48d2b0c48b9b5f6eb3193dba9c55955e3a735b71ae31116a3e906b87b0bc3c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a10d869218ae81f8d6772ab020bf686a1fb495500c328e00cbcdcc800f1fbed2583338d8d2a3be8d7ed2e079119039879897354d1be33ba10af1cf8a2b1ace34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3764dd41f23744a43a35df22e381da1d1811fb233448600bce041defbdc300394d62a4968c259146014f53991ab672a55b699e5377175e9d8943613b9f678fc"} 14:05:08 INFO - Running post-run listener: copy_logs_to_upload_dir 14:05:08 INFO - Copying logs to upload dir... 14:05:08 INFO - mkdir: /builds/slave/test/build/upload/logs 14:05:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.575516 ========= master_lag: 1.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-09 14:05:09.645840) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:05:09.649812) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99c3e31836391ef19a20a3988be0282e31471e206d8d316e6c9d68a001ce9c68d48d2b0c48b9b5f6eb3193dba9c55955e3a735b71ae31116a3e906b87b0bc3c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a10d869218ae81f8d6772ab020bf686a1fb495500c328e00cbcdcc800f1fbed2583338d8d2a3be8d7ed2e079119039879897354d1be33ba10af1cf8a2b1ace34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3764dd41f23744a43a35df22e381da1d1811fb233448600bce041defbdc300394d62a4968c259146014f53991ab672a55b699e5377175e9d8943613b9f678fc"} build_url:https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99c3e31836391ef19a20a3988be0282e31471e206d8d316e6c9d68a001ce9c68d48d2b0c48b9b5f6eb3193dba9c55955e3a735b71ae31116a3e906b87b0bc3c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a10d869218ae81f8d6772ab020bf686a1fb495500c328e00cbcdcc800f1fbed2583338d8d2a3be8d7ed2e079119039879897354d1be33ba10af1cf8a2b1ace34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3764dd41f23744a43a35df22e381da1d1811fb233448600bce041defbdc300394d62a4968c259146014f53991ab672a55b699e5377175e9d8943613b9f678fc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:05:09.675074) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:05:09.675411) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1465505073.443861-1372049229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:05:09.725132) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:05:09.725453) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:05:09.725746) ========= ========= Total master_lag: 1.49 =========