builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1465402091.84 results: success (0) buildid: 20160608061731 builduid: bb02556692494efd83a786b8f78d49fd revision: 3a4cd59e97b5100b2b14185a068271531b80c68d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 09:08:11.840029) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 09:08:11.843556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 09:08:11.843948) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 09:08:11.907094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:08:11.907367) ========= 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=836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 09:08:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-06-08 09:08:12 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139582 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:08:12.064098) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:08:12.064439) ========= 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=836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016595 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:08:12.118216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 09:08:12.118594) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3a4cd59e97b5100b2b14185a068271531b80c68d --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 3a4cd59e97b5100b2b14185a068271531b80c68d --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=836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 09:08:12,315 truncating revision to first 12 chars 2016-06-08 09:08:12,315 Setting DEBUG logging. 2016-06-08 09:08:12,315 attempt 1/10 2016-06-08 09:08:12,315 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3a4cd59e97b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 09:08:12,821 unpacking tar archive at: mozilla-aurora-3a4cd59e97b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.846031 ========= master_lag: 0.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 09:08:13.227700) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 09:08:13.227997) ========= script_repo_revision: 3a4cd59e97b5100b2b14185a068271531b80c68d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 09:08:13.228420) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 09:08:13.228711) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 09:08:13.250116) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-08 09:08:13.250521) ========= /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=836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:08:13 INFO - MultiFileLogger online at 20160608 09:08:13 in /builds/slave/test 09:08:13 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 09:08:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:08:13 INFO - {'append_to_log': False, 09:08:13 INFO - 'base_work_dir': '/builds/slave/test', 09:08:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:08:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:08:13 INFO - 'branch': 'Mozilla-Aurora', 09:08:13 INFO - 'buildbot_json_path': 'buildprops.json', 09:08:13 INFO - 'config_files': ('talos/linux_config.py',), 09:08:13 INFO - 'default_actions': ('clobber', 09:08:13 INFO - 'read-buildbot-config', 09:08:13 INFO - 'download-and-extract', 09:08:13 INFO - 'populate-webroot', 09:08:13 INFO - 'create-virtualenv', 09:08:13 INFO - 'install', 09:08:13 INFO - 'run-tests'), 09:08:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:08:13 INFO - 'download_minidump_stackwalk': True, 09:08:13 INFO - 'download_symbols': 'ondemand', 09:08:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:08:13 INFO - 'tooltool.py': '/tools/tooltool.py', 09:08:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:08:13 INFO - '/tools/misc-python/virtualenv.py')}, 09:08:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:08:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:08:13 INFO - 'installer_path': 'installer.exe', 09:08:13 INFO - 'log_level': 'info', 09:08:13 INFO - 'log_name': 'talos', 09:08:13 INFO - 'log_to_console': True, 09:08:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:08:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:08:13 INFO - 'opt_config_files': (), 09:08:13 INFO - 'pip_index': False, 09:08:13 INFO - 'sps_profile': False, 09:08:13 INFO - 'sps_profile_interval': 0, 09:08:13 INFO - 'suite': 'dromaeojs-e10s', 09:08:13 INFO - 'system_bits': '32', 09:08:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:08:13 INFO - 'title': 'talos-linux64-ix-028', 09:08:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:08:13 INFO - 'use_talos_json': True, 09:08:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:08:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:08:13 INFO - 'work_dir': 'build'} 09:08:13 INFO - ##### 09:08:13 INFO - ##### Running clobber step. 09:08:13 INFO - ##### 09:08:13 INFO - Running pre-action listener: _resource_record_pre_action 09:08:13 INFO - Running main action method: clobber 09:08:13 INFO - rmtree: /builds/slave/test/build 09:08:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:08:14 INFO - Running post-action listener: _resource_record_post_action 09:08:14 INFO - ##### 09:08:14 INFO - ##### Finished clobber step (success) 09:08:14 INFO - ##### 09:08:14 INFO - ##### 09:08:14 INFO - ##### Running read-buildbot-config step. 09:08:14 INFO - ##### 09:08:14 INFO - Running pre-action listener: _resource_record_pre_action 09:08:14 INFO - Running main action method: read_buildbot_config 09:08:14 INFO - Using buildbot properties: 09:08:14 INFO - { 09:08:14 INFO - "project": "", 09:08:14 INFO - "product": "firefox", 09:08:14 INFO - "script_repo_revision": "production", 09:08:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:08:14 INFO - "repository": "", 09:08:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:08:14 INFO - "buildid": "20160608061731", 09:08:14 INFO - "pgo_build": "True", 09:08:14 INFO - "basedir": "/builds/slave/test", 09:08:14 INFO - "buildnumber": 395, 09:08:14 INFO - "slavename": "talos-linux64-ix-028", 09:08:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:08:14 INFO - "platform": "ubuntu64_hw", 09:08:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:08:14 INFO - "branch": "mozilla-aurora", 09:08:14 INFO - "repo_path": "releases/mozilla-aurora", 09:08:14 INFO - "revision": "3a4cd59e97b5100b2b14185a068271531b80c68d", 09:08:14 INFO - "stage_platform": "linux64-pgo", 09:08:14 INFO - "builduid": "bb02556692494efd83a786b8f78d49fd", 09:08:14 INFO - "slavebuilddir": "test" 09:08:14 INFO - } 09:08:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 09:08:14 INFO - Running post-action listener: _resource_record_post_action 09:08:14 INFO - ##### 09:08:14 INFO - ##### Finished read-buildbot-config step (success) 09:08:14 INFO - ##### 09:08:14 INFO - ##### 09:08:14 INFO - ##### Running download-and-extract step. 09:08:14 INFO - ##### 09:08:14 INFO - Running pre-action listener: _resource_record_pre_action 09:08:14 INFO - Running main action method: download_and_extract 09:08:14 INFO - mkdir: /builds/slave/test/build/tests 09:08:14 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')]} 09:08:14 INFO - https://queue.taskcluster.net/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:08:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:08:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:08:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/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 09:08:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/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 09:08:23 INFO - Downloaded 1361 bytes. 09:08:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:08:23 INFO - Using the following test package requirements: 09:08:23 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 09:08:23 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:08:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:08:23 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:08:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:08:23 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:08:23 INFO - u'jsshell-linux-x86_64.zip'], 09:08:23 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:08:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:08:23 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 09:08:23 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:08:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:08:23 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:08:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:08:23 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:08:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:08:23 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:08:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:08:23 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:08:23 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')]} 09:08:23 INFO - https://queue.taskcluster.net/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:08:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:08:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:08:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/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 09:08:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/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 09:08:24 INFO - Downloaded 24473779 bytes. 09:08:24 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'] 09:08:24 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 09:08:25 INFO - Return code: 0 09:08:25 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 09:08:25 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')]} 09:08:25 INFO - https://queue.taskcluster.net/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:08:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:08:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:08:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/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 09:08:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/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 09:08:33 INFO - Downloaded 24473779 bytes. 09:08:33 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'] 09:08:33 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 09:08:35 INFO - Return code: 0 09:08: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')]} 09:08:35 INFO - https://queue.taskcluster.net/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:08:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:08:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:08:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/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 09:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/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 09:08:38 INFO - Downloaded 10833369 bytes. 09:08:38 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'] 09:08:38 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 09:08:39 INFO - Return code: 0 09:08:39 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')]} 09:08:39 INFO - https://queue.taskcluster.net/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:08:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:08:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:08:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/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 09:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OxBHYH8JQuS--nZ5D8ygUA/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 09:08:45 INFO - Downloaded 63577559 bytes. 09:08:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:08:45 INFO - mkdir: /builds/slave/test/properties 09:08:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:08:45 INFO - Writing to file /builds/slave/test/properties/build_url 09:08:45 INFO - Contents: 09:08:45 INFO - build_url:https://queue.taskcluster.net/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:08:47 INFO - Running post-action listener: _resource_record_post_action 09:08:47 INFO - Running post-action listener: set_extra_try_arguments 09:08:47 INFO - ##### 09:08:47 INFO - ##### Finished download-and-extract step (success) 09:08:47 INFO - ##### 09:08:47 INFO - ##### 09:08:47 INFO - ##### Running populate-webroot step. 09:08:47 INFO - ##### 09:08:47 INFO - Running pre-action listener: _resource_record_pre_action 09:08:47 INFO - Running main action method: populate_webroot 09:08:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:08:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:08:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:08:47 INFO - '--tppagecycles', 09:08:47 INFO - '7'], 09:08:47 INFO - 'tests': ['tsvgm']}}, 09:08:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:08:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:08:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:08:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:08:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:08:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:08:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:47 INFO - 'talos_options': ['--disable-e10s'], 09:08:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:08:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:08:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:47 INFO - 'talos_options': ['--disable-e10s'], 09:08:47 INFO - 'tests': ['damp', 'tps']}, 09:08:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:47 INFO - 'tests': ['damp', 'tps']}, 09:08:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:08:47 INFO - 'tests': ['dromaeo_dom']}, 09:08:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:08:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:08:47 INFO - 'tests': ['a11yr', 09:08:47 INFO - 'ts_paint', 09:08:47 INFO - 'tpaint', 09:08:47 INFO - 'sessionrestore', 09:08:47 INFO - 'sessionrestore_no_auto_restore', 09:08:47 INFO - 'tabpaint']}, 09:08:47 INFO - 'other-e10s': {'tests': ['a11yr', 09:08:47 INFO - 'ts_paint', 09:08:47 INFO - 'tpaint', 09:08:47 INFO - 'sessionrestore', 09:08:47 INFO - 'sessionrestore_no_auto_restore', 09:08:47 INFO - 'tabpaint']}, 09:08:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:08:47 INFO - 'ts_paint', 09:08:47 INFO - 'tpaint', 09:08:47 INFO - 'sessionrestore', 09:08:47 INFO - 'sessionrestore_no_auto_restore', 09:08:47 INFO - 'tabpaint']}, 09:08:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:08:47 INFO - 'ts_paint', 09:08:47 INFO - 'tpaint', 09:08:47 INFO - 'sessionrestore', 09:08:47 INFO - 'sessionrestore_no_auto_restore', 09:08:47 INFO - 'tabpaint']}, 09:08:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:08:47 INFO - 'tests': ['a11yr', 09:08:47 INFO - 'ts_paint', 09:08:47 INFO - 'tpaint', 09:08:47 INFO - 'sessionrestore', 09:08:47 INFO - 'sessionrestore_no_auto_restore', 09:08:47 INFO - 'tabpaint']}, 09:08:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:08:47 INFO - 'tests': ['a11yr', 09:08:47 INFO - 'ts_paint', 09:08:47 INFO - 'tpaint', 09:08:47 INFO - 'sessionrestore', 09:08:47 INFO - 'sessionrestore_no_auto_restore', 09:08:47 INFO - 'tabpaint']}, 09:08:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:08:47 INFO - 'tests': ['tsvgx', 09:08:47 INFO - 'tsvgr_opacity', 09:08:47 INFO - 'tart', 09:08:47 INFO - 'tscrollx', 09:08:47 INFO - 'cart']}, 09:08:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:08:47 INFO - 'tsvgr_opacity', 09:08:47 INFO - 'tart', 09:08:47 INFO - 'tscrollx', 09:08:47 INFO - 'cart']}, 09:08:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:47 INFO - 'talos_options': ['--disable-e10s'], 09:08:47 INFO - 'tests': ['tp5o']}, 09:08:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:47 INFO - 'tests': ['tp5o']}, 09:08:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:47 INFO - 'talos_options': ['--disable-e10s', 09:08:47 INFO - '--xperf_path', 09:08:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:08:47 INFO - 'tests': ['tp5n']}, 09:08:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:47 INFO - 'talos_options': ['--xperf_path', 09:08:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:08:47 INFO - 'tests': ['tp5n']}}, 09:08:47 INFO - 'talos.zip': {'path': '', 09:08:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:08:47 INFO - Running post-action listener: _resource_record_post_action 09:08:47 INFO - ##### 09:08:47 INFO - ##### Finished populate-webroot step (success) 09:08:47 INFO - ##### 09:08:47 INFO - ##### 09:08:47 INFO - ##### Running create-virtualenv step. 09:08:47 INFO - ##### 09:08:47 INFO - Running pre-action listener: _resource_record_pre_action 09:08:47 INFO - Running main action method: create_virtualenv 09:08:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:08:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:08:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:08:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:08:47 INFO - Using real prefix '/usr' 09:08:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:08:47 INFO - Installing distribute.............................................................................................................................................................................................done. 09:08:49 INFO - Installing pip.................done. 09:08:49 INFO - Return code: 0 09:08:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:08: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')]} 09:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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')]} 09:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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 0x7f2a2c40ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad1c0>, '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 0x12ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae550>, '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': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', '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 09:08: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 09:08: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 09:08:49 INFO - Using env: {'DISPLAY': ':0', 09:08:49 INFO - 'HOME': '/home/cltbld', 09:08:49 INFO - 'LANG': 'en_US.UTF-8', 09:08:49 INFO - 'LANGUAGE': 'en_US:en', 09:08:49 INFO - 'LOGNAME': 'cltbld', 09:08:49 INFO - 'MAIL': '/var/mail/cltbld', 09:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:49 INFO - 'MOZ_NO_REMOTE': '1', 09:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:49 INFO - 'NO_EM_RESTART': '1', 09:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:49 INFO - 'PWD': '/builds/slave/test', 09:08:49 INFO - 'SHELL': '/bin/bash', 09:08:49 INFO - 'SHLVL': '1', 09:08:49 INFO - 'TERM': 'linux', 09:08:49 INFO - 'TMOUT': '86400', 09:08:49 INFO - 'USER': 'cltbld', 09:08:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', 09:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:49 INFO - '_': '/tools/buildbot/bin/python'} 09:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:08:50 INFO - Cleaning up... 09:08:50 INFO - Return code: 0 09:08:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2a2c40ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad1c0>, '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 0x12ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae550>, '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': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', '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 09:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:08:50 INFO - Using env: {'DISPLAY': ':0', 09:08:50 INFO - 'HOME': '/home/cltbld', 09:08:50 INFO - 'LANG': 'en_US.UTF-8', 09:08:50 INFO - 'LANGUAGE': 'en_US:en', 09:08:50 INFO - 'LOGNAME': 'cltbld', 09:08:50 INFO - 'MAIL': '/var/mail/cltbld', 09:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:50 INFO - 'MOZ_NO_REMOTE': '1', 09:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:50 INFO - 'NO_EM_RESTART': '1', 09:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:50 INFO - 'PWD': '/builds/slave/test', 09:08:50 INFO - 'SHELL': '/bin/bash', 09:08:50 INFO - 'SHLVL': '1', 09:08:50 INFO - 'TERM': 'linux', 09:08:50 INFO - 'TMOUT': '86400', 09:08:50 INFO - 'USER': 'cltbld', 09:08:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', 09:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:50 INFO - '_': '/tools/buildbot/bin/python'} 09:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:50 INFO - Downloading/unpacking psutil>=3.1.1 09:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:08:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:08:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:52 INFO - Installing collected packages: psutil 09:08:52 INFO - Running setup.py install for psutil 09:08:52 INFO - building 'psutil._psutil_linux' extension 09:08: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 09:08: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 09:08:52 INFO - building 'psutil._psutil_posix' extension 09:08: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 09:08: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 09:08:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:08:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:52 INFO - Successfully installed psutil 09:08:52 INFO - Cleaning up... 09:08:52 INFO - Return code: 0 09:08:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:08: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')]} 09:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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')]} 09:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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 0x7f2a2c40ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad1c0>, '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 0x12ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae550>, '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': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', '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 09:08: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 09:08: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 09:08:52 INFO - Using env: {'DISPLAY': ':0', 09:08:52 INFO - 'HOME': '/home/cltbld', 09:08:52 INFO - 'LANG': 'en_US.UTF-8', 09:08:52 INFO - 'LANGUAGE': 'en_US:en', 09:08:52 INFO - 'LOGNAME': 'cltbld', 09:08:52 INFO - 'MAIL': '/var/mail/cltbld', 09:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:52 INFO - 'MOZ_NO_REMOTE': '1', 09:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:52 INFO - 'NO_EM_RESTART': '1', 09:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:52 INFO - 'PWD': '/builds/slave/test', 09:08:52 INFO - 'SHELL': '/bin/bash', 09:08:52 INFO - 'SHLVL': '1', 09:08:52 INFO - 'TERM': 'linux', 09:08:52 INFO - 'TMOUT': '86400', 09:08:52 INFO - 'USER': 'cltbld', 09:08:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', 09:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:52 INFO - '_': '/tools/buildbot/bin/python'} 09:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:08:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:08:55 INFO - Installing collected packages: mozsystemmonitor 09:08:55 INFO - Running setup.py install for mozsystemmonitor 09:08:55 INFO - Successfully installed mozsystemmonitor 09:08:55 INFO - Cleaning up... 09:08:55 INFO - Return code: 0 09:08:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2a2c40ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad1c0>, '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 0x12ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae550>, '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': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', '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 09:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:08:55 INFO - Using env: {'DISPLAY': ':0', 09:08:55 INFO - 'HOME': '/home/cltbld', 09:08:55 INFO - 'LANG': 'en_US.UTF-8', 09:08:55 INFO - 'LANGUAGE': 'en_US:en', 09:08:55 INFO - 'LOGNAME': 'cltbld', 09:08:55 INFO - 'MAIL': '/var/mail/cltbld', 09:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:55 INFO - 'MOZ_NO_REMOTE': '1', 09:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:55 INFO - 'NO_EM_RESTART': '1', 09:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:55 INFO - 'PWD': '/builds/slave/test', 09:08:55 INFO - 'SHELL': '/bin/bash', 09:08:55 INFO - 'SHLVL': '1', 09:08:55 INFO - 'TERM': 'linux', 09:08:55 INFO - 'TMOUT': '86400', 09:08:55 INFO - 'USER': 'cltbld', 09:08:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', 09:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:55 INFO - '_': '/tools/buildbot/bin/python'} 09:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:55 INFO - Downloading/unpacking jsonschema==2.5.1 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:08:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08:57 INFO - Downloading functools32-3.2.3-2.tar.gz 09:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:08:57 INFO - warning: no files found matching '*.txt' 09:08:57 INFO - no previously-included directories found matching 'build' 09:08:57 INFO - no previously-included directories found matching 'dist' 09:08:57 INFO - no previously-included directories found matching '.git*' 09:08:57 INFO - Installing collected packages: jsonschema, functools32 09:08:57 INFO - Running setup.py install for functools32 09:08:57 INFO - warning: no files found matching '*.txt' 09:08:57 INFO - no previously-included directories found matching 'build' 09:08:57 INFO - no previously-included directories found matching 'dist' 09:08:57 INFO - no previously-included directories found matching '.git*' 09:08:57 INFO - Successfully installed jsonschema functools32 09:08:57 INFO - Cleaning up... 09:08:57 INFO - Return code: 0 09:08:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:08: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')]} 09:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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')]} 09:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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 0x7f2a2c40ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad1c0>, '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 0x12ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae550>, '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': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', '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 09:08: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 09:08: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 09:08:57 INFO - Using env: {'DISPLAY': ':0', 09:08:57 INFO - 'HOME': '/home/cltbld', 09:08:57 INFO - 'LANG': 'en_US.UTF-8', 09:08:57 INFO - 'LANGUAGE': 'en_US:en', 09:08:57 INFO - 'LOGNAME': 'cltbld', 09:08:57 INFO - 'MAIL': '/var/mail/cltbld', 09:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:57 INFO - 'MOZ_NO_REMOTE': '1', 09:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:57 INFO - 'NO_EM_RESTART': '1', 09:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:57 INFO - 'PWD': '/builds/slave/test', 09:08:57 INFO - 'SHELL': '/bin/bash', 09:08:57 INFO - 'SHLVL': '1', 09:08:57 INFO - 'TERM': 'linux', 09:08:57 INFO - 'TMOUT': '86400', 09:08:57 INFO - 'USER': 'cltbld', 09:08:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', 09:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:57 INFO - '_': '/tools/buildbot/bin/python'} 09:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:58 INFO - Downloading/unpacking blobuploader==1.2.4 09:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:59 INFO - Downloading blobuploader-1.2.4.tar.gz 09:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:09:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:09:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09:00 INFO - Downloading docopt-0.6.1.tar.gz 09:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:09:00 INFO - Installing collected packages: blobuploader, requests, docopt 09:09:00 INFO - Running setup.py install for blobuploader 09:09:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:09:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:09:00 INFO - Running setup.py install for requests 09:09:01 INFO - Running setup.py install for docopt 09:09:01 INFO - Successfully installed blobuploader requests docopt 09:09:01 INFO - Cleaning up... 09:09:01 INFO - Return code: 0 09:09:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2a2c40ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad1c0>, '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 0x12ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae550>, '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': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', '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 09:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:09:01 INFO - Using env: {'DISPLAY': ':0', 09:09:01 INFO - 'HOME': '/home/cltbld', 09:09:01 INFO - 'LANG': 'en_US.UTF-8', 09:09:01 INFO - 'LANGUAGE': 'en_US:en', 09:09:01 INFO - 'LOGNAME': 'cltbld', 09:09:01 INFO - 'MAIL': '/var/mail/cltbld', 09:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:01 INFO - 'MOZ_NO_REMOTE': '1', 09:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:01 INFO - 'NO_EM_RESTART': '1', 09:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:01 INFO - 'PWD': '/builds/slave/test', 09:09:01 INFO - 'SHELL': '/bin/bash', 09:09:01 INFO - 'SHLVL': '1', 09:09:01 INFO - 'TERM': 'linux', 09:09:01 INFO - 'TMOUT': '86400', 09:09:01 INFO - 'USER': 'cltbld', 09:09:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', 09:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:01 INFO - '_': '/tools/buildbot/bin/python'} 09:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:01 INFO - Running setup.py (path:/tmp/pip-c1sJlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:01 INFO - Running setup.py (path:/tmp/pip-siblTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:01 INFO - Running setup.py (path:/tmp/pip-R0gq0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:01 INFO - Running setup.py (path:/tmp/pip-U_SUwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:01 INFO - Running setup.py (path:/tmp/pip-HBcRi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:01 INFO - Running setup.py (path:/tmp/pip-7Tb6Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:01 INFO - Running setup.py (path:/tmp/pip-qLftpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:02 INFO - Running setup.py (path:/tmp/pip-Q5b34_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:02 INFO - Running setup.py (path:/tmp/pip-Zf4wWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:02 INFO - Running setup.py (path:/tmp/pip-0DRAqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:02 INFO - Running setup.py (path:/tmp/pip-r6qPXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:02 INFO - Running setup.py (path:/tmp/pip-rOPk4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:02 INFO - Running setup.py (path:/tmp/pip-ZJZ7w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:02 INFO - Running setup.py (path:/tmp/pip-pDWoB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:02 INFO - Running setup.py (path:/tmp/pip-5lQNAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:02 INFO - Running setup.py (path:/tmp/pip-A4_jh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:02 INFO - Running setup.py (path:/tmp/pip-Q2rpGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:09:02 INFO - Running setup.py install for manifestparser 09:09:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:09:02 INFO - Running setup.py install for mozcrash 09:09:02 INFO - Running setup.py install for mozdebug 09:09:03 INFO - Running setup.py install for mozdevice 09:09:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:09:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:09:03 INFO - Running setup.py install for mozfile 09:09:03 INFO - Running setup.py install for mozhttpd 09:09:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:09:03 INFO - Running setup.py install for mozinfo 09:09:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:09:03 INFO - Running setup.py install for mozInstall 09:09:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:09:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:09:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:09:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:09:03 INFO - Running setup.py install for mozleak 09:09:03 INFO - Running setup.py install for mozlog 09:09:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:09:03 INFO - Running setup.py install for moznetwork 09:09:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:09:03 INFO - Running setup.py install for mozprocess 09:09:04 INFO - Running setup.py install for mozprofile 09:09:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:09:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:09:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:09:04 INFO - Running setup.py install for mozrunner 09:09:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:09:04 INFO - Running setup.py install for mozscreenshot 09:09:04 INFO - Running setup.py install for moztest 09:09:04 INFO - Running setup.py install for mozversion 09:09:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:09:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:09:04 INFO - Cleaning up... 09:09:04 INFO - Return code: 0 09:09:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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 0x7f2a2c40ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad1c0>, '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 0x12ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae550>, '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': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', '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 09:09: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 09:09: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 09:09:04 INFO - Using env: {'DISPLAY': ':0', 09:09:04 INFO - 'HOME': '/home/cltbld', 09:09:04 INFO - 'LANG': 'en_US.UTF-8', 09:09:04 INFO - 'LANGUAGE': 'en_US:en', 09:09:04 INFO - 'LOGNAME': 'cltbld', 09:09:04 INFO - 'MAIL': '/var/mail/cltbld', 09:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:04 INFO - 'MOZ_NO_REMOTE': '1', 09:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:04 INFO - 'NO_EM_RESTART': '1', 09:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:04 INFO - 'PWD': '/builds/slave/test', 09:09:04 INFO - 'SHELL': '/bin/bash', 09:09:04 INFO - 'SHLVL': '1', 09:09:04 INFO - 'TERM': 'linux', 09:09:04 INFO - 'TMOUT': '86400', 09:09:04 INFO - 'USER': 'cltbld', 09:09:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', 09:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:04 INFO - '_': '/tools/buildbot/bin/python'} 09:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:04 INFO - Running setup.py (path:/tmp/pip-wS19rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09: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)) 09:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:04 INFO - Running setup.py (path:/tmp/pip-I6RKvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09: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)) 09:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:04 INFO - Running setup.py (path:/tmp/pip-j40dSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:05 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)) 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:05 INFO - Running setup.py (path:/tmp/pip-9xMmSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:05 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)) 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:05 INFO - Running setup.py (path:/tmp/pip-5seNeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:05 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)) 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:05 INFO - Running setup.py (path:/tmp/pip-SuOeig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:05 INFO - Running setup.py (path:/tmp/pip-GMr2d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:05 INFO - Running setup.py (path:/tmp/pip-zM0Tnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09: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)) 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:05 INFO - Running setup.py (path:/tmp/pip-iiKco2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09: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)) 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:05 INFO - Running setup.py (path:/tmp/pip-TKjVFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09: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)) 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:05 INFO - Running setup.py (path:/tmp/pip-CXQr_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09: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)) 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:05 INFO - Running setup.py (path:/tmp/pip-WMaKwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09: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)) 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:05 INFO - Running setup.py (path:/tmp/pip-y4oKPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09: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)) 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:05 INFO - Running setup.py (path:/tmp/pip-hAIXf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09: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)) 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:05 INFO - Running setup.py (path:/tmp/pip-Ck71qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09: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)) 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:05 INFO - Running setup.py (path:/tmp/pip-ypZbhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09: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)) 09:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:05 INFO - Running setup.py (path:/tmp/pip-txo3OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:06 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)) 09:09:06 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)) 09:09:06 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)) 09:09:06 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)) 09:09:06 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)) 09:09:06 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)) 09:09:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:09:06 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 09:09:06 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 09:09:06 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 09:09:06 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 09:09:06 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 09:09:06 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 09:09:07 INFO - Downloading blessings-1.6.tar.gz 09:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:09:08 INFO - Installing collected packages: blessings 09:09:08 INFO - Running setup.py install for blessings 09:09:08 INFO - Successfully installed blessings 09:09:08 INFO - Cleaning up... 09:09:08 INFO - Return code: 0 09:09:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:09:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:08 INFO - Reading from file tmpfile_stdout 09:09:08 INFO - Current package versions: 09:09:08 INFO - argparse == 1.2.1 09:09:08 INFO - blessings == 1.6 09:09:08 INFO - blobuploader == 1.2.4 09:09:08 INFO - docopt == 0.6.1 09:09:08 INFO - functools32 == 3.2.3-2 09:09:08 INFO - jsonschema == 2.5.1 09:09:08 INFO - manifestparser == 1.1 09:09:08 INFO - mozInstall == 1.12 09:09:08 INFO - mozcrash == 0.17 09:09:08 INFO - mozdebug == 0.1 09:09:08 INFO - mozdevice == 0.48 09:09:08 INFO - mozfile == 1.2 09:09:08 INFO - mozhttpd == 0.7 09:09:08 INFO - mozinfo == 0.9 09:09:08 INFO - mozleak == 0.1 09:09:08 INFO - mozlog == 3.2 09:09:08 INFO - moznetwork == 0.27 09:09:08 INFO - mozprocess == 0.22 09:09:08 INFO - mozprofile == 0.28 09:09:08 INFO - mozrunner == 6.11 09:09:08 INFO - mozscreenshot == 0.1 09:09:08 INFO - mozsystemmonitor == 0.3 09:09:08 INFO - moztest == 0.7 09:09:08 INFO - mozversion == 1.4 09:09:08 INFO - psutil == 3.1.1 09:09:08 INFO - requests == 1.2.3 09:09:08 INFO - wsgiref == 0.1.2 09:09:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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 0x7f2a2c40ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad1c0>, '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 0x12ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae550>, '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': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', '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 09:09: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 09:09: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 09:09:08 INFO - Using env: {'DISPLAY': ':0', 09:09:08 INFO - 'HOME': '/home/cltbld', 09:09:08 INFO - 'LANG': 'en_US.UTF-8', 09:09:08 INFO - 'LANGUAGE': 'en_US:en', 09:09:08 INFO - 'LOGNAME': 'cltbld', 09:09:08 INFO - 'MAIL': '/var/mail/cltbld', 09:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:08 INFO - 'MOZ_NO_REMOTE': '1', 09:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:08 INFO - 'NO_EM_RESTART': '1', 09:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:08 INFO - 'PWD': '/builds/slave/test', 09:09:08 INFO - 'SHELL': '/bin/bash', 09:09:08 INFO - 'SHLVL': '1', 09:09:08 INFO - 'TERM': 'linux', 09:09:08 INFO - 'TMOUT': '86400', 09:09:08 INFO - 'USER': 'cltbld', 09:09:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', 09:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:08 INFO - '_': '/tools/buildbot/bin/python'} 09:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09: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)) 09:09: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)) 09:09: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)) 09:09: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)) 09:09: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)) 09:09: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)) 09:09: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)) 09:09: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)) 09:09: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)) 09:09: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)) 09:09: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)) 09:09:08 INFO - Cleaning up... 09:09:08 INFO - Return code: 0 09:09:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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 0x7f2a2c40ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad1c0>, '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 0x12ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae550>, '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': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', '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 09:09: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 09:09: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 09:09:08 INFO - Using env: {'DISPLAY': ':0', 09:09:08 INFO - 'HOME': '/home/cltbld', 09:09:08 INFO - 'LANG': 'en_US.UTF-8', 09:09:08 INFO - 'LANGUAGE': 'en_US:en', 09:09:08 INFO - 'LOGNAME': 'cltbld', 09:09:08 INFO - 'MAIL': '/var/mail/cltbld', 09:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:08 INFO - 'MOZ_NO_REMOTE': '1', 09:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:08 INFO - 'NO_EM_RESTART': '1', 09:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:08 INFO - 'PWD': '/builds/slave/test', 09:09:08 INFO - 'SHELL': '/bin/bash', 09:09:08 INFO - 'SHLVL': '1', 09:09:08 INFO - 'TERM': 'linux', 09:09:08 INFO - 'TMOUT': '86400', 09:09:08 INFO - 'USER': 'cltbld', 09:09:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', 09:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:08 INFO - '_': '/tools/buildbot/bin/python'} 09:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:09:08 INFO - Cleaning up... 09:09:08 INFO - Return code: 0 09:09:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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 0x7f2a2c40ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ad1c0>, '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 0x12ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae550>, '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': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', '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 09:09: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 09:09: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 09:09:08 INFO - Using env: {'DISPLAY': ':0', 09:09:08 INFO - 'HOME': '/home/cltbld', 09:09:08 INFO - 'LANG': 'en_US.UTF-8', 09:09:08 INFO - 'LANGUAGE': 'en_US:en', 09:09:08 INFO - 'LOGNAME': 'cltbld', 09:09:08 INFO - 'MAIL': '/var/mail/cltbld', 09:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:08 INFO - 'MOZ_NO_REMOTE': '1', 09:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:08 INFO - 'NO_EM_RESTART': '1', 09:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:08 INFO - 'PWD': '/builds/slave/test', 09:09:08 INFO - 'SHELL': '/bin/bash', 09:09:08 INFO - 'SHLVL': '1', 09:09:08 INFO - 'TERM': 'linux', 09:09:08 INFO - 'TMOUT': '86400', 09:09:08 INFO - 'USER': 'cltbld', 09:09:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', 09:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:08 INFO - '_': '/tools/buildbot/bin/python'} 09:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:09 INFO - Downloading/unpacking flake8 09:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:09:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:09:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:09:11 INFO - no previously-included directories found matching 'docs/_build' 09:09:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:09:11 INFO - Running setup.py install for pep8 09:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:09:11 INFO - no previously-included directories found matching 'docs/_build' 09:09:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:09:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:09:11 INFO - Cleaning up... 09:09:12 INFO - Return code: 0 09:09:12 INFO - Running post-action listener: _resource_record_post_action 09:09:12 INFO - Running post-action listener: _start_resource_monitoring 09:09:12 INFO - Starting resource monitoring. 09:09:12 INFO - ##### 09:09:12 INFO - ##### Finished create-virtualenv step (success) 09:09:12 INFO - ##### 09:09:12 INFO - ##### 09:09:12 INFO - ##### Running install step. 09:09:12 INFO - ##### 09:09:12 INFO - Running pre-action listener: _resource_record_pre_action 09:09:12 INFO - Running main action method: install 09:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:12 INFO - Reading from file tmpfile_stdout 09:09:12 INFO - Detecting whether we're running mozinstall >=1.0... 09:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:09:12 INFO - Reading from file tmpfile_stdout 09:09:12 INFO - Output received: 09:09:12 INFO - Usage: mozinstall [options] installer 09:09:12 INFO - Options: 09:09:12 INFO - -h, --help show this help message and exit 09:09:12 INFO - -d DEST, --destination=DEST 09:09:12 INFO - Directory to install application into. [default: 09:09:12 INFO - "/builds/slave/test"] 09:09:12 INFO - --app=APP Application being installed. [default: firefox] 09:09:12 INFO - mkdir: /builds/slave/test/build/application 09:09: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'] 09:09: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 09:09:28 INFO - Reading from file tmpfile_stdout 09:09:28 INFO - Output received: 09:09:28 INFO - /builds/slave/test/build/application/firefox/firefox 09:09:28 INFO - Running post-action listener: _resource_record_post_action 09:09:28 INFO - ##### 09:09:28 INFO - ##### Finished install step (success) 09:09:28 INFO - ##### 09:09:28 INFO - ##### 09:09:28 INFO - ##### Running run-tests step. 09:09:28 INFO - ##### 09:09:28 INFO - Running pre-action listener: _resource_record_pre_action 09:09:28 INFO - Running main action method: run_tests 09:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:09:28 INFO - Python 2.7.3 09:09:28 INFO - Return code: 0 09:09:28 INFO - grabbing minidump binary from tooltool 09:09: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')]} 09:09: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 0x12ad1c0>, '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 0x12ae0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ae550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:09: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 09:09: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 09:09: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 09:09:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:09:28 INFO - Return code: 0 09:09:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:09:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:09:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:09:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:09:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:09:29 INFO - Return code: 0 09:09: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/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 09:09: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/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 09:09:29 INFO - Using env: {'DISPLAY': ':0', 09:09:29 INFO - 'HOME': '/home/cltbld', 09:09:29 INFO - 'LANG': 'en_US.UTF-8', 09:09:29 INFO - 'LANGUAGE': 'en_US:en', 09:09:29 INFO - 'LOGNAME': 'cltbld', 09:09:29 INFO - 'MAIL': '/var/mail/cltbld', 09:09:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:09:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:29 INFO - 'MOZ_NO_REMOTE': '1', 09:09:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:29 INFO - 'NO_EM_RESTART': '1', 09:09:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:29 INFO - 'PWD': '/builds/slave/test', 09:09:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:09:29 INFO - 'SHELL': '/bin/bash', 09:09:29 INFO - 'SHLVL': '1', 09:09:29 INFO - 'TERM': 'linux', 09:09:29 INFO - 'TMOUT': '86400', 09:09:29 INFO - 'USER': 'cltbld', 09:09:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241', 09:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:29 INFO - '_': '/tools/buildbot/bin/python'} 09:09: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/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 09:09:29 INFO - mozversion application_buildid: 20160608061731 09:09:29 INFO - mozversion application_changeset: 3a4cd59e97b5100b2b14185a068271531b80c68d 09:09:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:09:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:09:29 INFO - mozversion application_name: Firefox 09:09:29 INFO - mozversion application_remotingname: firefox-dev 09:09:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:09:29 INFO - mozversion application_vendor: Mozilla 09:09:29 INFO - mozversion application_version: 49.0a2 09:09:29 INFO - mozversion platform_buildid: 20160608061731 09:09:29 INFO - mozversion platform_changeset: 3a4cd59e97b5100b2b14185a068271531b80c68d 09:09:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:09:29 INFO - mozversion platform_version: 49.0a2 09:09:29 INFO - using testdate: 1465402169 09:09:29 INFO - actual date: 1465402169 09:09:29 INFO - starting webserver on 'localhost:42184' 09:09:29 INFO - SUITE-START | Running 2 tests 09:09:29 INFO - TEST-START | dromaeo_css 09:09:29 INFO - operating with platform_type : linux_ 09:09:29 INFO - Initialising browser for dromaeo_css test... 09:09:29 INFO - TEST-INFO | started process 7143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Sxh6F/profile http://localhost:42184/getInfo.html) 09:09:34 INFO - PROCESS | 7143 | __metrics Screen width/height:1600/1200 09:09:34 INFO - PROCESS | 7143 | colorDepth:24 09:09:34 INFO - PROCESS | 7143 | Browser inner width/height: 1024/697 09:09:34 INFO - PROCESS | 7143 | __metrics 09:09:34 ERROR - PROCESS | 7143 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 09:09:35 INFO - TEST-INFO | 7143: exit 0 09:09:35 INFO - Browser initialized. 09:09:35 INFO - Running cycle 1/1 for dromaeo_css test... 09:09:35 INFO - TEST-INFO | started process 7277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Sxh6F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:47 INFO - PROCESS | 7277 | RSS: Main: 156094464 09:09:47 INFO - PROCESS | 7277 | 09:10:37 INFO - PROCESS | 7277 | 1465402237160 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] 09:12:45 INFO - PROCESS | 7277 | Cycle 1(1): loaded http://localhost:42184/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42184/tests/dromaeo/cssquery-ext.html) 09:12:46 INFO - PROCESS | 7277 | RSS: Main: 159457280 09:12:46 INFO - PROCESS | 7277 | 09:15:48 INFO - PROCESS | 7277 | Cycle 1(1): loaded http://localhost:42184/tests/dromaeo/cssquery-ext.html (next: http://localhost:42184/tests/dromaeo/cssquery-jquery.html) 09:15:49 INFO - PROCESS | 7277 | RSS: Main: 158285824 09:15:49 INFO - PROCESS | 7277 | 09:18:50 INFO - PROCESS | 7277 | Cycle 1(1): loaded http://localhost:42184/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42184/tests/dromaeo/cssquery-mootools.html) 09:18:51 INFO - PROCESS | 7277 | RSS: Main: 156729344 09:18:51 INFO - PROCESS | 7277 | 09:21:53 INFO - PROCESS | 7277 | Cycle 1(1): loaded http://localhost:42184/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42184/tests/dromaeo/cssquery-prototype.html) 09:21:53 INFO - PROCESS | 7277 | RSS: Main: 156581888 09:21:53 INFO - PROCESS | 7277 | 09:24:56 INFO - PROCESS | 7277 | Cycle 1(1): loaded http://localhost:42184/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42184/tests/dromaeo/cssquery-yui.html) 09:24:56 INFO - PROCESS | 7277 | RSS: Main: 158556160 09:24:56 INFO - PROCESS | 7277 | 09:27:59 INFO - PROCESS | 7277 | Cycle 1(1): loaded http://localhost:42184/tests/dromaeo/cssquery-yui.html (next: http://localhost:42184/tests/dromaeo/cssquery-dojo.html) 09:27:59 INFO - PROCESS | 7277 | RSS: Main: 158711808 09:27:59 INFO - PROCESS | 7277 | 09:27:59 INFO - PROCESS | 7277 | __start_tp_report 09:27:59 INFO - PROCESS | 7277 | _x_x_mozilla_page_load 09:27:59 INFO - PROCESS | 7277 | _x_x_mozilla_page_load_details 09:27:59 INFO - PROCESS | 7277 | |i|pagename|runs| 09:27:59 INFO - PROCESS | 7277 | |0;dojo.html;3412.6587341265868;3452.706519945805;3466.2894106708095;3507.631698671641;3511.5259439975594;5659.688717120557;5741.425857414257;5760.884782304352;5761.135829625553;5769.134629805531;5780.364159942414;5786.074228123501;5806.506446952004;5816.621919575236;5829.213056237407;5183.196604526295;5253.7373131343475;5280.075986702331;5289.047971365153;5350.117230656937;5136.255242989764;5213.3743950725775;5329.067413202693;5333.733313334337;5360.035193665139;5173.818916337929;5175.275461435402;5186.299849520323;5187.3775146982225;5268;5203.8178663746585;5233.842984710427;5234.555062819665;5237.266782650432;5263.921041184385;5087.643864929457;5089.643724939256;5121.692698438105;5140.434552199255;5155.200943853709;5586.301712285965;5594.300712410949;5609.775608975636;5645.068563686987;5645.915311270334;6138.171346868205;6143.631382117087;6155.353687862755;6166.8766624667705;6198.938010619881;6127.203463549755;6184.443400094013;6237.906431403532;6245.875082498324;6250.562460627758;5890.293164820249;5899.941000589982;5904.2029326040865;5911.497522710575;5920.733566989453;6285.59143655661;6323.083152942798;6410.583312084699;6414.422701956846;6418.807435776934;5888;5933.199018132583;5933.436323549256;5953.464188222994;6020.247469066367;6085.574009819358;6108;6109.694515274218;6111.51107911366;6115.235595550556;5965.612235204698;5991.940080599225;5999.550033747487;6036;6063;6072.939270607326;6073;6111;6154.230721159855;6161.353057928853;4617.353570500132;4637.605803506673;4639.976800115978;4643.048175124091;4686.015936653341;4111.033907031845;4153.958460415418;4165.021220013295;4166.937495937564;4217.451731274976;5853.882922341614;5915.231019967463;5943.970280148572;5982.760689572456;6109.14471973924;6209.037599172136;6234.781782637586;6261.749530018839;6272.905906411407;6292.937070629327;5851.473367396955;5908.556858235649;5955.887492137037;5974.910376344358;6058.848528786815;5195.480451954774;5202.843914682566;5252.133397989365;5252.894942101213;5282.366116066097;6441.774537891151;6451.774187903401;6453.548251622436;6456.451201647913;6464.095026696266;6034.9094763577705;6133.334663918993;6136.6722581676495;6237.781677641442;6249.500039996789;6492.35076492347;6502.349765023459;6518.054882041983;6527.934720652923;6541.901871471837;6174.228221472316;6181.1655426516845;6184.783532576338;6189.319174890668;6192.81421557354;5926.022206336079;6114.7536090578;6130.703893785035;6185.350538193605;6309.148264984168;6100.235277662567;6107.059952181356;6119.785807496716;6133.355997620186;6137.539684523589;6046.3046749624355;6090.634561926298;6095.1466794647895;6112.755489780359;6115.388461153849;5890.057590785454;5928.911066334094;5944.762209511571;5998.3401825798255;6056.939430605814;6154.476869466145;6165.383461653799;6176.629402235881;6185.783497577563;6188.783392581238;5765.884682306414;6021.066734656135;6023.945809483235;6026.548008899263;6041.9395806041375 09:27:59 INFO - PROCESS | 7277 | |1;ext.html;598.9520838332934;638.2723694987718;641.6631268583993;659.9835004124897;673.9022841687959;41096.17807643849;44816.551834481645;44936.77531612346;45056.87357816052;45466.8633284168;37749.81125094378;38396;38444.61555384445;38653.80673096631;38714.41928371077;9018.819623607524;9172.357934944557;9185.908140918573;9192.218661413754;9209.033051529594;9055.909440905605;9107.499087550183;9119.589618467151;9120.361574689774;9151.816963660724;9040.095990400972;9103.36276460648;9156.084391560857;9180.219681327062;9185.586648600796;9051.59267832949;9067.410618309854;9097.090290970884;9131.497767622777;9153.038930912258;8996.460212387277;9021;9104;9130.543472826332;9131.178193962574;42146.789266053784;42437.57562424367;42439.78780106111;42632.786836065934;42651.786741066404;3583.068402215443;3642.4172132458943;3732.8133593320226;3836.5779764225913;4370.7159034662645;34336.313273734384;34377.48433773495;34441.31117377638;34812.477812832825;35543;4650.790714417825;4719.197736384823;4727.503612120712;4775.164346239394;4784.521547845223;358450;358471;359348;359383;360614.9999999974;37848.43227351592;64516.67741661356;64938.67530662316;65035;65172;37086.44370334447;38595.22809543793;38710.612893870704;38730.225395492496;39262.80368598196;14343.139411635335;14364.712705745827;14519;14525.92737036308;14589.635259118395;12282.570110046285;12346.074044446703;12352.197107188003;12373.566925157756;12384.380780960915;9020.729378118667;9076.228520575693;9103.772405689911;9131.543422828832;9217.400868943498;3459.6367381425093;3466.5146879436393;3469.150058235698;3492.441209406483;3506.8772592959126;1089.096050278267;1098.2696506823033;1106.1593189176283;1192.4693511387522;1223.5839814462947;33415.498767518504;33574.49638255428;33636.512659516615;33984.83007584995;34184.658153418146;1177.05835331736;1191.9046476281876;1194.1402190422882;1247.0670460785745;1271.4215032160346;17177.398791042255;17401;17582.560435989202;17678.911605441892;17836.252943255382;619209;620286;622151;623146;623529;61627.69186154041;61713.29720216801;61921;62000.68999654973;62320.37679623236;1441.9495317663832;1477.0768269831356;1486.9925650371679;1488.78412630168;1498.7227362937892;32958.50562241616;33038.5044224332;33079;33125.33749325048;33420.33159336751;54932;55622.72188639031;55710.72144639251;55716.72141639266;55781;518142;518312;519567;521499;524848;30189.849050754605;30201.546976795806;30656.233594159432;30798.84600576983;30812.69187308098;51836.74081629568;51838.481615183366;52188.217176743135;52357.7382113087;53097;42700.35949460823;42736.78631606822;43811.561884380746;44188;44855.551444485136;42893.356599650404;42934.14131717411;43009.784951075046;43086;44353.11293774171;44017.339739904564;44685;44859.77570112129;45073.32390014218;46750.766246168554;37948.24103517969;38164.809175953946;38242.2351552973;38485.615143848205;38739.37747775623;28986.420271594026;29251;29265;29742.55386169166;29905 09:27:59 INFO - PROCESS | 7277 | |2;jquery.html;423.7923417525412;429.67774169372973;430.5178200415534;431.1613910943213;444.6020811373821;18731.71902421463;19292.51768705783;20304.086316115772;20308.39074827754;20439.48901277465;18957.33649322274;19031.809681903178;19191.80808191918;19601;19613.215471381165;5918.970405147968;6032.939670603304;6103.389661033905;6109.602875813058;6122.47958923492;5840.853978650546;5971.5222782177325;5974.701264936757;6017.007193813016;6024.5180385569265;5942.5840191186635;5955.553333500005;5980.252468441445;5981.192539007222;5990.460858522732;5778.7977420790285;5938.792142275021;5983.341832398432;5989.13157592151;5996.220491336142;5326.121190003645;5357.276767636397;5363.9463605363835;5366.597505187126;5370.865728356784;22914.885425572764;23910;24440.14459493927;24603.13889013894;24650;2505.837120587156;2547.4013606802387;2562.2825608829557;2575.459153577751;2824.209221418006;8786.516741579211;9438.528073596293;14811.259437028213;15219.086854788637;15752.842471575252;1937.883726976386;1977.0608960743675;2020.4241791089469;2040.8571400002006;2051.21028404064;84501;86364.56817715934;86797;87647.12352876517;87659;11254.381009044417;11541.307521548733;11681.532738690357;12289.324087175113;12529.31088790107;16169;16442.588935276715;16481.17594120289;16485.093319867283;16487.587810304838;7982.201779821971;7985.241402066795;8078.838423231502;8091.190880911861;8131.59342032896;7464.589447580327;7522.924770752223;7614.314711675976;7645.655945482466;7674.96162519195;4303.203907277164;4475.239209334421;4887.315775791392;4922.458529561745;4975.203967365204;2054.239931225456;2070;2072.057213967641;2078.1687325070093;2080.4070839810884;965.9565319560637;1015.2942408481462;1072.3165925047488;1083.8482612434266;1085.733995171188;19442.222311107682;19636;19914.90042549778;20109.71113398152;20245.898770506054;997.1125698128672;1030.5568605499557;1042.7288904884786;1087.0542627913765;1090.1605763562172;10993.450327483593;11318.26431281964;11340.149488788375;11350.432478376213;11379.089672826154;489417;493517;493965;499125;500192;98647;100286;100542;101782;102138.48930755447;1064.8775390830153;1069.1927594666133;1074.3500182389698;1077.439731339699;1085.2620218251664;17490;17665.911670441565;17876.97768002241;17997.19012644408;18286.725699114257;40687.38968915409;41736.165276694905;41836.95407614834;41951.370729439695;42826.357604635334;57162.7141864288;57792.422075778704;59360;59522.40477595168;59700;8093.150219226896;8101.675932962616;8115.79710507242;8123.7156699515235;8382;9034.728958131267;13488.460461581819;13701.383437745126;13844.653883652989;13971.720565588834;11319.773604527698;12391.194572352768;12654.177478463871;12681.93659031699;12702.555410560586;12286.508539658671;12577.742225777349;12710.555130570385;12770.553030643883;12852.228866268053;12568.622941311774;13116.672083197996;13150.145240559334;13290.734185316047;13332.3333833306;8625.654973801229;8697.782555436164;8753.956230218808;8894.73315800527;8925.910740892508;11406.258593191416;12173;12265.26408415498;12364.690882728004;12434.440450179583 09:27:59 INFO - PROCESS | 7277 | |3;mootools.html;1553.7747026681127;1609.356257497001;1809.439073887095;1914.1386376130745;1936.3900371383013;8661.17718816713;9201.58592863321;9412.717618471439;9991.60117583538;10040.046195611423;9398.62405503779;9440.480773557452;9713.757156071102;9722.270829687784;9724.173445257162;2434.4644178280796;2447.49826285611;2471.8393304435244;2478.033566908907;2482.2056941778637;2375.8812059397046;2465.90136394544;2483.639872218527;2487.067349743846;2491.4145175883655;2406.711194656644;2425.8301918865686;2469.703635563726;2488.228649118779;2497.0760818497183;2398.59223931932;2425.769551892576;2441.426264827764;2442.010985550855;2454.9754502454925;2469.5060987802512;2485.4904744527507;2517.093846215361;2521.6217567365043;2528.898844046236;9578.760530986712;9585.041495850359;9665.371750836173;9687.031296870256;9724.75688107803;5564.721763911788;5694.402087780765;5742.569307301969;5743.54051675865;5761.654300741969;3423.9486407703903;3486.442169252907;3555.520004799345;3560.572731272264;3585.1216451969435;1207.6377086873902;1238.9752204955942;1239.20690757915;1244.6826059354808;1276.9872301277055;13763.518276860263;13781.931090344584;13825.308734563232;13878.791818122736;13928.233947132903;4894.241392584155;4958.057968985881;5101.668391554537;5127.897442051213;5133.614978876599;11532.135089868125;11548.422578871023;11651.76696466066;11655.184137110491;11687.065034797195;5800.100984347433;5817.592768506249;5827.941720582825;5833;5833.037548804485;4634.675572709945;5160.767765450564;5331.520163185254;5331.786728530893;5362.329708786402;4404.493483249467;4496.213162696515;4566.885827854264;4609.469910960215;4633.4208223972;1342.9798553021712;1351.6147897849262;1353.553327401955;1354.864513548657;1393.1780249652754;903.6024149374255;1001.9448930308903;1020.8468729690605;1031.1750599520503;1049.7060822969581;6161.599496032743;6184.721687524072;6271.498280137578;6277.905831412532;6295.748170073146;461.84297338904935;485.33266758207463;1065.733566608348;1152.262551966742;1157.3403160198607;4372.781360931941;4489.2592722201125;4549.954500454953;4556.567126123013;4564.109998550317;11917.940410297893;11978.401079945968;12057.457414416373;12252.693682658004;12266;11891.88108118925;12153.93923030397;12183.817242741366;12191.695207619703;12195.756084878252;9070.365074444857;9195.494247816434;9200.861987070066;9243.815123697488;9316.114969077928;6178.814635560941;6222.595531290452;6240.719167637558;6396.328385519453;6439.098526206429;11095.88904110981;11222.49498772541;11394.088472922313;11411.828822567502;11603.825942611036;11442.71393215143;11601.303921764722;11608.24546404481;11789.292642441482;11804.468798904241;7445.553266804009;7591.127020392725;7819.648115834915;8181.5500147490075;8308.376871734523;9589.184919281939;9605.087516685904;9638.855417168608;9674.85487717699;9702.854457183006;8346.624401901807;8545.914540854512;8597.18326758957;8687.565621718762;8750.037495875322;8239.958800206201;8301.46040507365;8482.236598706146;8496.787580310542;8518.105598912272;7566.735164269224;7572.280633339824;7597.506162099446;7641.579713115832;7657.885131722917;5305.283786688902;5347.545458635904;5414.783408663609;5437.755301011385;5524.972375138259;5449.482299181572;5568.832935011957;5615.410381909841;5619.269494965628;5631.267935168566 09:27:59 INFO - PROCESS | 7277 | |4;prototype.html;328.9424350738621;329.22467588828306;337.1402922547503;347.6419288133222;350.18057744876984;5734.225879506265;5776.295992682159;5881.206037184978;5934.436228558291;5934.881302373955;5761.991651460988;5790.913136302948;5792.304923409186;5793;5795.884082318351;4508.571685689871;4518.8418405355815;4548.931766023512;4552.499225085238;4556.248219043854;4237.682173836959;4464.285714285715;4468.50846406895;4565.269556870901;4571.771411429432;4389.780510974454;4395.296752519597;4424.247877860771;4433.534478879719;4446.199684056868;4411.544190417155;4419.513853476099;4473.9552604473865;4486.125205584913;4510.458744950627;3756.718246131551;3805.4482100095606;3881.9223615527812;3882.1265215326607;3892.2799282132896;5525.336959564878;5533.557315414757;5539;5542.140968149944;5581.888362232773;5039;5040.933217380856;5043.722595257259;5077.238414237857;5107.157319042353;5847.795327163529;6040.365761595013;6061.696735201953;6097.420745029215;6111;4261.509926358446;4269.146170765859;4270.676090411982;4286.39990401344;4294.828206871753;6290.937090629127;6293.653849038301;6295.496360291166;6333.524985626096;6380.266269378988;4204.729446099133;4361.781910904442;4368.405531980804;4375.628071613948;4416.33754936762;4424.911501769947;4434.357018232338;4435.667324950641;4444.711093778894;4455.1312494064;5076.898462030813;5102.438731739506;5118.872028199325;5125.897482050413;5143.665661731976;5920.881582368328;5950.679235098315;6107.328193898667;6134.9079763803575;6170.2233994702565;1517.4976772994655;1535.2937648681732;1542.6683263098487;1547.2341191110472;1547.4970634543592;956.9617215311449;962.2350231565922;968.1141755293968;971.9368241064308;982.4203719805349;5270.130428479335;5288.576913846883;5314.5748340132695;5395.676259424447;5404.702741349263;5514.145307477347;5585.301837270341;5659.462351076641;5668.29951014694;5690.601657883991;5420.319700892735;5451.64564303319;5479.671219726829;5962.821115366546;6018.578699491081;3322.0399964021344;3370.79775213488;3376.18971446851;3385.4583266677705;3396.6093899201414;6247.375262473716;6563.556017676104;6576.868462630816;6584.6378449184795;6644.335566443317;6284.622922624657;6395.360463953661;6419.693857663307;6450.41946224842;6461.450776683941;6368.426841584187;6430.260520040255;6440.291567927524;6496.375906023494;6554.279029306773;6235.719392627433;6267.623942563278;6294.779682711083;6303.180586523723;6358.1734374531015;6190.721417536131;6211.316755156839;6240.344763799736;6248.812535623939;6275.152854364603;6225.25296964349;6517.608943463408;6521.184851893513;6522.934770652422;6559.162889709573;4384.728428755625;4399.384086227995;4402.405675233803;4405.31717583775;4434.600885920283;6032.698365081641;6140.662263575547;6316.936830631635;6317.652529110943;6344.270408903035;6096.146539484387;6117.204763380732;6133.662648554372;6136.325004249618;6141.447269745744;5878.676672783038;6057.637031667839;6105.14527966094;6143.662098584442;6146.477549408351;6030.457258846549;6032.728527216198;6043;6047.758089676364;6069.969650151721;6126.284640300723;6139.066194148829;6156.938430615636;6184.58801067593;6195.380461953769;5726.398728133486;5909.940900591111;5990;6008.4291992262415;6008.446410275703 09:27:59 INFO - PROCESS | 7277 | |5;yui.html;710.527499213023;726.2156870579774;862.2799962031703;863.5423225690387;892.4466830565046;14595.854041459583;14671.706565868677;15453.22733863305;15539.844601553996;15544.766828497568;14867.851321486782;14964.476243331486;14975.47585834496;14985.475508357209;14987.025843320203;712.8574285142967;844.2992316377392;868.452874688945;872.31959071924;873.9563021848913;854.8632218844986;858.1247127929508;859.6475445067524;859.7549698335976;860.1054902900976;912.5026860361119;913.3560839608093;914.3873604684844;915.9908400916006;916.1159481100736;896.8654701794783;903.4985583001431;904.6924045824451;906.12106256931;911.4030310146865;667.9465642748569;668.3149771484219;670.2426258328106;670.70488984847;671.3454381977582;15089.54731358061;15097.924510377488;15098.471553495576;15105.39578416873;15266.542003739794;15011.099334039884;15049;15204;15292.388304467808;15407.768883466757;12798.04014698892;12812.42344094518;12852.036097292646;12861.356932153354;13017.21896686202;4057.4928133983253;4057.6145266199665;4100.302948498763;4147.6474499667565;4173.39485774564;67824.6608766953;70431.64784176047;74076.25923740747;74355.25644743537;74461.6276918612;12180.147389682637;12292.323922184365;12382.504699812087;12729.55446559366;12790.61628151157;22956.54086918252;23205.071797127926;23309.533809324057;23319.650205246933;23451.41371465727;8851.51316677576;8942.776430589287;8952.104789520996;9023.774405639911;9081.727548173565;4671.48613652498;4758.405199350082;4766.904661906742;4767.6424268179335;4832.251001094836;3467.271872906718;3534.6288639692975;3538.628444013393;3560.003199104255;3569.214772749991;661.9304972977768;690.5097380859545;693.230514129316;694.5416025423197;694.8818700820873;669.4343279928453;696.3553100817559;712.3588770106945;734.6290123487711;744.3375395897656;10153.695389138338;10508.947455262827;10530.420826854443;10690.09134223584;10795.406252656023;614.3027663601844;618.3569088148275;666.044226534924;758.5069704691995;809.3039985612369;4598.8620341389815;4898.14282500561;5063;5109.591232701375;5470.288862447856;82576;91662;137720;142857;144963.2751836234;111093;111447;113495.43252283685;115125;117235;97515.51242243743;98580;99141.50429247807;100337;100738.49630751945;9269.44383337002;9496.47769372691;9498.14516693501;9725.756856078655;9923.305368624127;57527.7123614396;57837.71081144567;58257.4174258252;58730.412695874205;60075.69962150161;84378.57810710908;86027.1397286019;87557;88105.55947220222;89001.55499222463;14918.738026049306;14946.476873309817;14959;15045.924770376078;15296.617584560476;15301.234938253265;16270.186490675182;16308;16324.591885202964;16765.99404035762;15248.695026099638;15272.312745926682;15402.84597154014;15837.049777013415;16089.195540222709;13724.45102195901;14059.22674252926;14107.788383174466;14822.332995015466;14843.851561484247;13205.20768753878;13993.580192594238;14597.12417254968;14814.111153330834;15245.6188595286;11767.176297659082;12532.37338133108;12641.304728240035;13018.609441716764;13358.732825343244;12527.937360313505;12588.685282867635;12688.936555317165;12903.741925161257;13008.284544350152 09:27:59 INFO - PROCESS | 7277 | __end_tp_report 09:27:59 INFO - PROCESS | 7277 | __start_cc_report 09:27:59 INFO - PROCESS | 7277 | _x_x_mozilla_cycle_collect,333 09:27:59 INFO - PROCESS | 7277 | __end_cc_report 09:27:59 INFO - PROCESS | 7277 | __startTimestamp1465403279642__endTimestamp 09:27:59 INFO - PROCESS | 7277 | 09:27:59 INFO - PROCESS | 7277 | ------- Summary: start ------- 09:27:59 INFO - PROCESS | 7277 | Number of tests: 6 09:27:59 INFO - PROCESS | 7277 | 09:27:59 INFO - PROCESS | 7277 | [#0] dojo.html Cycles:165 Average:5743.36 Median:5982.76 stddev:661.05 (11.0%) stddev-sans-first:637.29 09:27:59 INFO - PROCESS | 7277 | Values: 3412.7 3452.7 3466.3 3507.6 3511.5 5659.7 5741.4 5760.9 5761.1 5769.1 5780.4 5786.1 5806.5 5816.6 5829.2 5183.2 5253.7 5280.1 5289.0 5350.1 5136.3 5213.4 5329.1 5333.7 5360.0 5173.8 5175.3 5186.3 5187.4 5268.0 5203.8 5233.8 5234.6 5237.3 5263.9 5087.6 5089.6 5121.7 5140.4 5155.2 5586.3 5594.3 5609.8 5645.1 5645.9 6138.2 6143.6 6155.4 6166.9 6198.9 6127.2 6184.4 6237.9 6245.9 6250.6 5890.3 5899.9 5904.2 5911.5 5920.7 6285.6 6323.1 6410.6 6414.4 6418.8 5888.0 5933.2 5933.4 5953.5 6020.2 6085.6 6108.0 6109.7 6111.5 6115.2 5965.6 5991.9 5999.6 6036.0 6063.0 6072.9 6073.0 6111.0 6154.2 6161.4 4617.4 4637.6 4640.0 4643.0 4686.0 4111.0 4154.0 4165.0 4166.9 4217.5 5853.9 5915.2 5944.0 5982.8 6109.1 6209.0 6234.8 6261.7 6272.9 6292.9 5851.5 5908.6 5955.9 5974.9 6058.8 5195.5 5202.8 5252.1 5252.9 5282.4 6441.8 6451.8 6453.5 6456.5 6464.1 6034.9 6133.3 6136.7 6237.8 6249.5 6492.4 6502.3 6518.1 6527.9 6541.9 6174.2 6181.2 6184.8 6189.3 6192.8 5926.0 6114.8 6130.7 6185.4 6309.1 6100.2 6107.1 6119.8 6133.4 6137.5 6046.3 6090.6 6095.1 6112.8 6115.4 5890.1 5928.9 5944.8 5998.3 6056.9 6154.5 6165.4 6176.6 6185.8 6188.8 5765.9 6021.1 6023.9 6026.5 6041.9 09:27:59 INFO - PROCESS | 7277 | 09:27:59 INFO - PROCESS | 7277 | [#1] ext.html Cycles:180 Average:65045.75 Median:42676.07 stddev:136587.44 (320.1%) stddev-sans-first:136884.89 09:27:59 INFO - PROCESS | 7277 | Values: 599.0 638.3 641.7 660.0 673.9 41096.2 44816.6 44936.8 45056.9 45466.9 37749.8 38396.0 38444.6 38653.8 38714.4 9018.8 9172.4 9185.9 9192.2 9209.0 9055.9 9107.5 9119.6 9120.4 9151.8 9040.1 9103.4 9156.1 9180.2 9185.6 9051.6 9067.4 9097.1 9131.5 9153.0 8996.5 9021.0 9104.0 9130.5 9131.2 42146.8 42437.6 42439.8 42632.8 42651.8 3583.1 3642.4 3732.8 3836.6 4370.7 34336.3 34377.5 34441.3 34812.5 35543.0 4650.8 4719.2 4727.5 4775.2 4784.5 358450.0 358471.0 359348.0 359383.0 360615.0 37848.4 64516.7 64938.7 65035.0 65172.0 37086.4 38595.2 38710.6 38730.2 39262.8 14343.1 14364.7 14519.0 14525.9 14589.6 12282.6 12346.1 12352.2 12373.6 12384.4 9020.7 9076.2 9103.8 9131.5 9217.4 3459.6 3466.5 3469.2 3492.4 3506.9 1089.1 1098.3 1106.2 1192.5 1223.6 33415.5 33574.5 33636.5 33984.8 34184.7 1177.1 1191.9 1194.1 1247.1 1271.4 17177.4 17401.0 17582.6 17678.9 17836.3 619209.0 620286.0 622151.0 623146.0 623529.0 61627.7 61713.3 61921.0 62000.7 62320.4 1441.9 1477.1 1487.0 1488.8 1498.7 32958.5 33038.5 33079.0 33125.3 33420.3 54932.0 55622.7 55710.7 55716.7 55781.0 518142.0 518312.0 519567.0 521499.0 524848.0 30189.8 30201.5 30656.2 30798.8 30812.7 51836.7 51838.5 52188.2 52357.7 53097.0 42700.4 42736.8 43811.6 44188.0 44855.6 42893.4 42934.1 43009.8 43086.0 44353.1 44017.3 44685.0 44859.8 45073.3 46750.8 37948.2 38164.8 38242.2 38485.6 38739.4 28986.4 29251.0 29265.0 29742.6 29905.0 09:27:59 INFO - PROCESS | 7277 | 09:27:59 INFO - PROCESS | 7277 | [#2] jquery.html Cycles:180 Average:29894.21 Median:24175.07 stddev:81876.04 (338.7%) stddev-sans-first:82075.82 09:27:59 INFO - PROCESS | 7277 | Values: 423.8 429.7 430.5 431.2 444.6 18731.7 19292.5 20304.1 20308.4 20439.5 18957.3 19031.8 19191.8 19601.0 19613.2 5919.0 6032.9 6103.4 6109.6 6122.5 5840.9 5971.5 5974.7 6017.0 6024.5 5942.6 5955.6 5980.3 5981.2 5990.5 5778.8 5938.8 5983.3 5989.1 5996.2 5326.1 5357.3 5363.9 5366.6 5370.9 22914.9 23910.0 24440.1 24603.1 24650.0 2505.8 2547.4 2562.3 2575.5 2824.2 8786.5 9438.5 14811.3 15219.1 15752.8 1937.9 1977.1 2020.4 2040.9 2051.2 84501.0 86364.6 86797.0 87647.1 87659.0 11254.4 11541.3 11681.5 12289.3 12529.3 16169.0 16442.6 16481.2 16485.1 16487.6 7982.2 7985.2 8078.8 8091.2 8131.6 7464.6 7522.9 7614.3 7645.7 7675.0 4303.2 4475.2 4887.3 4922.5 4975.2 2054.2 2070.0 2072.1 2078.2 2080.4 966.0 1015.3 1072.3 1083.8 1085.7 19442.2 19636.0 19914.9 20109.7 20245.9 997.1 1030.6 1042.7 1087.1 1090.2 10993.5 11318.3 11340.1 11350.4 11379.1 489417.0 493517.0 493965.0 499125.0 500192.0 98647.0 100286.0 100542.0 101782.0 102138.5 1064.9 1069.2 1074.4 1077.4 1085.3 17490.0 17665.9 17877.0 17997.2 18286.7 40687.4 41736.2 41837.0 41951.4 42826.4 57162.7 57792.4 59360.0 59522.4 59700.0 8093.2 8101.7 8115.8 8123.7 8382.0 9034.7 13488.5 13701.4 13844.7 13971.7 11319.8 12391.2 12654.2 12681.9 12702.6 12286.5 12577.7 12710.6 12770.6 12852.2 12568.6 13116.7 13150.1 13290.7 13332.3 8625.7 8697.8 8754.0 8894.7 8925.9 11406.3 12173.0 12265.3 12364.7 12434.4 09:27:59 INFO - PROCESS | 7277 | 09:27:59 INFO - PROCESS | 7277 | [#3] mootools.html Cycles:180 Average:6362.72 Median:4588.18 stddev:3712.33 (80.9%) stddev-sans-first:3705.16 09:27:59 INFO - PROCESS | 7277 | Values: 1553.8 1609.4 1809.4 1914.1 1936.4 8661.2 9201.6 9412.7 9991.6 10040.0 9398.6 9440.5 9713.8 9722.3 9724.2 2434.5 2447.5 2471.8 2478.0 2482.2 2375.9 2465.9 2483.6 2487.1 2491.4 2406.7 2425.8 2469.7 2488.2 2497.1 2398.6 2425.8 2441.4 2442.0 2455.0 2469.5 2485.5 2517.1 2521.6 2528.9 9578.8 9585.0 9665.4 9687.0 9724.8 5564.7 5694.4 5742.6 5743.5 5761.7 3423.9 3486.4 3555.5 3560.6 3585.1 1207.6 1239.0 1239.2 1244.7 1277.0 13763.5 13781.9 13825.3 13878.8 13928.2 4894.2 4958.1 5101.7 5127.9 5133.6 11532.1 11548.4 11651.8 11655.2 11687.1 5800.1 5817.6 5827.9 5833.0 5833.0 4634.7 5160.8 5331.5 5331.8 5362.3 4404.5 4496.2 4566.9 4609.5 4633.4 1343.0 1351.6 1353.6 1354.9 1393.2 903.6 1001.9 1020.8 1031.2 1049.7 6161.6 6184.7 6271.5 6277.9 6295.7 461.8 485.3 1065.7 1152.3 1157.3 4372.8 4489.3 4550.0 4556.6 4564.1 11917.9 11978.4 12057.5 12252.7 12266.0 11891.9 12153.9 12183.8 12191.7 12195.8 9070.4 9195.5 9200.9 9243.8 9316.1 6178.8 6222.6 6240.7 6396.3 6439.1 11095.9 11222.5 11394.1 11411.8 11603.8 11442.7 11601.3 11608.2 11789.3 11804.5 7445.6 7591.1 7819.6 8181.6 8308.4 9589.2 9605.1 9638.9 9674.9 9702.9 8346.6 8545.9 8597.2 8687.6 8750.0 8240.0 8301.5 8482.2 8496.8 8518.1 7566.7 7572.3 7597.5 7641.6 7657.9 5305.3 5347.5 5414.8 5437.8 5525.0 5449.5 5568.8 5615.4 5619.3 5631.3 09:27:59 INFO - PROCESS | 7277 | 09:27:59 INFO - PROCESS | 7277 | [#4] prototype.html Cycles:180 Average:5075.72 Median:5769.14 stddev:1515.55 (26.3%) stddev-sans-first:1477.33 09:27:59 INFO - PROCESS | 7277 | Values: 328.9 329.2 337.1 347.6 350.2 5734.2 5776.3 5881.2 5934.4 5934.9 5762.0 5790.9 5792.3 5793.0 5795.9 4508.6 4518.8 4548.9 4552.5 4556.2 4237.7 4464.3 4468.5 4565.3 4571.8 4389.8 4395.3 4424.2 4433.5 4446.2 4411.5 4419.5 4474.0 4486.1 4510.5 3756.7 3805.4 3881.9 3882.1 3892.3 5525.3 5533.6 5539.0 5542.1 5581.9 5039.0 5040.9 5043.7 5077.2 5107.2 5847.8 6040.4 6061.7 6097.4 6111.0 4261.5 4269.1 4270.7 4286.4 4294.8 6290.9 6293.7 6295.5 6333.5 6380.3 4204.7 4361.8 4368.4 4375.6 4416.3 4424.9 4434.4 4435.7 4444.7 4455.1 5076.9 5102.4 5118.9 5125.9 5143.7 5920.9 5950.7 6107.3 6134.9 6170.2 1517.5 1535.3 1542.7 1547.2 1547.5 957.0 962.2 968.1 971.9 982.4 5270.1 5288.6 5314.6 5395.7 5404.7 5514.1 5585.3 5659.5 5668.3 5690.6 5420.3 5451.6 5479.7 5962.8 6018.6 3322.0 3370.8 3376.2 3385.5 3396.6 6247.4 6563.6 6576.9 6584.6 6644.3 6284.6 6395.4 6419.7 6450.4 6461.5 6368.4 6430.3 6440.3 6496.4 6554.3 6235.7 6267.6 6294.8 6303.2 6358.2 6190.7 6211.3 6240.3 6248.8 6275.2 6225.3 6517.6 6521.2 6522.9 6559.2 4384.7 4399.4 4402.4 4405.3 4434.6 6032.7 6140.7 6316.9 6317.7 6344.3 6096.1 6117.2 6133.7 6136.3 6141.4 5878.7 6057.6 6105.1 6143.7 6146.5 6030.5 6032.7 6043.0 6047.8 6070.0 6126.3 6139.1 6156.9 6184.6 6195.4 5726.4 5909.9 5990.0 6008.4 6008.4 09:27:59 INFO - PROCESS | 7277 | 09:27:59 INFO - PROCESS | 7277 | [#5] yui.html Cycles:180 Average:22615.25 Median:4057.55 stddev:33141.04 (816.8%) stddev-sans-first:33193.20 09:27:59 INFO - PROCESS | 7277 | Values: 710.5 726.2 862.3 863.5 892.4 14595.9 14671.7 15453.2 15539.8 15544.8 14867.9 14964.5 14975.5 14985.5 14987.0 712.9 844.3 868.5 872.3 874.0 854.9 858.1 859.6 859.8 860.1 912.5 913.4 914.4 916.0 916.1 896.9 903.5 904.7 906.1 911.4 667.9 668.3 670.2 670.7 671.3 15089.5 15097.9 15098.5 15105.4 15266.5 15011.1 15049.0 15204.0 15292.4 15407.8 12798.0 12812.4 12852.0 12861.4 13017.2 4057.5 4057.6 4100.3 4147.6 4173.4 67824.7 70431.6 74076.3 74355.3 74461.6 12180.1 12292.3 12382.5 12729.6 12790.6 22956.5 23205.1 23309.5 23319.7 23451.4 8851.5 8942.8 8952.1 9023.8 9081.7 4671.5 4758.4 4766.9 4767.6 4832.3 3467.3 3534.6 3538.6 3560.0 3569.2 661.9 690.5 693.2 694.5 694.9 669.4 696.4 712.4 734.6 744.3 10153.7 10508.9 10530.4 10690.1 10795.4 614.3 618.4 666.0 758.5 809.3 4598.9 4898.1 5063.0 5109.6 5470.3 82576.0 91662.0 137720.0 142857.0 144963.3 111093.0 111447.0 113495.4 115125.0 117235.0 97515.5 98580.0 99141.5 100337.0 100738.5 9269.4 9496.5 9498.1 9725.8 9923.3 57527.7 57837.7 58257.4 58730.4 60075.7 84378.6 86027.1 87557.0 88105.6 89001.6 14918.7 14946.5 14959.0 15045.9 15296.6 15301.2 16270.2 16308.0 16324.6 16766.0 15248.7 15272.3 15402.8 15837.0 16089.2 13724.5 14059.2 14107.8 14822.3 14843.9 13205.2 13993.6 14597.1 14814.1 15245.6 11767.2 12532.4 12641.3 13018.6 13358.7 12527.9 12588.7 12688.9 12903.7 13008.3 09:27:59 INFO - PROCESS | 7277 | -------- Summary: end -------- 09:27:59 INFO - PROCESS | 7277 | 09:28:00 INFO - TEST-INFO | 7277: exit 0 09:28:00 INFO - TEST-OK | dromaeo_css | took 1110928ms 09:28:00 INFO - TEST-START | kraken 09:28:00 INFO - operating with platform_type : linux_ 09:28:00 INFO - Initialising browser for kraken test... 09:28:00 INFO - TEST-INFO | started process 7521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpilztAm/profile http://localhost:42184/getInfo.html) 09:28:05 INFO - PROCESS | 7521 | __metrics Screen width/height:1600/1200 09:28:05 INFO - PROCESS | 7521 | colorDepth:24 09:28:05 INFO - PROCESS | 7521 | Browser inner width/height: 1024/697 09:28:05 INFO - PROCESS | 7521 | __metrics 09:28:05 ERROR - PROCESS | 7521 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 09:28:06 INFO - TEST-INFO | 7521: exit 0 09:28:06 INFO - Browser initialized. 09:28:06 INFO - Running cycle 1/1 for kraken test... 09:28:06 INFO - TEST-INFO | started process 7653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpilztAm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:28:18 INFO - PROCESS | 7653 | RSS: Main: 156377088 09:28:18 INFO - PROCESS | 7653 | 09:28:20 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42184/tests/kraken/driver.html?testName=audio-beat-detection) 09:28:21 INFO - PROCESS | 7653 | RSS: Main: 161554432 09:28:21 INFO - PROCESS | 7653 | 09:28:24 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42184/tests/kraken/driver.html?testName=audio-dft) 09:28:24 INFO - PROCESS | 7653 | RSS: Main: 160362496 09:28:24 INFO - PROCESS | 7653 | 09:28:27 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42184/tests/kraken/driver.html?testName=audio-fft) 09:28:28 INFO - PROCESS | 7653 | RSS: Main: 161271808 09:28:28 INFO - PROCESS | 7653 | 09:28:30 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42184/tests/kraken/driver.html?testName=audio-oscillator) 09:28:31 INFO - PROCESS | 7653 | RSS: Main: 161337344 09:28:31 INFO - PROCESS | 7653 | 09:28:33 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42184/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:28:33 INFO - PROCESS | 7653 | RSS: Main: 161288192 09:28:33 INFO - PROCESS | 7653 | 09:28:36 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42184/tests/kraken/driver.html?testName=imaging-darkroom) 09:28:37 INFO - PROCESS | 7653 | RSS: Main: 160260096 09:28:37 INFO - PROCESS | 7653 | 09:28:40 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42184/tests/kraken/driver.html?testName=imaging-desaturate) 09:28:41 INFO - PROCESS | 7653 | RSS: Main: 161226752 09:28:41 INFO - PROCESS | 7653 | 09:28:44 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42184/tests/kraken/driver.html?testName=json-parse-financial) 09:28:45 INFO - PROCESS | 7653 | RSS: Main: 161071104 09:28:45 INFO - PROCESS | 7653 | 09:28:46 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42184/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:28:47 INFO - PROCESS | 7653 | RSS: Main: 160673792 09:28:47 INFO - PROCESS | 7653 | 09:28:48 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:28:49 INFO - PROCESS | 7653 | RSS: Main: 160612352 09:28:49 INFO - PROCESS | 7653 | 09:28:51 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:28:52 INFO - PROCESS | 7653 | RSS: Main: 161566720 09:28:52 INFO - PROCESS | 7653 | 09:28:54 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:28:55 INFO - PROCESS | 7653 | RSS: Main: 161562624 09:28:55 INFO - PROCESS | 7653 | 09:28:58 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:28:58 INFO - PROCESS | 7653 | RSS: Main: 161857536 09:28:58 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42184/tests/kraken/driver.html?testName=ai-astar) 09:29:00 INFO - PROCESS | 7653 | RSS: Main: 162430976 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | __start_tp_report 09:29:00 INFO - PROCESS | 7653 | _x_x_mozilla_page_load 09:29:00 INFO - PROCESS | 7653 | _x_x_mozilla_page_load_details 09:29:00 INFO - PROCESS | 7653 | |i|pagename|runs| 09:29:00 INFO - PROCESS | 7653 | |0;ai-astar;111;104;112;112;112;112;111;110;112;111 09:29:00 INFO - PROCESS | 7653 | |1;audio-beat-detection;153;126;148;192;128;148;159;140;187;132 09:29:00 INFO - PROCESS | 7653 | |2;audio-dft;166;164;163;164;162;164;161;162;161;171 09:29:00 INFO - PROCESS | 7653 | |3;audio-fft;76;75;77;187;77;78;77;76;181;75 09:29:00 INFO - PROCESS | 7653 | |4;audio-oscillator;86;85;151;85;86;85;142;84;84;139 09:29:00 INFO - PROCESS | 7653 | |5;imaging-gaussian-blur;118;118;118;117;118;118;117;117;117;117 09:29:00 INFO - PROCESS | 7653 | |6;imaging-darkroom;147;148;147;147;147;147;146;146;146;146 09:29:00 INFO - PROCESS | 7653 | |7;imaging-desaturate;95;96;96;95;95;95;95;96;97;95 09:29:00 INFO - PROCESS | 7653 | |8;json-parse-financial;51;52;53;53;53;53;53;53;52;52 09:29:00 INFO - PROCESS | 7653 | |9;json-stringify-tinderbox;60;60;61;61;61;60;59;60;60;61 09:29:00 INFO - PROCESS | 7653 | |10;stanford-crypto-aes;77;79;81;82;78;77;79;78;112;84 09:29:00 INFO - PROCESS | 7653 | |11;stanford-crypto-ccm;132;119;118;119;120;127;121;125;133;120 09:29:00 INFO - PROCESS | 7653 | |12;stanford-crypto-pbkdf2;164;160;165;156;162;159;163;157;163;158 09:29:00 INFO - PROCESS | 7653 | |13;stanford-crypto-sha256-iterative;64;64;63;64;61;62;62;64;66;61 09:29:00 INFO - PROCESS | 7653 | __end_tp_report 09:29:00 INFO - PROCESS | 7653 | __start_cc_report 09:29:00 INFO - PROCESS | 7653 | _x_x_mozilla_cycle_collect,857 09:29:00 INFO - PROCESS | 7653 | __end_cc_report 09:29:00 INFO - PROCESS | 7653 | __startTimestamp1465403340636__endTimestamp 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | ------- Summary: start ------- 09:29:00 INFO - PROCESS | 7653 | Number of tests: 14 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:2.45 (2.2%) stddev-sans-first:2.60 09:29:00 INFO - PROCESS | 7653 | Values: 111.0 104.0 112.0 112.0 112.0 112.0 111.0 110.0 112.0 111.0 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:150.50 stddev:22.85 (15.2%) stddev-sans-first:24.23 09:29:00 INFO - PROCESS | 7653 | Values: 153.0 126.0 148.0 192.0 128.0 148.0 159.0 140.0 187.0 132.0 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:2.97 (1.8%) stddev-sans-first:3.05 09:29:00 INFO - PROCESS | 7653 | Values: 166.0 164.0 163.0 164.0 162.0 164.0 161.0 162.0 161.0 171.0 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | [#3] audio-fft Cycles:10 Average:97.90 Median:76.50 stddev:45.41 (59.4%) stddev-sans-first:47.47 09:29:00 INFO - PROCESS | 7653 | Values: 76.0 75.0 77.0 187.0 77.0 78.0 77.0 76.0 181.0 75.0 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:85.00 stddev:28.66 (33.7%) stddev-sans-first:29.75 09:29:00 INFO - PROCESS | 7653 | Values: 86.0 85.0 151.0 85.0 86.0 85.0 142.0 84.0 84.0 139.0 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:29:00 INFO - PROCESS | 7653 | Values: 118.0 118.0 118.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 09:29:00 INFO - PROCESS | 7653 | Values: 147.0 148.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 09:29:00 INFO - PROCESS | 7653 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 97.0 95.0 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:0.71 (1.3%) stddev-sans-first:0.50 09:29:00 INFO - PROCESS | 7653 | Values: 51.0 52.0 53.0 53.0 53.0 53.0 53.0 53.0 52.0 52.0 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 09:29:00 INFO - PROCESS | 7653 | Values: 60.0 60.0 61.0 61.0 61.0 60.0 59.0 60.0 60.0 61.0 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:79.00 stddev:10.54 (13.3%) stddev-sans-first:10.98 09:29:00 INFO - PROCESS | 7653 | Values: 77.0 79.0 81.0 82.0 78.0 77.0 79.0 78.0 112.0 84.0 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:123.00 stddev:5.56 (4.5%) stddev-sans-first:4.95 09:29:00 INFO - PROCESS | 7653 | Values: 132.0 119.0 118.0 119.0 120.0 127.0 121.0 125.0 133.0 120.0 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:162.50 stddev:3.13 (1.9%) stddev-sans-first:3.08 09:29:00 INFO - PROCESS | 7653 | Values: 164.0 160.0 165.0 156.0 162.0 159.0 163.0 157.0 163.0 158.0 09:29:00 INFO - PROCESS | 7653 | 09:29:00 INFO - PROCESS | 7653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:64.00 stddev:1.60 (2.5%) stddev-sans-first:1.66 09:29:00 INFO - PROCESS | 7653 | Values: 64.0 64.0 63.0 64.0 61.0 62.0 62.0 64.0 66.0 61.0 09:29:00 INFO - PROCESS | 7653 | -------- Summary: end -------- 09:29:00 INFO - PROCESS | 7653 | 09:29:01 INFO - TEST-INFO | 7653: exit 0 09:29:01 INFO - TEST-OK | kraken | took 61213ms 09:29:01 INFO - SUITE-END | took 1172s 09:29:01 INFO - Completed test suite (00:19:32) 09:29:01 INFO - javascript benchmark 09:29:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7664.567464581853, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3412.6587341265868, 3452.706519945805, 3466.2894106708095, 3507.631698671641, 3511.5259439975594, 5659.688717120557, 5741.425857414257, 5760.884782304352, 5761.135829625553, 5769.134629805531, 5780.364159942414, 5786.074228123501, 5806.506446952004, 5816.621919575236, 5829.213056237407, 5183.196604526295, 5253.7373131343475, 5280.075986702331, 5289.047971365153, 5350.117230656937, 5136.255242989764, 5213.3743950725775, 5329.067413202693, 5333.733313334337, 5360.035193665139, 5173.818916337929, 5175.275461435402, 5186.299849520323, 5187.3775146982225, 5268.0, 5203.8178663746585, 5233.842984710427, 5234.555062819665, 5237.266782650432, 5263.921041184385, 5087.643864929457, 5089.643724939256, 5121.692698438105, 5140.434552199255, 5155.200943853709, 5586.301712285965, 5594.300712410949, 5609.775608975636, 5645.068563686987, 5645.915311270334, 6138.171346868205, 6143.631382117087, 6155.353687862755, 6166.8766624667705, 6198.938010619881, 6127.203463549755, 6184.443400094013, 6237.906431403532, 6245.875082498324, 6250.562460627758, 5890.293164820249, 5899.941000589982, 5904.2029326040865, 5911.497522710575, 5920.733566989453, 6285.59143655661, 6323.083152942798, 6410.583312084699, 6414.422701956846, 6418.807435776934, 5888.0, 5933.199018132583, 5933.436323549256, 5953.464188222994, 6020.247469066367, 6085.574009819358, 6108.0, 6109.694515274218, 6111.51107911366, 6115.235595550556, 5965.612235204698, 5991.940080599225, 5999.550033747487, 6036.0, 6063.0, 6072.939270607326, 6073.0, 6111.0, 6154.230721159855, 6161.353057928853, 4617.353570500132, 4637.605803506673, 4639.976800115978, 4643.048175124091, 4686.015936653341, 4111.033907031845, 4153.958460415418, 4165.021220013295, 4166.937495937564, 4217.451731274976, 5853.882922341614, 5915.231019967463, 5943.970280148572, 5982.760689572456, 6109.14471973924, 6209.037599172136, 6234.781782637586, 6261.749530018839, 6272.905906411407, 6292.937070629327, 5851.473367396955, 5908.556858235649, 5955.887492137037, 5974.910376344358, 6058.848528786815, 5195.480451954774, 5202.843914682566, 5252.133397989365, 5252.894942101213, 5282.366116066097, 6441.774537891151, 6451.774187903401, 6453.548251622436, 6456.451201647913, 6464.095026696266, 6034.9094763577705, 6133.334663918993, 6136.6722581676495, 6237.781677641442, 6249.500039996789, 6492.35076492347, 6502.349765023459, 6518.054882041983, 6527.934720652923, 6541.901871471837, 6174.228221472316, 6181.1655426516845, 6184.783532576338, 6189.319174890668, 6192.81421557354, 5926.022206336079, 6114.7536090578, 6130.703893785035, 6185.350538193605, 6309.148264984168, 6100.235277662567, 6107.059952181356, 6119.785807496716, 6133.355997620186, 6137.539684523589, 6046.3046749624355, 6090.634561926298, 6095.1466794647895, 6112.755489780359, 6115.388461153849, 5890.057590785454, 5928.911066334094, 5944.762209511571, 5998.3401825798255, 6056.939430605814, 6154.476869466145, 6165.383461653799, 6176.629402235881, 6185.783497577563, 6188.783392581238, 5765.884682306414, 6021.066734656135, 6023.945809483235, 6026.548008899263, 6041.9395806041375], "value": 5699.026761475173, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.9520838332934, 638.2723694987718, 641.6631268583993, 659.9835004124897, 673.9022841687959, 41096.17807643849, 44816.551834481645, 44936.77531612346, 45056.87357816052, 45466.8633284168, 37749.81125094378, 38396.0, 38444.61555384445, 38653.80673096631, 38714.41928371077, 9018.819623607524, 9172.357934944557, 9185.908140918573, 9192.218661413754, 9209.033051529594, 9055.909440905605, 9107.499087550183, 9119.589618467151, 9120.361574689774, 9151.816963660724, 9040.095990400972, 9103.36276460648, 9156.084391560857, 9180.219681327062, 9185.586648600796, 9051.59267832949, 9067.410618309854, 9097.090290970884, 9131.497767622777, 9153.038930912258, 8996.460212387277, 9021.0, 9104.0, 9130.543472826332, 9131.178193962574, 42146.789266053784, 42437.57562424367, 42439.78780106111, 42632.786836065934, 42651.786741066404, 3583.068402215443, 3642.4172132458943, 3732.8133593320226, 3836.5779764225913, 4370.7159034662645, 34336.313273734384, 34377.48433773495, 34441.31117377638, 34812.477812832825, 35543.0, 4650.790714417825, 4719.197736384823, 4727.503612120712, 4775.164346239394, 4784.521547845223, 358450.0, 358471.0, 359348.0, 359383.0, 360614.9999999974, 37848.43227351592, 64516.67741661356, 64938.67530662316, 65035.0, 65172.0, 37086.44370334447, 38595.22809543793, 38710.612893870704, 38730.225395492496, 39262.80368598196, 14343.139411635335, 14364.712705745827, 14519.0, 14525.92737036308, 14589.635259118395, 12282.570110046285, 12346.074044446703, 12352.197107188003, 12373.566925157756, 12384.380780960915, 9020.729378118667, 9076.228520575693, 9103.772405689911, 9131.543422828832, 9217.400868943498, 3459.6367381425093, 3466.5146879436393, 3469.150058235698, 3492.441209406483, 3506.8772592959126, 1089.096050278267, 1098.2696506823033, 1106.1593189176283, 1192.4693511387522, 1223.5839814462947, 33415.498767518504, 33574.49638255428, 33636.512659516615, 33984.83007584995, 34184.658153418146, 1177.05835331736, 1191.9046476281876, 1194.1402190422882, 1247.0670460785745, 1271.4215032160346, 17177.398791042255, 17401.0, 17582.560435989202, 17678.911605441892, 17836.252943255382, 619209.0, 620286.0, 622151.0, 623146.0, 623529.0, 61627.69186154041, 61713.29720216801, 61921.0, 62000.68999654973, 62320.37679623236, 1441.9495317663832, 1477.0768269831356, 1486.9925650371679, 1488.78412630168, 1498.7227362937892, 32958.50562241616, 33038.5044224332, 33079.0, 33125.33749325048, 33420.33159336751, 54932.0, 55622.72188639031, 55710.72144639251, 55716.72141639266, 55781.0, 518142.0, 518312.0, 519567.0, 521499.0, 524848.0, 30189.849050754605, 30201.546976795806, 30656.233594159432, 30798.84600576983, 30812.69187308098, 51836.74081629568, 51838.481615183366, 52188.217176743135, 52357.7382113087, 53097.0, 42700.35949460823, 42736.78631606822, 43811.561884380746, 44188.0, 44855.551444485136, 42893.356599650404, 42934.14131717411, 43009.784951075046, 43086.0, 44353.11293774171, 44017.339739904564, 44685.0, 44859.77570112129, 45073.32390014218, 46750.766246168554, 37948.24103517969, 38164.809175953946, 38242.2351552973, 38485.615143848205, 38739.37747775623, 28986.420271594026, 29251.0, 29265.0, 29742.55386169166, 29905.0], "value": 19915.182829549645, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.7923417525412, 429.67774169372973, 430.5178200415534, 431.1613910943213, 444.6020811373821, 18731.71902421463, 19292.51768705783, 20304.086316115772, 20308.39074827754, 20439.48901277465, 18957.33649322274, 19031.809681903178, 19191.80808191918, 19601.0, 19613.215471381165, 5918.970405147968, 6032.939670603304, 6103.389661033905, 6109.602875813058, 6122.47958923492, 5840.853978650546, 5971.5222782177325, 5974.701264936757, 6017.007193813016, 6024.5180385569265, 5942.5840191186635, 5955.553333500005, 5980.252468441445, 5981.192539007222, 5990.460858522732, 5778.7977420790285, 5938.792142275021, 5983.341832398432, 5989.13157592151, 5996.220491336142, 5326.121190003645, 5357.276767636397, 5363.9463605363835, 5366.597505187126, 5370.865728356784, 22914.885425572764, 23910.0, 24440.14459493927, 24603.13889013894, 24650.0, 2505.837120587156, 2547.4013606802387, 2562.2825608829557, 2575.459153577751, 2824.209221418006, 8786.516741579211, 9438.528073596293, 14811.259437028213, 15219.086854788637, 15752.842471575252, 1937.883726976386, 1977.0608960743675, 2020.4241791089469, 2040.8571400002006, 2051.21028404064, 84501.0, 86364.56817715934, 86797.0, 87647.12352876517, 87659.0, 11254.381009044417, 11541.307521548733, 11681.532738690357, 12289.324087175113, 12529.31088790107, 16169.0, 16442.588935276715, 16481.17594120289, 16485.093319867283, 16487.587810304838, 7982.201779821971, 7985.241402066795, 8078.838423231502, 8091.190880911861, 8131.59342032896, 7464.589447580327, 7522.924770752223, 7614.314711675976, 7645.655945482466, 7674.96162519195, 4303.203907277164, 4475.239209334421, 4887.315775791392, 4922.458529561745, 4975.203967365204, 2054.239931225456, 2070.0, 2072.057213967641, 2078.1687325070093, 2080.4070839810884, 965.9565319560637, 1015.2942408481462, 1072.3165925047488, 1083.8482612434266, 1085.733995171188, 19442.222311107682, 19636.0, 19914.90042549778, 20109.71113398152, 20245.898770506054, 997.1125698128672, 1030.5568605499557, 1042.7288904884786, 1087.0542627913765, 1090.1605763562172, 10993.450327483593, 11318.26431281964, 11340.149488788375, 11350.432478376213, 11379.089672826154, 489417.0, 493517.0, 493965.0, 499125.0, 500192.0, 98647.0, 100286.0, 100542.0, 101782.0, 102138.48930755447, 1064.8775390830153, 1069.1927594666133, 1074.3500182389698, 1077.439731339699, 1085.2620218251664, 17490.0, 17665.911670441565, 17876.97768002241, 17997.19012644408, 18286.725699114257, 40687.38968915409, 41736.165276694905, 41836.95407614834, 41951.370729439695, 42826.357604635334, 57162.7141864288, 57792.422075778704, 59360.0, 59522.40477595168, 59700.0, 8093.150219226896, 8101.675932962616, 8115.79710507242, 8123.7156699515235, 8382.0, 9034.728958131267, 13488.460461581819, 13701.383437745126, 13844.653883652989, 13971.720565588834, 11319.773604527698, 12391.194572352768, 12654.177478463871, 12681.93659031699, 12702.555410560586, 12286.508539658671, 12577.742225777349, 12710.555130570385, 12770.553030643883, 12852.228866268053, 12568.622941311774, 13116.672083197996, 13150.145240559334, 13290.734185316047, 13332.3333833306, 8625.654973801229, 8697.782555436164, 8753.956230218808, 8894.73315800527, 8925.910740892508, 11406.258593191416, 12173.0, 12265.26408415498, 12364.690882728004, 12434.440450179583], "value": 9613.38029348074, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1553.7747026681127, 1609.356257497001, 1809.439073887095, 1914.1386376130745, 1936.3900371383013, 8661.17718816713, 9201.58592863321, 9412.717618471439, 9991.60117583538, 10040.046195611423, 9398.62405503779, 9440.480773557452, 9713.757156071102, 9722.270829687784, 9724.173445257162, 2434.4644178280796, 2447.49826285611, 2471.8393304435244, 2478.033566908907, 2482.2056941778637, 2375.8812059397046, 2465.90136394544, 2483.639872218527, 2487.067349743846, 2491.4145175883655, 2406.711194656644, 2425.8301918865686, 2469.703635563726, 2488.228649118779, 2497.0760818497183, 2398.59223931932, 2425.769551892576, 2441.426264827764, 2442.010985550855, 2454.9754502454925, 2469.5060987802512, 2485.4904744527507, 2517.093846215361, 2521.6217567365043, 2528.898844046236, 9578.760530986712, 9585.041495850359, 9665.371750836173, 9687.031296870256, 9724.75688107803, 5564.721763911788, 5694.402087780765, 5742.569307301969, 5743.54051675865, 5761.654300741969, 3423.9486407703903, 3486.442169252907, 3555.520004799345, 3560.572731272264, 3585.1216451969435, 1207.6377086873902, 1238.9752204955942, 1239.20690757915, 1244.6826059354808, 1276.9872301277055, 13763.518276860263, 13781.931090344584, 13825.308734563232, 13878.791818122736, 13928.233947132903, 4894.241392584155, 4958.057968985881, 5101.668391554537, 5127.897442051213, 5133.614978876599, 11532.135089868125, 11548.422578871023, 11651.76696466066, 11655.184137110491, 11687.065034797195, 5800.100984347433, 5817.592768506249, 5827.941720582825, 5833.0, 5833.037548804485, 4634.675572709945, 5160.767765450564, 5331.520163185254, 5331.786728530893, 5362.329708786402, 4404.493483249467, 4496.213162696515, 4566.885827854264, 4609.469910960215, 4633.4208223972, 1342.9798553021712, 1351.6147897849262, 1353.553327401955, 1354.864513548657, 1393.1780249652754, 903.6024149374255, 1001.9448930308903, 1020.8468729690605, 1031.1750599520503, 1049.7060822969581, 6161.599496032743, 6184.721687524072, 6271.498280137578, 6277.905831412532, 6295.748170073146, 461.84297338904935, 485.33266758207463, 1065.733566608348, 1152.262551966742, 1157.3403160198607, 4372.781360931941, 4489.2592722201125, 4549.954500454953, 4556.567126123013, 4564.109998550317, 11917.940410297893, 11978.401079945968, 12057.457414416373, 12252.693682658004, 12266.0, 11891.88108118925, 12153.93923030397, 12183.817242741366, 12191.695207619703, 12195.756084878252, 9070.365074444857, 9195.494247816434, 9200.861987070066, 9243.815123697488, 9316.114969077928, 6178.814635560941, 6222.595531290452, 6240.719167637558, 6396.328385519453, 6439.098526206429, 11095.88904110981, 11222.49498772541, 11394.088472922313, 11411.828822567502, 11603.825942611036, 11442.71393215143, 11601.303921764722, 11608.24546404481, 11789.292642441482, 11804.468798904241, 7445.553266804009, 7591.127020392725, 7819.648115834915, 8181.5500147490075, 8308.376871734523, 9589.184919281939, 9605.087516685904, 9638.855417168608, 9674.85487717699, 9702.854457183006, 8346.624401901807, 8545.914540854512, 8597.18326758957, 8687.565621718762, 8750.037495875322, 8239.958800206201, 8301.46040507365, 8482.236598706146, 8496.787580310542, 8518.105598912272, 7566.735164269224, 7572.280633339824, 7597.506162099446, 7641.579713115832, 7657.885131722917, 5305.283786688902, 5347.545458635904, 5414.783408663609, 5437.755301011385, 5524.972375138259, 5449.482299181572, 5568.832935011957, 5615.410381909841, 5619.269494965628, 5631.267935168566], "value": 5030.563416168751, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.9424350738621, 329.22467588828306, 337.1402922547503, 347.6419288133222, 350.18057744876984, 5734.225879506265, 5776.295992682159, 5881.206037184978, 5934.436228558291, 5934.881302373955, 5761.991651460988, 5790.913136302948, 5792.304923409186, 5793.0, 5795.884082318351, 4508.571685689871, 4518.8418405355815, 4548.931766023512, 4552.499225085238, 4556.248219043854, 4237.682173836959, 4464.285714285715, 4468.50846406895, 4565.269556870901, 4571.771411429432, 4389.780510974454, 4395.296752519597, 4424.247877860771, 4433.534478879719, 4446.199684056868, 4411.544190417155, 4419.513853476099, 4473.9552604473865, 4486.125205584913, 4510.458744950627, 3756.718246131551, 3805.4482100095606, 3881.9223615527812, 3882.1265215326607, 3892.2799282132896, 5525.336959564878, 5533.557315414757, 5539.0, 5542.140968149944, 5581.888362232773, 5039.0, 5040.933217380856, 5043.722595257259, 5077.238414237857, 5107.157319042353, 5847.795327163529, 6040.365761595013, 6061.696735201953, 6097.420745029215, 6111.0, 4261.509926358446, 4269.146170765859, 4270.676090411982, 4286.39990401344, 4294.828206871753, 6290.937090629127, 6293.653849038301, 6295.496360291166, 6333.524985626096, 6380.266269378988, 4204.729446099133, 4361.781910904442, 4368.405531980804, 4375.628071613948, 4416.33754936762, 4424.911501769947, 4434.357018232338, 4435.667324950641, 4444.711093778894, 4455.1312494064, 5076.898462030813, 5102.438731739506, 5118.872028199325, 5125.897482050413, 5143.665661731976, 5920.881582368328, 5950.679235098315, 6107.328193898667, 6134.9079763803575, 6170.2233994702565, 1517.4976772994655, 1535.2937648681732, 1542.6683263098487, 1547.2341191110472, 1547.4970634543592, 956.9617215311449, 962.2350231565922, 968.1141755293968, 971.9368241064308, 982.4203719805349, 5270.130428479335, 5288.576913846883, 5314.5748340132695, 5395.676259424447, 5404.702741349263, 5514.145307477347, 5585.301837270341, 5659.462351076641, 5668.29951014694, 5690.601657883991, 5420.319700892735, 5451.64564303319, 5479.671219726829, 5962.821115366546, 6018.578699491081, 3322.0399964021344, 3370.79775213488, 3376.18971446851, 3385.4583266677705, 3396.6093899201414, 6247.375262473716, 6563.556017676104, 6576.868462630816, 6584.6378449184795, 6644.335566443317, 6284.622922624657, 6395.360463953661, 6419.693857663307, 6450.41946224842, 6461.450776683941, 6368.426841584187, 6430.260520040255, 6440.291567927524, 6496.375906023494, 6554.279029306773, 6235.719392627433, 6267.623942563278, 6294.779682711083, 6303.180586523723, 6358.1734374531015, 6190.721417536131, 6211.316755156839, 6240.344763799736, 6248.812535623939, 6275.152854364603, 6225.25296964349, 6517.608943463408, 6521.184851893513, 6522.934770652422, 6559.162889709573, 4384.728428755625, 4399.384086227995, 4402.405675233803, 4405.31717583775, 4434.600885920283, 6032.698365081641, 6140.662263575547, 6316.936830631635, 6317.652529110943, 6344.270408903035, 6096.146539484387, 6117.204763380732, 6133.662648554372, 6136.325004249618, 6141.447269745744, 5878.676672783038, 6057.637031667839, 6105.14527966094, 6143.662098584442, 6146.477549408351, 6030.457258846549, 6032.728527216198, 6043.0, 6047.758089676364, 6069.969650151721, 6126.284640300723, 6139.066194148829, 6156.938430615636, 6184.58801067593, 6195.380461953769, 5726.398728133486, 5909.940900591111, 5990.0, 6008.4291992262415, 6008.446410275703], "value": 4583.106538454236, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.527499213023, 726.2156870579774, 862.2799962031703, 863.5423225690387, 892.4466830565046, 14595.854041459583, 14671.706565868677, 15453.22733863305, 15539.844601553996, 15544.766828497568, 14867.851321486782, 14964.476243331486, 14975.47585834496, 14985.475508357209, 14987.025843320203, 712.8574285142967, 844.2992316377392, 868.452874688945, 872.31959071924, 873.9563021848913, 854.8632218844986, 858.1247127929508, 859.6475445067524, 859.7549698335976, 860.1054902900976, 912.5026860361119, 913.3560839608093, 914.3873604684844, 915.9908400916006, 916.1159481100736, 896.8654701794783, 903.4985583001431, 904.6924045824451, 906.12106256931, 911.4030310146865, 667.9465642748569, 668.3149771484219, 670.2426258328106, 670.70488984847, 671.3454381977582, 15089.54731358061, 15097.924510377488, 15098.471553495576, 15105.39578416873, 15266.542003739794, 15011.099334039884, 15049.0, 15204.0, 15292.388304467808, 15407.768883466757, 12798.04014698892, 12812.42344094518, 12852.036097292646, 12861.356932153354, 13017.21896686202, 4057.4928133983253, 4057.6145266199665, 4100.302948498763, 4147.6474499667565, 4173.39485774564, 67824.6608766953, 70431.64784176047, 74076.25923740747, 74355.25644743537, 74461.6276918612, 12180.147389682637, 12292.323922184365, 12382.504699812087, 12729.55446559366, 12790.61628151157, 22956.54086918252, 23205.071797127926, 23309.533809324057, 23319.650205246933, 23451.41371465727, 8851.51316677576, 8942.776430589287, 8952.104789520996, 9023.774405639911, 9081.727548173565, 4671.48613652498, 4758.405199350082, 4766.904661906742, 4767.6424268179335, 4832.251001094836, 3467.271872906718, 3534.6288639692975, 3538.628444013393, 3560.003199104255, 3569.214772749991, 661.9304972977768, 690.5097380859545, 693.230514129316, 694.5416025423197, 694.8818700820873, 669.4343279928453, 696.3553100817559, 712.3588770106945, 734.6290123487711, 744.3375395897656, 10153.695389138338, 10508.947455262827, 10530.420826854443, 10690.09134223584, 10795.406252656023, 614.3027663601844, 618.3569088148275, 666.044226534924, 758.5069704691995, 809.3039985612369, 4598.8620341389815, 4898.14282500561, 5063.0, 5109.591232701375, 5470.288862447856, 82576.0, 91662.0, 137720.0, 142857.0, 144963.2751836234, 111093.0, 111447.0, 113495.43252283685, 115125.0, 117235.0, 97515.51242243743, 98580.0, 99141.50429247807, 100337.0, 100738.49630751945, 9269.44383337002, 9496.47769372691, 9498.14516693501, 9725.756856078655, 9923.305368624127, 57527.7123614396, 57837.71081144567, 58257.4174258252, 58730.412695874205, 60075.69962150161, 84378.57810710908, 86027.1397286019, 87557.0, 88105.55947220222, 89001.55499222463, 14918.738026049306, 14946.476873309817, 14959.0, 15045.924770376078, 15296.617584560476, 15301.234938253265, 16270.186490675182, 16308.0, 16324.591885202964, 16765.99404035762, 15248.695026099638, 15272.312745926682, 15402.84597154014, 15837.049777013415, 16089.195540222709, 13724.45102195901, 14059.22674252926, 14107.788383174466, 14822.332995015466, 14843.851561484247, 13205.20768753878, 13993.580192594238, 14597.12417254968, 14814.111153330834, 15245.6188595286, 11767.176297659082, 12532.37338133108, 12641.304728240035, 13018.609441716764, 13358.732825343244, 12527.937360313505, 12588.685282867635, 12688.936555317165, 12903.741925161257, 13008.284544350152], "value": 8058.422296850684, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 112.0, 112.0, 112.0, 112.0, 111.0, 110.0, 112.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 148.0, 192.0, 128.0, 148.0, 159.0, 140.0, 187.0, 132.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 163.0, 164.0, 162.0, 164.0, 161.0, 162.0, 161.0, 171.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 187.0, 77.0, 78.0, 77.0, 76.0, 181.0, 75.0], "value": 97.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 151.0, 85.0, 86.0, 85.0, 142.0, 84.0, 84.0, 139.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 97.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 52.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 61.0, 61.0, 60.0, 59.0, 60.0, 60.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 81.0, 82.0, 78.0, 77.0, 79.0, 78.0, 112.0, 84.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 119.0, 118.0, 119.0, 120.0, 127.0, 121.0, 125.0, 133.0, 120.0], "value": 123.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 165.0, 156.0, 162.0, 159.0, 163.0, 157.0, 163.0, 158.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 61.0, 62.0, 62.0, 64.0, 66.0, 61.0], "value": 63.1, "unit": "score"}]}]} 09:29:01 INFO - Return code: 0 09:29:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:29:01 ERROR - # TBPL SUCCESS # 09:29:01 INFO - Running post-action listener: _resource_record_post_action 09:29:01 INFO - ##### 09:29:01 INFO - ##### Finished run-tests step (success) 09:29:01 INFO - ##### 09:29:01 INFO - Running post-run listener: _resource_record_post_run 09:29:02 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 367386624; Read time: 24; Write time: 266444 09:29:02 INFO - TinderboxPrint: CPU usage
13.4% 09:29:02 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 09:29:02 INFO - TinderboxPrint: I/O write bytes / time
367,386,624 / 266,444 09:29:02 INFO - TinderboxPrint: CPU idle
8,217.2 (86.6%) 09:29:02 INFO - TinderboxPrint: CPU user
1,214.0 (12.8%) 09:29:02 INFO - TinderboxPrint: Swap in / out
0 / 0 09:29:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 84414464; Read time: 0; Write time: 78620 09:29:02 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 246206464; Read time: 24; Write time: 169612 09:29:02 INFO - Running post-run listener: _upload_blobber_files 09:29:02 INFO - Blob upload gear active. 09:29:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:29:02 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 09:29:02 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'] 09:29:02 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 09:29:02 INFO - (blobuploader) - INFO - Open directory for files ... 09:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:29:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:03 INFO - (blobuploader) - INFO - Done attempting. 09:29:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:29:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:07 INFO - (blobuploader) - INFO - Done attempting. 09:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:07 INFO - (blobuploader) - INFO - Done attempting. 09:29:07 INFO - (blobuploader) - INFO - Iteration through files over. 09:29:07 INFO - Return code: 0 09:29:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:29:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:29:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d23ab7d9f4cf56fafb12f5633a9d7e6d6bf4dab03c69512e30f25191912a243a5f15de3d7d36dba6f7b14cb0a752f018c3b830f7b902dd52f6119f9285d67ffd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ec7be999110c2c95023084e0b39b40b47d3d542fa6e3a01d09168856786659a5a0f3e3e8a93ea22566e227a77535a27fa76a94643988a54dc669d630e3718b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/970b2f563a008e0f4a77fe5cad709e666b1596734b7e29cf15304311214627a54169c9b72a2d8f641d2ee76fcb842c9a36a26bbfa3e3ce1927f02a71b48eae2a"} 09:29:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:29:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:29:07 INFO - Contents: 09:29:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d23ab7d9f4cf56fafb12f5633a9d7e6d6bf4dab03c69512e30f25191912a243a5f15de3d7d36dba6f7b14cb0a752f018c3b830f7b902dd52f6119f9285d67ffd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ec7be999110c2c95023084e0b39b40b47d3d542fa6e3a01d09168856786659a5a0f3e3e8a93ea22566e227a77535a27fa76a94643988a54dc669d630e3718b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/970b2f563a008e0f4a77fe5cad709e666b1596734b7e29cf15304311214627a54169c9b72a2d8f641d2ee76fcb842c9a36a26bbfa3e3ce1927f02a71b48eae2a"} 09:29:07 INFO - Running post-run listener: copy_logs_to_upload_dir 09:29:07 INFO - Copying logs to upload dir... 09:29:07 INFO - mkdir: /builds/slave/test/build/upload/logs 09:29:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.531933 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-08 09:29:07.794648) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 09:29:07.798452) ========= 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=836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241 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/d23ab7d9f4cf56fafb12f5633a9d7e6d6bf4dab03c69512e30f25191912a243a5f15de3d7d36dba6f7b14cb0a752f018c3b830f7b902dd52f6119f9285d67ffd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ec7be999110c2c95023084e0b39b40b47d3d542fa6e3a01d09168856786659a5a0f3e3e8a93ea22566e227a77535a27fa76a94643988a54dc669d630e3718b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/970b2f563a008e0f4a77fe5cad709e666b1596734b7e29cf15304311214627a54169c9b72a2d8f641d2ee76fcb842c9a36a26bbfa3e3ce1927f02a71b48eae2a"} build_url:https://queue.taskcluster.net/v1/task/OxBHYH8JQuS--nZ5D8ygUA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/OxBHYH8JQuS--nZ5D8ygUA/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/d23ab7d9f4cf56fafb12f5633a9d7e6d6bf4dab03c69512e30f25191912a243a5f15de3d7d36dba6f7b14cb0a752f018c3b830f7b902dd52f6119f9285d67ffd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ec7be999110c2c95023084e0b39b40b47d3d542fa6e3a01d09168856786659a5a0f3e3e8a93ea22566e227a77535a27fa76a94643988a54dc669d630e3718b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/970b2f563a008e0f4a77fe5cad709e666b1596734b7e29cf15304311214627a54169c9b72a2d8f641d2ee76fcb842c9a36a26bbfa3e3ce1927f02a71b48eae2a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 09:29:07.831744) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:29:07.832097) ========= 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=836cfdc75598d54cb747368e000001a9-1465401757.108967-878418241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:29:07.916714) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 09:29:07.917065) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 09:29:07.917404) ========= ========= Total master_lag: 0.43 =========