builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0278 starttime: 1468027953.89 results: success (0) buildid: 20160708152725 builduid: 1a73598bcd764572bb2282ef95fa4385 revision: 4287a45df22d86765e15561a8834f6f3d00c24ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:33.894878) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:33.895348) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2016-07-08 18:32:33.895627) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2016-07-08 18:32:43.254362) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 18:32:43.258437) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.StIKfeNW8Y/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-08 18:32:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 178M=0s 2016-07-08 18:32:43 (178 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128828 ========= master_lag: 1.44 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 18:32:44.823131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 18:32:44.823416) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.StIKfeNW8Y/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026541 ========= master_lag: 1.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 18:32:45.941908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-08 18:32:45.942241) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4287a45df22d86765e15561a8834f6f3d00c24ec --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 4287a45df22d86765e15561a8834f6f3d00c24ec --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.StIKfeNW8Y/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-08 18:32:46,027 truncating revision to first 12 chars 2016-07-08 18:32:46,028 Setting DEBUG logging. 2016-07-08 18:32:46,028 attempt 1/10 2016-07-08 18:32:46,028 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4287a45df22d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 18:32:47,026 unpacking tar archive at: autoland-4287a45df22d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.269975 ========= master_lag: 2.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-08 18:32:49.441529) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:49.441889) ========= script_repo_revision: 4287a45df22d86765e15561a8834f6f3d00c24ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:49.442322) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:49.442605) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 18:32:49.474345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-08 18:32:49.474752) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.StIKfeNW8Y/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 18:32:49 INFO - MultiFileLogger online at 20160708 18:32:49 in /builds/slave/test 18:32:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 18:32:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:32:49 INFO - {'append_to_log': False, 18:32:49 INFO - 'base_work_dir': '/builds/slave/test', 18:32:49 INFO - 'blob_upload_branch': 'Autoland', 18:32:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:32:49 INFO - 'branch': 'Autoland', 18:32:49 INFO - 'buildbot_json_path': 'buildprops.json', 18:32:49 INFO - 'config_files': ('talos/mac_config.py',), 18:32:49 INFO - 'default_actions': ('clobber', 18:32:49 INFO - 'read-buildbot-config', 18:32:49 INFO - 'download-and-extract', 18:32:49 INFO - 'populate-webroot', 18:32:49 INFO - 'create-virtualenv', 18:32:49 INFO - 'install', 18:32:49 INFO - 'run-tests'), 18:32:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:32:49 INFO - 'download_minidump_stackwalk': True, 18:32:49 INFO - 'download_symbols': 'ondemand', 18:32:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:32:49 INFO - 'tooltool.py': '/tools/tooltool.py', 18:32:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:32:49 INFO - '/tools/misc-python/virtualenv.py')}, 18:32:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:32:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:32:49 INFO - 'installer_path': 'installer.exe', 18:32:49 INFO - 'log_level': 'info', 18:32:49 INFO - 'log_name': 'talos', 18:32:49 INFO - 'log_to_console': True, 18:32:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:32:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:32:49 INFO - 'opt_config_files': (), 18:32:49 INFO - 'pip_index': False, 18:32:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:32:49 INFO - 'cmd': ('bash', 18:32:49 INFO - '-c', 18:32:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:32:49 INFO - 'enabled': True, 18:32:49 INFO - 'halt_on_failure': False, 18:32:49 INFO - 'name': 'check_screen_resolution'},), 18:32:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:32:49 INFO - 'cmd': ('bash', 18:32:49 INFO - '-c', 18:32:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:32:49 INFO - 'enabled': True, 18:32:49 INFO - 'halt_on_failure': False, 18:32:49 INFO - 'name': 'check_screen_resolution'},), 18:32:49 INFO - 'run_cmd_checks_enabled': True, 18:32:49 INFO - 'sps_profile': False, 18:32:49 INFO - 'sps_profile_interval': 0, 18:32:49 INFO - 'suite': 'dromaeojs', 18:32:49 INFO - 'system_bits': '32', 18:32:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:32:49 INFO - 'title': 't-yosemite-r7-0278', 18:32:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:32:49 INFO - 'use_talos_json': True, 18:32:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:32:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:32:49 INFO - 'work_dir': 'build'} 18:32:49 INFO - ##### 18:32:49 INFO - ##### Running clobber step. 18:32:49 INFO - ##### 18:32:49 INFO - Running pre-action listener: _resource_record_pre_action 18:32:49 INFO - Running main action method: clobber 18:32:49 INFO - rmtree: /builds/slave/test/build 18:32:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:32:51 INFO - Running post-action listener: _resource_record_post_action 18:32:51 INFO - ##### 18:32:51 INFO - ##### Finished clobber step (success) 18:32:51 INFO - ##### 18:32:51 INFO - ##### 18:32:51 INFO - ##### Running read-buildbot-config step. 18:32:51 INFO - ##### 18:32:51 INFO - Running pre-action listener: _resource_record_pre_action 18:32:51 INFO - Running main action method: read_buildbot_config 18:32:51 INFO - Using buildbot properties: 18:32:51 INFO - { 18:32:51 INFO - "project": "", 18:32:51 INFO - "product": "firefox", 18:32:51 INFO - "script_repo_revision": "production", 18:32:51 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 18:32:51 INFO - "repository": "", 18:32:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 18:32:51 INFO - "buildid": "20160708152725", 18:32:51 INFO - "pgo_build": "False", 18:32:51 INFO - "basedir": "/builds/slave/test", 18:32:51 INFO - "buildnumber": 47, 18:32:51 INFO - "slavename": "t-yosemite-r7-0278", 18:32:51 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:32:51 INFO - "platform": "yosemite_r7", 18:32:51 INFO - "scheduler": "tests-autoland-macosx64-talos", 18:32:51 INFO - "branch": "autoland", 18:32:51 INFO - "repo_path": "integration/autoland", 18:32:51 INFO - "revision": "4287a45df22d86765e15561a8834f6f3d00c24ec", 18:32:51 INFO - "stage_platform": "macosx64", 18:32:51 INFO - "builduid": "1a73598bcd764572bb2282ef95fa4385", 18:32:51 INFO - "slavebuilddir": "test" 18:32:51 INFO - } 18:32:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 18:32:51 INFO - Running post-action listener: _resource_record_post_action 18:32:51 INFO - ##### 18:32:51 INFO - ##### Finished read-buildbot-config step (success) 18:32:51 INFO - ##### 18:32:51 INFO - ##### 18:32:51 INFO - ##### Running download-and-extract step. 18:32:51 INFO - ##### 18:32:51 INFO - Running pre-action listener: _resource_record_pre_action 18:32:51 INFO - Running main action method: download_and_extract 18:32:51 INFO - mkdir: /builds/slave/test/build/tests 18:32:51 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')]} 18:32:51 INFO - https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:32:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 18:32:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 18:32:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 18:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 18:32:52 INFO - Downloaded 1199 bytes. 18:32:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 18:32:52 INFO - Using the following test package requirements: 18:32:52 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 18:32:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:52 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 18:32:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:52 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 18:32:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:52 INFO - u'jsshell-mac.zip'], 18:32:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:52 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 18:32:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 18:32:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:52 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 18:32:52 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:52 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 18:32:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:52 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 18:32:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:32:52 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 18:32:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:52 INFO - https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:32:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:32:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:32:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:32:54 INFO - Downloaded 18805120 bytes. 18:32:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:32:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:32:57 INFO - Return code: 0 18:32:57 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:57 INFO - https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:32:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:32:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:32:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:32:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:32:58 INFO - Downloaded 18805120 bytes. 18:32:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:32:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:33:02 INFO - Return code: 0 18:33:02 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')]} 18:33:02 INFO - https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:33:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:33:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:33:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:33:03 INFO - Downloaded 14403333 bytes. 18:33:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:33:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:33:03 INFO - Return code: 0 18:33:03 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')]} 18:33:03 INFO - https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:33:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:33:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:33:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 18:33:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 18:33:07 INFO - Downloaded 112496134 bytes. 18:33:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:33:07 INFO - mkdir: /builds/slave/test/properties 18:33:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:33:07 INFO - Writing to file /builds/slave/test/properties/build_url 18:33:07 INFO - Contents: 18:33:07 INFO - build_url:https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:33:08 INFO - Running post-action listener: _resource_record_post_action 18:33:08 INFO - Running post-action listener: set_extra_try_arguments 18:33:08 INFO - ##### 18:33:08 INFO - ##### Finished download-and-extract step (success) 18:33:08 INFO - ##### 18:33:08 INFO - ##### 18:33:08 INFO - ##### Running populate-webroot step. 18:33:08 INFO - ##### 18:33:08 INFO - Running pre-action listener: _resource_record_pre_action 18:33:08 INFO - Running main action method: populate_webroot 18:33:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:33:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:33:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:33:08 INFO - '--tppagecycles', 18:33:08 INFO - '7'], 18:33:08 INFO - 'tests': ['tsvgm']}}, 18:33:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:33:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:33:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:33:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:33:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:33:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:33:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:08 INFO - 'talos_options': ['--disable-e10s'], 18:33:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:08 INFO - 'talos_options': ['--disable-e10s'], 18:33:08 INFO - 'tests': ['damp', 'tps']}, 18:33:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:08 INFO - 'tests': ['damp', 'tps']}, 18:33:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:33:08 INFO - 'tests': ['dromaeo_dom']}, 18:33:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:33:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:33:08 INFO - 'tests': ['basic_compositor_video']}, 18:33:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:33:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:33:08 INFO - 'tests': ['a11yr', 18:33:08 INFO - 'ts_paint', 18:33:08 INFO - 'tpaint', 18:33:08 INFO - 'sessionrestore', 18:33:08 INFO - 'sessionrestore_no_auto_restore', 18:33:08 INFO - 'tabpaint']}, 18:33:08 INFO - 'other-e10s': {'tests': ['a11yr', 18:33:08 INFO - 'ts_paint', 18:33:08 INFO - 'tpaint', 18:33:08 INFO - 'sessionrestore', 18:33:08 INFO - 'sessionrestore_no_auto_restore', 18:33:08 INFO - 'tabpaint']}, 18:33:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:33:08 INFO - 'ts_paint', 18:33:08 INFO - 'tpaint', 18:33:08 INFO - 'sessionrestore', 18:33:08 INFO - 'sessionrestore_no_auto_restore', 18:33:08 INFO - 'tabpaint']}, 18:33:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:33:08 INFO - 'ts_paint', 18:33:08 INFO - 'tpaint', 18:33:08 INFO - 'sessionrestore', 18:33:08 INFO - 'sessionrestore_no_auto_restore', 18:33:08 INFO - 'tabpaint']}, 18:33:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:33:08 INFO - 'tests': ['a11yr', 18:33:08 INFO - 'ts_paint', 18:33:08 INFO - 'tpaint', 18:33:08 INFO - 'sessionrestore', 18:33:08 INFO - 'sessionrestore_no_auto_restore', 18:33:08 INFO - 'tabpaint']}, 18:33:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:33:08 INFO - 'tests': ['a11yr', 18:33:08 INFO - 'ts_paint', 18:33:08 INFO - 'tpaint', 18:33:08 INFO - 'sessionrestore', 18:33:08 INFO - 'sessionrestore_no_auto_restore', 18:33:08 INFO - 'tabpaint']}, 18:33:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:33:08 INFO - 'tests': ['tsvgx', 18:33:08 INFO - 'tsvgr_opacity', 18:33:08 INFO - 'tart', 18:33:08 INFO - 'tscrollx', 18:33:08 INFO - 'cart']}, 18:33:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:33:08 INFO - 'tsvgr_opacity', 18:33:08 INFO - 'tart', 18:33:08 INFO - 'tscrollx', 18:33:08 INFO - 'cart']}, 18:33:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:08 INFO - 'talos_options': ['--disable-e10s'], 18:33:08 INFO - 'tests': ['tp5o']}, 18:33:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:08 INFO - 'tests': ['tp5o']}, 18:33:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:08 INFO - 'talos_options': ['--disable-e10s', 18:33:08 INFO - '--xperf_path', 18:33:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:08 INFO - 'tests': ['tp5n']}, 18:33:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:08 INFO - 'talos_options': ['--xperf_path', 18:33:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:08 INFO - 'tests': ['tp5n']}}, 18:33:08 INFO - 'talos.zip': {'path': '', 18:33:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:33:08 INFO - Running post-action listener: _resource_record_post_action 18:33:08 INFO - ##### 18:33:08 INFO - ##### Finished populate-webroot step (success) 18:33:08 INFO - ##### 18:33:08 INFO - ##### 18:33:08 INFO - ##### Running create-virtualenv step. 18:33:08 INFO - ##### 18:33:08 INFO - Running pre-action listener: _resource_record_pre_action 18:33:08 INFO - Running main action method: create_virtualenv 18:33:08 INFO - Creating virtualenv /builds/slave/test/build/venv 18:33:08 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 18:33:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:33:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:33:08 INFO - Using real prefix '/tools/python27' 18:33:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:33:09 INFO - Installing distribute.............................................................................................................................................................................................done. 18:33:12 INFO - Installing pip.................done. 18:33:12 INFO - Return code: 0 18:33:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:33:12 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')]} 18:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:12 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')]} 18:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:12 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 0x1067c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106857618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd350c81500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106726d30>, '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 0x10648bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10671eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:12 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 18:33:12 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 18:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 18:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:12 INFO - 'HOME': '/Users/cltbld', 18:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:12 INFO - 'LOGNAME': 'cltbld', 18:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:12 INFO - 'MOZ_NO_REMOTE': '1', 18:33:12 INFO - 'NO_EM_RESTART': '1', 18:33:12 INFO - 'PAGER': '/bin/cat', 18:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:12 INFO - 'PWD': '/builds/slave/test', 18:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:12 INFO - 'SHELL': '/bin/bash', 18:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 18:33:12 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 18:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:12 INFO - 'USER': 'cltbld', 18:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:12 INFO - 'XPC_FLAGS': '0x0', 18:33:12 INFO - 'XPC_SERVICE_NAME': '0', 18:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:12 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 18:33:12 INFO - Cleaning up... 18:33:12 INFO - Return code: 0 18:33:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:33:12 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')]} 18:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:12 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')]} 18:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:12 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 0x1067c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106857618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd350c81500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106726d30>, '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 0x10648bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10671eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:12 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 18:33:12 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 18:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 18:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:12 INFO - 'HOME': '/Users/cltbld', 18:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:12 INFO - 'LOGNAME': 'cltbld', 18:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:12 INFO - 'MOZ_NO_REMOTE': '1', 18:33:12 INFO - 'NO_EM_RESTART': '1', 18:33:12 INFO - 'PAGER': '/bin/cat', 18:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:12 INFO - 'PWD': '/builds/slave/test', 18:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:12 INFO - 'SHELL': '/bin/bash', 18:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 18:33:12 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 18:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:12 INFO - 'USER': 'cltbld', 18:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:12 INFO - 'XPC_FLAGS': '0x0', 18:33:12 INFO - 'XPC_SERVICE_NAME': '0', 18:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:12 INFO - Downloading/unpacking psutil>=3.1.1 18:33:12 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 18:33:12 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 18:33:12 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 18:33:12 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 18:33:12 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 18:33:12 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 18:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:33:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:15 INFO - Installing collected packages: psutil 18:33:15 INFO - Running setup.py install for psutil 18:33:15 INFO - building 'psutil._psutil_osx' extension 18:33:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:33:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:33:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:33:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:33:16 INFO - building 'psutil._psutil_posix' extension 18:33:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:33:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:33:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:33:16 INFO - ^ 18:33:16 INFO - 1 warning generated. 18:33:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:33:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:16 INFO - Successfully installed psutil 18:33:16 INFO - Cleaning up... 18:33:16 INFO - Return code: 0 18:33:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33: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')]} 18:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:16 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 0x1067c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106857618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd350c81500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106726d30>, '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 0x10648bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10671eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:16 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 18:33:16 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 18:33:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 18:33:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:16 INFO - 'HOME': '/Users/cltbld', 18:33:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:16 INFO - 'LOGNAME': 'cltbld', 18:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:16 INFO - 'MOZ_NO_REMOTE': '1', 18:33:16 INFO - 'NO_EM_RESTART': '1', 18:33:16 INFO - 'PAGER': '/bin/cat', 18:33:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:16 INFO - 'PWD': '/builds/slave/test', 18:33:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:16 INFO - 'SHELL': '/bin/bash', 18:33:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 18:33:16 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 18:33:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:16 INFO - 'USER': 'cltbld', 18:33:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:16 INFO - 'XPC_FLAGS': '0x0', 18:33:16 INFO - 'XPC_SERVICE_NAME': '0', 18:33:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:33:16 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 18:33:16 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 18:33:16 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 18:33:16 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 18:33:16 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 18:33:16 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 18:33:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:33:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:33:19 INFO - Installing collected packages: mozsystemmonitor 18:33:19 INFO - Running setup.py install for mozsystemmonitor 18:33:19 INFO - Successfully installed mozsystemmonitor 18:33:19 INFO - Cleaning up... 18:33:19 INFO - Return code: 0 18:33:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:33:19 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')]} 18:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:19 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')]} 18:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:19 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 0x1067c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106857618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd350c81500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106726d30>, '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 0x10648bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10671eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:19 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 18:33:19 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 18:33:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 18:33:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:19 INFO - 'HOME': '/Users/cltbld', 18:33:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:19 INFO - 'LOGNAME': 'cltbld', 18:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:19 INFO - 'MOZ_NO_REMOTE': '1', 18:33:19 INFO - 'NO_EM_RESTART': '1', 18:33:19 INFO - 'PAGER': '/bin/cat', 18:33:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:19 INFO - 'PWD': '/builds/slave/test', 18:33:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:19 INFO - 'SHELL': '/bin/bash', 18:33:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 18:33:19 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 18:33:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:19 INFO - 'USER': 'cltbld', 18:33:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:19 INFO - 'XPC_FLAGS': '0x0', 18:33:19 INFO - 'XPC_SERVICE_NAME': '0', 18:33:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:19 INFO - Downloading/unpacking jsonschema==2.5.1 18:33:19 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 18:33:19 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 18:33:19 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 18:33:19 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 18:33:19 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 18:33:19 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 18:33:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:33:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:33: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 18:33: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 18:33: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 18:33: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 18:33: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 18:33: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 18:33:22 INFO - Downloading functools32-3.2.3-2.tar.gz 18:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:33:22 INFO - warning: no files found matching '*.txt' 18:33:22 INFO - no previously-included directories found matching 'build' 18:33:22 INFO - no previously-included directories found matching 'dist' 18:33:22 INFO - no previously-included directories found matching '.git*' 18:33:22 INFO - Installing collected packages: jsonschema, functools32 18:33:22 INFO - Running setup.py install for functools32 18:33:22 INFO - warning: no files found matching '*.txt' 18:33:22 INFO - no previously-included directories found matching 'build' 18:33:22 INFO - no previously-included directories found matching 'dist' 18:33:22 INFO - no previously-included directories found matching '.git*' 18:33:23 INFO - Successfully installed jsonschema functools32 18:33:23 INFO - Cleaning up... 18:33:23 INFO - Return code: 0 18:33:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:23 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 0x1067c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106857618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd350c81500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106726d30>, '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 0x10648bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10671eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:23 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 18:33:23 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 18:33:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 18:33:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:23 INFO - 'HOME': '/Users/cltbld', 18:33:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:23 INFO - 'LOGNAME': 'cltbld', 18:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:23 INFO - 'MOZ_NO_REMOTE': '1', 18:33:23 INFO - 'NO_EM_RESTART': '1', 18:33:23 INFO - 'PAGER': '/bin/cat', 18:33:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:23 INFO - 'PWD': '/builds/slave/test', 18:33:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:23 INFO - 'SHELL': '/bin/bash', 18:33:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 18:33:23 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 18:33:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:23 INFO - 'USER': 'cltbld', 18:33:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:23 INFO - 'XPC_FLAGS': '0x0', 18:33:23 INFO - 'XPC_SERVICE_NAME': '0', 18:33:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:23 INFO - Downloading/unpacking blobuploader==1.2.4 18:33:23 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 18:33:23 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 18:33:23 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 18:33:23 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 18:33:23 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 18:33:23 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 18:33:25 INFO - Downloading blobuploader-1.2.4.tar.gz 18:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:33:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:33: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 18:33: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 18:33: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 18:33: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 18:33: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 18:33: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 18:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:33:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:33:26 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 18:33:26 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 18:33:26 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 18:33:26 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 18:33:26 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 18:33:26 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 18:33:27 INFO - Downloading docopt-0.6.1.tar.gz 18:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:33:27 INFO - Installing collected packages: blobuploader, requests, docopt 18:33:27 INFO - Running setup.py install for blobuploader 18:33:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:33:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:33:27 INFO - Running setup.py install for requests 18:33:27 INFO - Running setup.py install for docopt 18:33:27 INFO - Successfully installed blobuploader requests docopt 18:33:27 INFO - Cleaning up... 18:33:28 INFO - Return code: 0 18:33:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:28 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 0x1067c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106857618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd350c81500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106726d30>, '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 0x10648bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10671eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:28 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 18:33:28 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 18:33:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 18:33:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:28 INFO - 'HOME': '/Users/cltbld', 18:33:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:28 INFO - 'LOGNAME': 'cltbld', 18:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:28 INFO - 'MOZ_NO_REMOTE': '1', 18:33:28 INFO - 'NO_EM_RESTART': '1', 18:33:28 INFO - 'PAGER': '/bin/cat', 18:33:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:28 INFO - 'PWD': '/builds/slave/test', 18:33:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:28 INFO - 'SHELL': '/bin/bash', 18:33:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 18:33:28 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 18:33:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:28 INFO - 'USER': 'cltbld', 18:33:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:28 INFO - 'XPC_FLAGS': '0x0', 18:33:28 INFO - 'XPC_SERVICE_NAME': '0', 18:33:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:28 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-odScJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:28 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-haowYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:28 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-xUTREL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:28 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-w15MmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:29 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-qS5Vky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:29 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-TlJT4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:29 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-DliiIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:29 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Z1QMuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:29 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-3ZbNIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:29 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-S2D1fO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:29 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-j96iCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:29 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-7qNyfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:29 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-fbWsJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:30 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-znX5yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:30 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Rrggev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:30 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-3xptz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:30 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-TvYDR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:33:30 INFO - Running setup.py install for manifestparser 18:33:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:33:30 INFO - Running setup.py install for mozcrash 18:33:30 INFO - Running setup.py install for mozdebug 18:33:30 INFO - Running setup.py install for mozdevice 18:33:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:33:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:33:31 INFO - Running setup.py install for mozfile 18:33:31 INFO - Running setup.py install for mozhttpd 18:33:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:33:31 INFO - Running setup.py install for mozinfo 18:33:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:33:31 INFO - Running setup.py install for mozInstall 18:33:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:33:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:33:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:33:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:33:31 INFO - Running setup.py install for mozleak 18:33:31 INFO - Running setup.py install for mozlog 18:33:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:33:31 INFO - Running setup.py install for moznetwork 18:33:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Running setup.py install for mozprocess 18:33:32 INFO - Running setup.py install for mozprofile 18:33:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Running setup.py install for mozrunner 18:33:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Running setup.py install for mozscreenshot 18:33:32 INFO - Running setup.py install for moztest 18:33:32 INFO - Running setup.py install for mozversion 18:33:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:33:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:33:32 INFO - Cleaning up... 18:33:32 INFO - Return code: 0 18:33:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:32 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 0x1067c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106857618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd350c81500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106726d30>, '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 0x10648bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10671eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:32 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 18:33:32 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 18:33:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 18:33:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:32 INFO - 'HOME': '/Users/cltbld', 18:33:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:32 INFO - 'LOGNAME': 'cltbld', 18:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:32 INFO - 'MOZ_NO_REMOTE': '1', 18:33:32 INFO - 'NO_EM_RESTART': '1', 18:33:32 INFO - 'PAGER': '/bin/cat', 18:33:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:32 INFO - 'PWD': '/builds/slave/test', 18:33:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:32 INFO - 'SHELL': '/bin/bash', 18:33:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 18:33:32 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 18:33:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:32 INFO - 'USER': 'cltbld', 18:33:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:32 INFO - 'XPC_FLAGS': '0x0', 18:33:32 INFO - 'XPC_SERVICE_NAME': '0', 18:33:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:33 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-jQ9IHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:33 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)) 18:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:33 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-bbwVlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:33 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)) 18:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:33 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-cM7xwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:33 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)) 18:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:33 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-gw_GUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:33 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)) 18:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:33 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-kZ3A35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:33 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)) 18:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:33 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Wuotfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:33 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)) 18:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:33 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-SYmLRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:33 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)) 18:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:33 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-QCR3uY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:34 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)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-EI2opE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:34 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)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-XvTNUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:34 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)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-CQYc20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:34 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)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-x8Sqjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:34 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)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Ypiy7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:34 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)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-0MC_cM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:34 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)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-wocniq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:34 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)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-1r7KHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:34 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)) 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:34 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-nzPGWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:35 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)) 18:33:35 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)) 18:33:35 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)) 18:33:35 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)) 18:33:35 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)) 18:33:35 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)) 18:33:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:37 INFO - Downloading blessings-1.6.tar.gz 18:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:33:37 INFO - Installing collected packages: blessings 18:33:37 INFO - Running setup.py install for blessings 18:33:38 INFO - Successfully installed blessings 18:33:38 INFO - Cleaning up... 18:33:38 INFO - Return code: 0 18:33:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:33:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:33:38 INFO - Reading from file tmpfile_stdout 18:33:38 INFO - Current package versions: 18:33:38 INFO - blessings == 1.6 18:33:38 INFO - blobuploader == 1.2.4 18:33:38 INFO - docopt == 0.6.1 18:33:38 INFO - functools32 == 3.2.3-2 18:33:38 INFO - jsonschema == 2.5.1 18:33:38 INFO - manifestparser == 1.1 18:33:38 INFO - mozInstall == 1.12 18:33:38 INFO - mozcrash == 0.17 18:33:38 INFO - mozdebug == 0.1 18:33:38 INFO - mozdevice == 0.48 18:33:38 INFO - mozfile == 1.2 18:33:38 INFO - mozhttpd == 0.7 18:33:38 INFO - mozinfo == 0.9 18:33:38 INFO - mozleak == 0.1 18:33:38 INFO - mozlog == 3.2 18:33:38 INFO - moznetwork == 0.27 18:33:38 INFO - mozprocess == 0.23 18:33:38 INFO - mozprofile == 0.28 18:33:38 INFO - mozrunner == 6.12 18:33:38 INFO - mozscreenshot == 0.1 18:33:38 INFO - mozsystemmonitor == 0.3 18:33:38 INFO - moztest == 0.7 18:33:38 INFO - mozversion == 1.4 18:33:38 INFO - psutil == 3.1.1 18:33:38 INFO - requests == 1.2.3 18:33:38 INFO - wsgiref == 0.1.2 18:33:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:38 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 0x1067c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106857618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd350c81500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106726d30>, '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 0x10648bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10671eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:38 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 18:33:38 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 18:33:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 18:33:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:38 INFO - 'HOME': '/Users/cltbld', 18:33:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:38 INFO - 'LOGNAME': 'cltbld', 18:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:38 INFO - 'MOZ_NO_REMOTE': '1', 18:33:38 INFO - 'NO_EM_RESTART': '1', 18:33:38 INFO - 'PAGER': '/bin/cat', 18:33:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:38 INFO - 'PWD': '/builds/slave/test', 18:33:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:38 INFO - 'SHELL': '/bin/bash', 18:33:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 18:33:38 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 18:33:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:38 INFO - 'USER': 'cltbld', 18:33:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:38 INFO - 'XPC_FLAGS': '0x0', 18:33:38 INFO - 'XPC_SERVICE_NAME': '0', 18:33:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:38 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)) 18:33:38 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)) 18:33:38 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)) 18:33:38 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)) 18:33:38 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)) 18:33:38 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)) 18:33:38 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)) 18:33:38 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)) 18:33:38 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)) 18:33:38 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)) 18:33:38 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)) 18:33:38 INFO - Cleaning up... 18:33:38 INFO - Return code: 0 18:33:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1067c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106857618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd350c81500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106726d30>, '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 0x10648bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10671eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:33:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 18:33:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:38 INFO - 'HOME': '/Users/cltbld', 18:33:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:38 INFO - 'LOGNAME': 'cltbld', 18:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:38 INFO - 'MOZ_NO_REMOTE': '1', 18:33:38 INFO - 'NO_EM_RESTART': '1', 18:33:38 INFO - 'PAGER': '/bin/cat', 18:33:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:38 INFO - 'PWD': '/builds/slave/test', 18:33:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:38 INFO - 'SHELL': '/bin/bash', 18:33:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 18:33:38 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 18:33:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:38 INFO - 'USER': 'cltbld', 18:33:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:38 INFO - 'XPC_FLAGS': '0x0', 18:33:38 INFO - 'XPC_SERVICE_NAME': '0', 18:33:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:33:38 INFO - Cleaning up... 18:33:38 INFO - Return code: 0 18:33:38 INFO - Running post-action listener: _resource_record_post_action 18:33:38 INFO - Running post-action listener: _start_resource_monitoring 18:33:38 INFO - Starting resource monitoring. 18:33:38 INFO - ##### 18:33:38 INFO - ##### Finished create-virtualenv step (success) 18:33:38 INFO - ##### 18:33:38 INFO - ##### 18:33:38 INFO - ##### Running install step. 18:33:38 INFO - ##### 18:33:38 INFO - Running pre-action listener: _resource_record_pre_action 18:33:38 INFO - Running main action method: install 18:33:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:33:39 INFO - Reading from file tmpfile_stdout 18:33:39 INFO - Detecting whether we're running mozinstall >=1.0... 18:33:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:33:39 INFO - Reading from file tmpfile_stdout 18:33:39 INFO - Output received: 18:33:39 INFO - Usage: mozinstall [options] installer 18:33:39 INFO - Options: 18:33:39 INFO - -h, --help show this help message and exit 18:33:39 INFO - -d DEST, --destination=DEST 18:33:39 INFO - Directory to install application into. [default: 18:33:39 INFO - "/builds/slave/test"] 18:33:39 INFO - --app=APP Application being installed. [default: firefox] 18:33:39 INFO - mkdir: /builds/slave/test/build/application 18:33:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:34:13 INFO - Reading from file tmpfile_stdout 18:34:13 INFO - Output received: 18:34:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:34:13 INFO - Running post-action listener: _resource_record_post_action 18:34:13 INFO - ##### 18:34:13 INFO - ##### Finished install step (success) 18:34:13 INFO - ##### 18:34:13 INFO - ##### 18:34:13 INFO - ##### Running run-tests step. 18:34:13 INFO - ##### 18:34:13 INFO - Running pre-action listener: _resource_record_pre_action 18:34:13 INFO - Running main action method: run_tests 18:34:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:34:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:34:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:34:13 INFO - 2016-07-08 18:34:13.351 screenresolution[1669:7551] starting screenresolution argv=screenresolution get 18:34:13 INFO - 2016-07-08 18:34:13.354 screenresolution[1669:7551] Display 0: 1600x1200x32@60 18:34:13 INFO - 2016-07-08 18:34:13.359 screenresolution[1670:7553] starting screenresolution argv=screenresolution list 18:34:13 INFO - Available Modes on Display 0 18:34:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:34:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:34:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:34:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:34:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:34:13 INFO - Intel Iris: 18:34:13 INFO - Chipset Model: Intel Iris 18:34:13 INFO - Type: GPU 18:34:13 INFO - Bus: Built-In 18:34:13 INFO - VRAM (Dynamic, Max): 1536 MB 18:34:13 INFO - Vendor: Intel (0x8086) 18:34:13 INFO - Device ID: 0x0a2e 18:34:13 INFO - Revision ID: 0x0009 18:34:13 INFO - Displays: 18:34:13 INFO - Display: 18:34:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:34:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:34:13 INFO - Display Serial Number: 1600x1200 60 18:34:13 INFO - Main Display: Yes 18:34:13 INFO - Mirror: Off 18:34:13 INFO - Online: Yes 18:34:13 INFO - Rotation: Supported 18:34:13 INFO - Return code: 0 18:34:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:34:13 INFO - Python 2.7.3 18:34:13 INFO - Return code: 0 18:34:13 INFO - grabbing minidump binary from tooltool 18:34: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')]} 18:34:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/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 0x106726d30>, '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 0x10648bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10671eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:34:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:34:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:34:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:34:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:34:13 INFO - Return code: 0 18:34:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:34:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:34:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:34:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:34:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:34:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--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 18:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0278 --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 18:34:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.StIKfeNW8Y/Render', 18:34:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:13 INFO - 'HOME': '/Users/cltbld', 18:34:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:13 INFO - 'LOGNAME': 'cltbld', 18:34:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:34:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:13 INFO - 'MOZ_NO_REMOTE': '1', 18:34:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:34:13 INFO - 'NO_EM_RESTART': '1', 18:34:13 INFO - 'PAGER': '/bin/cat', 18:34:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:13 INFO - 'PWD': '/builds/slave/test', 18:34:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:34:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:13 INFO - 'SHELL': '/bin/bash', 18:34:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners', 18:34:13 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 18:34:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:13 INFO - 'USER': 'cltbld', 18:34:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:13 INFO - 'XPC_FLAGS': '0x0', 18:34:13 INFO - 'XPC_SERVICE_NAME': '0', 18:34:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--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 18:34:13 INFO - mozversion application_buildid: 20160708152725 18:34:13 INFO - mozversion application_changeset: 4287a45df22d86765e15561a8834f6f3d00c24ec 18:34:13 INFO - mozversion application_display_name: Nightly 18:34:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:34:13 INFO - mozversion application_name: Firefox 18:34:13 INFO - mozversion application_remotingname: firefox 18:34:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:34:13 INFO - mozversion application_vendor: Mozilla 18:34:13 INFO - mozversion application_version: 50.0a1 18:34:13 INFO - mozversion platform_buildid: 20160708152725 18:34:13 INFO - mozversion platform_changeset: 4287a45df22d86765e15561a8834f6f3d00c24ec 18:34:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:34:13 INFO - mozversion platform_version: 50.0a1 18:34:13 INFO - using testdate: 1468028053 18:34:13 INFO - actual date: 1468028053 18:34:13 INFO - starting webserver on 'localhost:49266' 18:34:13 INFO - SUITE-START | Running 2 tests 18:34:13 INFO - TEST-START | dromaeo_css 18:34:13 INFO - operating with platform_type : mac_ 18:34:13 INFO - Initialising browser for dromaeo_css test... 18:34:13 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpycXHHg/profile http://localhost:49266/getInfo.html) 18:34:16 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 18:34:16 INFO - PROCESS | 1680 | colorDepth:24 18:34:16 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 18:34:16 INFO - PROCESS | 1680 | __metrics 18:34:16 INFO - PROCESS | 1680 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:34:16 INFO - PROCESS | 1680 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:34:16 INFO - TEST-INFO | 1680: exit 0 18:34:16 INFO - Browser initialized. 18:34:16 INFO - Running cycle 1/1 for dromaeo_css test... 18:34:16 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpycXHHg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:34:28 INFO - PROCESS | 1682 | RSS: Main: 243523584 18:34:28 INFO - PROCESS | 1682 | 18:35:20 INFO - PROCESS | 1682 | 1468028120677 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] 18:37:31 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 18:37:32 INFO - PROCESS | 1682 | RSS: Main: 386502656 18:37:32 INFO - PROCESS | 1682 | 18:40:35 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 18:40:36 INFO - PROCESS | 1682 | RSS: Main: 378462208 18:40:36 INFO - PROCESS | 1682 | 18:43:38 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 18:43:39 INFO - PROCESS | 1682 | RSS: Main: 369737728 18:43:39 INFO - PROCESS | 1682 | 18:46:41 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 18:46:42 INFO - PROCESS | 1682 | RSS: Main: 370966528 18:46:42 INFO - PROCESS | 1682 | 18:49:45 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 18:49:46 INFO - PROCESS | 1682 | RSS: Main: 338350080 18:49:46 INFO - PROCESS | 1682 | 18:52:49 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 18:52:49 INFO - PROCESS | 1682 | RSS: Main: 406016000 18:52:49 INFO - PROCESS | 1682 | 18:52:49 INFO - PROCESS | 1682 | __start_tp_report 18:52:49 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 18:52:49 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 18:52:49 INFO - PROCESS | 1682 | |i|pagename|runs| 18:52:49 INFO - PROCESS | 1682 | |0;dojo.html;3345.514900339451;3366.5623468949047;3384.712299454546;3396.711279541239;3438.277961628058;5568.805091821787;5630.042892708239;5686.573506986977;5769.740361683724;5817.912731309034;5738.885222295552;5765.164051212582;5847.386024467433;5864.061750119981;5880.529557635389;5189.273501709764;5200;5246.8688282792855;5267.683938963655;5344.839654810362;5317.8404647860625;5349.973250133744;5357.946420535804;5368.946310536903;5403.8108666196695;5179.922301165486;5188.066148093341;5239.345081864767;5268.183431568074;5268.92096618551;5170.767315470775;5188.169892817131;5206.323177986876;5256.448072952361;5316.3354580677415;5193.454687257859;5193.818216362409;5232.843014709565;5300.337457817773;5306.469353064701;5622.409646987048;5670.943290567124;5680.460356266148;5750.712464376765;5761;6250.562460627758;6297.433231009231;6303.55875088744;6316.96841515794;6318.178636777189;5207.765650545734;6352.364763523657;6360.427561519439;6361.522885783585;6364.904526432108;5648.378678345338;5720.656760594377;5721.4278572143285;5798.391168927202;5893.469587737124;6271.592346497463;6335.904961425582;6337.04944258365;6346.048092786026;6348.460380867586;6082.470111570179;6106.053561697944;6177.413145751147;6182.845428864314;6185.8144255672405;6245.656488893154;6287;6310.463610593151;6313.873722525524;6314.810555683337;6107.097787096137;6135.447809697149;6238.688065596702;6253.874922501615;6255.155554000152;6152.846178845564;6231.688415579203;6238.812835614939;6307;6342.460890824239;4969.90060198794;5013.323201367842;5020.995800839846;5022.924656130088;5055.09008378488;4433.756143412079;4461;4516.254817955067;4528.7509186994375;4570.9314360284625;5691.975444420044;5743.54051675865;5744.425557444222;5798.565107616945;5839.941600584025;6312;6314.463270622048;6350.142730731384;6363.61818290904;6383.425491705769;5595.07681232592;5671.262735844314;5768.134779783066;5768.721355064726;5826.096954971901;5410.107332290128;5435.646682965595;5447.754851031713;5452.536534394541;5454.863628409322;6254.061890716429;6274.996000639967;6301.779437719658;6342;6344.080108384166;5562.805301814417;6356.809295721136;6361.586496877688;6369.649669268235;6370.74517019314;5605.019121653776;6252.624842509464;6284.622922624657;6323.36766323364;6336.017917222838;6026.789062382795;6210.347913469021;6234.220722409699;6248.281447633399;6283.5601507895835;6292.4966002720585;6312.242530896322;6319.747210111544;6320.810375688737;6322.715477803602;5904.675242861512;5995.760169593167;6035;6087.66517841523;6159.784407545714;6132.35610260934;6148.78479253224;6163.445289923929;6178.845528861814;6205.720742566505;5976.432238937294;5992.101184822312;6014.248218972629;6018.247719035121;6023.488003519575;5972.641641501524;6030.6080104793045;6050.9394906050375;6176.81469555914;6178;5939.16851640762;5975.073863551156;5982.49148822355;5989.940100598938;6027.487663548647 18:52:49 INFO - PROCESS | 1682 | |1;ext.html;474.2554189921822;514.8172398798426;541.6154530283499;541.7074779619006;544.7330807904126;30488.695113048863;30857.691423085762;42876.356854647165;43148;43255.56744432555;45042.54957450433;45140.09719805602;45342.546574534244;45396;45471;9671.27465440093;9857.162141217968;9862.506874656274;9864.358816676893;9894.208463322953;9736;9859.654912078078;9872.308938374317;9881.95059024704;9887.209023278156;9556.80886382272;9856.162226210781;9906.504674766269;9908.900910990906;9915.058069483388;9804.362716423446;9872.851907221397;9884.357516761387;9887.505624718735;9892.50537473127;9365.625374984993;9682.806343873153;9783.853242201372;9784.804303913881;9788.363756355815;41842.79078604587;42114.789426052674;42135.57864421347;42142.367864482054;42206.57793422088;3492.8952131435844;3569.928601427983;3756.6619004289746;3934.744241624285;4202.894927626803;32326.515102273486;32984.83507582447;33114.50328245054;33510.1622459438;33547.4967875482;3263.853126609308;3409.9488507672404;3420.4185288501017;3420.794752314869;3451.119964409085;474008.6299568515;476118;476499.61750191374;478043;479091;62848.68575657092;62896;63202.68398658069;63504.68247658825;63564.36435635584;65095.67452162709;65127;65151;65164.67417662881;65281.67359163174;16735.83264167367;16963.236654350338;16977.236024378934;16981.745273820903;16995.150242487827;12962.092653514352;13018.218906865619;13033;13037.413316400785;13057.477700891857;17424.128793560525;17803.554911127325;17804.821951780315;17837.28650853977;17883.374081907332;5681.57388195887;6197.96901015492;6291.930371836799;6754.290799466084;6935.54918930278;902.4765635931276;951.4291425144858;965.753732798132;1004.6734811186394;1128.3173679923527;30518.847405763274;30981.380372392425;31302.719767360653;31434.685653143177;31662.68337316597;994.2145704893198;1032.4579595712162;1086.8750093739163;1104.7514309280348;1155.6764106050318;15609.843901561066;16238.431654892021;16246.75629865553;16402.67194656124;16611.003339799652;682019;702317;711626;712057.4397128085;948054;62471.687641561504;62623.68688156621;63270.68364658147;63539.6823015882;63569.36430635727;1221.407617305606;1288.9613311600667;1391.1861560986733;1407.4510940733123;1421.4243231491262;31552.053438396884;31650.68349316477;32288.677113229507;33131.17172070718;33208.33583328272;59600.40399595949;59696.40303597082;60529.78940421255;60569;60865;470538;470974;471292;472313;473227;22905.65641515345;24200.878995604908;26965.38207707544;27231.183064508095;27663.893444262005;42139.57860421479;50326.74836625793;50713.49286507235;50814.7296317595;51195.74402127966;36061;39651.80174099226;40528.797356013034;40673;42169.578304216564;38168.80915595404;40410.79794601008;40751.22433391732;41320.38019429651;41456.3781543271;38779.224415510966;39320.2135957285;39371.80314098411;39444.40833387444;39495.802520987214;31019.68980310168;34341.828290858386;35263;36013.0996725084;36254;25912;26030.34924126912;26315.73684263133;26624.8668756655;26892.327691807077 18:52:49 INFO - PROCESS | 1682 | |2;jquery.html;364.0589077235347;386.4010783285907;392.28016589558166;396.6925632634708;415.34168343176066;15652.530424087281;20115.698264526025;20626.690599641;21039.948002599886;21540.461488462795;20609.587808243865;20804;20841.06215220315;21692.240771572997;21727.13091476339;5140.408852981899;5406.675599464044;5594.8530551237;5713.628729105006;5956.463918247357;5755.136729490589;5832.096025116114;5834.474897259246;5866.9706651466895;5882.441168089046;5756.280464941882;5814.883702325972;5815.156802263669;5816.1275808628625;5822.1266809978415;6043.758249670008;6124.2957059938235;6124.601900876451;6147.231596050471;6154.369092190573;5418.593605479566;5467.316585426822;5751.25233719618;5824.88350232993;5906.616069955439;13308;13376.464941402332;13540;17138.657226855394;26363.20910372692;2217.4975659188885;2271.9889649106153;2345.44881952741;2870.7846911481515;3104.28601421672;9538.52307384628;9661.71014869555;10045.89954100457;10497.370157790558;10515.789684206273;1572.371051579366;1679.7312430011261;1871.2047379863504;1925.5763731978943;1976.2292705844732;109184;114334;117446;119175;121106.3944680271;9373.531323433937;9730.61077556904;11310.60412885545;11691.590794322157;11891.405429728478;12019.738155680378;13531;13548.119372240773;13561.118527295694;13585;8513.489190648581;8576.742697719079;8585.141485851365;8633.395662303705;8684.696035638723;8487.193716596914;8488.83022339562;8508.149185081442;8601.655933762704;8638.956805215934;3798.9430158547643;4507.5943165115295;4549.135664223787;4558.475775285885;4647.744374059459;1625.6423586810884;1628.8452597003266;1887.594167254047;1933.6519426503364;1934.5550523379702;874.7725591346295;968.2641192693462;985.0789511806483;987.1461186074138;1028.5063169678597;21816.890915545322;21827.454313642287;21963.195082032795;22826.201082962016;23024.769752302596;822.6339279020898;932.48247222792;965.5014691332792;1016.7443207638561;1087.7443800706828;9514.762130946781;10576.52405641748;11720.765584688428;11732.12009099321;11766.411679415995;642478;652702;656258;664972.4011039601;665244;73152.63423682848;74010.25989740141;107272.46363768131;143960;147951;1009.1321463541349;1032.726327523222;1044.4412239452008;1065.1532032034397;1070.0155856611937;15679.624444897425;19498.415047548595;19741.91419471943;19892.80643161415;19905.402837914884;34771.65228347684;55740;57386.42613573811;58058.7097064512;59267;75565.24434755582;77485;83294.58352708198;83692.32615347537;84306.57846710728;5570.61005729595;8136.633851476816;8165.101838797608;8179.550124743197;8440.324774018187;11227.831582526105;12996.870031299944;13182.736345273233;13386.799198012233;13414.865851341752;10037.5483103262;11193.99254067138;11632.709182270512;11646.883531164918;11680.532778688757;11281.943590281997;11405.828912566483;11463.598774042868;11516.94241528787;11623.941880290544;9441.52792360393;9729.805403891742;11273.492692828679;11864.466099025392;11888.34614096233;7008;7526.285002924714;7586.924130758843;7662.080550333772;8545.401821872409;10631.734206644896;11590.188686791844;11703.356315402734;11778.352190629597;11852.881471185523 18:52:49 INFO - PROCESS | 1682 | |3;mootools.html;1457.424317394629;1553.6115971007246;1773.9201735921881;1934.5260411199258;1948.1915005272813;8625.827483450335;8917.019127895943;9091.454512729233;9108.18026377626;9115.95442022789;7935.047794264682;8155;8163.6734530618705;8292.626831792568;8868.113188681145;2014.9697754533693;2144.496043429797;2295.7015587973624;2364.6925899633025;2378.2627385510546;2347.4366152123453;2354.858708477488;2379.95240095198;2381.166591692911;2383;2085.1346691123167;2289.3933107726466;2359.4101474631343;2375.5011447596025;2376.92869213923;2355.4464700795384;2383.678203442539;2398.0887262840183;2401.207601491521;2402.651615515758;2363.9527209455887;2364.2670772060546;2381;2385.1890357278435;2390.175389490623;8867.423617464909;8925.509096999662;8934.86597701035;8939.329550283755;8947.373683842134;5242.1088414969545;5357.249985002103;5390.110631745757;5403.78384864605;5413.296271484721;3503.9124021899656;3589.856405743767;3646.32542979547;3657.3965295726175;3660.6156353582755;1065.9946700266526;1107;1118.4743170709753;1119.7312644965232;1124.207433759206;11412.372319522423;11636.76726465466;11662.358570278631;11673.76652466946;11706;3859.614038596174;4673.299005149255;4811.422629284508;4814.061258054646;4848.781804818792;10007.549660265306;10102.747431314128;10117.797644047225;10119.089281964658;10153.695389138338;5394.703291318937;5397.973010135002;5409.486098820606;5415.702136382537;5416.160495123262;4434.046679963823;4605.148047611136;4728.905421891612;4862.51374862518;4935.975320123376;3941.4481972523868;3994.560598334181;4083.1833633273463;4088.2232375848494;4106.589341065869;1289.7162624222656;1299.6880748620263;1300.174389262825;1305.764962306794;1310.1614966421498;802.9839403211903;857.1385757313859;918.894327152386;930.437085563238;934.9626014959462;5843.678597677169;5850.473457388855;5889.676067816311;6063.181470501426;6113.5414843886;856.5845564901018;956.5791051937125;976.4239098931664;980.475445636581;997.2321312589265;3705.4627079073384;3714.8483969969398;3917.5494818095713;3955.841766329372;4023.7384570002855;10104.494775261208;10763.19276054299;10769.084627806567;10786.406747628798;10791;10241.385516869012;10563.788724225626;10740.838887416696;10755.300905441121;10799.082078023455;7130.358267755927;8290.4611200273;8317.8336433271;8319.334453243726;8334.49993000422;5821.330546987151;5890.911636325544;5900.055991041413;5940.138679891478;5987.520998320037;9881.96239394882;9908.35595686278;9929.900700993187;10005.54975026111;10028.899711003089;8987.281017518713;10064.798704026025;10260.743481413025;10346.793064138825;10371.63699270552;6792.626405547742;7021;7301.634918254173;7554.962225189059;7625.275598818325;8226.177382261965;8404.075551689431;8433.493990360597;8439.620217090369;8442.197991190827;7282.563046217244;7351.963240183765;7427.257274272745;7529.58587277705;7589.886151707618;6807.489438292049;6996.195437524546;7426.628668566658;7492.213317601573;7541.2458754124145;6999.370056694922;7036.612986285803;7068.893966590403;7082.858342833218;7087.184973728087;4872.342233798392;4874.488178741323;4933.407991041098;5019.84940451787;5073.822416215415;4992.850214493571;5057.216131499624;5106.693598384109;5122.129238029469;5201.713905735221 18:52:49 INFO - PROCESS | 1682 | |4;prototype.html;301.39419766269793;302.91972627253784;313.5344014139004;321.50648754162364;322.25237449118043;4274.829006839726;5014.348134742479;5237.166991552959;5259.948620038179;5371.758270877805;4192.811323490442;5074.213496907976;5126.795477944483;5211.973940130303;5236.31927849379;4092.774897380643;4118.464599602055;4133.276676581601;4137.793110344486;4142.502899652046;3782.4870051979156;3813.466114743938;4101.671866250707;4107.363358679395;4113.650339721127;3051.2219384057034;3859.321195280062;4030.838766449353;4050.1976620403934;4069.491313585802;4008.4788977432895;4022.8534867562603;4037.8788636340955;4056.4118202860714;4072.4705788247634;3550.467429885512;3557.4308110702164;3568.7145028397927;3570.357335679577;3590.2460483298537;4293.592108749695;4473.977630111861;4790.041991601694;4981.601471882241;5083.186690129562;4568.977155114237;4581.977090114528;4614.400127983375;4623.630109591225;4634.420697412824;5304.912492938938;5420.91868621971;5478.561715062825;5490.396056433789;5500.80747173851;3238.951415728766;3515.402381595135;3804;3809.733318667694;3917.5505063126825;5767.33675627304;5773.797917072882;5776.249087618625;5786.1069465267365;5927.8221653350465;3884.864029758945;3885.4366116913457;3885.55316138642;3911.164405805768;3914.3345631242187;3763.1156678180605;3833.4441505982036;3892.96107038926;3899.6880249579967;3933.056066544066;4504.864854054318;4527.3435351873795;4528.366028755977;4556.612687921497;4562.5665561771575;4816.446108697474;5076.258820237031;5473.67157970523;5536.584756143306;5625.465580769902;1160.6982184631888;1249.6750844780422;1278.571678487717;1296.572131196703;1314.625331780438;840.7267638017669;883.7172104926361;897.717219075989;902.2691619787993;912.5482885971487;4559.726416415026;4797.232442809134;5036.546710796046;5106.183010718267;5136.255242989746;5322.467753224724;5605.552585160097;5647.915281270784;5660.377358490645;5708.429157084258;4955.810605454737;4989.825356112518;5073.416557095908;5097.260897169964;5114.130597798383;2323.953520929572;2521.394865232368;2715.6557504035236;2821.548552231674;2934.9706502934696;4619.745913974763;5749.770009199585;5767.538596912237;6017.488513476404;6038.607490513103;5206.088934436459;5889.587728858939;5895.941040589625;5922.911156332659;5973.432523910222;4580.839670611513;5705.429457054427;5902.321233058167;6006.849828754316;6091.238595175603;4794.489735733233;5441.782328706966;5740.425957404394;5807.186993820953;5863.824085277449;5597.132444471114;5749.511291540099;5767.452092051249;5803.970980145073;5821.27234095738;4871.661602430924;5478.561715062865;5523.28197334344;5780.976658169607;5795.507381872588;3870.5161854768153;3878.030492376906;3887.5140607424073;3892.5328960524917;3907.7069219809196;5781.739821707949;5783.566232532493;5790.565707572033;5817.996522990141;5833.745744664918;5195.298634684269;5583.553315734813;5620.606557540933;5661.858453538694;5674.631148975303;4563.863084107482;5323.653962492425;5423.078076727044;5549.833504994856;5597.305778186377;4821.734804585782;4861.52401033263;5363.570914326767;5437.483439073281;5568.638038527482;5055.963527476785;5428.864278393072;5545.916811247916;5589.860253493695;5596.832095037155;4761.857144285677;5193.545193545164;5422.403535611158;5435.619506634655;5478.863028424162 18:52:49 INFO - PROCESS | 1682 | |5;yui.html;637.4995628431682;742.7029188324673;752.1012390193714;795.5783434779569;854.6068808348159;15019.24903754812;16293.266802993865;16344.346226150954;16347.26437310321;16349.918250408746;14734.263286835669;14920.328585213665;14941.551753447387;14971.925140374311;14981.550553483386;707.0913875669766;722.5881247688819;880.6565439478609;887.40987243483;910.3445519226179;882.1707594860842;900.1673452056821;900.2617853360247;901.7204666553357;902.5081330674798;968.7674958010062;972.2853702528636;973.3429934793986;976.24828881761;976.3556053005018;754.2871985973285;933.3746389918771;964.4358050540442;964.8118616869713;971.0580736685404;718.2314923032358;718.267367285366;718.586812582767;719.3633634233688;724.5145752345941;14828.3327250274;14915;14916.403343866232;14936.701265974729;14952.327145278488;14070.788938165935;14130.364133614012;14182.716345673132;14206.360713767905;14248.501302454468;13039.413226404835;13188.472461101544;13343.666408339772;13407.99440041991;13410.994175436881;4577.382053422779;4593.081383723235;4724.291356296549;4826.806927722887;4875.926861097087;110821.44589277002;111052;111195.33207001901;111350.44324778405;115446;11247.381394023243;11269.211155219056;11364.261323013978;11434.656960291039;11698.590549330733;22188;22238.888805555867;22252.109915603196;22266.22068227604;22270;7421.332080112816;7945.562994035384;7971.242731940456;8025.077116131602;8204.138565450661;4354.8911277217685;4379.080393117481;4392.538783427758;4452.243118669834;4627.629789616823;3157.6579953519663;3355.6308806031316;3578.0697018774786;3578.570571531433;3580.1765593913024;627.7520379450092;654.0777503719733;658.2232965101131;666.0275997044273;676.9559978601375;621.7450845153465;630.2594451519537;651.771879842061;654.1071437487794;656.1175219329994;8604.741857744277;9085.227755640844;9100.544972751335;9116.361854670242;9175.58709858058;590.952723782105;593.3354642800092;621.8973869311513;624.2041397218583;643.4659232836734;4369.781510924441;4406.867793966187;4421.4915284742665;4431.645468362523;4442.178197033559;153625;154295.45704543035;154615;154658.226708868;156842;106727;134435;134739;136644.86670787423;140100;109710.45144774225;109917;110881;111053.11314104129;111353.77292454106;8537.359698022548;8553.914460855562;8653.350998674998;8656;8735.650573977224;51044;62962.68518657378;62993.370066298754;63762;63791.68104159449;89650.55174724084;93188;94481;97377.51311243682;100568;11554.942225289156;11658.88341116612;11689.590864319707;11702.648920532398;11798.764024719629;11978.64064078079;12043.518259269882;12092.153549251469;12096.213746106476;12616;11861.822072668745;12072.517099316281;12200.694982625506;12335.321557314075;12383.566575169825;11647.6505704829;11868.525258989544;11931.76136477283;12155.209911355734;12190.146689731633;11658.300501969909;11848.229865058744;11998.940005299917;12117.454714537691;12194.268343899394;8344.207300306462;9679.419234845931;9845.950770246103;9921.454320012468;9995;7846.9109456878705;9571.569279382305;9872.259580531632;9881.20950323958;9885.50572471388 18:52:49 INFO - PROCESS | 1682 | __end_tp_report 18:52:49 INFO - PROCESS | 1682 | __start_cc_report 18:52:49 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1429 18:52:49 INFO - PROCESS | 1682 | __end_cc_report 18:52:49 INFO - PROCESS | 1682 | __startTimestamp1468029169417__endTimestamp 18:52:49 INFO - PROCESS | 1682 | 18:52:49 INFO - PROCESS | 1682 | ------- Summary: start ------- 18:52:49 INFO - PROCESS | 1682 | Number of tests: 6 18:52:49 INFO - PROCESS | 1682 | 18:52:49 INFO - PROCESS | 1682 | [#0] dojo.html Cycles:165 Average:5774.57 Median:5976.43 stddev:633.77 (10.6%) stddev-sans-first:606.40 18:52:49 INFO - PROCESS | 1682 | Values: 3345.5 3366.6 3384.7 3396.7 3438.3 5568.8 5630.0 5686.6 5769.7 5817.9 5738.9 5765.2 5847.4 5864.1 5880.5 5189.3 5200.0 5246.9 5267.7 5344.8 5317.8 5350.0 5357.9 5368.9 5403.8 5179.9 5188.1 5239.3 5268.2 5268.9 5170.8 5188.2 5206.3 5256.4 5316.3 5193.5 5193.8 5232.8 5300.3 5306.5 5622.4 5670.9 5680.5 5750.7 5761.0 6250.6 6297.4 6303.6 6317.0 6318.2 5207.8 6352.4 6360.4 6361.5 6364.9 5648.4 5720.7 5721.4 5798.4 5893.5 6271.6 6335.9 6337.0 6346.0 6348.5 6082.5 6106.1 6177.4 6182.8 6185.8 6245.7 6287.0 6310.5 6313.9 6314.8 6107.1 6135.4 6238.7 6253.9 6255.2 6152.8 6231.7 6238.8 6307.0 6342.5 4969.9 5013.3 5021.0 5022.9 5055.1 4433.8 4461.0 4516.3 4528.8 4570.9 5692.0 5743.5 5744.4 5798.6 5839.9 6312.0 6314.5 6350.1 6363.6 6383.4 5595.1 5671.3 5768.1 5768.7 5826.1 5410.1 5435.6 5447.8 5452.5 5454.9 6254.1 6275.0 6301.8 6342.0 6344.1 5562.8 6356.8 6361.6 6369.6 6370.7 5605.0 6252.6 6284.6 6323.4 6336.0 6026.8 6210.3 6234.2 6248.3 6283.6 6292.5 6312.2 6319.7 6320.8 6322.7 5904.7 5995.8 6035.0 6087.7 6159.8 6132.4 6148.8 6163.4 6178.8 6205.7 5976.4 5992.1 6014.2 6018.2 6023.5 5972.6 6030.6 6050.9 6176.8 6178.0 5939.2 5975.1 5982.5 5989.9 6027.5 18:52:49 INFO - PROCESS | 1682 | 18:52:49 INFO - PROCESS | 1682 | [#1] ext.html Cycles:180 Average:71090.07 Median:42140.97 stddev:156567.18 (371.5%) stddev-sans-first:156916.62 18:52:49 INFO - PROCESS | 1682 | Values: 474.3 514.8 541.6 541.7 544.7 30488.7 30857.7 42876.4 43148.0 43255.6 45042.5 45140.1 45342.5 45396.0 45471.0 9671.3 9857.2 9862.5 9864.4 9894.2 9736.0 9859.7 9872.3 9882.0 9887.2 9556.8 9856.2 9906.5 9908.9 9915.1 9804.4 9872.9 9884.4 9887.5 9892.5 9365.6 9682.8 9783.9 9784.8 9788.4 41842.8 42114.8 42135.6 42142.4 42206.6 3492.9 3569.9 3756.7 3934.7 4202.9 32326.5 32984.8 33114.5 33510.2 33547.5 3263.9 3409.9 3420.4 3420.8 3451.1 474008.6 476118.0 476499.6 478043.0 479091.0 62848.7 62896.0 63202.7 63504.7 63564.4 65095.7 65127.0 65151.0 65164.7 65281.7 16735.8 16963.2 16977.2 16981.7 16995.2 12962.1 13018.2 13033.0 13037.4 13057.5 17424.1 17803.6 17804.8 17837.3 17883.4 5681.6 6198.0 6291.9 6754.3 6935.5 902.5 951.4 965.8 1004.7 1128.3 30518.8 30981.4 31302.7 31434.7 31662.7 994.2 1032.5 1086.9 1104.8 1155.7 15609.8 16238.4 16246.8 16402.7 16611.0 682019.0 702317.0 711626.0 712057.4 948054.0 62471.7 62623.7 63270.7 63539.7 63569.4 1221.4 1289.0 1391.2 1407.5 1421.4 31552.1 31650.7 32288.7 33131.2 33208.3 59600.4 59696.4 60529.8 60569.0 60865.0 470538.0 470974.0 471292.0 472313.0 473227.0 22905.7 24200.9 26965.4 27231.2 27663.9 42139.6 50326.7 50713.5 50814.7 51195.7 36061.0 39651.8 40528.8 40673.0 42169.6 38168.8 40410.8 40751.2 41320.4 41456.4 38779.2 39320.2 39371.8 39444.4 39495.8 31019.7 34341.8 35263.0 36013.1 36254.0 25912.0 26030.3 26315.7 26624.9 26892.3 18:52:49 INFO - PROCESS | 1682 | 18:52:49 INFO - PROCESS | 1682 | [#2] jquery.html Cycles:180 Average:35921.60 Median:14354.33 stddev:108832.42 (758.2%) stddev-sans-first:109104.98 18:52:49 INFO - PROCESS | 1682 | Values: 364.1 386.4 392.3 396.7 415.3 15652.5 20115.7 20626.7 21039.9 21540.5 20609.6 20804.0 20841.1 21692.2 21727.1 5140.4 5406.7 5594.9 5713.6 5956.5 5755.1 5832.1 5834.5 5867.0 5882.4 5756.3 5814.9 5815.2 5816.1 5822.1 6043.8 6124.3 6124.6 6147.2 6154.4 5418.6 5467.3 5751.3 5824.9 5906.6 13308.0 13376.5 13540.0 17138.7 26363.2 2217.5 2272.0 2345.4 2870.8 3104.3 9538.5 9661.7 10045.9 10497.4 10515.8 1572.4 1679.7 1871.2 1925.6 1976.2 109184.0 114334.0 117446.0 119175.0 121106.4 9373.5 9730.6 11310.6 11691.6 11891.4 12019.7 13531.0 13548.1 13561.1 13585.0 8513.5 8576.7 8585.1 8633.4 8684.7 8487.2 8488.8 8508.1 8601.7 8639.0 3798.9 4507.6 4549.1 4558.5 4647.7 1625.6 1628.8 1887.6 1933.7 1934.6 874.8 968.3 985.1 987.1 1028.5 21816.9 21827.5 21963.2 22826.2 23024.8 822.6 932.5 965.5 1016.7 1087.7 9514.8 10576.5 11720.8 11732.1 11766.4 642478.0 652702.0 656258.0 664972.4 665244.0 73152.6 74010.3 107272.5 143960.0 147951.0 1009.1 1032.7 1044.4 1065.2 1070.0 15679.6 19498.4 19741.9 19892.8 19905.4 34771.7 55740.0 57386.4 58058.7 59267.0 75565.2 77485.0 83294.6 83692.3 84306.6 5570.6 8136.6 8165.1 8179.6 8440.3 11227.8 12996.9 13182.7 13386.8 13414.9 10037.5 11194.0 11632.7 11646.9 11680.5 11281.9 11405.8 11463.6 11516.9 11623.9 9441.5 9729.8 11273.5 11864.5 11888.3 7008.0 7526.3 7586.9 7662.1 8545.4 10631.7 11590.2 11703.4 11778.4 11852.9 18:52:49 INFO - PROCESS | 1682 | 18:52:49 INFO - PROCESS | 1682 | [#3] mootools.html Cycles:180 Average:5715.39 Median:4873.42 stddev:3187.14 (65.4%) stddev-sans-first:3180.02 18:52:49 INFO - PROCESS | 1682 | Values: 1457.4 1553.6 1773.9 1934.5 1948.2 8625.8 8917.0 9091.5 9108.2 9116.0 7935.0 8155.0 8163.7 8292.6 8868.1 2015.0 2144.5 2295.7 2364.7 2378.3 2347.4 2354.9 2380.0 2381.2 2383.0 2085.1 2289.4 2359.4 2375.5 2376.9 2355.4 2383.7 2398.1 2401.2 2402.7 2364.0 2364.3 2381.0 2385.2 2390.2 8867.4 8925.5 8934.9 8939.3 8947.4 5242.1 5357.2 5390.1 5403.8 5413.3 3503.9 3589.9 3646.3 3657.4 3660.6 1066.0 1107.0 1118.5 1119.7 1124.2 11412.4 11636.8 11662.4 11673.8 11706.0 3859.6 4673.3 4811.4 4814.1 4848.8 10007.5 10102.7 10117.8 10119.1 10153.7 5394.7 5398.0 5409.5 5415.7 5416.2 4434.0 4605.1 4728.9 4862.5 4936.0 3941.4 3994.6 4083.2 4088.2 4106.6 1289.7 1299.7 1300.2 1305.8 1310.2 803.0 857.1 918.9 930.4 935.0 5843.7 5850.5 5889.7 6063.2 6113.5 856.6 956.6 976.4 980.5 997.2 3705.5 3714.8 3917.5 3955.8 4023.7 10104.5 10763.2 10769.1 10786.4 10791.0 10241.4 10563.8 10740.8 10755.3 10799.1 7130.4 8290.5 8317.8 8319.3 8334.5 5821.3 5890.9 5900.1 5940.1 5987.5 9882.0 9908.4 9929.9 10005.5 10028.9 8987.3 10064.8 10260.7 10346.8 10371.6 6792.6 7021.0 7301.6 7555.0 7625.3 8226.2 8404.1 8433.5 8439.6 8442.2 7282.6 7352.0 7427.3 7529.6 7589.9 6807.5 6996.2 7426.6 7492.2 7541.2 6999.4 7036.6 7068.9 7082.9 7087.2 4872.3 4874.5 4933.4 5019.8 5073.8 4992.9 5057.2 5106.7 5122.1 5201.7 18:52:49 INFO - PROCESS | 1682 | 18:52:49 INFO - PROCESS | 1682 | [#4] prototype.html Cycles:180 Average:4509.13 Median:5046.26 stddev:1390.10 (27.5%) stddev-sans-first:1357.65 18:52:49 INFO - PROCESS | 1682 | Values: 301.4 302.9 313.5 321.5 322.3 4274.8 5014.3 5237.2 5259.9 5371.8 4192.8 5074.2 5126.8 5212.0 5236.3 4092.8 4118.5 4133.3 4137.8 4142.5 3782.5 3813.5 4101.7 4107.4 4113.7 3051.2 3859.3 4030.8 4050.2 4069.5 4008.5 4022.9 4037.9 4056.4 4072.5 3550.5 3557.4 3568.7 3570.4 3590.2 4293.6 4474.0 4790.0 4981.6 5083.2 4569.0 4582.0 4614.4 4623.6 4634.4 5304.9 5420.9 5478.6 5490.4 5500.8 3239.0 3515.4 3804.0 3809.7 3917.6 5767.3 5773.8 5776.2 5786.1 5927.8 3884.9 3885.4 3885.6 3911.2 3914.3 3763.1 3833.4 3893.0 3899.7 3933.1 4504.9 4527.3 4528.4 4556.6 4562.6 4816.4 5076.3 5473.7 5536.6 5625.5 1160.7 1249.7 1278.6 1296.6 1314.6 840.7 883.7 897.7 902.3 912.5 4559.7 4797.2 5036.5 5106.2 5136.3 5322.5 5605.6 5647.9 5660.4 5708.4 4955.8 4989.8 5073.4 5097.3 5114.1 2324.0 2521.4 2715.7 2821.5 2935.0 4619.7 5749.8 5767.5 6017.5 6038.6 5206.1 5889.6 5895.9 5922.9 5973.4 4580.8 5705.4 5902.3 6006.8 6091.2 4794.5 5441.8 5740.4 5807.2 5863.8 5597.1 5749.5 5767.5 5804.0 5821.3 4871.7 5478.6 5523.3 5781.0 5795.5 3870.5 3878.0 3887.5 3892.5 3907.7 5781.7 5783.6 5790.6 5818.0 5833.7 5195.3 5583.6 5620.6 5661.9 5674.6 4563.9 5323.7 5423.1 5549.8 5597.3 4821.7 4861.5 5363.6 5437.5 5568.6 5056.0 5428.9 5545.9 5589.9 5596.8 4761.9 5193.5 5422.4 5435.6 5478.9 18:52:49 INFO - PROCESS | 1682 | 18:52:49 INFO - PROCESS | 1682 | [#5] yui.html Cycles:180 Average:24981.36 Median:4414.18 stddev:40644.02 (920.8%) stddev-sans-first:40716.94 18:52:49 INFO - PROCESS | 1682 | Values: 637.5 742.7 752.1 795.6 854.6 15019.2 16293.3 16344.3 16347.3 16349.9 14734.3 14920.3 14941.6 14971.9 14981.6 707.1 722.6 880.7 887.4 910.3 882.2 900.2 900.3 901.7 902.5 968.8 972.3 973.3 976.2 976.4 754.3 933.4 964.4 964.8 971.1 718.2 718.3 718.6 719.4 724.5 14828.3 14915.0 14916.4 14936.7 14952.3 14070.8 14130.4 14182.7 14206.4 14248.5 13039.4 13188.5 13343.7 13408.0 13411.0 4577.4 4593.1 4724.3 4826.8 4875.9 110821.4 111052.0 111195.3 111350.4 115446.0 11247.4 11269.2 11364.3 11434.7 11698.6 22188.0 22238.9 22252.1 22266.2 22270.0 7421.3 7945.6 7971.2 8025.1 8204.1 4354.9 4379.1 4392.5 4452.2 4627.6 3157.7 3355.6 3578.1 3578.6 3580.2 627.8 654.1 658.2 666.0 677.0 621.7 630.3 651.8 654.1 656.1 8604.7 9085.2 9100.5 9116.4 9175.6 591.0 593.3 621.9 624.2 643.5 4369.8 4406.9 4421.5 4431.6 4442.2 153625.0 154295.5 154615.0 154658.2 156842.0 106727.0 134435.0 134739.0 136644.9 140100.0 109710.5 109917.0 110881.0 111053.1 111353.8 8537.4 8553.9 8653.4 8656.0 8735.7 51044.0 62962.7 62993.4 63762.0 63791.7 89650.6 93188.0 94481.0 97377.5 100568.0 11554.9 11658.9 11689.6 11702.6 11798.8 11978.6 12043.5 12092.2 12096.2 12616.0 11861.8 12072.5 12200.7 12335.3 12383.6 11647.7 11868.5 11931.8 12155.2 12190.1 11658.3 11848.2 11998.9 12117.5 12194.3 8344.2 9679.4 9846.0 9921.5 9995.0 7846.9 9571.6 9872.3 9881.2 9885.5 18:52:49 INFO - PROCESS | 1682 | -------- Summary: end -------- 18:52:49 INFO - PROCESS | 1682 | 18:52:50 INFO - TEST-INFO | 1682: exit 0 18:52:50 INFO - TEST-OK | dromaeo_css | took 1116107ms 18:52:50 INFO - TEST-START | kraken 18:52:50 INFO - operating with platform_type : mac_ 18:52:50 INFO - Initialising browser for kraken test... 18:52:50 INFO - TEST-INFO | started process 1801 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpeN2uD9/profile http://localhost:49266/getInfo.html) 18:52:52 INFO - PROCESS | 1801 | __metrics Screen width/height:1600/1200 18:52:52 INFO - PROCESS | 1801 | colorDepth:24 18:52:52 INFO - PROCESS | 1801 | Browser inner width/height: 1024/689 18:52:52 INFO - PROCESS | 1801 | __metrics 18:52:52 INFO - PROCESS | 1801 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:52:52 INFO - PROCESS | 1801 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:52:52 INFO - TEST-INFO | 1801: exit 0 18:52:52 INFO - Browser initialized. 18:52:52 INFO - Running cycle 1/1 for kraken test... 18:52:52 INFO - TEST-INFO | started process 1802 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpeN2uD9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:53:04 INFO - PROCESS | 1802 | RSS: Main: 243638272 18:53:04 INFO - PROCESS | 1802 | 18:53:07 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 18:53:08 INFO - PROCESS | 1802 | RSS: Main: 294502400 18:53:08 INFO - PROCESS | 1802 | 18:53:11 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 18:53:11 INFO - PROCESS | 1802 | RSS: Main: 305897472 18:53:11 INFO - PROCESS | 1802 | 18:53:15 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 18:53:15 INFO - PROCESS | 1802 | RSS: Main: 393756672 18:53:15 INFO - PROCESS | 1802 | 18:53:17 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 18:53:18 INFO - PROCESS | 1802 | RSS: Main: 294334464 18:53:18 INFO - PROCESS | 1802 | 18:53:20 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:53:21 INFO - PROCESS | 1802 | RSS: Main: 298356736 18:53:21 INFO - PROCESS | 1802 | 18:53:23 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 18:53:24 INFO - PROCESS | 1802 | RSS: Main: 334610432 18:53:24 INFO - PROCESS | 1802 | 18:53:27 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 18:53:27 INFO - PROCESS | 1802 | RSS: Main: 335974400 18:53:27 INFO - PROCESS | 1802 | 18:53:30 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 18:53:31 INFO - PROCESS | 1802 | RSS: Main: 335794176 18:53:31 INFO - PROCESS | 1802 | 18:53:32 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:53:33 INFO - PROCESS | 1802 | RSS: Main: 313704448 18:53:33 INFO - PROCESS | 1802 | 18:53:35 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:53:35 INFO - PROCESS | 1802 | RSS: Main: 320757760 18:53:35 INFO - PROCESS | 1802 | 18:53:38 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:53:38 INFO - PROCESS | 1802 | RSS: Main: 318537728 18:53:38 INFO - PROCESS | 1802 | 18:53:41 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:53:42 INFO - PROCESS | 1802 | RSS: Main: 328015872 18:53:42 INFO - PROCESS | 1802 | 18:53:45 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:53:45 INFO - PROCESS | 1802 | RSS: Main: 330182656 18:53:45 INFO - PROCESS | 1802 | 18:53:47 INFO - PROCESS | 1802 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 18:53:48 INFO - PROCESS | 1802 | RSS: Main: 373403648 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | __start_tp_report 18:53:48 INFO - PROCESS | 1802 | _x_x_mozilla_page_load 18:53:48 INFO - PROCESS | 1802 | _x_x_mozilla_page_load_details 18:53:48 INFO - PROCESS | 1802 | |i|pagename|runs| 18:53:48 INFO - PROCESS | 1802 | |0;ai-astar;100;112;117;161;112;111;110;110;108;111 18:53:48 INFO - PROCESS | 1802 | |1;audio-beat-detection;142;107;109;189;140;141;125;108;158;106 18:53:48 INFO - PROCESS | 1802 | |2;audio-dft;184;182;184;183;183;181;184;184;180;183 18:53:48 INFO - PROCESS | 1802 | |3;audio-fft;77;76;75;137;61;57;61;70;83;58 18:53:48 INFO - PROCESS | 1802 | |4;audio-oscillator;86;90;91;69;71;68;96;70;67;98 18:53:48 INFO - PROCESS | 1802 | |5;imaging-gaussian-blur;88;85;88;84;88;83;88;85;87;83 18:53:48 INFO - PROCESS | 1802 | |6;imaging-darkroom;93;94;93;95;94;93;93;93;94;93 18:53:48 INFO - PROCESS | 1802 | |7;imaging-desaturate;86;87;85;83;83;87;84;85;84;84 18:53:48 INFO - PROCESS | 1802 | |8;json-parse-financial;55;55;55;53;56;53;53;55;53;53 18:53:48 INFO - PROCESS | 1802 | |9;json-stringify-tinderbox;66;72;73;74;70;70;69;71;70;72 18:53:48 INFO - PROCESS | 1802 | |10;stanford-crypto-aes;83;82;83;84;98;104;98;75;85;85 18:53:48 INFO - PROCESS | 1802 | |11;stanford-crypto-ccm;135;133;136;136;144;147;137;136;205;150 18:53:48 INFO - PROCESS | 1802 | |12;stanford-crypto-pbkdf2;164;165;163;164;166;167;162;163;158;211 18:53:48 INFO - PROCESS | 1802 | |13;stanford-crypto-sha256-iterative;68;68;75;84;87;75;66;66;67;63 18:53:48 INFO - PROCESS | 1802 | __end_tp_report 18:53:48 INFO - PROCESS | 1802 | __start_cc_report 18:53:48 INFO - PROCESS | 1802 | _x_x_mozilla_cycle_collect,2021 18:53:48 INFO - PROCESS | 1802 | __end_cc_report 18:53:48 INFO - PROCESS | 1802 | __startTimestamp1468029228010__endTimestamp 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | ------- Summary: start ------- 18:53:48 INFO - PROCESS | 1802 | Number of tests: 14 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | [#0] ai-astar Cycles:10 Average:115.20 Median:111.50 stddev:16.65 (14.9%) stddev-sans-first:16.72 18:53:48 INFO - PROCESS | 1802 | Values: 100.0 112.0 117.0 161.0 112.0 111.0 110.0 110.0 108.0 111.0 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:140.50 stddev:27.13 (19.3%) stddev-sans-first:28.55 18:53:48 INFO - PROCESS | 1802 | Values: 142.0 107.0 109.0 189.0 140.0 141.0 125.0 108.0 158.0 106.0 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.50 stddev:1.40 (0.8%) stddev-sans-first:1.41 18:53:48 INFO - PROCESS | 1802 | Values: 184.0 182.0 184.0 183.0 183.0 181.0 184.0 184.0 180.0 183.0 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | [#3] audio-fft Cycles:10 Average:75.50 Median:72.50 stddev:23.43 (32.3%) stddev-sans-first:24.84 18:53:48 INFO - PROCESS | 1802 | Values: 77.0 76.0 75.0 137.0 61.0 57.0 61.0 70.0 83.0 58.0 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | [#4] audio-oscillator Cycles:10 Average:80.60 Median:88.00 stddev:12.69 (14.4%) stddev-sans-first:13.30 18:53:48 INFO - PROCESS | 1802 | Values: 86.0 90.0 91.0 69.0 71.0 68.0 96.0 70.0 67.0 98.0 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.50 stddev:2.13 (2.4%) stddev-sans-first:2.12 18:53:48 INFO - PROCESS | 1802 | Values: 88.0 85.0 88.0 84.0 88.0 83.0 88.0 85.0 87.0 83.0 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:93.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 18:53:48 INFO - PROCESS | 1802 | Values: 93.0 94.0 93.0 95.0 94.0 93.0 93.0 93.0 94.0 93.0 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.48 (1.7%) stddev-sans-first:1.50 18:53:48 INFO - PROCESS | 1802 | Values: 86.0 87.0 85.0 83.0 83.0 87.0 84.0 85.0 84.0 84.0 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:55.00 stddev:1.20 (2.2%) stddev-sans-first:1.22 18:53:48 INFO - PROCESS | 1802 | Values: 55.0 55.0 55.0 53.0 56.0 53.0 53.0 55.0 53.0 53.0 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.50 stddev:2.26 (3.2%) stddev-sans-first:1.64 18:53:48 INFO - PROCESS | 1802 | Values: 66.0 72.0 73.0 74.0 70.0 70.0 69.0 71.0 70.0 72.0 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:84.50 stddev:9.09 (10.8%) stddev-sans-first:9.48 18:53:48 INFO - PROCESS | 1802 | Values: 83.0 82.0 83.0 84.0 98.0 104.0 98.0 75.0 85.0 85.0 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:140.50 stddev:21.53 (15.3%) stddev-sans-first:22.47 18:53:48 INFO - PROCESS | 1802 | Values: 135.0 133.0 136.0 136.0 144.0 147.0 137.0 136.0 205.0 150.0 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:164.50 stddev:15.20 (9.2%) stddev-sans-first:16.05 18:53:48 INFO - PROCESS | 1802 | Values: 164.0 165.0 163.0 164.0 166.0 167.0 162.0 163.0 158.0 211.0 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - PROCESS | 1802 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:71.50 stddev:8.14 (11.4%) stddev-sans-first:8.51 18:53:48 INFO - PROCESS | 1802 | Values: 68.0 68.0 75.0 84.0 87.0 75.0 66.0 66.0 67.0 63.0 18:53:48 INFO - PROCESS | 1802 | -------- Summary: end -------- 18:53:48 INFO - PROCESS | 1802 | 18:53:48 INFO - TEST-INFO | 1802: exit 0 18:53:49 INFO - TEST-OK | kraken | took 58960ms 18:53:49 INFO - SUITE-END | took 1175s 18:53:49 INFO - Completed test suite (00:19:35) 18:53:49 INFO - javascript benchmark 18:53:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3345.514900339451, 3366.5623468949047, 3384.712299454546, 3396.711279541239, 3438.277961628058, 5568.805091821787, 5630.042892708239, 5686.573506986977, 5769.740361683724, 5817.912731309034, 5738.885222295552, 5765.164051212582, 5847.386024467433, 5864.061750119981, 5880.529557635389, 5189.273501709764, 5200.0, 5246.8688282792855, 5267.683938963655, 5344.839654810362, 5317.8404647860625, 5349.973250133744, 5357.946420535804, 5368.946310536903, 5403.8108666196695, 5179.922301165486, 5188.066148093341, 5239.345081864767, 5268.183431568074, 5268.92096618551, 5170.767315470775, 5188.169892817131, 5206.323177986876, 5256.448072952361, 5316.3354580677415, 5193.454687257859, 5193.818216362409, 5232.843014709565, 5300.337457817773, 5306.469353064701, 5622.409646987048, 5670.943290567124, 5680.460356266148, 5750.712464376765, 5761.0, 6250.562460627758, 6297.433231009231, 6303.55875088744, 6316.96841515794, 6318.178636777189, 5207.765650545734, 6352.364763523657, 6360.427561519439, 6361.522885783585, 6364.904526432108, 5648.378678345338, 5720.656760594377, 5721.4278572143285, 5798.391168927202, 5893.469587737124, 6271.592346497463, 6335.904961425582, 6337.04944258365, 6346.048092786026, 6348.460380867586, 6082.470111570179, 6106.053561697944, 6177.413145751147, 6182.845428864314, 6185.8144255672405, 6245.656488893154, 6287.0, 6310.463610593151, 6313.873722525524, 6314.810555683337, 6107.097787096137, 6135.447809697149, 6238.688065596702, 6253.874922501615, 6255.155554000152, 6152.846178845564, 6231.688415579203, 6238.812835614939, 6307.0, 6342.460890824239, 4969.90060198794, 5013.323201367842, 5020.995800839846, 5022.924656130088, 5055.09008378488, 4433.756143412079, 4461.0, 4516.254817955067, 4528.7509186994375, 4570.9314360284625, 5691.975444420044, 5743.54051675865, 5744.425557444222, 5798.565107616945, 5839.941600584025, 6312.0, 6314.463270622048, 6350.142730731384, 6363.61818290904, 6383.425491705769, 5595.07681232592, 5671.262735844314, 5768.134779783066, 5768.721355064726, 5826.096954971901, 5410.107332290128, 5435.646682965595, 5447.754851031713, 5452.536534394541, 5454.863628409322, 6254.061890716429, 6274.996000639967, 6301.779437719658, 6342.0, 6344.080108384166, 5562.805301814417, 6356.809295721136, 6361.586496877688, 6369.649669268235, 6370.74517019314, 5605.019121653776, 6252.624842509464, 6284.622922624657, 6323.36766323364, 6336.017917222838, 6026.789062382795, 6210.347913469021, 6234.220722409699, 6248.281447633399, 6283.5601507895835, 6292.4966002720585, 6312.242530896322, 6319.747210111544, 6320.810375688737, 6322.715477803602, 5904.675242861512, 5995.760169593167, 6035.0, 6087.66517841523, 6159.784407545714, 6132.35610260934, 6148.78479253224, 6163.445289923929, 6178.845528861814, 6205.720742566505, 5976.432238937294, 5992.101184822312, 6014.248218972629, 6018.247719035121, 6023.488003519575, 5972.641641501524, 6030.6080104793045, 6050.9394906050375, 6176.81469555914, 6178.0, 5939.16851640762, 5975.073863551156, 5982.49148822355, 5989.940100598938, 6027.487663548647], "value": 5734.656851746009, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.2554189921822, 514.8172398798426, 541.6154530283499, 541.7074779619006, 544.7330807904126, 30488.695113048863, 30857.691423085762, 42876.356854647165, 43148.0, 43255.56744432555, 45042.54957450433, 45140.09719805602, 45342.546574534244, 45396.0, 45471.0, 9671.27465440093, 9857.162141217968, 9862.506874656274, 9864.358816676893, 9894.208463322953, 9736.0, 9859.654912078078, 9872.308938374317, 9881.95059024704, 9887.209023278156, 9556.80886382272, 9856.162226210781, 9906.504674766269, 9908.900910990906, 9915.058069483388, 9804.362716423446, 9872.851907221397, 9884.357516761387, 9887.505624718735, 9892.50537473127, 9365.625374984993, 9682.806343873153, 9783.853242201372, 9784.804303913881, 9788.363756355815, 41842.79078604587, 42114.789426052674, 42135.57864421347, 42142.367864482054, 42206.57793422088, 3492.8952131435844, 3569.928601427983, 3756.6619004289746, 3934.744241624285, 4202.894927626803, 32326.515102273486, 32984.83507582447, 33114.50328245054, 33510.1622459438, 33547.4967875482, 3263.853126609308, 3409.9488507672404, 3420.4185288501017, 3420.794752314869, 3451.119964409085, 474008.6299568515, 476118.0, 476499.61750191374, 478043.0, 479091.0, 62848.68575657092, 62896.0, 63202.68398658069, 63504.68247658825, 63564.36435635584, 65095.67452162709, 65127.0, 65151.0, 65164.67417662881, 65281.67359163174, 16735.83264167367, 16963.236654350338, 16977.236024378934, 16981.745273820903, 16995.150242487827, 12962.092653514352, 13018.218906865619, 13033.0, 13037.413316400785, 13057.477700891857, 17424.128793560525, 17803.554911127325, 17804.821951780315, 17837.28650853977, 17883.374081907332, 5681.57388195887, 6197.96901015492, 6291.930371836799, 6754.290799466084, 6935.54918930278, 902.4765635931276, 951.4291425144858, 965.753732798132, 1004.6734811186394, 1128.3173679923527, 30518.847405763274, 30981.380372392425, 31302.719767360653, 31434.685653143177, 31662.68337316597, 994.2145704893198, 1032.4579595712162, 1086.8750093739163, 1104.7514309280348, 1155.6764106050318, 15609.843901561066, 16238.431654892021, 16246.75629865553, 16402.67194656124, 16611.003339799652, 682019.0, 702317.0, 711626.0, 712057.4397128085, 948054.0, 62471.687641561504, 62623.68688156621, 63270.68364658147, 63539.6823015882, 63569.36430635727, 1221.407617305606, 1288.9613311600667, 1391.1861560986733, 1407.4510940733123, 1421.4243231491262, 31552.053438396884, 31650.68349316477, 32288.677113229507, 33131.17172070718, 33208.33583328272, 59600.40399595949, 59696.40303597082, 60529.78940421255, 60569.0, 60865.0, 470538.0, 470974.0, 471292.0, 472313.0, 473227.0, 22905.65641515345, 24200.878995604908, 26965.38207707544, 27231.183064508095, 27663.893444262005, 42139.57860421479, 50326.74836625793, 50713.49286507235, 50814.7296317595, 51195.74402127966, 36061.0, 39651.80174099226, 40528.797356013034, 40673.0, 42169.578304216564, 38168.80915595404, 40410.79794601008, 40751.22433391732, 41320.38019429651, 41456.3781543271, 38779.224415510966, 39320.2135957285, 39371.80314098411, 39444.40833387444, 39495.802520987214, 31019.68980310168, 34341.828290858386, 35263.0, 36013.0996725084, 36254.0, 25912.0, 26030.34924126912, 26315.73684263133, 26624.8668756655, 26892.327691807077], "value": 20498.627710659024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.0589077235347, 386.4010783285907, 392.28016589558166, 396.6925632634708, 415.34168343176066, 15652.530424087281, 20115.698264526025, 20626.690599641, 21039.948002599886, 21540.461488462795, 20609.587808243865, 20804.0, 20841.06215220315, 21692.240771572997, 21727.13091476339, 5140.408852981899, 5406.675599464044, 5594.8530551237, 5713.628729105006, 5956.463918247357, 5755.136729490589, 5832.096025116114, 5834.474897259246, 5866.9706651466895, 5882.441168089046, 5756.280464941882, 5814.883702325972, 5815.156802263669, 5816.1275808628625, 5822.1266809978415, 6043.758249670008, 6124.2957059938235, 6124.601900876451, 6147.231596050471, 6154.369092190573, 5418.593605479566, 5467.316585426822, 5751.25233719618, 5824.88350232993, 5906.616069955439, 13308.0, 13376.464941402332, 13540.0, 17138.657226855394, 26363.20910372692, 2217.4975659188885, 2271.9889649106153, 2345.44881952741, 2870.7846911481515, 3104.28601421672, 9538.52307384628, 9661.71014869555, 10045.89954100457, 10497.370157790558, 10515.789684206273, 1572.371051579366, 1679.7312430011261, 1871.2047379863504, 1925.5763731978943, 1976.2292705844732, 109184.0, 114334.0, 117446.0, 119175.0, 121106.3944680271, 9373.531323433937, 9730.61077556904, 11310.60412885545, 11691.590794322157, 11891.405429728478, 12019.738155680378, 13531.0, 13548.119372240773, 13561.118527295694, 13585.0, 8513.489190648581, 8576.742697719079, 8585.141485851365, 8633.395662303705, 8684.696035638723, 8487.193716596914, 8488.83022339562, 8508.149185081442, 8601.655933762704, 8638.956805215934, 3798.9430158547643, 4507.5943165115295, 4549.135664223787, 4558.475775285885, 4647.744374059459, 1625.6423586810884, 1628.8452597003266, 1887.594167254047, 1933.6519426503364, 1934.5550523379702, 874.7725591346295, 968.2641192693462, 985.0789511806483, 987.1461186074138, 1028.5063169678597, 21816.890915545322, 21827.454313642287, 21963.195082032795, 22826.201082962016, 23024.769752302596, 822.6339279020898, 932.48247222792, 965.5014691332792, 1016.7443207638561, 1087.7443800706828, 9514.762130946781, 10576.52405641748, 11720.765584688428, 11732.12009099321, 11766.411679415995, 642478.0, 652702.0, 656258.0, 664972.4011039601, 665244.0, 73152.63423682848, 74010.25989740141, 107272.46363768131, 143960.0, 147951.0, 1009.1321463541349, 1032.726327523222, 1044.4412239452008, 1065.1532032034397, 1070.0155856611937, 15679.624444897425, 19498.415047548595, 19741.91419471943, 19892.80643161415, 19905.402837914884, 34771.65228347684, 55740.0, 57386.42613573811, 58058.7097064512, 59267.0, 75565.24434755582, 77485.0, 83294.58352708198, 83692.32615347537, 84306.57846710728, 5570.61005729595, 8136.633851476816, 8165.101838797608, 8179.550124743197, 8440.324774018187, 11227.831582526105, 12996.870031299944, 13182.736345273233, 13386.799198012233, 13414.865851341752, 10037.5483103262, 11193.99254067138, 11632.709182270512, 11646.883531164918, 11680.532778688757, 11281.943590281997, 11405.828912566483, 11463.598774042868, 11516.94241528787, 11623.941880290544, 9441.52792360393, 9729.805403891742, 11273.492692828679, 11864.466099025392, 11888.34614096233, 7008.0, 7526.285002924714, 7586.924130758843, 7662.080550333772, 8545.401821872409, 10631.734206644896, 11590.188686791844, 11703.356315402734, 11778.352190629597, 11852.881471185523], "value": 9466.741611003261, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.424317394629, 1553.6115971007246, 1773.9201735921881, 1934.5260411199258, 1948.1915005272813, 8625.827483450335, 8917.019127895943, 9091.454512729233, 9108.18026377626, 9115.95442022789, 7935.047794264682, 8155.0, 8163.6734530618705, 8292.626831792568, 8868.113188681145, 2014.9697754533693, 2144.496043429797, 2295.7015587973624, 2364.6925899633025, 2378.2627385510546, 2347.4366152123453, 2354.858708477488, 2379.95240095198, 2381.166591692911, 2383.0, 2085.1346691123167, 2289.3933107726466, 2359.4101474631343, 2375.5011447596025, 2376.92869213923, 2355.4464700795384, 2383.678203442539, 2398.0887262840183, 2401.207601491521, 2402.651615515758, 2363.9527209455887, 2364.2670772060546, 2381.0, 2385.1890357278435, 2390.175389490623, 8867.423617464909, 8925.509096999662, 8934.86597701035, 8939.329550283755, 8947.373683842134, 5242.1088414969545, 5357.249985002103, 5390.110631745757, 5403.78384864605, 5413.296271484721, 3503.9124021899656, 3589.856405743767, 3646.32542979547, 3657.3965295726175, 3660.6156353582755, 1065.9946700266526, 1107.0, 1118.4743170709753, 1119.7312644965232, 1124.207433759206, 11412.372319522423, 11636.76726465466, 11662.358570278631, 11673.76652466946, 11706.0, 3859.614038596174, 4673.299005149255, 4811.422629284508, 4814.061258054646, 4848.781804818792, 10007.549660265306, 10102.747431314128, 10117.797644047225, 10119.089281964658, 10153.695389138338, 5394.703291318937, 5397.973010135002, 5409.486098820606, 5415.702136382537, 5416.160495123262, 4434.046679963823, 4605.148047611136, 4728.905421891612, 4862.51374862518, 4935.975320123376, 3941.4481972523868, 3994.560598334181, 4083.1833633273463, 4088.2232375848494, 4106.589341065869, 1289.7162624222656, 1299.6880748620263, 1300.174389262825, 1305.764962306794, 1310.1614966421498, 802.9839403211903, 857.1385757313859, 918.894327152386, 930.437085563238, 934.9626014959462, 5843.678597677169, 5850.473457388855, 5889.676067816311, 6063.181470501426, 6113.5414843886, 856.5845564901018, 956.5791051937125, 976.4239098931664, 980.475445636581, 997.2321312589265, 3705.4627079073384, 3714.8483969969398, 3917.5494818095713, 3955.841766329372, 4023.7384570002855, 10104.494775261208, 10763.19276054299, 10769.084627806567, 10786.406747628798, 10791.0, 10241.385516869012, 10563.788724225626, 10740.838887416696, 10755.300905441121, 10799.082078023455, 7130.358267755927, 8290.4611200273, 8317.8336433271, 8319.334453243726, 8334.49993000422, 5821.330546987151, 5890.911636325544, 5900.055991041413, 5940.138679891478, 5987.520998320037, 9881.96239394882, 9908.35595686278, 9929.900700993187, 10005.54975026111, 10028.899711003089, 8987.281017518713, 10064.798704026025, 10260.743481413025, 10346.793064138825, 10371.63699270552, 6792.626405547742, 7021.0, 7301.634918254173, 7554.962225189059, 7625.275598818325, 8226.177382261965, 8404.075551689431, 8433.493990360597, 8439.620217090369, 8442.197991190827, 7282.563046217244, 7351.963240183765, 7427.257274272745, 7529.58587277705, 7589.886151707618, 6807.489438292049, 6996.195437524546, 7426.628668566658, 7492.213317601573, 7541.2458754124145, 6999.370056694922, 7036.612986285803, 7068.893966590403, 7082.858342833218, 7087.184973728087, 4872.342233798392, 4874.488178741323, 4933.407991041098, 5019.84940451787, 5073.822416215415, 4992.850214493571, 5057.216131499624, 5106.693598384109, 5122.129238029469, 5201.713905735221], "value": 4606.003996544428, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.39419766269793, 302.91972627253784, 313.5344014139004, 321.50648754162364, 322.25237449118043, 4274.829006839726, 5014.348134742479, 5237.166991552959, 5259.948620038179, 5371.758270877805, 4192.811323490442, 5074.213496907976, 5126.795477944483, 5211.973940130303, 5236.31927849379, 4092.774897380643, 4118.464599602055, 4133.276676581601, 4137.793110344486, 4142.502899652046, 3782.4870051979156, 3813.466114743938, 4101.671866250707, 4107.363358679395, 4113.650339721127, 3051.2219384057034, 3859.321195280062, 4030.838766449353, 4050.1976620403934, 4069.491313585802, 4008.4788977432895, 4022.8534867562603, 4037.8788636340955, 4056.4118202860714, 4072.4705788247634, 3550.467429885512, 3557.4308110702164, 3568.7145028397927, 3570.357335679577, 3590.2460483298537, 4293.592108749695, 4473.977630111861, 4790.041991601694, 4981.601471882241, 5083.186690129562, 4568.977155114237, 4581.977090114528, 4614.400127983375, 4623.630109591225, 4634.420697412824, 5304.912492938938, 5420.91868621971, 5478.561715062825, 5490.396056433789, 5500.80747173851, 3238.951415728766, 3515.402381595135, 3804.0, 3809.733318667694, 3917.5505063126825, 5767.33675627304, 5773.797917072882, 5776.249087618625, 5786.1069465267365, 5927.8221653350465, 3884.864029758945, 3885.4366116913457, 3885.55316138642, 3911.164405805768, 3914.3345631242187, 3763.1156678180605, 3833.4441505982036, 3892.96107038926, 3899.6880249579967, 3933.056066544066, 4504.864854054318, 4527.3435351873795, 4528.366028755977, 4556.612687921497, 4562.5665561771575, 4816.446108697474, 5076.258820237031, 5473.67157970523, 5536.584756143306, 5625.465580769902, 1160.6982184631888, 1249.6750844780422, 1278.571678487717, 1296.572131196703, 1314.625331780438, 840.7267638017669, 883.7172104926361, 897.717219075989, 902.2691619787993, 912.5482885971487, 4559.726416415026, 4797.232442809134, 5036.546710796046, 5106.183010718267, 5136.255242989746, 5322.467753224724, 5605.552585160097, 5647.915281270784, 5660.377358490645, 5708.429157084258, 4955.810605454737, 4989.825356112518, 5073.416557095908, 5097.260897169964, 5114.130597798383, 2323.953520929572, 2521.394865232368, 2715.6557504035236, 2821.548552231674, 2934.9706502934696, 4619.745913974763, 5749.770009199585, 5767.538596912237, 6017.488513476404, 6038.607490513103, 5206.088934436459, 5889.587728858939, 5895.941040589625, 5922.911156332659, 5973.432523910222, 4580.839670611513, 5705.429457054427, 5902.321233058167, 6006.849828754316, 6091.238595175603, 4794.489735733233, 5441.782328706966, 5740.425957404394, 5807.186993820953, 5863.824085277449, 5597.132444471114, 5749.511291540099, 5767.452092051249, 5803.970980145073, 5821.27234095738, 4871.661602430924, 5478.561715062865, 5523.28197334344, 5780.976658169607, 5795.507381872588, 3870.5161854768153, 3878.030492376906, 3887.5140607424073, 3892.5328960524917, 3907.7069219809196, 5781.739821707949, 5783.566232532493, 5790.565707572033, 5817.996522990141, 5833.745744664918, 5195.298634684269, 5583.553315734813, 5620.606557540933, 5661.858453538694, 5674.631148975303, 4563.863084107482, 5323.653962492425, 5423.078076727044, 5549.833504994856, 5597.305778186377, 4821.734804585782, 4861.52401033263, 5363.570914326767, 5437.483439073281, 5568.638038527482, 5055.963527476785, 5428.864278393072, 5545.916811247916, 5589.860253493695, 5596.832095037155, 4761.857144285677, 5193.545193545164, 5422.403535611158, 5435.619506634655, 5478.863028424162], "value": 4065.321325922006, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.4995628431682, 742.7029188324673, 752.1012390193714, 795.5783434779569, 854.6068808348159, 15019.24903754812, 16293.266802993865, 16344.346226150954, 16347.26437310321, 16349.918250408746, 14734.263286835669, 14920.328585213665, 14941.551753447387, 14971.925140374311, 14981.550553483386, 707.0913875669766, 722.5881247688819, 880.6565439478609, 887.40987243483, 910.3445519226179, 882.1707594860842, 900.1673452056821, 900.2617853360247, 901.7204666553357, 902.5081330674798, 968.7674958010062, 972.2853702528636, 973.3429934793986, 976.24828881761, 976.3556053005018, 754.2871985973285, 933.3746389918771, 964.4358050540442, 964.8118616869713, 971.0580736685404, 718.2314923032358, 718.267367285366, 718.586812582767, 719.3633634233688, 724.5145752345941, 14828.3327250274, 14915.0, 14916.403343866232, 14936.701265974729, 14952.327145278488, 14070.788938165935, 14130.364133614012, 14182.716345673132, 14206.360713767905, 14248.501302454468, 13039.413226404835, 13188.472461101544, 13343.666408339772, 13407.99440041991, 13410.994175436881, 4577.382053422779, 4593.081383723235, 4724.291356296549, 4826.806927722887, 4875.926861097087, 110821.44589277002, 111052.0, 111195.33207001901, 111350.44324778405, 115446.0, 11247.381394023243, 11269.211155219056, 11364.261323013978, 11434.656960291039, 11698.590549330733, 22188.0, 22238.888805555867, 22252.109915603196, 22266.22068227604, 22270.0, 7421.332080112816, 7945.562994035384, 7971.242731940456, 8025.077116131602, 8204.138565450661, 4354.8911277217685, 4379.080393117481, 4392.538783427758, 4452.243118669834, 4627.629789616823, 3157.6579953519663, 3355.6308806031316, 3578.0697018774786, 3578.570571531433, 3580.1765593913024, 627.7520379450092, 654.0777503719733, 658.2232965101131, 666.0275997044273, 676.9559978601375, 621.7450845153465, 630.2594451519537, 651.771879842061, 654.1071437487794, 656.1175219329994, 8604.741857744277, 9085.227755640844, 9100.544972751335, 9116.361854670242, 9175.58709858058, 590.952723782105, 593.3354642800092, 621.8973869311513, 624.2041397218583, 643.4659232836734, 4369.781510924441, 4406.867793966187, 4421.4915284742665, 4431.645468362523, 4442.178197033559, 153625.0, 154295.45704543035, 154615.0, 154658.226708868, 156842.0, 106727.0, 134435.0, 134739.0, 136644.86670787423, 140100.0, 109710.45144774225, 109917.0, 110881.0, 111053.11314104129, 111353.77292454106, 8537.359698022548, 8553.914460855562, 8653.350998674998, 8656.0, 8735.650573977224, 51044.0, 62962.68518657378, 62993.370066298754, 63762.0, 63791.68104159449, 89650.55174724084, 93188.0, 94481.0, 97377.51311243682, 100568.0, 11554.942225289156, 11658.88341116612, 11689.590864319707, 11702.648920532398, 11798.764024719629, 11978.64064078079, 12043.518259269882, 12092.153549251469, 12096.213746106476, 12616.0, 11861.822072668745, 12072.517099316281, 12200.694982625506, 12335.321557314075, 12383.566575169825, 11647.6505704829, 11868.525258989544, 11931.76136477283, 12155.209911355734, 12190.146689731633, 11658.300501969909, 11848.229865058744, 11998.940005299917, 12117.454714537691, 12194.268343899394, 8344.207300306462, 9679.419234845931, 9845.950770246103, 9921.454320012468, 9995.0, 7846.9109456878705, 9571.569279382305, 9872.259580531632, 9881.20950323958, 9885.50572471388], "value": 7745.759365385275, "unit": "score"}], "name": "dromaeo_css", "value": 7378.936870306526, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 117.0, 161.0, 112.0, 111.0, 110.0, 110.0, 108.0, 111.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 107.0, 109.0, 189.0, 140.0, 141.0, 125.0, 108.0, 158.0, 106.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 184.0, 183.0, 183.0, 181.0, 184.0, 184.0, 180.0, 183.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 137.0, 61.0, 57.0, 61.0, 70.0, 83.0, 58.0], "value": 75.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 91.0, 69.0, 71.0, 68.0, 96.0, 70.0, 67.0, 98.0], "value": 80.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 84.0, 88.0, 83.0, 88.0, 85.0, 87.0, 83.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 95.0, 94.0, 93.0, 93.0, 93.0, 94.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 85.0, 83.0, 83.0, 87.0, 84.0, 85.0, 84.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 53.0, 56.0, 53.0, 53.0, 55.0, 53.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 73.0, 74.0, 70.0, 70.0, 69.0, 71.0, 70.0, 72.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 84.0, 98.0, 104.0, 98.0, 75.0, 85.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 136.0, 136.0, 144.0, 147.0, 137.0, 136.0, 205.0, 150.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 164.0, 166.0, 167.0, 162.0, 163.0, 158.0, 211.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 75.0, 84.0, 87.0, 75.0, 66.0, 66.0, 67.0, 63.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1449.4, "alertThreshold": 2.0}]} 18:53:49 INFO - Return code: 0 18:53:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:53:49 INFO - # TBPL SUCCESS # 18:53:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:53:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:53:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:53:49 INFO - 2016-07-08 18:53:49.339 screenresolution[1811:9858] starting screenresolution argv=screenresolution get 18:53:49 INFO - 2016-07-08 18:53:49.342 screenresolution[1811:9858] Display 0: 1600x1200x32@60 18:53:49 INFO - 2016-07-08 18:53:49.348 screenresolution[1812:9861] starting screenresolution argv=screenresolution list 18:53:49 INFO - Available Modes on Display 0 18:53:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:53:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:53:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:53:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:53:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:53:49 INFO - Intel Iris: 18:53:49 INFO - Chipset Model: Intel Iris 18:53:49 INFO - Type: GPU 18:53:49 INFO - Bus: Built-In 18:53:49 INFO - VRAM (Dynamic, Max): 1536 MB 18:53:49 INFO - Vendor: Intel (0x8086) 18:53:49 INFO - Device ID: 0x0a2e 18:53:49 INFO - Revision ID: 0x0009 18:53:49 INFO - Displays: 18:53:49 INFO - Display: 18:53:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:53:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:53:49 INFO - Display Serial Number: 1600x1200 60 18:53:49 INFO - Main Display: Yes 18:53:49 INFO - Mirror: Off 18:53:49 INFO - Online: Yes 18:53:49 INFO - Rotation: Supported 18:53:49 INFO - Return code: 0 18:53:49 INFO - Running post-action listener: _resource_record_post_action 18:53:49 INFO - ##### 18:53:49 INFO - ##### Finished run-tests step (success) 18:53:49 INFO - ##### 18:53:49 INFO - Running post-run listener: _resource_record_post_run 18:53:49 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 37045760; Write bytes: 709233664; Read time: 232; Write time: 2060 18:53:49 INFO - TinderboxPrint: CPU usage
53.4% 18:53:49 INFO - TinderboxPrint: I/O read bytes / time
37,045,760 / 232 18:53:49 INFO - TinderboxPrint: I/O write bytes / time
709,233,664 / 2,060 18:53:49 INFO - TinderboxPrint: CPU idle
2,255.7 (46.6%) 18:53:49 INFO - TinderboxPrint: CPU system
964.0 (19.9%) 18:53:49 INFO - TinderboxPrint: CPU user
1,621.8 (33.5%) 18:53:49 INFO - TinderboxPrint: Swap in / out
444,026,880 / 0 18:53:49 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 406127104; Write bytes: 395929600; Read time: 29539; Write time: 863 18:53:49 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 29654528; Write bytes: 297550848; Read time: 174; Write time: 1159 18:53:50 INFO - Running post-run listener: _upload_blobber_files 18:53:50 INFO - Blob upload gear active. 18:53:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:53:50 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 18:53:50 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:53:50 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:53:50 INFO - (blobuploader) - INFO - Open directory for files ... 18:53:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:53:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:53:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:51 INFO - (blobuploader) - INFO - Done attempting. 18:53:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:53:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:53:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:52 INFO - (blobuploader) - INFO - Done attempting. 18:53:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:53:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:53:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:54 INFO - (blobuploader) - INFO - Done attempting. 18:53:54 INFO - (blobuploader) - INFO - Iteration through files over. 18:53:54 INFO - Return code: 0 18:53:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:53:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:53:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0a039b42b2df7d453f3e0532caf95b661466a458f8ee00a67eaa2274fef5a511b6956de3163b5df96b995a5631385a107f467cd6914d2de3251a39b1b100110d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2fa66a246b22894027f6267fb8315473a284c20cfc146ba116ae4d2744453b6a75a879b3ffd9dce8b017820052cf5a597ccbd03042e403270a1e1c118c8b8612", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/921ca99813888aead997ee52182f1441e9b5d3d8d5f13c25bbc5b8a02e0b567677d0efbae168a3174ef8f799574f7e5ed62da5bd6a2dbbadd7377bcaa73bc8af"} 18:53:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:53:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:53:54 INFO - Contents: 18:53:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0a039b42b2df7d453f3e0532caf95b661466a458f8ee00a67eaa2274fef5a511b6956de3163b5df96b995a5631385a107f467cd6914d2de3251a39b1b100110d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2fa66a246b22894027f6267fb8315473a284c20cfc146ba116ae4d2744453b6a75a879b3ffd9dce8b017820052cf5a597ccbd03042e403270a1e1c118c8b8612", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/921ca99813888aead997ee52182f1441e9b5d3d8d5f13c25bbc5b8a02e0b567677d0efbae168a3174ef8f799574f7e5ed62da5bd6a2dbbadd7377bcaa73bc8af"} 18:53:54 INFO - Running post-run listener: copy_logs_to_upload_dir 18:53:54 INFO - Copying logs to upload dir... 18:53:54 INFO - mkdir: /builds/slave/test/build/upload/logs 18:53:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.008248 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-08 18:53:54.525150) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 18:53:54.528424) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.StIKfeNW8Y/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0a039b42b2df7d453f3e0532caf95b661466a458f8ee00a67eaa2274fef5a511b6956de3163b5df96b995a5631385a107f467cd6914d2de3251a39b1b100110d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2fa66a246b22894027f6267fb8315473a284c20cfc146ba116ae4d2744453b6a75a879b3ffd9dce8b017820052cf5a597ccbd03042e403270a1e1c118c8b8612", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/921ca99813888aead997ee52182f1441e9b5d3d8d5f13c25bbc5b8a02e0b567677d0efbae168a3174ef8f799574f7e5ed62da5bd6a2dbbadd7377bcaa73bc8af"} build_url:https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011045 build_url: 'https://queue.taskcluster.net/v1/task/eyknSQtiRO6IH1NLHukxRQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0a039b42b2df7d453f3e0532caf95b661466a458f8ee00a67eaa2274fef5a511b6956de3163b5df96b995a5631385a107f467cd6914d2de3251a39b1b100110d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2fa66a246b22894027f6267fb8315473a284c20cfc146ba116ae4d2744453b6a75a879b3ffd9dce8b017820052cf5a597ccbd03042e403270a1e1c118c8b8612", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/921ca99813888aead997ee52182f1441e9b5d3d8d5f13c25bbc5b8a02e0b567677d0efbae168a3174ef8f799574f7e5ed62da5bd6a2dbbadd7377bcaa73bc8af"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 18:53:54.565174) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 18:53:54.565911) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.StIKfeNW8Y/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Cqec62JDMb/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005088 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 18:53:54.618360) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 18:53:54.619024) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 18:53:54.619763) ========= ========= Total master_lag: 4.87 =========