builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1468348807.1 results: success (0) buildid: 20160712070226 builduid: b3eb8b0e109c4fbabeee045f740ad316 revision: 385340f31f4d6bbc00b1a0f8c59d583ce3f8d4e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 11:40:07.103460) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 11:40:07.103919) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 11:40:07.104213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 11:40:07.118998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 11:40:07.119354) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 11:40:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 65.7M=0s 2016-07-12 11:40:08 (65.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070901 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 11:40:07.204417) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 11:40:07.204774) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018465 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 11:40:07.253919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 11:40:07.254283) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 385340f31f4d6bbc00b1a0f8c59d583ce3f8d4e3 --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 385340f31f4d6bbc00b1a0f8c59d583ce3f8d4e3 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 11:40:08,261 truncating revision to first 12 chars 2016-07-12 11:40:08,261 Setting DEBUG logging. 2016-07-12 11:40:08,261 attempt 1/10 2016-07-12 11:40:08,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/385340f31f4d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 11:40:09,482 unpacking tar archive at: mozilla-aurora-385340f31f4d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.558097 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 11:40:08.825858) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 11:40:08.826198) ========= script_repo_revision: 385340f31f4d6bbc00b1a0f8c59d583ce3f8d4e3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 11:40:08.826586) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 11:40:08.826853) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 11:40:08.836648) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-12 11:40:08.836919) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:40:09 INFO - MultiFileLogger online at 20160712 11:40:09 in /builds/slave/test 11:40:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:40:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:40:09 INFO - {'append_to_log': False, 11:40:09 INFO - 'base_work_dir': '/builds/slave/test', 11:40:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:40:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:40:09 INFO - 'branch': 'Mozilla-Aurora', 11:40:09 INFO - 'buildbot_json_path': 'buildprops.json', 11:40:09 INFO - 'config_files': ('talos/linux_config.py',), 11:40:09 INFO - 'default_actions': ('clobber', 11:40:09 INFO - 'read-buildbot-config', 11:40:09 INFO - 'download-and-extract', 11:40:09 INFO - 'populate-webroot', 11:40:09 INFO - 'create-virtualenv', 11:40:09 INFO - 'install', 11:40:09 INFO - 'run-tests'), 11:40:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:40:09 INFO - 'download_minidump_stackwalk': True, 11:40:09 INFO - 'download_symbols': 'ondemand', 11:40:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:40:09 INFO - 'tooltool.py': '/tools/tooltool.py', 11:40:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:40:09 INFO - '/tools/misc-python/virtualenv.py')}, 11:40:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:40:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:40:09 INFO - 'installer_path': 'installer.exe', 11:40:09 INFO - 'log_level': 'info', 11:40:09 INFO - 'log_name': 'talos', 11:40:09 INFO - 'log_to_console': True, 11:40:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:40:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:40:09 INFO - 'opt_config_files': (), 11:40:09 INFO - 'pip_index': False, 11:40:09 INFO - 'sps_profile': False, 11:40:09 INFO - 'sps_profile_interval': 0, 11:40:09 INFO - 'suite': 'dromaeojs', 11:40:09 INFO - 'system_bits': '32', 11:40:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:40:09 INFO - 'title': 'talos-linux64-ix-062', 11:40:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:40:09 INFO - 'use_talos_json': True, 11:40:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:40:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:40:09 INFO - 'work_dir': 'build'} 11:40:09 INFO - ##### 11:40:09 INFO - ##### Running clobber step. 11:40:09 INFO - ##### 11:40:09 INFO - Running pre-action listener: _resource_record_pre_action 11:40:09 INFO - Running main action method: clobber 11:40:09 INFO - rmtree: /builds/slave/test/build 11:40:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:40:10 INFO - Running post-action listener: _resource_record_post_action 11:40:10 INFO - ##### 11:40:10 INFO - ##### Finished clobber step (success) 11:40:10 INFO - ##### 11:40:10 INFO - ##### 11:40:10 INFO - ##### Running read-buildbot-config step. 11:40:10 INFO - ##### 11:40:10 INFO - Running pre-action listener: _resource_record_pre_action 11:40:10 INFO - Running main action method: read_buildbot_config 11:40:10 INFO - Using buildbot properties: 11:40:10 INFO - { 11:40:10 INFO - "project": "", 11:40:10 INFO - "product": "firefox", 11:40:10 INFO - "script_repo_revision": "production", 11:40:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:40:10 INFO - "repository": "", 11:40:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:40:10 INFO - "buildid": "20160712070226", 11:40:10 INFO - "pgo_build": "True", 11:40:10 INFO - "basedir": "/builds/slave/test", 11:40:10 INFO - "buildnumber": 603, 11:40:10 INFO - "slavename": "talos-linux64-ix-062", 11:40:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:40:10 INFO - "platform": "ubuntu64_hw", 11:40:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:40:10 INFO - "branch": "mozilla-aurora", 11:40:10 INFO - "repo_path": "releases/mozilla-aurora", 11:40:10 INFO - "revision": "385340f31f4d6bbc00b1a0f8c59d583ce3f8d4e3", 11:40:10 INFO - "stage_platform": "linux64-pgo", 11:40:10 INFO - "builduid": "b3eb8b0e109c4fbabeee045f740ad316", 11:40:10 INFO - "slavebuilddir": "test" 11:40:10 INFO - } 11:40:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 11:40:10 INFO - Running post-action listener: _resource_record_post_action 11:40:10 INFO - ##### 11:40:10 INFO - ##### Finished read-buildbot-config step (success) 11:40:10 INFO - ##### 11:40:10 INFO - ##### 11:40:10 INFO - ##### Running download-and-extract step. 11:40:10 INFO - ##### 11:40:10 INFO - Running pre-action listener: _resource_record_pre_action 11:40:10 INFO - Running main action method: download_and_extract 11:40:10 INFO - mkdir: /builds/slave/test/build/tests 11:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:10 INFO - https://queue.taskcluster.net/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:40:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:40:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:40:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/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 11:40:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/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 11:40:11 INFO - Downloaded 1361 bytes. 11:40:11 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:40:11 INFO - Using the following test package requirements: 11:40:11 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 11:40:11 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:40:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:40:11 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:40:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:40:11 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:40:11 INFO - u'jsshell-linux-x86_64.zip'], 11:40:11 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:40:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:40:11 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 11:40:11 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:40:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:40:11 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:40:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:40:11 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:40:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:40:11 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:40:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:40:11 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:11 INFO - https://queue.taskcluster.net/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:40:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:40:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:40:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/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 11:40:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/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 11:40:12 INFO - Downloaded 24527558 bytes. 11:40:12 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'] 11:40:12 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 11:40:13 INFO - Return code: 0 11:40:13 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 11:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:13 INFO - https://queue.taskcluster.net/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:40:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:40:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:40:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/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 11:40:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/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 11:40:14 INFO - Downloaded 24527558 bytes. 11:40:14 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'] 11:40:14 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 11:40:16 INFO - Return code: 0 11:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:16 INFO - https://queue.taskcluster.net/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:40:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 11:40:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 11:40:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/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 11:40:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/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 11:40:17 INFO - Downloaded 10833369 bytes. 11:40:17 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'] 11:40:17 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 11:40:17 INFO - Return code: 0 11:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:17 INFO - https://queue.taskcluster.net/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:40:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:40:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:40:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/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 11:40:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/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 11:40:18 INFO - Downloaded 63634652 bytes. 11:40:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:40:18 INFO - mkdir: /builds/slave/test/properties 11:40:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:40:18 INFO - Writing to file /builds/slave/test/properties/build_url 11:40:18 INFO - Contents: 11:40:18 INFO - build_url:https://queue.taskcluster.net/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:40:19 INFO - Running post-action listener: _resource_record_post_action 11:40:19 INFO - Running post-action listener: set_extra_try_arguments 11:40:19 INFO - ##### 11:40:19 INFO - ##### Finished download-and-extract step (success) 11:40:19 INFO - ##### 11:40:19 INFO - ##### 11:40:19 INFO - ##### Running populate-webroot step. 11:40:19 INFO - ##### 11:40:19 INFO - Running pre-action listener: _resource_record_pre_action 11:40:19 INFO - Running main action method: populate_webroot 11:40:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:40:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:40:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:40:19 INFO - '--tppagecycles', 11:40:19 INFO - '7'], 11:40:19 INFO - 'tests': ['tsvgm']}}, 11:40:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:40:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:40:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:40:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:40:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:40:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:40:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:19 INFO - 'talos_options': ['--disable-e10s'], 11:40:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:40:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:40:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:19 INFO - 'talos_options': ['--disable-e10s'], 11:40:19 INFO - 'tests': ['damp', 'tps']}, 11:40:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:19 INFO - 'tests': ['damp', 'tps']}, 11:40:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:40:19 INFO - 'tests': ['dromaeo_dom']}, 11:40:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:40:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:40:19 INFO - 'tests': ['a11yr', 11:40:19 INFO - 'ts_paint', 11:40:19 INFO - 'tpaint', 11:40:19 INFO - 'sessionrestore', 11:40:19 INFO - 'sessionrestore_no_auto_restore', 11:40:19 INFO - 'tabpaint']}, 11:40:19 INFO - 'other-e10s': {'tests': ['a11yr', 11:40:19 INFO - 'ts_paint', 11:40:19 INFO - 'tpaint', 11:40:19 INFO - 'sessionrestore', 11:40:19 INFO - 'sessionrestore_no_auto_restore', 11:40:19 INFO - 'tabpaint']}, 11:40:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:40:19 INFO - 'ts_paint', 11:40:19 INFO - 'tpaint', 11:40:19 INFO - 'sessionrestore', 11:40:19 INFO - 'sessionrestore_no_auto_restore', 11:40:19 INFO - 'tabpaint']}, 11:40:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:40:19 INFO - 'ts_paint', 11:40:19 INFO - 'tpaint', 11:40:19 INFO - 'sessionrestore', 11:40:19 INFO - 'sessionrestore_no_auto_restore', 11:40:19 INFO - 'tabpaint']}, 11:40:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:40:19 INFO - 'tests': ['a11yr', 11:40:19 INFO - 'ts_paint', 11:40:19 INFO - 'tpaint', 11:40:19 INFO - 'sessionrestore', 11:40:19 INFO - 'sessionrestore_no_auto_restore', 11:40:19 INFO - 'tabpaint']}, 11:40:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:40:19 INFO - 'tests': ['a11yr', 11:40:19 INFO - 'ts_paint', 11:40:19 INFO - 'tpaint', 11:40:19 INFO - 'sessionrestore', 11:40:19 INFO - 'sessionrestore_no_auto_restore', 11:40:19 INFO - 'tabpaint']}, 11:40:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:40:19 INFO - 'tests': ['tsvgx', 11:40:19 INFO - 'tsvgr_opacity', 11:40:19 INFO - 'tart', 11:40:19 INFO - 'tscrollx', 11:40:19 INFO - 'cart']}, 11:40:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:40:19 INFO - 'tsvgr_opacity', 11:40:19 INFO - 'tart', 11:40:19 INFO - 'tscrollx', 11:40:19 INFO - 'cart']}, 11:40:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:19 INFO - 'talos_options': ['--disable-e10s'], 11:40:19 INFO - 'tests': ['tp5o']}, 11:40:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:19 INFO - 'tests': ['tp5o']}, 11:40:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:19 INFO - 'talos_options': ['--disable-e10s', 11:40:19 INFO - '--xperf_path', 11:40:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:40:19 INFO - 'tests': ['tp5n']}, 11:40:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:19 INFO - 'talos_options': ['--xperf_path', 11:40:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:40:19 INFO - 'tests': ['tp5n']}}, 11:40:19 INFO - 'talos.zip': {'path': '', 11:40:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:40:19 INFO - Running post-action listener: _resource_record_post_action 11:40:19 INFO - ##### 11:40:19 INFO - ##### Finished populate-webroot step (success) 11:40:19 INFO - ##### 11:40:19 INFO - ##### 11:40:19 INFO - ##### Running create-virtualenv step. 11:40:19 INFO - ##### 11:40:19 INFO - Running pre-action listener: _resource_record_pre_action 11:40:19 INFO - Running main action method: create_virtualenv 11:40:19 INFO - Creating virtualenv /builds/slave/test/build/venv 11:40:19 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 11:40:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:40:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:40:19 INFO - Using real prefix '/usr' 11:40:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:40:20 INFO - Installing distribute.............................................................................................................................................................................................done. 11:40:22 INFO - Installing pip.................done. 11:40:22 INFO - Return code: 0 11:40:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:22 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 0x7fb93efa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c12e0>, '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 0x252d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', '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 11:40:22 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 11:40:22 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 11:40:22 INFO - Using env: {'DISPLAY': ':0', 11:40:22 INFO - 'HOME': '/home/cltbld', 11:40:22 INFO - 'LANG': 'en_US.UTF-8', 11:40:22 INFO - 'LANGUAGE': 'en_US:en', 11:40:22 INFO - 'LOGNAME': 'cltbld', 11:40:22 INFO - 'MAIL': '/var/mail/cltbld', 11:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:22 INFO - 'MOZ_NO_REMOTE': '1', 11:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:22 INFO - 'NO_EM_RESTART': '1', 11:40:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:22 INFO - 'PWD': '/builds/slave/test', 11:40:22 INFO - 'SHELL': '/bin/bash', 11:40:22 INFO - 'SHLVL': '1', 11:40:22 INFO - 'TERM': 'linux', 11:40:22 INFO - 'TMOUT': '86400', 11:40:22 INFO - 'USER': 'cltbld', 11:40:22 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', 11:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:22 INFO - '_': '/tools/buildbot/bin/python'} 11:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:22 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 11:40:22 INFO - Cleaning up... 11:40:22 INFO - Return code: 0 11:40:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:22 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 0x7fb93efa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c12e0>, '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 0x252d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', '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 11:40:22 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 11:40:22 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 11:40:22 INFO - Using env: {'DISPLAY': ':0', 11:40:22 INFO - 'HOME': '/home/cltbld', 11:40:22 INFO - 'LANG': 'en_US.UTF-8', 11:40:22 INFO - 'LANGUAGE': 'en_US:en', 11:40:22 INFO - 'LOGNAME': 'cltbld', 11:40:22 INFO - 'MAIL': '/var/mail/cltbld', 11:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:22 INFO - 'MOZ_NO_REMOTE': '1', 11:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:22 INFO - 'NO_EM_RESTART': '1', 11:40:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:22 INFO - 'PWD': '/builds/slave/test', 11:40:22 INFO - 'SHELL': '/bin/bash', 11:40:22 INFO - 'SHLVL': '1', 11:40:22 INFO - 'TERM': 'linux', 11:40:22 INFO - 'TMOUT': '86400', 11:40:22 INFO - 'USER': 'cltbld', 11:40:22 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', 11:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:22 INFO - '_': '/tools/buildbot/bin/python'} 11:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:22 INFO - Downloading/unpacking psutil>=3.1.1 11:40:22 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 11:40:22 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 11:40:22 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 11:40:22 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 11:40:22 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 11:40:22 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 11:40:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:40:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:40:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:40:24 INFO - Installing collected packages: psutil 11:40:24 INFO - Running setup.py install for psutil 11:40:24 INFO - building 'psutil._psutil_linux' extension 11:40:24 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 11:40:24 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 11:40:24 INFO - building 'psutil._psutil_posix' extension 11:40:24 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 11:40:24 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 11:40:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:40:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:40:25 INFO - Successfully installed psutil 11:40:25 INFO - Cleaning up... 11:40:25 INFO - Return code: 0 11:40:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:40: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')]} 11:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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')]} 11:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:25 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 0x7fb93efa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c12e0>, '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 0x252d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', '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 11:40:25 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 11:40:25 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 11:40:25 INFO - Using env: {'DISPLAY': ':0', 11:40:25 INFO - 'HOME': '/home/cltbld', 11:40:25 INFO - 'LANG': 'en_US.UTF-8', 11:40:25 INFO - 'LANGUAGE': 'en_US:en', 11:40:25 INFO - 'LOGNAME': 'cltbld', 11:40:25 INFO - 'MAIL': '/var/mail/cltbld', 11:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:25 INFO - 'MOZ_NO_REMOTE': '1', 11:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:25 INFO - 'NO_EM_RESTART': '1', 11:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:25 INFO - 'PWD': '/builds/slave/test', 11:40:25 INFO - 'SHELL': '/bin/bash', 11:40:25 INFO - 'SHLVL': '1', 11:40:25 INFO - 'TERM': 'linux', 11:40:25 INFO - 'TMOUT': '86400', 11:40:25 INFO - 'USER': 'cltbld', 11:40:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', 11:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:25 INFO - '_': '/tools/buildbot/bin/python'} 11:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:40:25 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 11:40:25 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 11:40:25 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 11:40:25 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 11:40:25 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 11:40:25 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 11:40:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:40:27 INFO - Installing collected packages: mozsystemmonitor 11:40:27 INFO - Running setup.py install for mozsystemmonitor 11:40:27 INFO - Successfully installed mozsystemmonitor 11:40:27 INFO - Cleaning up... 11:40:27 INFO - Return code: 0 11:40:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:27 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 0x7fb93efa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c12e0>, '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 0x252d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', '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 11:40:27 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 11:40:27 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 11:40:27 INFO - Using env: {'DISPLAY': ':0', 11:40:27 INFO - 'HOME': '/home/cltbld', 11:40:27 INFO - 'LANG': 'en_US.UTF-8', 11:40:27 INFO - 'LANGUAGE': 'en_US:en', 11:40:27 INFO - 'LOGNAME': 'cltbld', 11:40:27 INFO - 'MAIL': '/var/mail/cltbld', 11:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:27 INFO - 'MOZ_NO_REMOTE': '1', 11:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:27 INFO - 'NO_EM_RESTART': '1', 11:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:27 INFO - 'PWD': '/builds/slave/test', 11:40:27 INFO - 'SHELL': '/bin/bash', 11:40:27 INFO - 'SHLVL': '1', 11:40:27 INFO - 'TERM': 'linux', 11:40:27 INFO - 'TMOUT': '86400', 11:40:27 INFO - 'USER': 'cltbld', 11:40:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', 11:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:27 INFO - '_': '/tools/buildbot/bin/python'} 11:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:27 INFO - Downloading/unpacking jsonschema==2.5.1 11:40:27 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 11:40:27 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 11:40:27 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 11:40:27 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 11:40:27 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 11:40:27 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 11:40:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:40:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:40:29 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 11:40:29 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 11:40:29 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 11:40:29 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 11:40:29 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 11:40:29 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 11:40:29 INFO - Downloading functools32-3.2.3-2.tar.gz 11:40:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:40:29 INFO - warning: no files found matching '*.txt' 11:40:29 INFO - no previously-included directories found matching 'build' 11:40:29 INFO - no previously-included directories found matching 'dist' 11:40:29 INFO - no previously-included directories found matching '.git*' 11:40:29 INFO - Installing collected packages: jsonschema, functools32 11:40:29 INFO - Running setup.py install for functools32 11:40:29 INFO - warning: no files found matching '*.txt' 11:40:29 INFO - no previously-included directories found matching 'build' 11:40:29 INFO - no previously-included directories found matching 'dist' 11:40:29 INFO - no previously-included directories found matching '.git*' 11:40:29 INFO - Successfully installed jsonschema functools32 11:40:29 INFO - Cleaning up... 11:40:29 INFO - Return code: 0 11:40:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:29 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 0x7fb93efa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c12e0>, '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 0x252d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', '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 11:40:29 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 11:40:29 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 11:40:29 INFO - Using env: {'DISPLAY': ':0', 11:40:29 INFO - 'HOME': '/home/cltbld', 11:40:29 INFO - 'LANG': 'en_US.UTF-8', 11:40:29 INFO - 'LANGUAGE': 'en_US:en', 11:40:29 INFO - 'LOGNAME': 'cltbld', 11:40:29 INFO - 'MAIL': '/var/mail/cltbld', 11:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:29 INFO - 'MOZ_NO_REMOTE': '1', 11:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:29 INFO - 'NO_EM_RESTART': '1', 11:40:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:29 INFO - 'PWD': '/builds/slave/test', 11:40:29 INFO - 'SHELL': '/bin/bash', 11:40:29 INFO - 'SHLVL': '1', 11:40:29 INFO - 'TERM': 'linux', 11:40:29 INFO - 'TMOUT': '86400', 11:40:29 INFO - 'USER': 'cltbld', 11:40:29 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', 11:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:29 INFO - '_': '/tools/buildbot/bin/python'} 11:40:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:30 INFO - Downloading/unpacking blobuploader==1.2.4 11:40:30 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 11:40:30 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 11:40:30 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 11:40:30 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 11:40:30 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 11:40:30 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 11:40:32 INFO - Downloading blobuploader-1.2.4.tar.gz 11:40:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:40:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:40:32 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 11:40:32 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 11:40:32 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 11:40:32 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 11:40:32 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 11:40:32 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 11:40:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:40:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:40:32 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 11:40:32 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 11:40:32 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 11:40:32 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 11:40:32 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 11:40:32 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 11:40:32 INFO - Downloading docopt-0.6.1.tar.gz 11:40:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:40:32 INFO - Installing collected packages: blobuploader, requests, docopt 11:40:32 INFO - Running setup.py install for blobuploader 11:40:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:40:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:40:33 INFO - Running setup.py install for requests 11:40:33 INFO - Running setup.py install for docopt 11:40:33 INFO - Successfully installed blobuploader requests docopt 11:40:33 INFO - Cleaning up... 11:40:33 INFO - Return code: 0 11:40:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:33 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 0x7fb93efa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c12e0>, '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 0x252d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', '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 11:40:33 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 11:40:33 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 11:40:33 INFO - Using env: {'DISPLAY': ':0', 11:40:33 INFO - 'HOME': '/home/cltbld', 11:40:33 INFO - 'LANG': 'en_US.UTF-8', 11:40:33 INFO - 'LANGUAGE': 'en_US:en', 11:40:33 INFO - 'LOGNAME': 'cltbld', 11:40:33 INFO - 'MAIL': '/var/mail/cltbld', 11:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:33 INFO - 'MOZ_NO_REMOTE': '1', 11:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:33 INFO - 'NO_EM_RESTART': '1', 11:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:33 INFO - 'PWD': '/builds/slave/test', 11:40:33 INFO - 'SHELL': '/bin/bash', 11:40:33 INFO - 'SHLVL': '1', 11:40:33 INFO - 'TERM': 'linux', 11:40:33 INFO - 'TMOUT': '86400', 11:40:33 INFO - 'USER': 'cltbld', 11:40:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', 11:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:33 INFO - '_': '/tools/buildbot/bin/python'} 11:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:33 INFO - Running setup.py (path:/tmp/pip-pAZ7tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:33 INFO - Running setup.py (path:/tmp/pip-6h_naL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:33 INFO - Running setup.py (path:/tmp/pip-KNoXyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:34 INFO - Running setup.py (path:/tmp/pip-fBT255-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:34 INFO - Running setup.py (path:/tmp/pip-U7XUWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:34 INFO - Running setup.py (path:/tmp/pip-xD56N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:34 INFO - Running setup.py (path:/tmp/pip-HmXwMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:34 INFO - Running setup.py (path:/tmp/pip-0RJe65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:34 INFO - Running setup.py (path:/tmp/pip-lIeO98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:34 INFO - Running setup.py (path:/tmp/pip-ybr1YY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:34 INFO - Running setup.py (path:/tmp/pip-IZ51NY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:34 INFO - Running setup.py (path:/tmp/pip-0cZeyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:34 INFO - Running setup.py (path:/tmp/pip-HCFdLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:34 INFO - Running setup.py (path:/tmp/pip-Tp65Wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:34 INFO - Running setup.py (path:/tmp/pip-uskjix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:34 INFO - Running setup.py (path:/tmp/pip-T5J9me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:34 INFO - Running setup.py (path:/tmp/pip-xktIry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:40:35 INFO - Running setup.py install for manifestparser 11:40:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:40:35 INFO - Running setup.py install for mozcrash 11:40:35 INFO - Running setup.py install for mozdebug 11:40:35 INFO - Running setup.py install for mozdevice 11:40:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:40:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:40:35 INFO - Running setup.py install for mozfile 11:40:35 INFO - Running setup.py install for mozhttpd 11:40:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:40:35 INFO - Running setup.py install for mozinfo 11:40:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:40:35 INFO - Running setup.py install for mozInstall 11:40:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:40:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:40:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:40:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:40:35 INFO - Running setup.py install for mozleak 11:40:35 INFO - Running setup.py install for mozlog 11:40:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:40:36 INFO - Running setup.py install for moznetwork 11:40:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:40:36 INFO - Running setup.py install for mozprocess 11:40:36 INFO - Running setup.py install for mozprofile 11:40:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:40:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:40:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:40:36 INFO - Running setup.py install for mozrunner 11:40:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:40:36 INFO - Running setup.py install for mozscreenshot 11:40:36 INFO - Running setup.py install for moztest 11:40:36 INFO - Running setup.py install for mozversion 11:40:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:40:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:40:36 INFO - Cleaning up... 11:40:36 INFO - Return code: 0 11:40:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:36 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 0x7fb93efa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c12e0>, '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 0x252d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', '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 11:40:36 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 11:40:36 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 11:40:36 INFO - Using env: {'DISPLAY': ':0', 11:40:36 INFO - 'HOME': '/home/cltbld', 11:40:36 INFO - 'LANG': 'en_US.UTF-8', 11:40:36 INFO - 'LANGUAGE': 'en_US:en', 11:40:36 INFO - 'LOGNAME': 'cltbld', 11:40:36 INFO - 'MAIL': '/var/mail/cltbld', 11:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:36 INFO - 'MOZ_NO_REMOTE': '1', 11:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:36 INFO - 'NO_EM_RESTART': '1', 11:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:36 INFO - 'PWD': '/builds/slave/test', 11:40:36 INFO - 'SHELL': '/bin/bash', 11:40:36 INFO - 'SHLVL': '1', 11:40:36 INFO - 'TERM': 'linux', 11:40:36 INFO - 'TMOUT': '86400', 11:40:36 INFO - 'USER': 'cltbld', 11:40:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', 11:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:36 INFO - '_': '/tools/buildbot/bin/python'} 11:40:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:37 INFO - Running setup.py (path:/tmp/pip-HQFu3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:37 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)) 11:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:37 INFO - Running setup.py (path:/tmp/pip-HRJA0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:37 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)) 11:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:37 INFO - Running setup.py (path:/tmp/pip-VYbU9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:37 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)) 11:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:37 INFO - Running setup.py (path:/tmp/pip-wPXU7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:37 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)) 11:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:37 INFO - Running setup.py (path:/tmp/pip-V_eocp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:37 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)) 11:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:37 INFO - Running setup.py (path:/tmp/pip-2OnqEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:37 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)) 11:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:37 INFO - Running setup.py (path:/tmp/pip-gDQyxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:37 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)) 11:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:37 INFO - Running setup.py (path:/tmp/pip-ZvbkiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:37 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)) 11:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:37 INFO - Running setup.py (path:/tmp/pip-jT8Nx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:37 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)) 11:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:37 INFO - Running setup.py (path:/tmp/pip-AVcPml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:37 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)) 11:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:37 INFO - Running setup.py (path:/tmp/pip-hNUr4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:37 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)) 11:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:37 INFO - Running setup.py (path:/tmp/pip-W1f7xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 11:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:37 INFO - Running setup.py (path:/tmp/pip-gDIPXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:38 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)) 11:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:38 INFO - Running setup.py (path:/tmp/pip-p6VbFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 11:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:38 INFO - Running setup.py (path:/tmp/pip-7GxzwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:38 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)) 11:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:38 INFO - Running setup.py (path:/tmp/pip-xkQLqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:38 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)) 11:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:38 INFO - Running setup.py (path:/tmp/pip-Le9AH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:38 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)) 11:40:38 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)) 11:40:38 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)) 11:40:38 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)) 11:40:38 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)) 11:40:38 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)) 11:40:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:40 INFO - Downloading blessings-1.6.tar.gz 11:40:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:40:40 INFO - Installing collected packages: blessings 11:40:40 INFO - Running setup.py install for blessings 11:40:40 INFO - Successfully installed blessings 11:40:40 INFO - Cleaning up... 11:40:40 INFO - Return code: 0 11:40:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:40:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:40:40 INFO - Reading from file tmpfile_stdout 11:40:40 INFO - Current package versions: 11:40:40 INFO - argparse == 1.2.1 11:40:40 INFO - blessings == 1.6 11:40:40 INFO - blobuploader == 1.2.4 11:40:40 INFO - docopt == 0.6.1 11:40:40 INFO - functools32 == 3.2.3-2 11:40:40 INFO - jsonschema == 2.5.1 11:40:40 INFO - manifestparser == 1.1 11:40:40 INFO - mozInstall == 1.12 11:40:40 INFO - mozcrash == 0.17 11:40:40 INFO - mozdebug == 0.1 11:40:40 INFO - mozdevice == 0.48 11:40:40 INFO - mozfile == 1.2 11:40:40 INFO - mozhttpd == 0.7 11:40:40 INFO - mozinfo == 0.9 11:40:40 INFO - mozleak == 0.1 11:40:40 INFO - mozlog == 3.2 11:40:40 INFO - moznetwork == 0.27 11:40:40 INFO - mozprocess == 0.23 11:40:40 INFO - mozprofile == 0.28 11:40:40 INFO - mozrunner == 6.12 11:40:40 INFO - mozscreenshot == 0.1 11:40:40 INFO - mozsystemmonitor == 0.3 11:40:40 INFO - moztest == 0.7 11:40:40 INFO - mozversion == 1.4 11:40:40 INFO - psutil == 3.1.1 11:40:40 INFO - requests == 1.2.3 11:40:40 INFO - wsgiref == 0.1.2 11:40:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:40 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 0x7fb93efa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c12e0>, '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 0x252d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', '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 11:40:40 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 11:40:40 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 11:40:40 INFO - Using env: {'DISPLAY': ':0', 11:40:40 INFO - 'HOME': '/home/cltbld', 11:40:40 INFO - 'LANG': 'en_US.UTF-8', 11:40:40 INFO - 'LANGUAGE': 'en_US:en', 11:40:40 INFO - 'LOGNAME': 'cltbld', 11:40:40 INFO - 'MAIL': '/var/mail/cltbld', 11:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:40 INFO - 'MOZ_NO_REMOTE': '1', 11:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:40 INFO - 'NO_EM_RESTART': '1', 11:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:40 INFO - 'PWD': '/builds/slave/test', 11:40:40 INFO - 'SHELL': '/bin/bash', 11:40:40 INFO - 'SHLVL': '1', 11:40:40 INFO - 'TERM': 'linux', 11:40:40 INFO - 'TMOUT': '86400', 11:40:40 INFO - 'USER': 'cltbld', 11:40:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', 11:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:40 INFO - '_': '/tools/buildbot/bin/python'} 11:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:40 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)) 11:40:40 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)) 11:40:40 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)) 11:40:40 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)) 11:40:40 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)) 11:40:40 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)) 11:40:40 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)) 11:40:40 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)) 11:40:40 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)) 11:40:40 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)) 11:40:40 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)) 11:40:40 INFO - Cleaning up... 11:40:40 INFO - Return code: 0 11:40:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb93efa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c12e0>, '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 0x252d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', '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 11:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:40:40 INFO - Using env: {'DISPLAY': ':0', 11:40:40 INFO - 'HOME': '/home/cltbld', 11:40:40 INFO - 'LANG': 'en_US.UTF-8', 11:40:40 INFO - 'LANGUAGE': 'en_US:en', 11:40:40 INFO - 'LOGNAME': 'cltbld', 11:40:40 INFO - 'MAIL': '/var/mail/cltbld', 11:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:40 INFO - 'MOZ_NO_REMOTE': '1', 11:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:40 INFO - 'NO_EM_RESTART': '1', 11:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:40 INFO - 'PWD': '/builds/slave/test', 11:40:40 INFO - 'SHELL': '/bin/bash', 11:40:40 INFO - 'SHLVL': '1', 11:40:40 INFO - 'TERM': 'linux', 11:40:40 INFO - 'TMOUT': '86400', 11:40:40 INFO - 'USER': 'cltbld', 11:40:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', 11:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:40 INFO - '_': '/tools/buildbot/bin/python'} 11:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:40:41 INFO - Cleaning up... 11:40:41 INFO - Return code: 0 11:40:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:41 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 0x7fb93efa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c12e0>, '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 0x252d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', '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 11:40:41 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 11:40:41 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 11:40:41 INFO - Using env: {'DISPLAY': ':0', 11:40:41 INFO - 'HOME': '/home/cltbld', 11:40:41 INFO - 'LANG': 'en_US.UTF-8', 11:40:41 INFO - 'LANGUAGE': 'en_US:en', 11:40:41 INFO - 'LOGNAME': 'cltbld', 11:40:41 INFO - 'MAIL': '/var/mail/cltbld', 11:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:41 INFO - 'MOZ_NO_REMOTE': '1', 11:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:41 INFO - 'NO_EM_RESTART': '1', 11:40:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:41 INFO - 'PWD': '/builds/slave/test', 11:40:41 INFO - 'SHELL': '/bin/bash', 11:40:41 INFO - 'SHLVL': '1', 11:40:41 INFO - 'TERM': 'linux', 11:40:41 INFO - 'TMOUT': '86400', 11:40:41 INFO - 'USER': 'cltbld', 11:40:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', 11:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:41 INFO - '_': '/tools/buildbot/bin/python'} 11:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:41 INFO - Downloading/unpacking flake8 11:40:41 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 11:40:41 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 11:40:41 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 11:40:41 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 11:40:41 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 11:40:41 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 11:40:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:40:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:40:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:40:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:40:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:40:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:40:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:40:43 INFO - no previously-included directories found matching 'docs/_build' 11:40:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:40:44 INFO - Running setup.py install for pep8 11:40:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:40:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:40:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:40:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:40:44 INFO - no previously-included directories found matching 'docs/_build' 11:40:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:40:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:40:44 INFO - Cleaning up... 11:40:44 INFO - Return code: 0 11:40:44 INFO - Running post-action listener: _resource_record_post_action 11:40:44 INFO - Running post-action listener: _start_resource_monitoring 11:40:44 INFO - Starting resource monitoring. 11:40:44 INFO - ##### 11:40:44 INFO - ##### Finished create-virtualenv step (success) 11:40:44 INFO - ##### 11:40:44 INFO - ##### 11:40:44 INFO - ##### Running install step. 11:40:44 INFO - ##### 11:40:44 INFO - Running pre-action listener: _resource_record_pre_action 11:40:44 INFO - Running main action method: install 11:40:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:40:44 INFO - Reading from file tmpfile_stdout 11:40:44 INFO - Detecting whether we're running mozinstall >=1.0... 11:40:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:40:44 INFO - Reading from file tmpfile_stdout 11:40:44 INFO - Output received: 11:40:44 INFO - Usage: mozinstall [options] installer 11:40:44 INFO - Options: 11:40:44 INFO - -h, --help show this help message and exit 11:40:44 INFO - -d DEST, --destination=DEST 11:40:44 INFO - Directory to install application into. [default: 11:40:44 INFO - "/builds/slave/test"] 11:40:44 INFO - --app=APP Application being installed. [default: firefox] 11:40:44 INFO - mkdir: /builds/slave/test/build/application 11:40:44 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'] 11:40:44 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 11:41:00 INFO - Reading from file tmpfile_stdout 11:41:00 INFO - Output received: 11:41:00 INFO - /builds/slave/test/build/application/firefox/firefox 11:41:00 INFO - Running post-action listener: _resource_record_post_action 11:41:00 INFO - ##### 11:41:00 INFO - ##### Finished install step (success) 11:41:00 INFO - ##### 11:41:00 INFO - ##### 11:41:00 INFO - ##### Running run-tests step. 11:41:00 INFO - ##### 11:41:00 INFO - Running pre-action listener: _resource_record_pre_action 11:41:00 INFO - Running main action method: run_tests 11:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:41:00 INFO - Python 2.7.3 11:41:00 INFO - Return code: 0 11:41:00 INFO - grabbing minidump binary from tooltool 11:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:00 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 0x25c12e0>, '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 0x252d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252d5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:41:00 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 11:41:00 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 11:41:00 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 11:41:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:41:00 INFO - Return code: 0 11:41:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:41:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:41:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:41:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:41:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:41:01 INFO - Return code: 0 11:41:01 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:41:01 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:41:01 INFO - Using env: {'DISPLAY': ':0', 11:41:01 INFO - 'HOME': '/home/cltbld', 11:41:01 INFO - 'LANG': 'en_US.UTF-8', 11:41:01 INFO - 'LANGUAGE': 'en_US:en', 11:41:01 INFO - 'LOGNAME': 'cltbld', 11:41:01 INFO - 'MAIL': '/var/mail/cltbld', 11:41:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:41:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:01 INFO - 'MOZ_NO_REMOTE': '1', 11:41:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:01 INFO - 'NO_EM_RESTART': '1', 11:41:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:01 INFO - 'PWD': '/builds/slave/test', 11:41:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:41:01 INFO - 'SHELL': '/bin/bash', 11:41:01 INFO - 'SHLVL': '1', 11:41:01 INFO - 'TERM': 'linux', 11:41:01 INFO - 'TMOUT': '86400', 11:41:01 INFO - 'USER': 'cltbld', 11:41:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241', 11:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:01 INFO - '_': '/tools/buildbot/bin/python'} 11:41:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:41:01 INFO - mozversion application_buildid: 20160712070226 11:41:01 INFO - mozversion application_changeset: 385340f31f4d6bbc00b1a0f8c59d583ce3f8d4e3 11:41:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:41:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:41:01 INFO - mozversion application_name: Firefox 11:41:01 INFO - mozversion application_remotingname: firefox-dev 11:41:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:41:01 INFO - mozversion application_vendor: Mozilla 11:41:01 INFO - mozversion application_version: 49.0a2 11:41:01 INFO - mozversion platform_buildid: 20160712070226 11:41:01 INFO - mozversion platform_changeset: 385340f31f4d6bbc00b1a0f8c59d583ce3f8d4e3 11:41:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:41:01 INFO - mozversion platform_version: 49.0a2 11:41:01 INFO - using testdate: 1468348861 11:41:01 INFO - actual date: 1468348861 11:41:01 INFO - starting webserver on 'localhost:35737' 11:41:01 INFO - SUITE-START | Running 2 tests 11:41:01 INFO - TEST-START | dromaeo_css 11:41:01 INFO - operating with platform_type : linux_ 11:41:01 INFO - Initialising browser for dromaeo_css test... 11:41:01 INFO - TEST-INFO | started process 26814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSPVgMH/profile http://localhost:35737/getInfo.html) 11:41:05 INFO - PROCESS | 26814 | __metrics Screen width/height:1600/1200 11:41:05 INFO - PROCESS | 26814 | colorDepth:24 11:41:05 INFO - PROCESS | 26814 | Browser inner width/height: 1024/697 11:41:05 INFO - PROCESS | 26814 | __metrics 11:41:06 ERROR - PROCESS | 26814 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:41:07 INFO - TEST-INFO | 26814: exit 0 11:41:07 INFO - Browser initialized. 11:41:07 INFO - Running cycle 1/1 for dromaeo_css test... 11:41:07 INFO - TEST-INFO | started process 26911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSPVgMH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:19 INFO - PROCESS | 26911 | RSS: Main: 144744448 11:41:19 INFO - PROCESS | 26911 | 11:42:10 INFO - PROCESS | 26911 | 1468348930371 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] 11:44:18 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:35737/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35737/tests/dromaeo/cssquery-ext.html) 11:44:19 INFO - PROCESS | 26911 | RSS: Main: 254230528 11:44:19 INFO - PROCESS | 26911 | 11:47:21 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:35737/tests/dromaeo/cssquery-ext.html (next: http://localhost:35737/tests/dromaeo/cssquery-jquery.html) 11:47:22 INFO - PROCESS | 26911 | RSS: Main: 229548032 11:47:22 INFO - PROCESS | 26911 | 11:50:24 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:35737/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35737/tests/dromaeo/cssquery-mootools.html) 11:50:24 INFO - PROCESS | 26911 | RSS: Main: 223379456 11:50:24 INFO - PROCESS | 26911 | 11:53:26 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:35737/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35737/tests/dromaeo/cssquery-prototype.html) 11:53:27 INFO - PROCESS | 26911 | RSS: Main: 220131328 11:53:27 INFO - PROCESS | 26911 | 11:56:30 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:35737/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35737/tests/dromaeo/cssquery-yui.html) 11:56:30 INFO - PROCESS | 26911 | RSS: Main: 216375296 11:56:30 INFO - PROCESS | 26911 | 11:59:33 INFO - PROCESS | 26911 | Cycle 1(1): loaded http://localhost:35737/tests/dromaeo/cssquery-yui.html (next: http://localhost:35737/tests/dromaeo/cssquery-dojo.html) 11:59:33 INFO - PROCESS | 26911 | RSS: Main: 260378624 11:59:33 INFO - PROCESS | 26911 | 11:59:33 INFO - PROCESS | 26911 | __start_tp_report 11:59:33 INFO - PROCESS | 26911 | _x_x_mozilla_page_load 11:59:33 INFO - PROCESS | 26911 | _x_x_mozilla_page_load_details 11:59:33 INFO - PROCESS | 26911 | |i|pagename|runs| 11:59:33 INFO - PROCESS | 26911 | |0;dojo.html;3338.582677165354;3376.79739215647;3380.6450322716114;3412.3004784019276;3431.0907609483475;5479.835604931848;5523.613347065707;5524.4199359067325;5553.416891226419;5594.580406469516;5489.64317319375;5565.582581306408;5570.693611851357;5570.749316280767;5610.214569960199;4922.286268491067;4970.776315065822;4982.676126051813;5027.974860125694;5062.2406639004075;4880.438749543795;5023.974880125595;5059.544640982311;5064.544191022807;5072.9492705073035;4930.6795058321095;4945.332380128691;4968.552830245278;4971.751412429364;5054.721990290551;5062.063518249136;5063.113955057868;5078.619103567247;5093.490650934914;5112.0287145442435;4919.3358896549225;4943.1102401567705;4993.625478089158;5054.393472783253;5054.570361519275;5352.946470535284;5359.464053594609;5384.9461505385225;5399;5410.377806552257;5874.765009399662;5884.588078834483;5925.911111333334;5929.436703513159;5936.376680448577;5840.678762668052;5899.085641725539;5904.350521442638;5965.940340596582;5969.955257829863;5500.889982200333;5559.499645031967;5588.469095435927;5603.3836278009385;5604.187392828057;5873.060310350409;6045.881511920309;6047.455728984412;6052.939470605237;6099.329073801879;5702.486776190163;5728.856778580569;5757.424257574293;5843.561732870052;5857.092150716646;5881.500072493886;5887.970560147171;5908.704564771744;5917.727688546983;5923.555733319932;5661.7735290588735;5768.9711551442815;5853.151293062568;5859.794907178229;5860.150278209636;5876.9118463223085;5919.792807251725;5921.2006379138265;5930.229070220844;5957.582969192115;4585.862424127282;4599.770011499479;4603.562661547147;4610.677252592286;4624.838130665411;4035.778032208198;4040.7575545467366;4064.9593504065174;4107.712460127762;4154.169166166779;5682.6306290091015;5697.4302569742695;5705.258316418839;5706.771729130871;5707.429257074259;5945.137954996501;5949;5952.642841429441;5955.52355811534;5965.910511342333;5415.512603865671;5572.60991730575;5628.774849005994;5644.915326270109;5663.065594176997;5204.479552044841;5210.114280572312;5212.947870521322;5212.9739351303;5215.947840521622;6229.127922090911;6236.875262494725;6237.563370564108;6247.812565623039;6251.906221406683;5798.94201057984;5878.2358293421585;5923.555733319932;5965.552583556164;6073.362296958756;6219.751209951552;6248.937510624835;6248.968920128128;6262.15460912771;6273.780417685359;5836.299644042742;5852.326982397079;5863.882722345615;5892.175095486721;5923.703814809329;5778.306603207642;5810.883782324415;5877.382874798084;5894.440028197314;5949.702514874326;5747.339056008445;5791;5792.102224155263;5794.101914203306;5805.82582522525;5649.604527683023;5723.055695810144;5763;5780.94219057804;5794.565407594363;5611.6352437091455;5664.433556644302;5679.119736440858;5708.714564271853;5714.342850572238;5836.737346819488;5894.086416605433;5895.498882595028;5895.970520147372;5896.587238893237;5404.351477822686;5606;5721.141828725725;5724.141378793048;5729.627574207663 11:59:33 INFO - PROCESS | 26911 | |1;ext.html;594.4471641373524;635.1425575473112;646.0761111610398;651.4072194303185;658.5982550644108;32771;46355.30467042993;46590.301145482845;46642.533574664325;47090.293645595346;48029.519704802944;48257.75871120648;48633.51366486334;48695.269570956465;48740.75629621847;8183.754487365389;8923.152300531456;9070.138336857988;10692.251542392036;10952.233343665946;10556.524956376981;10688.358698478078;10700.78598428031;10709.946450267777;10725.83911241332;10762.246642735012;10814.72963175919;10826.350418974847;10852.891471085306;10861.782764344709;8381.371397145238;10865.45672716369;11109.83335249972;11113.72215694606;11119.944400277947;10515.106215971651;10569.154467642571;10577.04806567405;10908.50911708975;10913.563457461692;45982.310265346045;46046.07907841858;46627;46634.76682616599;46646.5335346649;3830.1765120499226;3890.5720370759195;4439.245328294198;4511.639068874482;4608.400907881987;35179.82410087959;35636.46545301822;35878.28243435143;36089.09777255564;36226.275474490365;4564.977175114103;4652.883677908046;4701.412323459567;4729.69256998294;4794.448638406593;404709;405990;407294;407613;407706;39905.201895961916;40547.39178912318;73494.63252683703;73877;74345.25654743383;42278.577214227465;42489;42512.57487425148;42725;42767.786161068994;15496.612584685248;17804.198811053535;17931.910340448474;17950.461486155436;17975.1012449377;14632.048916820373;14877;14895.404183832741;15077.793776497854;15245.23773811305;9331.533423328807;9354.345195836362;9401.811963760687;9410.858837117448;9444.90555094454;3684.3184010958057;3695.667389934919;3702.426123950792;3711.2206436648607;3737.289914916157;1032.5043978890176;1048.6749107776614;1056.3239526702916;1092.3336764573762;1183.4201241391656;32886.91142730593;34102;34178.14554636154;34362;34551.308973820385;1162.1922763679163;1172.8709841917382;1202.903767698582;1219.6034791634481;1223.718544734716;17257;17835.46493605194;17983.370582029565;18088;18154.273829046953;601515;606339;607224;608463;610831;63658.6817065921;65216;65239;65391.67304163449;65494.345056548824;1312.2454588611586;1455.0760267230385;1492.6641505661357;1497.5657059452853;1503.368585194199;33619.49570756392;34557.654423455446;34740;35294.47058294179;35341.116472088404;52470.21294680506;52768.20847687211;52904.20643690271;52938.47061529489;52986.47013529815;412598;413977;414588;415307;416995;24641.137560185307;25567.082468815286;32723.836380817942;32812.50781238331;32973.02161870296;51644.22533662073;51950;52298.477015229364;52526.47473525369;52641.47358526366;43220;43340.78329608332;43454.78272608617;44162.337564937196;45047.09905801931;43161.70276029486;43918;44193;44430;44648.33027504655;43513.34729979116;43646.781766090964;43880.34179487374;44780;45214.32178517391;37845.62154378421;39981.40027899642;40120.39819402653;40411.595884040784;40849.795751021054;29685.85157074201;29947.55078673865;30119.849400752857;30552.236194095327;30714.84642576773 11:59:33 INFO - PROCESS | 26911 | |2;jquery.html;419.2516358300433;425.73391630231123;427.12013252699444;427.69419864796663;446.58244541353815;19690.40928772139;19697.901510492444;20280.492987675316;20852;20866.269680561185;18283.451496455127;19094.23623055076;19109.713354299696;19608.70586941197;20266.189352425885;5100.795968161278;5301.8939621207555;5342.759575819097;5346.759395827197;5347.278117454152;3992.6207010333974;4809.951900480985;5233.947660523403;5241.475852414766;6523.543351965364;6397.168368112162;6517.315681853408;6541.116949211867;6584.802455926306;6605.207375114993;5745.999999999958;5914.2311499504785;5920.052791553352;6127.325994140641;6505.056766768816;3843.692504599653;4067.430559721641;5366.2755528004;5674.602777805555;5688.061469857468;14121.435142594284;14357.353919073666;14403.135811851322;14458.783118253235;14510.1293922365;2540.707818600866;2623.514649789795;2920.6051038148726;3049.542568614703;3070.094322174941;10089.798204035951;10285.434301113435;10373;10618.309809862334;11080;1843.935462258828;1871.9625607487774;2054.1064636883;2063.401613532074;2064.133064113061;82895.58552207261;88514;89740.99999999935;90337.54831225867;90392.54803726004;11473.827892581618;11524.250923689933;11527.752088342693;11784.88215117855;11793.941030294965;16587.253573589216;16654.250558724645;16747.91626041862;16765.497035088967;16774.74837877433;8294.3779216559;8624.310055195569;8784.472931624123;8993.415427997159;9046.411983221069;8760.342974276955;8801.427907186013;8801.647934082694;8917.643294268286;8931.508767017876;4986.556587272211;5104.821331253388;5186.81846135391;5188.818391356284;5204.557612602971;1931.6100244071565;1972.5660354721938;1991.9502012449805;2030.7969203079574;2081.5108449514655;963.6386355116831;1072.0868828774878;1094.0919037199105;1111.5331560744346;1126.1666366888444;18118.728219076726;18759.0620468976;19122.71315930262;19383.90308048479;20050.799492005186;1041.6927006533092;1054.414799786126;1069.8823129455754;1075.8117329467311;1081.3619964221148;10582.841257381146;10649.84025239622;10800.675979720621;11033;11142.665720028412;506302;509987;533035;537272;545795;92840.53579732058;96642;96944;97807;98342.5082874581;1063.3726101599939;1071.8660167479065;1076.494047797534;1078.7572796120967;1085.7394225385851;17516.474505764847;17582.120893954994;17718.46844594664;17796;18053.458396248134;41296.79351603223;42214;42595.57404425916;44097.338539922566;44151;60975.695121524106;61141.694291528256;61632.69183654053;61842.69078654758;62356;7943.920560794318;8413.116622754767;8532.786680333042;8631.007434145155;8662.436941598777;13419.127756695783;13471.191728496322;13518.79721804154;13795.655108622364;14303.64240893986;11864.762704745684;12105.33420661872;12162.817557736818;12360.75278494443;12367.876321236672;12000.519979200733;12073.517059317881;12237.632871013884;12249.326287054297;12683.42924568415;11989.880101198876;12190.329531875832;12320;12552.686182845502;12809.743805124031;8258.958705206436;8324.250817426218;8396.454230475;8455.281301089477;8701.782455438664;12471.064670149957;12629.621111366674;12659.556915508281;12740.554080607135;12823.294718790183 11:59:33 INFO - PROCESS | 26911 | |3;mootools.html;1368.8220531330937;1570.6151992761772;1578.0295118502124;1713.511649179984;1813.424936590042;8202.138775428584;9150.313726470516;9393.71818845434;9396.953015234923;9701.902980970188;9248.861267081;9402.670906518273;9429.481378524179;9445.905540944606;9489.430634161938;2393.8270247578735;2401.0275838285525;2417.153996101359;2421.539907417585;2427.66012758214;2407;2419.9153029643967;2431.0761910473993;2436.9390765230833;2444.1201167579657;2372.4424760181428;2380.119355838342;2384.6423036544484;2409.5542324669905;2412.19191570824;2319.2346525646667;2320.7679232076825;2323.8373313868037;2324.3840382298704;2417.8428402153804;2262.988685056581;2292.106078629336;2300.5973954558053;2303.2284184798114;2303.6890019847274;8175.509469431853;9087.909120908838;9493.810123797555;9561.474118923456;9595.328327017112;5502.862428439281;5779.335376431723;5780.7687692492245;5781.219535362757;5786.392428794958;3463.930721385583;3486.3375958568045;3526.823658817049;3574.928501429983;3586.1214002569536;1101.8512500812367;1112.1103117505963;1117.8602674665667;1161.4657257661486;1182.7752726981932;13107.14803537767;13139.408726607326;13154.342282885913;13196.934015329862;13277.46890124394;4830.106430310404;4854.296127061556;4877.512248775165;4891.779869905863;4978.65149439543;11186.049185819134;11187;11254.099672026383;11255.155863310121;11268.21122521432;5532.585056120807;5551.8889622207325;5567.081431563827;5632.971835140798;5639.182318563868;5098.107831129538;5115.411727651368;5136.383633963948;5185.144451165591;5224.425313215544;4104.835806567704;4146.921800331936;4153.958460415418;4182.665386769051;4202.6847986400535;1249.8375211222483;1261.848578170607;1261.9305938173304;1310.3841194638505;1318.4792007157312;874.3660845886682;979.9265055120894;1049.8110340138696;1053.9987012338308;1063.3832377221192;6467.482601391877;6517.73929042833;6601.471882249504;6602.207735071822;6605.207375115017;455.9444885091004;457.7596761700134;458.7522737721593;1097.1716354152563;1133.5012594458412;4455.68810183284;4520.909581808345;4543.7728113594185;4555.202839503074;4557.772111394417;10708.1433485321;11497.367644779617;11803.586874459354;11842.230255033395;12260;12099.27404355724;12135.5145794169;12164.209326393933;12173.69565760863;12217.816732749016;8844.159804818531;9020.774480637905;9040.231580315616;9059.501727405055;9061.909380906107;6290.24517057956;6496.155499784998;6548.443382312556;6663.033860090357;6757.729690812313;10872;10880.782384352111;10917.23579349438;10993.560257589606;11115.166362522681;10364.740881478023;10672.62645807393;10673.35959842412;11143.554257829595;11146.05258553032;8371.706990255312;8481.236688698047;8606.65573377058;8615.353848461265;8626.654933802578;9100.36297459198;9178.724638260863;9208.723738287863;9225.12361325673;9267.258619310574;8116.594170291343;8286.4199506034;8290.792730181794;8497;8559.400841941004;8120.715774947848;8131.308838748772;8225.383096267924;8309.169083091643;8352.498850069016;7752.9921110257565;7781.144074151725;7834.960825196065;7851.411144164096;7857.410694197843;5462.9180562292395;5469.316335458067;5595.244641973281;5608.663480191201;5729.28383952006;5711;5714.9142762857755;5736.139579063174;5810.82567522975;5855.092460668603 11:59:33 INFO - PROCESS | 26911 | |4;prototype.html;346.0621715151938;347.2100970292586;354.8988538266594;355.2646022732941;355.6017260668049;5345.518903298703;5501.367342755584;5517.461967494947;5539.806106786264;5580.804671836487;5408.945910540893;5475.72621368932;5491.780328786844;5515.117581187011;5521;3866.3233934061427;4090.1206240658325;4218.869470917198;4230.323148296273;4257.659387249013;4205.747655140702;4224.352502524018;4231.259529582311;4242.830286788525;4269.252880745873;4022.296098182821;4234.237837189305;4235.74585524868;4252.319628859384;4260.339647354665;4084.9991752020646;4210.915781684349;4224.366345048236;4250.192463431938;4255.957290463825;3753.8873833784755;3761.285355782393;3763.435484677293;3787.091098136455;3793.867214647474;5179.19722443022;5187.48125187482;5191.2472691459525;5207.739613019334;5241.554467870235;4825.445073816521;4844.636652251095;4858;4867.732274724889;4868;5348.304720386363;5449.738358581184;5607.990561698893;5618.550515958714;5629.296337957755;4027.9798601006805;4076.32740597801;4130.194612050651;4140.37894315852;4149.356849688304;5852.297724273029;5855.795047173328;5858.648481091148;5889.411058894119;5904;3994.360902255625;4171.311733563928;4200.7479551227025;4216.388623649554;4230.957690423118;4253.936190957138;4254.829806807693;4263.104748002892;4265.317549192115;4281.972326641646;4802.919343147763;4828.275758636232;4850.927236091461;4875.171220892456;4882.170031094652;5513.862153446196;5681.659100453903;5683.488486036276;5685.744141513642;5689.544836413077;1420.155007770375;1421.3390773290469;1422.4168091082606;1436.8203974503188;1439.9136051836713;899.9823532871868;926.4858003807817;934.6635211323918;941.8304705153001;950.1970834644715;4855.295982082649;4908.9754551227015;4918.475272665485;4991.675541089818;5011.699298042129;5035.84892453227;5042.235217673785;5135.974320128375;5140.712382989608;5154.87090345109;4730.337752714623;4953.479884612064;4953.554180123806;4958.785097651026;5003.649014765992;2730.8361498310164;2771.3348796288747;2793.231861238135;2820.5474180796905;2821.7742580593504;5488.051741631743;5505.449455054462;5516.834494965157;5524.397924601901;5547.889042219133;5096.101043382742;5160.380754309432;5231.398389185217;5327.600429967768;5387.838364849061;5485.533729633026;5922.3417443115995;6024.668643224665;6063.484603808725;6104.603200791934;5843.386444423444;5863.853403664943;5894.587378883437;5905.498032667271;5921.1414344918885;5537.501624853782;5765.050940105873;5774.39368866263;5796.362400135898;5836.358000620014;6009.429104235091;6037.879242415215;6076.660485712944;6082.236151516187;6107.969460152671;4110.506739191316;4121.814518346621;4122.958770412378;4144.212599606065;4163.770992595436;5511.35454981603;5756.510696590669;5782.537397008314;5844.977129002323;5888.941110588839;5748.120018987251;5748.511376533042;5752.626079304831;5775.075987841925;5780.94219057804;5520.917186242129;5703.315602127771;5715.171300161536;5755.1367294906095;5756.71216439168;5557.221988921635;5605.859853503695;5635.633683810539;5653.632513886584;5669.092945128925;5696.658200507983;5775.48020678141;5776.740046697824;5832.475077243069;5855;5477.233187353853;5604.243427137284;5608.158776183605;5635.6618602883955;5644.927463781868 11:59:33 INFO - PROCESS | 26911 | |5;yui.html;770.7456539342018;775.7284950267407;849.2865992566243;889.5018789477891;890.4078787606243;15532.767008494882;15534.145621990787;15534.844651553467;15560.68878622427;15761.054336739804;16061;16125.516234512954;16149.192540372964;16153.111578863158;16184.352625894979;850.5109562001843;877.5305211711735;879.2526352600303;881.5460038080394;882.563131250029;872.4285592936604;882.5278476015333;883.2360008592553;883.2757139145903;884.5135175653365;941.3269512298705;944.2021491839384;944.5371767833781;945.9337846350758;946.7349142240149;936.4942930817384;941.4915945389515;942.853857652065;942.9245660347156;943.9852158929178;688.3082502085372;688.7245101959256;690.3441730356132;691.1982100763091;691.2810676896022;16303.918480407641;16407;16517;16526.6694666106;16529.090900000494;14310.713785724227;14427.78358324626;14490.275486225646;15040.247987600576;15172.848271517254;13515.59453216405;13660.726785464334;13814.240216788072;13905.443782248698;13955.372008259652;4659.627229821606;4659.906801863977;4679;4733.3846599942135;4754.120487709784;51537.484625153644;54785.72607136978;56569;69578;79403.6029819853;12129.696757580954;12527.624171274876;12697.746045079046;12713;13083.149595276276;22328.106875725112;22334.21830235934;22355.21756738539;22381.55236895253;22464.32607021792;8274.462159959583;9218.76953076165;9416.623335066657;9512.04879512057;9868.851967220497;5208.296879921162;5277.525022747971;5291.550218231493;5306.177542480922;5338.759755810997;3769.4911186989953;3935.4883865097354;3935.704822138351;3936.7637941723588;3941.034446560611;687.388224480213;705.0270626535348;710.6446776611695;718.3391280022392;723.1936390924081;798.2017982017982;799.5162926429426;807.8909347238165;814.4095530740166;825.7729124490693;10251.231157663206;10890.836637450444;11043.889561104446;11055.00504954558;11073.446327683583;704.6054209642514;775.0970119810357;780.3211206250598;803.4094940218935;821.2075347289774;4961.305417241589;5029.698218106925;5051.772670229849;5115.721069732567;5123.462036486189;68798.3120168802;69534.3046569538;109014.45492772645;110460.84930657622;112941;88620;97167.51416242874;97593.51203243938;98038;98175.50912245536;58721.412785872446;74412.62793685996;75445.62277188689;86254.56872715596;88298;10621.150307975498;10678.466076695979;10765.784684306427;10835;10852.348859068481;51097.744511277204;51249.23126153036;51524.227136593734;51888;52940.4705952951;68158.3184168152;69214.65392673004;79910.6004469974;80834.59582702049;81200.18799811926;13643.249621270925;14042.227677477837;14102.858971410154;14263.286835657967;14407.85592144107;15604.531864044096;15612;16035.759463608289;16040.11779352147;16611.335546578;14487.275636218357;14488.34802433914;14544.85455145435;15134.243287835345;15378.692426151638;14746.705065898837;15102.697946041237;15160.393584256506;15237.542873713806;15547.922260388626;13786.241756703077;14308.49920252786;14413.567592972227;15127.848721512644;15272.465463708717;11789.469473873867;12190.512379505075;12241.265524068584;12274.877251227374;12664.810027849773;12298.139130261154;12433.875661243272;12548.749025019266;12555.183913045623;12605.07952567278 11:59:33 INFO - PROCESS | 26911 | __end_tp_report 11:59:33 INFO - PROCESS | 26911 | __start_cc_report 11:59:33 INFO - PROCESS | 26911 | _x_x_mozilla_cycle_collect,863 11:59:33 INFO - PROCESS | 26911 | __end_cc_report 11:59:33 INFO - PROCESS | 26911 | __startTimestamp1468349973263__endTimestamp 11:59:33 INFO - PROCESS | 26911 | 11:59:33 INFO - PROCESS | 26911 | ------- Summary: start ------- 11:59:33 INFO - PROCESS | 26911 | Number of tests: 6 11:59:33 INFO - PROCESS | 26911 | 11:59:33 INFO - PROCESS | 26911 | [#0] dojo.html Cycles:165 Average:5508.14 Median:5707.43 stddev:603.36 (10.6%) stddev-sans-first:580.71 11:59:33 INFO - PROCESS | 26911 | Values: 3338.6 3376.8 3380.6 3412.3 3431.1 5479.8 5523.6 5524.4 5553.4 5594.6 5489.6 5565.6 5570.7 5570.7 5610.2 4922.3 4970.8 4982.7 5028.0 5062.2 4880.4 5024.0 5059.5 5064.5 5072.9 4930.7 4945.3 4968.6 4971.8 5054.7 5062.1 5063.1 5078.6 5093.5 5112.0 4919.3 4943.1 4993.6 5054.4 5054.6 5352.9 5359.5 5384.9 5399.0 5410.4 5874.8 5884.6 5925.9 5929.4 5936.4 5840.7 5899.1 5904.4 5965.9 5970.0 5500.9 5559.5 5588.5 5603.4 5604.2 5873.1 6045.9 6047.5 6052.9 6099.3 5702.5 5728.9 5757.4 5843.6 5857.1 5881.5 5888.0 5908.7 5917.7 5923.6 5661.8 5769.0 5853.2 5859.8 5860.2 5876.9 5919.8 5921.2 5930.2 5957.6 4585.9 4599.8 4603.6 4610.7 4624.8 4035.8 4040.8 4065.0 4107.7 4154.2 5682.6 5697.4 5705.3 5706.8 5707.4 5945.1 5949.0 5952.6 5955.5 5965.9 5415.5 5572.6 5628.8 5644.9 5663.1 5204.5 5210.1 5212.9 5213.0 5215.9 6229.1 6236.9 6237.6 6247.8 6251.9 5798.9 5878.2 5923.6 5965.6 6073.4 6219.8 6248.9 6249.0 6262.2 6273.8 5836.3 5852.3 5863.9 5892.2 5923.7 5778.3 5810.9 5877.4 5894.4 5949.7 5747.3 5791.0 5792.1 5794.1 5805.8 5649.6 5723.1 5763.0 5780.9 5794.6 5611.6 5664.4 5679.1 5708.7 5714.3 5836.7 5894.1 5895.5 5896.0 5896.6 5404.4 5606.0 5721.1 5724.1 5729.6 11:59:33 INFO - PROCESS | 26911 | 11:59:33 INFO - PROCESS | 26911 | [#1] ext.html Cycles:180 Average:64037.78 Median:223268.70 stddev:128850.56 (57.7%) stddev-sans-first:129123.98 11:59:33 INFO - PROCESS | 26911 | Values: 594.4 635.1 646.1 651.4 658.6 32771.0 46355.3 46590.3 46642.5 47090.3 48029.5 48257.8 48633.5 48695.3 48740.8 8183.8 8923.2 9070.1 10692.3 10952.2 10556.5 10688.4 10700.8 10709.9 10725.8 10762.2 10814.7 10826.4 10852.9 10861.8 8381.4 10865.5 11109.8 11113.7 11119.9 10515.1 10569.2 10577.0 10908.5 10913.6 45982.3 46046.1 46627.0 46634.8 46646.5 3830.2 3890.6 4439.2 4511.6 4608.4 35179.8 35636.5 35878.3 36089.1 36226.3 4565.0 4652.9 4701.4 4729.7 4794.4 404709.0 405990.0 407294.0 407613.0 407706.0 39905.2 40547.4 73494.6 73877.0 74345.3 42278.6 42489.0 42512.6 42725.0 42767.8 15496.6 17804.2 17931.9 17950.5 17975.1 14632.0 14877.0 14895.4 15077.8 15245.2 9331.5 9354.3 9401.8 9410.9 9444.9 3684.3 3695.7 3702.4 3711.2 3737.3 1032.5 1048.7 1056.3 1092.3 1183.4 32886.9 34102.0 34178.1 34362.0 34551.3 1162.2 1172.9 1202.9 1219.6 1223.7 17257.0 17835.5 17983.4 18088.0 18154.3 601515.0 606339.0 607224.0 608463.0 610831.0 63658.7 65216.0 65239.0 65391.7 65494.3 1312.2 1455.1 1492.7 1497.6 1503.4 33619.5 34557.7 34740.0 35294.5 35341.1 52470.2 52768.2 52904.2 52938.5 52986.5 412598.0 413977.0 414588.0 415307.0 416995.0 24641.1 25567.1 32723.8 32812.5 32973.0 51644.2 51950.0 52298.5 52526.5 52641.5 43220.0 43340.8 43454.8 44162.3 45047.1 43161.7 43918.0 44193.0 44430.0 44648.3 43513.3 43646.8 43880.3 44780.0 45214.3 37845.6 39981.4 40120.4 40411.6 40849.8 29685.9 29947.6 30119.8 30552.2 30714.8 11:59:33 INFO - PROCESS | 26911 | 11:59:33 INFO - PROCESS | 26911 | [#2] jquery.html Cycles:180 Average:30483.08 Median:2072.82 stddev:86900.85 (4192.4%) stddev-sans-first:87115.31 11:59:33 INFO - PROCESS | 26911 | Values: 419.3 425.7 427.1 427.7 446.6 19690.4 19697.9 20280.5 20852.0 20866.3 18283.5 19094.2 19109.7 19608.7 20266.2 5100.8 5301.9 5342.8 5346.8 5347.3 3992.6 4810.0 5233.9 5241.5 6523.5 6397.2 6517.3 6541.1 6584.8 6605.2 5746.0 5914.2 5920.1 6127.3 6505.1 3843.7 4067.4 5366.3 5674.6 5688.1 14121.4 14357.4 14403.1 14458.8 14510.1 2540.7 2623.5 2920.6 3049.5 3070.1 10089.8 10285.4 10373.0 10618.3 11080.0 1843.9 1872.0 2054.1 2063.4 2064.1 82895.6 88514.0 89741.0 90337.5 90392.5 11473.8 11524.3 11527.8 11784.9 11793.9 16587.3 16654.3 16747.9 16765.5 16774.7 8294.4 8624.3 8784.5 8993.4 9046.4 8760.3 8801.4 8801.6 8917.6 8931.5 4986.6 5104.8 5186.8 5188.8 5204.6 1931.6 1972.6 1992.0 2030.8 2081.5 963.6 1072.1 1094.1 1111.5 1126.2 18118.7 18759.1 19122.7 19383.9 20050.8 1041.7 1054.4 1069.9 1075.8 1081.4 10582.8 10649.8 10800.7 11033.0 11142.7 506302.0 509987.0 533035.0 537272.0 545795.0 92840.5 96642.0 96944.0 97807.0 98342.5 1063.4 1071.9 1076.5 1078.8 1085.7 17516.5 17582.1 17718.5 17796.0 18053.5 41296.8 42214.0 42595.6 44097.3 44151.0 60975.7 61141.7 61632.7 61842.7 62356.0 7943.9 8413.1 8532.8 8631.0 8662.4 13419.1 13471.2 13518.8 13795.7 14303.6 11864.8 12105.3 12162.8 12360.8 12367.9 12000.5 12073.5 12237.6 12249.3 12683.4 11989.9 12190.3 12320.0 12552.7 12809.7 8259.0 8324.3 8396.5 8455.3 8701.8 12471.1 12629.6 12659.6 12740.6 12823.3 11:59:33 INFO - PROCESS | 26911 | 11:59:33 INFO - PROCESS | 26911 | [#3] mootools.html Cycles:180 Average:6234.92 Median:2507.77 stddev:3603.91 (143.7%) stddev-sans-first:3595.47 11:59:33 INFO - PROCESS | 26911 | Values: 1368.8 1570.6 1578.0 1713.5 1813.4 8202.1 9150.3 9393.7 9397.0 9701.9 9248.9 9402.7 9429.5 9445.9 9489.4 2393.8 2401.0 2417.2 2421.5 2427.7 2407.0 2419.9 2431.1 2436.9 2444.1 2372.4 2380.1 2384.6 2409.6 2412.2 2319.2 2320.8 2323.8 2324.4 2417.8 2263.0 2292.1 2300.6 2303.2 2303.7 8175.5 9087.9 9493.8 9561.5 9595.3 5502.9 5779.3 5780.8 5781.2 5786.4 3463.9 3486.3 3526.8 3574.9 3586.1 1101.9 1112.1 1117.9 1161.5 1182.8 13107.1 13139.4 13154.3 13196.9 13277.5 4830.1 4854.3 4877.5 4891.8 4978.7 11186.0 11187.0 11254.1 11255.2 11268.2 5532.6 5551.9 5567.1 5633.0 5639.2 5098.1 5115.4 5136.4 5185.1 5224.4 4104.8 4146.9 4154.0 4182.7 4202.7 1249.8 1261.8 1261.9 1310.4 1318.5 874.4 979.9 1049.8 1054.0 1063.4 6467.5 6517.7 6601.5 6602.2 6605.2 455.9 457.8 458.8 1097.2 1133.5 4455.7 4520.9 4543.8 4555.2 4557.8 10708.1 11497.4 11803.6 11842.2 12260.0 12099.3 12135.5 12164.2 12173.7 12217.8 8844.2 9020.8 9040.2 9059.5 9061.9 6290.2 6496.2 6548.4 6663.0 6757.7 10872.0 10880.8 10917.2 10993.6 11115.2 10364.7 10672.6 10673.4 11143.6 11146.1 8371.7 8481.2 8606.7 8615.4 8626.7 9100.4 9178.7 9208.7 9225.1 9267.3 8116.6 8286.4 8290.8 8497.0 8559.4 8120.7 8131.3 8225.4 8309.2 8352.5 7753.0 7781.1 7835.0 7851.4 7857.4 5462.9 5469.3 5595.2 5608.7 5729.3 5711.0 5714.9 5736.1 5810.8 5855.1 11:59:33 INFO - PROCESS | 26911 | 11:59:33 INFO - PROCESS | 26911 | [#4] prototype.html Cycles:180 Average:4699.55 Median:5219.57 stddev:1381.82 (26.5%) stddev-sans-first:1346.50 11:59:33 INFO - PROCESS | 26911 | Values: 346.1 347.2 354.9 355.3 355.6 5345.5 5501.4 5517.5 5539.8 5580.8 5408.9 5475.7 5491.8 5515.1 5521.0 3866.3 4090.1 4218.9 4230.3 4257.7 4205.7 4224.4 4231.3 4242.8 4269.3 4022.3 4234.2 4235.7 4252.3 4260.3 4085.0 4210.9 4224.4 4250.2 4256.0 3753.9 3761.3 3763.4 3787.1 3793.9 5179.2 5187.5 5191.2 5207.7 5241.6 4825.4 4844.6 4858.0 4867.7 4868.0 5348.3 5449.7 5608.0 5618.6 5629.3 4028.0 4076.3 4130.2 4140.4 4149.4 5852.3 5855.8 5858.6 5889.4 5904.0 3994.4 4171.3 4200.7 4216.4 4231.0 4253.9 4254.8 4263.1 4265.3 4282.0 4802.9 4828.3 4850.9 4875.2 4882.2 5513.9 5681.7 5683.5 5685.7 5689.5 1420.2 1421.3 1422.4 1436.8 1439.9 900.0 926.5 934.7 941.8 950.2 4855.3 4909.0 4918.5 4991.7 5011.7 5035.8 5042.2 5136.0 5140.7 5154.9 4730.3 4953.5 4953.6 4958.8 5003.6 2730.8 2771.3 2793.2 2820.5 2821.8 5488.1 5505.4 5516.8 5524.4 5547.9 5096.1 5160.4 5231.4 5327.6 5387.8 5485.5 5922.3 6024.7 6063.5 6104.6 5843.4 5863.9 5894.6 5905.5 5921.1 5537.5 5765.1 5774.4 5796.4 5836.4 6009.4 6037.9 6076.7 6082.2 6108.0 4110.5 4121.8 4123.0 4144.2 4163.8 5511.4 5756.5 5782.5 5845.0 5888.9 5748.1 5748.5 5752.6 5775.1 5780.9 5520.9 5703.3 5715.2 5755.1 5756.7 5557.2 5605.9 5635.6 5653.6 5669.1 5696.7 5775.5 5776.7 5832.5 5855.0 5477.2 5604.2 5608.2 5635.7 5644.9 11:59:33 INFO - PROCESS | 26911 | 11:59:33 INFO - PROCESS | 26911 | [#5] yui.html Cycles:180 Average:20136.85 Median:4706.19 stddev:26963.37 (572.9%) stddev-sans-first:26999.80 11:59:33 INFO - PROCESS | 26911 | Values: 770.7 775.7 849.3 889.5 890.4 15532.8 15534.1 15534.8 15560.7 15761.1 16061.0 16125.5 16149.2 16153.1 16184.4 850.5 877.5 879.3 881.5 882.6 872.4 882.5 883.2 883.3 884.5 941.3 944.2 944.5 945.9 946.7 936.5 941.5 942.9 942.9 944.0 688.3 688.7 690.3 691.2 691.3 16303.9 16407.0 16517.0 16526.7 16529.1 14310.7 14427.8 14490.3 15040.2 15172.8 13515.6 13660.7 13814.2 13905.4 13955.4 4659.6 4659.9 4679.0 4733.4 4754.1 51537.5 54785.7 56569.0 69578.0 79403.6 12129.7 12527.6 12697.7 12713.0 13083.1 22328.1 22334.2 22355.2 22381.6 22464.3 8274.5 9218.8 9416.6 9512.0 9868.9 5208.3 5277.5 5291.6 5306.2 5338.8 3769.5 3935.5 3935.7 3936.8 3941.0 687.4 705.0 710.6 718.3 723.2 798.2 799.5 807.9 814.4 825.8 10251.2 10890.8 11043.9 11055.0 11073.4 704.6 775.1 780.3 803.4 821.2 4961.3 5029.7 5051.8 5115.7 5123.5 68798.3 69534.3 109014.5 110460.8 112941.0 88620.0 97167.5 97593.5 98038.0 98175.5 58721.4 74412.6 75445.6 86254.6 88298.0 10621.2 10678.5 10765.8 10835.0 10852.3 51097.7 51249.2 51524.2 51888.0 52940.5 68158.3 69214.7 79910.6 80834.6 81200.2 13643.2 14042.2 14102.9 14263.3 14407.9 15604.5 15612.0 16035.8 16040.1 16611.3 14487.3 14488.3 14544.9 15134.2 15378.7 14746.7 15102.7 15160.4 15237.5 15547.9 13786.2 14308.5 14413.6 15127.8 15272.5 11789.5 12190.5 12241.3 12274.9 12664.8 12298.1 12433.9 12548.7 12555.2 12605.1 11:59:33 INFO - PROCESS | 26911 | -------- Summary: end -------- 11:59:33 INFO - PROCESS | 26911 | 11:59:33 INFO - TEST-INFO | 26911: exit 0 11:59:33 INFO - TEST-OK | dromaeo_css | took 1112302ms 11:59:33 INFO - TEST-START | kraken 11:59:33 INFO - operating with platform_type : linux_ 11:59:33 INFO - Initialising browser for kraken test... 11:59:33 INFO - TEST-INFO | started process 27103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOeir6f/profile http://localhost:35737/getInfo.html) 11:59:37 INFO - PROCESS | 27103 | __metrics Screen width/height:1600/1200 11:59:37 INFO - PROCESS | 27103 | colorDepth:24 11:59:37 INFO - PROCESS | 27103 | Browser inner width/height: 1024/697 11:59:37 INFO - PROCESS | 27103 | __metrics 11:59:38 ERROR - PROCESS | 27103 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:59:39 INFO - TEST-INFO | 27103: exit 0 11:59:39 INFO - Browser initialized. 11:59:39 INFO - Running cycle 1/1 for kraken test... 11:59:39 INFO - TEST-INFO | started process 27193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOeir6f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:59:51 INFO - PROCESS | 27193 | RSS: Main: 145305600 11:59:51 INFO - PROCESS | 27193 | 11:59:53 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:35737/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35737/tests/kraken/driver.html?testName=audio-beat-detection) 11:59:54 INFO - PROCESS | 27193 | RSS: Main: 194375680 11:59:54 INFO - PROCESS | 27193 | 11:59:57 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:35737/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35737/tests/kraken/driver.html?testName=audio-dft) 11:59:57 INFO - PROCESS | 27193 | RSS: Main: 192618496 11:59:57 INFO - PROCESS | 27193 | 12:00:00 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:35737/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35737/tests/kraken/driver.html?testName=audio-fft) 12:00:01 INFO - PROCESS | 27193 | RSS: Main: 278679552 12:00:01 INFO - PROCESS | 27193 | 12:00:03 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:35737/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35737/tests/kraken/driver.html?testName=audio-oscillator) 12:00:03 INFO - PROCESS | 27193 | RSS: Main: 188084224 12:00:03 INFO - PROCESS | 27193 | 12:00:05 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:35737/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35737/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:00:06 INFO - PROCESS | 27193 | RSS: Main: 188653568 12:00:06 INFO - PROCESS | 27193 | 12:00:09 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:35737/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35737/tests/kraken/driver.html?testName=imaging-darkroom) 12:00:10 INFO - PROCESS | 27193 | RSS: Main: 223264768 12:00:10 INFO - PROCESS | 27193 | 12:00:13 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:35737/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35737/tests/kraken/driver.html?testName=imaging-desaturate) 12:00:14 INFO - PROCESS | 27193 | RSS: Main: 223133696 12:00:14 INFO - PROCESS | 27193 | 12:00:16 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:35737/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35737/tests/kraken/driver.html?testName=json-parse-financial) 12:00:17 INFO - PROCESS | 27193 | RSS: Main: 223326208 12:00:17 INFO - PROCESS | 27193 | 12:00:18 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:35737/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35737/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:00:19 INFO - PROCESS | 27193 | RSS: Main: 201080832 12:00:19 INFO - PROCESS | 27193 | 12:00:21 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:35737/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35737/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:00:21 INFO - PROCESS | 27193 | RSS: Main: 202219520 12:00:21 INFO - PROCESS | 27193 | 12:00:23 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:35737/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35737/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:00:24 INFO - PROCESS | 27193 | RSS: Main: 207790080 12:00:24 INFO - PROCESS | 27193 | 12:00:27 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:35737/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:00:27 INFO - PROCESS | 27193 | RSS: Main: 215609344 12:00:27 INFO - PROCESS | 27193 | 12:00:30 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:35737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:00:30 INFO - PROCESS | 27193 | RSS: Main: 214245376 12:00:30 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | Cycle 1(1): loaded http://localhost:35737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35737/tests/kraken/driver.html?testName=ai-astar) 12:00:32 INFO - PROCESS | 27193 | RSS: Main: 256544768 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | __start_tp_report 12:00:32 INFO - PROCESS | 27193 | _x_x_mozilla_page_load 12:00:32 INFO - PROCESS | 27193 | _x_x_mozilla_page_load_details 12:00:32 INFO - PROCESS | 27193 | |i|pagename|runs| 12:00:32 INFO - PROCESS | 27193 | |0;ai-astar;113;104;112;110;111;109;109;109;109;110 12:00:32 INFO - PROCESS | 27193 | |1;audio-beat-detection;162;125;132;178;125;151;151;127;175;125 12:00:32 INFO - PROCESS | 27193 | |2;audio-dft;162;160;163;162;163;164;162;163;161;162 12:00:32 INFO - PROCESS | 27193 | |3;audio-fft;76;75;76;122;74;75;75;76;107;75 12:00:32 INFO - PROCESS | 27193 | |4;audio-oscillator;85;85;119;85;84;84;116;85;86;138 12:00:32 INFO - PROCESS | 27193 | |5;imaging-gaussian-blur;117;117;119;117;117;117;117;117;116;117 12:00:32 INFO - PROCESS | 27193 | |6;imaging-darkroom;148;148;147;148;148;149;147;146;146;147 12:00:32 INFO - PROCESS | 27193 | |7;imaging-desaturate;95;95;95;96;96;95;95;96;95;94 12:00:32 INFO - PROCESS | 27193 | |8;json-parse-financial;50;50;51;51;53;53;52;52;52;51 12:00:32 INFO - PROCESS | 27193 | |9;json-stringify-tinderbox;60;61;59;59;61;59;59;60;60;60 12:00:32 INFO - PROCESS | 27193 | |10;stanford-crypto-aes;83;77;76;78;77;78;82;87;108;78 12:00:32 INFO - PROCESS | 27193 | |11;stanford-crypto-ccm;122;128;121;122;122;118;127;124;131;119 12:00:32 INFO - PROCESS | 27193 | |12;stanford-crypto-pbkdf2;162;153;155;156;161;154;160;154;156;156 12:00:32 INFO - PROCESS | 27193 | |13;stanford-crypto-sha256-iterative;73;75;64;62;62;62;70;62;61;62 12:00:32 INFO - PROCESS | 27193 | __end_tp_report 12:00:32 INFO - PROCESS | 27193 | __start_cc_report 12:00:32 INFO - PROCESS | 27193 | _x_x_mozilla_cycle_collect,1557 12:00:32 INFO - PROCESS | 27193 | __end_cc_report 12:00:32 INFO - PROCESS | 27193 | __startTimestamp1468350032762__endTimestamp 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | ------- Summary: start ------- 12:00:32 INFO - PROCESS | 27193 | Number of tests: 14 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.41 (2.2%) stddev-sans-first:2.22 12:00:32 INFO - PROCESS | 27193 | Values: 113.0 104.0 112.0 110.0 111.0 109.0 109.0 109.0 109.0 110.0 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:151.00 stddev:21.19 (14.0%) stddev-sans-first:21.58 12:00:32 INFO - PROCESS | 27193 | Values: 162.0 125.0 132.0 178.0 125.0 151.0 151.0 127.0 175.0 125.0 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.14 (0.7%) stddev-sans-first:1.20 12:00:32 INFO - PROCESS | 27193 | Values: 162.0 160.0 163.0 162.0 163.0 164.0 162.0 163.0 161.0 162.0 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | [#3] audio-fft Cycles:10 Average:83.10 Median:75.00 stddev:16.93 (22.6%) stddev-sans-first:17.77 12:00:32 INFO - PROCESS | 27193 | Values: 76.0 75.0 76.0 122.0 74.0 75.0 75.0 76.0 107.0 75.0 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:85.00 stddev:19.89 (23.4%) stddev-sans-first:20.64 12:00:32 INFO - PROCESS | 27193 | Values: 85.0 85.0 119.0 85.0 84.0 84.0 116.0 85.0 86.0 138.0 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 12:00:32 INFO - PROCESS | 27193 | Values: 117.0 117.0 119.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 12:00:32 INFO - PROCESS | 27193 | Values: 148.0 148.0 147.0 148.0 148.0 149.0 147.0 146.0 146.0 147.0 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 12:00:32 INFO - PROCESS | 27193 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 94.0 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:1.08 (2.1%) stddev-sans-first:1.00 12:00:32 INFO - PROCESS | 27193 | Values: 50.0 50.0 51.0 51.0 53.0 53.0 52.0 52.0 52.0 51.0 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 12:00:32 INFO - PROCESS | 27193 | Values: 60.0 61.0 59.0 59.0 61.0 59.0 59.0 60.0 60.0 60.0 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:78.00 stddev:9.63 (12.3%) stddev-sans-first:10.21 12:00:32 INFO - PROCESS | 27193 | Values: 83.0 77.0 76.0 78.0 77.0 78.0 82.0 87.0 108.0 78.0 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:123.00 stddev:4.12 (3.3%) stddev-sans-first:4.33 12:00:32 INFO - PROCESS | 27193 | Values: 122.0 128.0 121.0 122.0 122.0 118.0 127.0 124.0 131.0 119.0 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:156.00 stddev:3.16 (2.0%) stddev-sans-first:2.71 12:00:32 INFO - PROCESS | 27193 | Values: 162.0 153.0 155.0 156.0 161.0 154.0 160.0 154.0 156.0 156.0 12:00:32 INFO - PROCESS | 27193 | 12:00:32 INFO - PROCESS | 27193 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:63.00 stddev:5.27 (8.4%) stddev-sans-first:4.80 12:00:32 INFO - PROCESS | 27193 | Values: 73.0 75.0 64.0 62.0 62.0 62.0 70.0 62.0 61.0 62.0 12:00:32 INFO - PROCESS | 27193 | -------- Summary: end -------- 12:00:32 INFO - PROCESS | 27193 | 12:00:33 INFO - TEST-INFO | 27193: exit 0 12:00:33 INFO - TEST-OK | kraken | took 59876ms 12:00:33 INFO - SUITE-END | took 1172s 12:00:33 INFO - Completed test suite (00:19:32) 12:00:33 INFO - javascript benchmark 12:00:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.582677165354, 3376.79739215647, 3380.6450322716114, 3412.3004784019276, 3431.0907609483475, 5479.835604931848, 5523.613347065707, 5524.4199359067325, 5553.416891226419, 5594.580406469516, 5489.64317319375, 5565.582581306408, 5570.693611851357, 5570.749316280767, 5610.214569960199, 4922.286268491067, 4970.776315065822, 4982.676126051813, 5027.974860125694, 5062.2406639004075, 4880.438749543795, 5023.974880125595, 5059.544640982311, 5064.544191022807, 5072.9492705073035, 4930.6795058321095, 4945.332380128691, 4968.552830245278, 4971.751412429364, 5054.721990290551, 5062.063518249136, 5063.113955057868, 5078.619103567247, 5093.490650934914, 5112.0287145442435, 4919.3358896549225, 4943.1102401567705, 4993.625478089158, 5054.393472783253, 5054.570361519275, 5352.946470535284, 5359.464053594609, 5384.9461505385225, 5399.0, 5410.377806552257, 5874.765009399662, 5884.588078834483, 5925.911111333334, 5929.436703513159, 5936.376680448577, 5840.678762668052, 5899.085641725539, 5904.350521442638, 5965.940340596582, 5969.955257829863, 5500.889982200333, 5559.499645031967, 5588.469095435927, 5603.3836278009385, 5604.187392828057, 5873.060310350409, 6045.881511920309, 6047.455728984412, 6052.939470605237, 6099.329073801879, 5702.486776190163, 5728.856778580569, 5757.424257574293, 5843.561732870052, 5857.092150716646, 5881.500072493886, 5887.970560147171, 5908.704564771744, 5917.727688546983, 5923.555733319932, 5661.7735290588735, 5768.9711551442815, 5853.151293062568, 5859.794907178229, 5860.150278209636, 5876.9118463223085, 5919.792807251725, 5921.2006379138265, 5930.229070220844, 5957.582969192115, 4585.862424127282, 4599.770011499479, 4603.562661547147, 4610.677252592286, 4624.838130665411, 4035.778032208198, 4040.7575545467366, 4064.9593504065174, 4107.712460127762, 4154.169166166779, 5682.6306290091015, 5697.4302569742695, 5705.258316418839, 5706.771729130871, 5707.429257074259, 5945.137954996501, 5949.0, 5952.642841429441, 5955.52355811534, 5965.910511342333, 5415.512603865671, 5572.60991730575, 5628.774849005994, 5644.915326270109, 5663.065594176997, 5204.479552044841, 5210.114280572312, 5212.947870521322, 5212.9739351303, 5215.947840521622, 6229.127922090911, 6236.875262494725, 6237.563370564108, 6247.812565623039, 6251.906221406683, 5798.94201057984, 5878.2358293421585, 5923.555733319932, 5965.552583556164, 6073.362296958756, 6219.751209951552, 6248.937510624835, 6248.968920128128, 6262.15460912771, 6273.780417685359, 5836.299644042742, 5852.326982397079, 5863.882722345615, 5892.175095486721, 5923.703814809329, 5778.306603207642, 5810.883782324415, 5877.382874798084, 5894.440028197314, 5949.702514874326, 5747.339056008445, 5791.0, 5792.102224155263, 5794.101914203306, 5805.82582522525, 5649.604527683023, 5723.055695810144, 5763.0, 5780.94219057804, 5794.565407594363, 5611.6352437091455, 5664.433556644302, 5679.119736440858, 5708.714564271853, 5714.342850572238, 5836.737346819488, 5894.086416605433, 5895.498882595028, 5895.970520147372, 5896.587238893237, 5404.351477822686, 5606.0, 5721.141828725725, 5724.141378793048, 5729.627574207663], "value": 5469.935863995766, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.4471641373524, 635.1425575473112, 646.0761111610398, 651.4072194303185, 658.5982550644108, 32771.0, 46355.30467042993, 46590.301145482845, 46642.533574664325, 47090.293645595346, 48029.519704802944, 48257.75871120648, 48633.51366486334, 48695.269570956465, 48740.75629621847, 8183.754487365389, 8923.152300531456, 9070.138336857988, 10692.251542392036, 10952.233343665946, 10556.524956376981, 10688.358698478078, 10700.78598428031, 10709.946450267777, 10725.83911241332, 10762.246642735012, 10814.72963175919, 10826.350418974847, 10852.891471085306, 10861.782764344709, 8381.371397145238, 10865.45672716369, 11109.83335249972, 11113.72215694606, 11119.944400277947, 10515.106215971651, 10569.154467642571, 10577.04806567405, 10908.50911708975, 10913.563457461692, 45982.310265346045, 46046.07907841858, 46627.0, 46634.76682616599, 46646.5335346649, 3830.1765120499226, 3890.5720370759195, 4439.245328294198, 4511.639068874482, 4608.400907881987, 35179.82410087959, 35636.46545301822, 35878.28243435143, 36089.09777255564, 36226.275474490365, 4564.977175114103, 4652.883677908046, 4701.412323459567, 4729.69256998294, 4794.448638406593, 404709.0, 405990.0, 407294.0, 407613.0, 407706.0, 39905.201895961916, 40547.39178912318, 73494.63252683703, 73877.0, 74345.25654743383, 42278.577214227465, 42489.0, 42512.57487425148, 42725.0, 42767.786161068994, 15496.612584685248, 17804.198811053535, 17931.910340448474, 17950.461486155436, 17975.1012449377, 14632.048916820373, 14877.0, 14895.404183832741, 15077.793776497854, 15245.23773811305, 9331.533423328807, 9354.345195836362, 9401.811963760687, 9410.858837117448, 9444.90555094454, 3684.3184010958057, 3695.667389934919, 3702.426123950792, 3711.2206436648607, 3737.289914916157, 1032.5043978890176, 1048.6749107776614, 1056.3239526702916, 1092.3336764573762, 1183.4201241391656, 32886.91142730593, 34102.0, 34178.14554636154, 34362.0, 34551.308973820385, 1162.1922763679163, 1172.8709841917382, 1202.903767698582, 1219.6034791634481, 1223.718544734716, 17257.0, 17835.46493605194, 17983.370582029565, 18088.0, 18154.273829046953, 601515.0, 606339.0, 607224.0, 608463.0, 610831.0, 63658.6817065921, 65216.0, 65239.0, 65391.67304163449, 65494.345056548824, 1312.2454588611586, 1455.0760267230385, 1492.6641505661357, 1497.5657059452853, 1503.368585194199, 33619.49570756392, 34557.654423455446, 34740.0, 35294.47058294179, 35341.116472088404, 52470.21294680506, 52768.20847687211, 52904.20643690271, 52938.47061529489, 52986.47013529815, 412598.0, 413977.0, 414588.0, 415307.0, 416995.0, 24641.137560185307, 25567.082468815286, 32723.836380817942, 32812.50781238331, 32973.02161870296, 51644.22533662073, 51950.0, 52298.477015229364, 52526.47473525369, 52641.47358526366, 43220.0, 43340.78329608332, 43454.78272608617, 44162.337564937196, 45047.09905801931, 43161.70276029486, 43918.0, 44193.0, 44430.0, 44648.33027504655, 43513.34729979116, 43646.781766090964, 43880.34179487374, 44780.0, 45214.32178517391, 37845.62154378421, 39981.40027899642, 40120.39819402653, 40411.595884040784, 40849.795751021054, 29685.85157074201, 29947.55078673865, 30119.849400752857, 30552.236194095327, 30714.84642576773], "value": 20817.975887785287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.2516358300433, 425.73391630231123, 427.12013252699444, 427.69419864796663, 446.58244541353815, 19690.40928772139, 19697.901510492444, 20280.492987675316, 20852.0, 20866.269680561185, 18283.451496455127, 19094.23623055076, 19109.713354299696, 19608.70586941197, 20266.189352425885, 5100.795968161278, 5301.8939621207555, 5342.759575819097, 5346.759395827197, 5347.278117454152, 3992.6207010333974, 4809.951900480985, 5233.947660523403, 5241.475852414766, 6523.543351965364, 6397.168368112162, 6517.315681853408, 6541.116949211867, 6584.802455926306, 6605.207375114993, 5745.999999999958, 5914.2311499504785, 5920.052791553352, 6127.325994140641, 6505.056766768816, 3843.692504599653, 4067.430559721641, 5366.2755528004, 5674.602777805555, 5688.061469857468, 14121.435142594284, 14357.353919073666, 14403.135811851322, 14458.783118253235, 14510.1293922365, 2540.707818600866, 2623.514649789795, 2920.6051038148726, 3049.542568614703, 3070.094322174941, 10089.798204035951, 10285.434301113435, 10373.0, 10618.309809862334, 11080.0, 1843.935462258828, 1871.9625607487774, 2054.1064636883, 2063.401613532074, 2064.133064113061, 82895.58552207261, 88514.0, 89740.99999999935, 90337.54831225867, 90392.54803726004, 11473.827892581618, 11524.250923689933, 11527.752088342693, 11784.88215117855, 11793.941030294965, 16587.253573589216, 16654.250558724645, 16747.91626041862, 16765.497035088967, 16774.74837877433, 8294.3779216559, 8624.310055195569, 8784.472931624123, 8993.415427997159, 9046.411983221069, 8760.342974276955, 8801.427907186013, 8801.647934082694, 8917.643294268286, 8931.508767017876, 4986.556587272211, 5104.821331253388, 5186.81846135391, 5188.818391356284, 5204.557612602971, 1931.6100244071565, 1972.5660354721938, 1991.9502012449805, 2030.7969203079574, 2081.5108449514655, 963.6386355116831, 1072.0868828774878, 1094.0919037199105, 1111.5331560744346, 1126.1666366888444, 18118.728219076726, 18759.0620468976, 19122.71315930262, 19383.90308048479, 20050.799492005186, 1041.6927006533092, 1054.414799786126, 1069.8823129455754, 1075.8117329467311, 1081.3619964221148, 10582.841257381146, 10649.84025239622, 10800.675979720621, 11033.0, 11142.665720028412, 506302.0, 509987.0, 533035.0, 537272.0, 545795.0, 92840.53579732058, 96642.0, 96944.0, 97807.0, 98342.5082874581, 1063.3726101599939, 1071.8660167479065, 1076.494047797534, 1078.7572796120967, 1085.7394225385851, 17516.474505764847, 17582.120893954994, 17718.46844594664, 17796.0, 18053.458396248134, 41296.79351603223, 42214.0, 42595.57404425916, 44097.338539922566, 44151.0, 60975.695121524106, 61141.694291528256, 61632.69183654053, 61842.69078654758, 62356.0, 7943.920560794318, 8413.116622754767, 8532.786680333042, 8631.007434145155, 8662.436941598777, 13419.127756695783, 13471.191728496322, 13518.79721804154, 13795.655108622364, 14303.64240893986, 11864.762704745684, 12105.33420661872, 12162.817557736818, 12360.75278494443, 12367.876321236672, 12000.519979200733, 12073.517059317881, 12237.632871013884, 12249.326287054297, 12683.42924568415, 11989.880101198876, 12190.329531875832, 12320.0, 12552.686182845502, 12809.743805124031, 8258.958705206436, 8324.250817426218, 8396.454230475, 8455.281301089477, 8701.782455438664, 12471.064670149957, 12629.621111366674, 12659.556915508281, 12740.554080607135, 12823.294718790183], "value": 9473.097215848511, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.8220531330937, 1570.6151992761772, 1578.0295118502124, 1713.511649179984, 1813.424936590042, 8202.138775428584, 9150.313726470516, 9393.71818845434, 9396.953015234923, 9701.902980970188, 9248.861267081, 9402.670906518273, 9429.481378524179, 9445.905540944606, 9489.430634161938, 2393.8270247578735, 2401.0275838285525, 2417.153996101359, 2421.539907417585, 2427.66012758214, 2407.0, 2419.9153029643967, 2431.0761910473993, 2436.9390765230833, 2444.1201167579657, 2372.4424760181428, 2380.119355838342, 2384.6423036544484, 2409.5542324669905, 2412.19191570824, 2319.2346525646667, 2320.7679232076825, 2323.8373313868037, 2324.3840382298704, 2417.8428402153804, 2262.988685056581, 2292.106078629336, 2300.5973954558053, 2303.2284184798114, 2303.6890019847274, 8175.509469431853, 9087.909120908838, 9493.810123797555, 9561.474118923456, 9595.328327017112, 5502.862428439281, 5779.335376431723, 5780.7687692492245, 5781.219535362757, 5786.392428794958, 3463.930721385583, 3486.3375958568045, 3526.823658817049, 3574.928501429983, 3586.1214002569536, 1101.8512500812367, 1112.1103117505963, 1117.8602674665667, 1161.4657257661486, 1182.7752726981932, 13107.14803537767, 13139.408726607326, 13154.342282885913, 13196.934015329862, 13277.46890124394, 4830.106430310404, 4854.296127061556, 4877.512248775165, 4891.779869905863, 4978.65149439543, 11186.049185819134, 11187.0, 11254.099672026383, 11255.155863310121, 11268.21122521432, 5532.585056120807, 5551.8889622207325, 5567.081431563827, 5632.971835140798, 5639.182318563868, 5098.107831129538, 5115.411727651368, 5136.383633963948, 5185.144451165591, 5224.425313215544, 4104.835806567704, 4146.921800331936, 4153.958460415418, 4182.665386769051, 4202.6847986400535, 1249.8375211222483, 1261.848578170607, 1261.9305938173304, 1310.3841194638505, 1318.4792007157312, 874.3660845886682, 979.9265055120894, 1049.8110340138696, 1053.9987012338308, 1063.3832377221192, 6467.482601391877, 6517.73929042833, 6601.471882249504, 6602.207735071822, 6605.207375115017, 455.9444885091004, 457.7596761700134, 458.7522737721593, 1097.1716354152563, 1133.5012594458412, 4455.68810183284, 4520.909581808345, 4543.7728113594185, 4555.202839503074, 4557.772111394417, 10708.1433485321, 11497.367644779617, 11803.586874459354, 11842.230255033395, 12260.0, 12099.27404355724, 12135.5145794169, 12164.209326393933, 12173.69565760863, 12217.816732749016, 8844.159804818531, 9020.774480637905, 9040.231580315616, 9059.501727405055, 9061.909380906107, 6290.24517057956, 6496.155499784998, 6548.443382312556, 6663.033860090357, 6757.729690812313, 10872.0, 10880.782384352111, 10917.23579349438, 10993.560257589606, 11115.166362522681, 10364.740881478023, 10672.62645807393, 10673.35959842412, 11143.554257829595, 11146.05258553032, 8371.706990255312, 8481.236688698047, 8606.65573377058, 8615.353848461265, 8626.654933802578, 9100.36297459198, 9178.724638260863, 9208.723738287863, 9225.12361325673, 9267.258619310574, 8116.594170291343, 8286.4199506034, 8290.792730181794, 8497.0, 8559.400841941004, 8120.715774947848, 8131.308838748772, 8225.383096267924, 8309.169083091643, 8352.498850069016, 7752.9921110257565, 7781.144074151725, 7834.960825196065, 7851.411144164096, 7857.410694197843, 5462.9180562292395, 5469.316335458067, 5595.244641973281, 5608.663480191201, 5729.28383952006, 5711.0, 5714.9142762857755, 5736.139579063174, 5810.82567522975, 5855.092460668603], "value": 4899.525300631878, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.0621715151938, 347.2100970292586, 354.8988538266594, 355.2646022732941, 355.6017260668049, 5345.518903298703, 5501.367342755584, 5517.461967494947, 5539.806106786264, 5580.804671836487, 5408.945910540893, 5475.72621368932, 5491.780328786844, 5515.117581187011, 5521.0, 3866.3233934061427, 4090.1206240658325, 4218.869470917198, 4230.323148296273, 4257.659387249013, 4205.747655140702, 4224.352502524018, 4231.259529582311, 4242.830286788525, 4269.252880745873, 4022.296098182821, 4234.237837189305, 4235.74585524868, 4252.319628859384, 4260.339647354665, 4084.9991752020646, 4210.915781684349, 4224.366345048236, 4250.192463431938, 4255.957290463825, 3753.8873833784755, 3761.285355782393, 3763.435484677293, 3787.091098136455, 3793.867214647474, 5179.19722443022, 5187.48125187482, 5191.2472691459525, 5207.739613019334, 5241.554467870235, 4825.445073816521, 4844.636652251095, 4858.0, 4867.732274724889, 4868.0, 5348.304720386363, 5449.738358581184, 5607.990561698893, 5618.550515958714, 5629.296337957755, 4027.9798601006805, 4076.32740597801, 4130.194612050651, 4140.37894315852, 4149.356849688304, 5852.297724273029, 5855.795047173328, 5858.648481091148, 5889.411058894119, 5904.0, 3994.360902255625, 4171.311733563928, 4200.7479551227025, 4216.388623649554, 4230.957690423118, 4253.936190957138, 4254.829806807693, 4263.104748002892, 4265.317549192115, 4281.972326641646, 4802.919343147763, 4828.275758636232, 4850.927236091461, 4875.171220892456, 4882.170031094652, 5513.862153446196, 5681.659100453903, 5683.488486036276, 5685.744141513642, 5689.544836413077, 1420.155007770375, 1421.3390773290469, 1422.4168091082606, 1436.8203974503188, 1439.9136051836713, 899.9823532871868, 926.4858003807817, 934.6635211323918, 941.8304705153001, 950.1970834644715, 4855.295982082649, 4908.9754551227015, 4918.475272665485, 4991.675541089818, 5011.699298042129, 5035.84892453227, 5042.235217673785, 5135.974320128375, 5140.712382989608, 5154.87090345109, 4730.337752714623, 4953.479884612064, 4953.554180123806, 4958.785097651026, 5003.649014765992, 2730.8361498310164, 2771.3348796288747, 2793.231861238135, 2820.5474180796905, 2821.7742580593504, 5488.051741631743, 5505.449455054462, 5516.834494965157, 5524.397924601901, 5547.889042219133, 5096.101043382742, 5160.380754309432, 5231.398389185217, 5327.600429967768, 5387.838364849061, 5485.533729633026, 5922.3417443115995, 6024.668643224665, 6063.484603808725, 6104.603200791934, 5843.386444423444, 5863.853403664943, 5894.587378883437, 5905.498032667271, 5921.1414344918885, 5537.501624853782, 5765.050940105873, 5774.39368866263, 5796.362400135898, 5836.358000620014, 6009.429104235091, 6037.879242415215, 6076.660485712944, 6082.236151516187, 6107.969460152671, 4110.506739191316, 4121.814518346621, 4122.958770412378, 4144.212599606065, 4163.770992595436, 5511.35454981603, 5756.510696590669, 5782.537397008314, 5844.977129002323, 5888.941110588839, 5748.120018987251, 5748.511376533042, 5752.626079304831, 5775.075987841925, 5780.94219057804, 5520.917186242129, 5703.315602127771, 5715.171300161536, 5755.1367294906095, 5756.71216439168, 5557.221988921635, 5605.859853503695, 5635.633683810539, 5653.632513886584, 5669.092945128925, 5696.658200507983, 5775.48020678141, 5776.740046697824, 5832.475077243069, 5855.0, 5477.233187353853, 5604.243427137284, 5608.158776183605, 5635.6618602883955, 5644.927463781868], "value": 4262.09711264813, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.7456539342018, 775.7284950267407, 849.2865992566243, 889.5018789477891, 890.4078787606243, 15532.767008494882, 15534.145621990787, 15534.844651553467, 15560.68878622427, 15761.054336739804, 16061.0, 16125.516234512954, 16149.192540372964, 16153.111578863158, 16184.352625894979, 850.5109562001843, 877.5305211711735, 879.2526352600303, 881.5460038080394, 882.563131250029, 872.4285592936604, 882.5278476015333, 883.2360008592553, 883.2757139145903, 884.5135175653365, 941.3269512298705, 944.2021491839384, 944.5371767833781, 945.9337846350758, 946.7349142240149, 936.4942930817384, 941.4915945389515, 942.853857652065, 942.9245660347156, 943.9852158929178, 688.3082502085372, 688.7245101959256, 690.3441730356132, 691.1982100763091, 691.2810676896022, 16303.918480407641, 16407.0, 16517.0, 16526.6694666106, 16529.090900000494, 14310.713785724227, 14427.78358324626, 14490.275486225646, 15040.247987600576, 15172.848271517254, 13515.59453216405, 13660.726785464334, 13814.240216788072, 13905.443782248698, 13955.372008259652, 4659.627229821606, 4659.906801863977, 4679.0, 4733.3846599942135, 4754.120487709784, 51537.484625153644, 54785.72607136978, 56569.0, 69578.0, 79403.6029819853, 12129.696757580954, 12527.624171274876, 12697.746045079046, 12713.0, 13083.149595276276, 22328.106875725112, 22334.21830235934, 22355.21756738539, 22381.55236895253, 22464.32607021792, 8274.462159959583, 9218.76953076165, 9416.623335066657, 9512.04879512057, 9868.851967220497, 5208.296879921162, 5277.525022747971, 5291.550218231493, 5306.177542480922, 5338.759755810997, 3769.4911186989953, 3935.4883865097354, 3935.704822138351, 3936.7637941723588, 3941.034446560611, 687.388224480213, 705.0270626535348, 710.6446776611695, 718.3391280022392, 723.1936390924081, 798.2017982017982, 799.5162926429426, 807.8909347238165, 814.4095530740166, 825.7729124490693, 10251.231157663206, 10890.836637450444, 11043.889561104446, 11055.00504954558, 11073.446327683583, 704.6054209642514, 775.0970119810357, 780.3211206250598, 803.4094940218935, 821.2075347289774, 4961.305417241589, 5029.698218106925, 5051.772670229849, 5115.721069732567, 5123.462036486189, 68798.3120168802, 69534.3046569538, 109014.45492772645, 110460.84930657622, 112941.0, 88620.0, 97167.51416242874, 97593.51203243938, 98038.0, 98175.50912245536, 58721.412785872446, 74412.62793685996, 75445.62277188689, 86254.56872715596, 88298.0, 10621.150307975498, 10678.466076695979, 10765.784684306427, 10835.0, 10852.348859068481, 51097.744511277204, 51249.23126153036, 51524.227136593734, 51888.0, 52940.4705952951, 68158.3184168152, 69214.65392673004, 79910.6004469974, 80834.59582702049, 81200.18799811926, 13643.249621270925, 14042.227677477837, 14102.858971410154, 14263.286835657967, 14407.85592144107, 15604.531864044096, 15612.0, 16035.759463608289, 16040.11779352147, 16611.335546578, 14487.275636218357, 14488.34802433914, 14544.85455145435, 15134.243287835345, 15378.692426151638, 14746.705065898837, 15102.697946041237, 15160.393584256506, 15237.542873713806, 15547.922260388626, 13786.241756703077, 14308.49920252786, 14413.567592972227, 15127.848721512644, 15272.465463708717, 11789.469473873867, 12190.512379505075, 12241.265524068584, 12274.877251227374, 12664.810027849773, 12298.139130261154, 12433.875661243272, 12548.749025019266, 12555.183913045623, 12605.07952567278], "value": 8059.734334623929, "unit": "score"}], "name": "dromaeo_css", "value": 7525.04623526113, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 104.0, 112.0, 110.0, 111.0, 109.0, 109.0, 109.0, 109.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 125.0, 132.0, 178.0, 125.0, 151.0, 151.0, 127.0, 175.0, 125.0], "value": 145.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 162.0, 163.0, 164.0, 162.0, 163.0, 161.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 122.0, 74.0, 75.0, 75.0, 76.0, 107.0, 75.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 119.0, 85.0, 84.0, 84.0, 116.0, 85.0, 86.0, 138.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 149.0, 147.0, 146.0, 146.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 51.0, 51.0, 53.0, 53.0, 52.0, 52.0, 52.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 59.0, 61.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 76.0, 78.0, 77.0, 78.0, 82.0, 87.0, 108.0, 78.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 128.0, 121.0, 122.0, 122.0, 118.0, 127.0, 124.0, 131.0, 119.0], "value": 123.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 153.0, 155.0, 156.0, 161.0, 154.0, 160.0, 154.0, 156.0, 156.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 64.0, 62.0, 62.0, 62.0, 70.0, 62.0, 61.0, 62.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1495.5000000000002, "alertThreshold": 2.0}]} 12:00:34 INFO - Return code: 0 12:00:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:00:34 ERROR - # TBPL SUCCESS # 12:00:34 INFO - Running post-action listener: _resource_record_post_action 12:00:34 INFO - ##### 12:00:34 INFO - ##### Finished run-tests step (success) 12:00:34 INFO - ##### 12:00:34 INFO - Running post-run listener: _resource_record_post_run 12:00:34 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 512753664; Read time: 28; Write time: 567692 12:00:34 INFO - TinderboxPrint: CPU usage
13.1% 12:00:34 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 12:00:34 INFO - TinderboxPrint: I/O write bytes / time
512,753,664 / 567,692 12:00:34 INFO - TinderboxPrint: CPU idle
8,240.5 (86.9%) 12:00:34 INFO - TinderboxPrint: CPU user
1,201.8 (12.7%) 12:00:34 INFO - TinderboxPrint: Swap in / out
0 / 0 12:00:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 262844416; Read time: 0; Write time: 354664 12:00:34 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 249909248; Read time: 28; Write time: 213028 12:00:34 INFO - Running post-run listener: _upload_blobber_files 12:00:34 INFO - Blob upload gear active. 12:00:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:00:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:00:34 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'] 12:00:34 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 12:00:35 INFO - (blobuploader) - INFO - Open directory for files ... 12:00:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:00:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:00:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:41 INFO - (blobuploader) - INFO - Done attempting. 12:00:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:00:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:00:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:42 INFO - (blobuploader) - INFO - Done attempting. 12:00:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:00:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:00:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:42 INFO - (blobuploader) - INFO - Done attempting. 12:00:42 INFO - (blobuploader) - INFO - Iteration through files over. 12:00:43 INFO - Return code: 0 12:00:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:00:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:00:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93e6a594beccea9c3bb69cb2fb8c952d67aa47b79e4d76a0f4f80380a705e387ee5065d2198b32592b6df96387122fe65e2719af13325a0e5f82ca887f2cefe7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7579c24b644ee6c4e8b290afd6e80d39d8b128a2463d3c2be7de47bc46b814f961a053f2e5880ca0c216e0f24ec0a98912ca8614d658ae2d8ffb686dba95322a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef77e5b775cb9c3484654643d8087399920c1d3ab5c58562bcfe541835d95a2c94140a49131e8040b2f45e00f3da46f196674b9caf68499a95c2266784f83c97"} 12:00:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:00:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:00:43 INFO - Contents: 12:00:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93e6a594beccea9c3bb69cb2fb8c952d67aa47b79e4d76a0f4f80380a705e387ee5065d2198b32592b6df96387122fe65e2719af13325a0e5f82ca887f2cefe7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7579c24b644ee6c4e8b290afd6e80d39d8b128a2463d3c2be7de47bc46b814f961a053f2e5880ca0c216e0f24ec0a98912ca8614d658ae2d8ffb686dba95322a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef77e5b775cb9c3484654643d8087399920c1d3ab5c58562bcfe541835d95a2c94140a49131e8040b2f45e00f3da46f196674b9caf68499a95c2266784f83c97"} 12:00:43 INFO - Running post-run listener: copy_logs_to_upload_dir 12:00:43 INFO - Copying logs to upload dir... 12:00:43 INFO - mkdir: /builds/slave/test/build/upload/logs 12:00:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.245537 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-12 12:00:42.095638) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 12:00:42.099496) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93e6a594beccea9c3bb69cb2fb8c952d67aa47b79e4d76a0f4f80380a705e387ee5065d2198b32592b6df96387122fe65e2719af13325a0e5f82ca887f2cefe7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7579c24b644ee6c4e8b290afd6e80d39d8b128a2463d3c2be7de47bc46b814f961a053f2e5880ca0c216e0f24ec0a98912ca8614d658ae2d8ffb686dba95322a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef77e5b775cb9c3484654643d8087399920c1d3ab5c58562bcfe541835d95a2c94140a49131e8040b2f45e00f3da46f196674b9caf68499a95c2266784f83c97"} build_url:https://queue.taskcluster.net/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/DbvBXcVBQ_CBHMAkmG8YXA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93e6a594beccea9c3bb69cb2fb8c952d67aa47b79e4d76a0f4f80380a705e387ee5065d2198b32592b6df96387122fe65e2719af13325a0e5f82ca887f2cefe7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7579c24b644ee6c4e8b290afd6e80d39d8b128a2463d3c2be7de47bc46b814f961a053f2e5880ca0c216e0f24ec0a98912ca8614d658ae2d8ffb686dba95322a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef77e5b775cb9c3484654643d8087399920c1d3ab5c58562bcfe541835d95a2c94140a49131e8040b2f45e00f3da46f196674b9caf68499a95c2266784f83c97"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 12:00:42.124594) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 12:00:42.124936) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1468348807.354928-405215241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 12:00:42.210296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 12:00:42.210604) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 12:00:42.210904) ========= ========= Total master_lag: 0.17 =========