builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0032 starttime: 1488228155.42 results: success (0) buildid: 20170227120121 builduid: 1acff3572b0b4d43b4d4cfd6feab3695 revision: 66e9dc9f094f790c94c7f2a5df0757c8f3b81e78 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 12:42:35.417600) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 12:42:35.418205) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 12:42:35.418543) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 12:42:35.452542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 12:42:35.452976) ========= 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.V7bnlotoVI/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.fpqgJfjIxA/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 --2017-02-27 12:42:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 138M=0s 2017-02-27 12:42:35 (138 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124890 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 12:42:35.602298) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 12:42:35.602641) ========= 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.V7bnlotoVI/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.fpqgJfjIxA/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.027984 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 12:42:35.656517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-02-27 12:42:35.656922) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 66e9dc9f094f790c94c7f2a5df0757c8f3b81e78 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 66e9dc9f094f790c94c7f2a5df0757c8f3b81e78 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V7bnlotoVI/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.fpqgJfjIxA/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 2017-02-27 12:42:35,770 truncating revision to first 12 chars 2017-02-27 12:42:35,770 Setting DEBUG logging. 2017-02-27 12:42:35,770 attempt 1/10 2017-02-27 12:42:35,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/66e9dc9f094f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-27 12:42:36,427 unpacking tar archive at: mozilla-aurora-66e9dc9f094f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.935068 ========= master_lag: 2.38 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-02-27 12:42:38.975591) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 12:42:38.975908) ========= script_repo_revision: 66e9dc9f094f790c94c7f2a5df0757c8f3b81e78 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 12:42:38.976315) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 12:42:38.976577) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 12:42:38.997250) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-27 12:42:38.997661) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V7bnlotoVI/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.fpqgJfjIxA/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 12:42:39 INFO - MultiFileLogger online at 20170227 12:42:39 in /builds/slave/test 12:42:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:42:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:42:39 INFO - {'append_to_log': False, 12:42:39 INFO - 'base_work_dir': '/builds/slave/test', 12:42:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:42:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:42:39 INFO - 'branch': 'Mozilla-Aurora', 12:42:39 INFO - 'buildbot_json_path': 'buildprops.json', 12:42:39 INFO - 'config_files': ('talos/mac_config.py',), 12:42:39 INFO - 'default_actions': ('clobber', 12:42:39 INFO - 'read-buildbot-config', 12:42:39 INFO - 'download-and-extract', 12:42:39 INFO - 'populate-webroot', 12:42:39 INFO - 'create-virtualenv', 12:42:39 INFO - 'install', 12:42:39 INFO - 'run-tests'), 12:42:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:42:39 INFO - 'download_minidump_stackwalk': True, 12:42:39 INFO - 'download_symbols': 'ondemand', 12:42:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:42:39 INFO - 'tooltool.py': '/tools/tooltool.py', 12:42:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:42:39 INFO - '/tools/misc-python/virtualenv.py')}, 12:42:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:42:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:42:39 INFO - 'installer_path': 'installer.exe', 12:42:39 INFO - 'log_level': 'info', 12:42:39 INFO - 'log_name': 'talos', 12:42:39 INFO - 'log_to_console': True, 12:42:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:42:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:42:39 INFO - 'opt_config_files': (), 12:42:39 INFO - 'pip_index': False, 12:42:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:42:39 INFO - 'cmd': ('bash', 12:42:39 INFO - '-c', 12:42:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:42:39 INFO - 'enabled': True, 12:42:39 INFO - 'halt_on_failure': False, 12:42:39 INFO - 'name': 'check_screen_resolution'},), 12:42:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:42:39 INFO - 'cmd': ('bash', 12:42:39 INFO - '-c', 12:42:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:42:39 INFO - 'enabled': True, 12:42:39 INFO - 'halt_on_failure': False, 12:42:39 INFO - 'name': 'check_screen_resolution'},), 12:42:39 INFO - 'run_cmd_checks_enabled': True, 12:42:39 INFO - 'sps_profile': False, 12:42:39 INFO - 'sps_profile_interval': 0, 12:42:39 INFO - 'suite': 'dromaeojs', 12:42:39 INFO - 'system_bits': '32', 12:42:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:42:39 INFO - 'title': 't-yosemite-r7-0032', 12:42:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:42:39 INFO - 'use_talos_json': True, 12:42:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:42:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:42:39 INFO - 'work_dir': 'build'} 12:42:39 INFO - [mozharness: 2017-02-27 20:42:39.216982Z] Running clobber step. 12:42:39 INFO - Running pre-action listener: _resource_record_pre_action 12:42:39 INFO - Running main action method: clobber 12:42:39 INFO - rmtree: /builds/slave/test/build 12:42:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:42:41 INFO - Running post-action listener: _resource_record_post_action 12:42:41 INFO - [mozharness: 2017-02-27 20:42:41.634780Z] Finished clobber step (success) 12:42:41 INFO - [mozharness: 2017-02-27 20:42:41.634915Z] Running read-buildbot-config step. 12:42:41 INFO - Running pre-action listener: _resource_record_pre_action 12:42:41 INFO - Running main action method: read_buildbot_config 12:42:41 INFO - Using buildbot properties: 12:42:41 INFO - { 12:42:41 INFO - "project": "", 12:42:41 INFO - "product": "firefox", 12:42:41 INFO - "script_repo_revision": "production", 12:42:41 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 12:42:41 INFO - "repository": "", 12:42:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 12:42:41 INFO - "buildid": "20170227120121", 12:42:41 INFO - "pgo_build": "False", 12:42:41 INFO - "basedir": "/builds/slave/test", 12:42:41 INFO - "buildnumber": 43, 12:42:41 INFO - "slavename": "t-yosemite-r7-0032", 12:42:41 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 12:42:41 INFO - "platform": "yosemite_r7", 12:42:41 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:42:41 INFO - "branch": "mozilla-aurora", 12:42:41 INFO - "repo_path": "releases/mozilla-aurora", 12:42:41 INFO - "revision": "66e9dc9f094f790c94c7f2a5df0757c8f3b81e78", 12:42:41 INFO - "stage_platform": "macosx64", 12:42:41 INFO - "builduid": "1acff3572b0b4d43b4d4cfd6feab3695", 12:42:41 INFO - "slavebuilddir": "test" 12:42:41 INFO - } 12:42:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 12:42:41 INFO - Running post-action listener: _resource_record_post_action 12:42:41 INFO - [mozharness: 2017-02-27 20:42:41.638372Z] Finished read-buildbot-config step (success) 12:42:41 INFO - [mozharness: 2017-02-27 20:42:41.638480Z] Running download-and-extract step. 12:42:41 INFO - Running pre-action listener: _resource_record_pre_action 12:42:41 INFO - Running main action method: download_and_extract 12:42:41 INFO - mkdir: /builds/slave/test/build/tests 12:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:41 INFO - trying https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 12:42:41 INFO - Downloading https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 12:42:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 12:42:42 INFO - Downloaded 1199 bytes. 12:42:42 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 12:42:42 INFO - Using the following test package requirements: 12:42:42 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 12:42:42 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:42:42 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 12:42:42 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:42:42 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 12:42:42 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:42:42 INFO - u'jsshell-mac.zip'], 12:42:42 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:42:42 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 12:42:42 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 12:42:42 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:42:42 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 12:42:42 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:42:42 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 12:42:42 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:42:42 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 12:42:42 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 12:42:42 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 12:42:42 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:42:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 12:42:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:42:42 INFO - Fetch https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 12:42:43 INFO - Expected file size: 16357783 12:42:43 INFO - Obtained file size: 16357783 12:42:50 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 12:42:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 12:42:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:42:50 INFO - Fetch https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 12:42:51 INFO - Expected file size: 16357783 12:42:51 INFO - Obtained file size: 16357783 12:42:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 12:42:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 12:42:57 INFO - Fetch https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 12:42:58 INFO - Expected file size: 14403472 12:42:58 INFO - Obtained file size: 14403472 12:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:58 INFO - trying https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 12:42:58 INFO - Downloading https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 12:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 12:43:01 INFO - Downloaded 73926405 bytes. 12:43:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 12:43:01 INFO - mkdir: /builds/slave/test/properties 12:43:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:43:01 INFO - Writing to file /builds/slave/test/properties/build_url 12:43:01 INFO - Contents: 12:43:01 INFO - build_url:https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 12:43:02 INFO - Running post-action listener: _resource_record_post_action 12:43:02 INFO - Running post-action listener: set_extra_try_arguments 12:43:02 INFO - [mozharness: 2017-02-27 20:43:02.151248Z] Finished download-and-extract step (success) 12:43:02 INFO - [mozharness: 2017-02-27 20:43:02.151346Z] Running populate-webroot step. 12:43:02 INFO - Running pre-action listener: _resource_record_pre_action 12:43:02 INFO - Running main action method: populate_webroot 12:43:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:43:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:43:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:43:02 INFO - '--tppagecycles', 12:43:02 INFO - '7'], 12:43:02 INFO - 'tests': ['tsvgm']}}, 12:43:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:43:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:43:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:43:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:43:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:43:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:43:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:43:02 INFO - 'talos_options': ['--disable-e10s'], 12:43:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:43:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:43:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:43:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:43:02 INFO - 'talos_options': ['--disable-e10s'], 12:43:02 INFO - 'tests': ['damp', 'tps']}, 12:43:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:43:02 INFO - 'tests': ['damp', 'tps']}, 12:43:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:43:02 INFO - 'tests': ['dromaeo_dom']}, 12:43:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:43:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:43:02 INFO - 'tests': ['basic_compositor_video']}, 12:43:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:43:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:43:02 INFO - 'tests': ['a11yr', 12:43:02 INFO - 'ts_paint', 12:43:02 INFO - 'tpaint', 12:43:02 INFO - 'sessionrestore', 12:43:02 INFO - 'sessionrestore_no_auto_restore', 12:43:02 INFO - 'tabpaint']}, 12:43:02 INFO - 'other-e10s': {'tests': ['a11yr', 12:43:02 INFO - 'ts_paint', 12:43:02 INFO - 'tpaint', 12:43:02 INFO - 'sessionrestore', 12:43:02 INFO - 'sessionrestore_no_auto_restore', 12:43:02 INFO - 'tabpaint']}, 12:43:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:43:02 INFO - 'ts_paint', 12:43:02 INFO - 'tpaint', 12:43:02 INFO - 'sessionrestore', 12:43:02 INFO - 'sessionrestore_no_auto_restore', 12:43:02 INFO - 'tabpaint']}, 12:43:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:43:02 INFO - 'ts_paint', 12:43:02 INFO - 'tpaint', 12:43:02 INFO - 'sessionrestore', 12:43:02 INFO - 'sessionrestore_no_auto_restore', 12:43:02 INFO - 'tabpaint']}, 12:43:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:43:02 INFO - 'tests': ['a11yr', 12:43:02 INFO - 'ts_paint', 12:43:02 INFO - 'tpaint', 12:43:02 INFO - 'sessionrestore', 12:43:02 INFO - 'sessionrestore_no_auto_restore', 12:43:02 INFO - 'tabpaint']}, 12:43:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:43:02 INFO - 'tests': ['a11yr', 12:43:02 INFO - 'ts_paint', 12:43:02 INFO - 'tpaint', 12:43:02 INFO - 'sessionrestore', 12:43:02 INFO - 'sessionrestore_no_auto_restore', 12:43:02 INFO - 'tabpaint']}, 12:43:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:43:02 INFO - 'tests': ['tsvgx', 12:43:02 INFO - 'tsvgr_opacity', 12:43:02 INFO - 'tart', 12:43:02 INFO - 'tscrollx', 12:43:02 INFO - 'cart', 12:43:02 INFO - 'tsvg_static']}, 12:43:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:43:02 INFO - 'tsvgr_opacity', 12:43:02 INFO - 'tart', 12:43:02 INFO - 'tscrollx', 12:43:02 INFO - 'cart', 12:43:02 INFO - 'tsvg_static']}, 12:43:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:43:02 INFO - 'talos_options': ['--disable-e10s'], 12:43:02 INFO - 'tests': ['tp5o']}, 12:43:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:43:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:43:02 INFO - 'talos_options': ['--disable-e10s', 12:43:02 INFO - '--xperf_path', 12:43:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:43:02 INFO - 'tests': ['tp5n']}, 12:43:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:43:02 INFO - 'talos_options': ['--xperf_path', 12:43:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:43:02 INFO - 'tests': ['tp5n']}}, 12:43:02 INFO - 'talos.zip': {'path': '', 12:43:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:43:02 INFO - Running post-action listener: _resource_record_post_action 12:43:02 INFO - [mozharness: 2017-02-27 20:43:02.170203Z] Finished populate-webroot step (success) 12:43:02 INFO - [mozharness: 2017-02-27 20:43:02.170336Z] Running create-virtualenv step. 12:43:02 INFO - Running pre-action listener: _resource_record_pre_action 12:43:02 INFO - Running main action method: create_virtualenv 12:43:02 INFO - Creating virtualenv /builds/slave/test/build/venv 12:43:02 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 12:43:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:43:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:43:02 INFO - Using real prefix '/tools/python27' 12:43:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:43:03 INFO - Installing distribute.............................................................................................................................................................................................done. 12:43:05 INFO - Installing pip.................done. 12:43:05 INFO - Return code: 0 12:43:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:43:06 INFO - Reading from file tmpfile_stdout 12:43:06 INFO - Output received: 12:43:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:43:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:43:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:06 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 0x10fcebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf857e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9d30>, '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 0x10f9f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fabebe8>, '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.V7bnlotoVI/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.fpqgJfjIxA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 12:43:06 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 12:43:06 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 12:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7bnlotoVI/Render', 12:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:06 INFO - 'HOME': '/Users/cltbld', 12:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:06 INFO - 'LOGNAME': 'cltbld', 12:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:06 INFO - 'MOZ_NO_REMOTE': '1', 12:43:06 INFO - 'NO_EM_RESTART': '1', 12:43:06 INFO - 'PAGER': '/bin/cat', 12:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:06 INFO - 'PWD': '/builds/slave/test', 12:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:06 INFO - 'SHELL': '/bin/bash', 12:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpqgJfjIxA/Listeners', 12:43:06 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 12:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:06 INFO - 'USER': 'cltbld', 12:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:06 INFO - 'XPC_FLAGS': '0x0', 12:43:06 INFO - 'XPC_SERVICE_NAME': '0', 12:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:06 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 12:43:06 INFO - Cleaning up... 12:43:06 INFO - Return code: 0 12:43:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:43:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:06 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 0x10fcebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf857e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9d30>, '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 0x10f9f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fabebe8>, '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.V7bnlotoVI/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.fpqgJfjIxA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 12:43:06 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 12:43:06 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 12:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7bnlotoVI/Render', 12:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:06 INFO - 'HOME': '/Users/cltbld', 12:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:06 INFO - 'LOGNAME': 'cltbld', 12:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:06 INFO - 'MOZ_NO_REMOTE': '1', 12:43:06 INFO - 'NO_EM_RESTART': '1', 12:43:06 INFO - 'PAGER': '/bin/cat', 12:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:06 INFO - 'PWD': '/builds/slave/test', 12:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:06 INFO - 'SHELL': '/bin/bash', 12:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpqgJfjIxA/Listeners', 12:43:06 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 12:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:06 INFO - 'USER': 'cltbld', 12:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:06 INFO - 'XPC_FLAGS': '0x0', 12:43:06 INFO - 'XPC_SERVICE_NAME': '0', 12:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:06 INFO - Downloading/unpacking psutil>=3.1.1 12:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:43:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:10 INFO - Installing collected packages: psutil 12:43:10 INFO - Running setup.py install for psutil 12:43:10 INFO - building 'psutil._psutil_osx' extension 12:43:10 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 12:43:10 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 12:43:10 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 12:43:11 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 12:43:11 INFO - building 'psutil._psutil_posix' extension 12:43:11 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 12:43:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:43:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:43:11 INFO - ^ 12:43:11 INFO - 1 warning generated. 12:43:11 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 12:43:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:11 INFO - Successfully installed psutil 12:43:11 INFO - Cleaning up... 12:43:11 INFO - Return code: 0 12:43:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fcebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf857e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9d30>, '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 0x10f9f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fabebe8>, '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.V7bnlotoVI/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.fpqgJfjIxA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 12:43:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:43:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7bnlotoVI/Render', 12:43:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:11 INFO - 'HOME': '/Users/cltbld', 12:43:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:11 INFO - 'LOGNAME': 'cltbld', 12:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:11 INFO - 'MOZ_NO_REMOTE': '1', 12:43:11 INFO - 'NO_EM_RESTART': '1', 12:43:11 INFO - 'PAGER': '/bin/cat', 12:43:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:11 INFO - 'PWD': '/builds/slave/test', 12:43:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:11 INFO - 'SHELL': '/bin/bash', 12:43:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpqgJfjIxA/Listeners', 12:43:11 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 12:43:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:11 INFO - 'USER': 'cltbld', 12:43:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:11 INFO - 'XPC_FLAGS': '0x0', 12:43:11 INFO - 'XPC_SERVICE_NAME': '0', 12:43:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:43:14 INFO - Installing collected packages: mozsystemmonitor 12:43:14 INFO - Running setup.py install for mozsystemmonitor 12:43:14 INFO - Successfully installed mozsystemmonitor 12:43:14 INFO - Cleaning up... 12:43:14 INFO - Return code: 0 12:43:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:14 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 0x10fcebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf857e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9d30>, '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 0x10f9f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fabebe8>, '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.V7bnlotoVI/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.fpqgJfjIxA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 12:43:14 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 12:43:14 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 12:43:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7bnlotoVI/Render', 12:43:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:14 INFO - 'HOME': '/Users/cltbld', 12:43:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:14 INFO - 'LOGNAME': 'cltbld', 12:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:14 INFO - 'MOZ_NO_REMOTE': '1', 12:43:14 INFO - 'NO_EM_RESTART': '1', 12:43:14 INFO - 'PAGER': '/bin/cat', 12:43:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:14 INFO - 'PWD': '/builds/slave/test', 12:43:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:14 INFO - 'SHELL': '/bin/bash', 12:43:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpqgJfjIxA/Listeners', 12:43:14 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 12:43:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:14 INFO - 'USER': 'cltbld', 12:43:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:14 INFO - 'XPC_FLAGS': '0x0', 12:43:14 INFO - 'XPC_SERVICE_NAME': '0', 12:43:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:14 INFO - Downloading/unpacking jsonschema==2.5.1 12:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:43:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:43:17 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 12:43:17 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 12:43:17 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 12:43:17 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 12:43:17 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 12:43:17 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 12:43:17 INFO - Downloading functools32-3.2.3-2.tar.gz 12:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:43:18 INFO - warning: no files found matching '*.txt' 12:43:18 INFO - no previously-included directories found matching 'build' 12:43:18 INFO - no previously-included directories found matching 'dist' 12:43:18 INFO - no previously-included directories found matching '.git*' 12:43:18 INFO - Installing collected packages: jsonschema, functools32 12:43:18 INFO - Running setup.py install for functools32 12:43:18 INFO - warning: no files found matching '*.txt' 12:43:18 INFO - no previously-included directories found matching 'build' 12:43:18 INFO - no previously-included directories found matching 'dist' 12:43:18 INFO - no previously-included directories found matching '.git*' 12:43:18 INFO - Successfully installed jsonschema functools32 12:43:18 INFO - Cleaning up... 12:43:18 INFO - Return code: 0 12:43:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:43:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:18 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fcebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf857e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9d30>, '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 0x10f9f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fabebe8>, '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.V7bnlotoVI/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.fpqgJfjIxA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 12:43:18 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:43:18 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 functools32==3.2.3-2 12:43:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7bnlotoVI/Render', 12:43:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:18 INFO - 'HOME': '/Users/cltbld', 12:43:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:18 INFO - 'LOGNAME': 'cltbld', 12:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:18 INFO - 'MOZ_NO_REMOTE': '1', 12:43:18 INFO - 'NO_EM_RESTART': '1', 12:43:18 INFO - 'PAGER': '/bin/cat', 12:43:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:18 INFO - 'PWD': '/builds/slave/test', 12:43:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:18 INFO - 'SHELL': '/bin/bash', 12:43:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpqgJfjIxA/Listeners', 12:43:18 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 12:43:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:18 INFO - 'USER': 'cltbld', 12:43:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:18 INFO - 'XPC_FLAGS': '0x0', 12:43:18 INFO - 'XPC_SERVICE_NAME': '0', 12:43:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:43:18 INFO - Cleaning up... 12:43:18 INFO - Return code: 0 12:43:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:43:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:18 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 0x10fcebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf857e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9d30>, '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 0x10f9f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fabebe8>, '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.V7bnlotoVI/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.fpqgJfjIxA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 12:43:18 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 12:43:18 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 12:43:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7bnlotoVI/Render', 12:43:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:18 INFO - 'HOME': '/Users/cltbld', 12:43:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:18 INFO - 'LOGNAME': 'cltbld', 12:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:18 INFO - 'MOZ_NO_REMOTE': '1', 12:43:18 INFO - 'NO_EM_RESTART': '1', 12:43:18 INFO - 'PAGER': '/bin/cat', 12:43:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:18 INFO - 'PWD': '/builds/slave/test', 12:43:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:18 INFO - 'SHELL': '/bin/bash', 12:43:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpqgJfjIxA/Listeners', 12:43:18 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 12:43:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:18 INFO - 'USER': 'cltbld', 12:43:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:18 INFO - 'XPC_FLAGS': '0x0', 12:43:18 INFO - 'XPC_SERVICE_NAME': '0', 12:43:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:18 INFO - Downloading/unpacking blobuploader==1.2.4 12:43:18 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 12:43:18 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 12:43:18 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 12:43:18 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 12:43:18 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 12:43:18 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 12:43:21 INFO - Downloading blobuploader-1.2.4.tar.gz 12:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:43:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:43:21 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 12:43:21 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 12:43:21 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 12:43:21 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 12:43:21 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 12:43:21 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 12:43:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:43:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:43: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 12:43: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 12:43: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 12:43: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 12:43: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 12:43: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 12:43:22 INFO - Downloading docopt-0.6.1.tar.gz 12:43:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:43:22 INFO - Installing collected packages: blobuploader, requests, docopt 12:43:22 INFO - Running setup.py install for blobuploader 12:43:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:43:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:43:22 INFO - Running setup.py install for requests 12:43:23 INFO - Running setup.py install for docopt 12:43:23 INFO - Successfully installed blobuploader requests docopt 12:43:23 INFO - Cleaning up... 12:43:23 INFO - Return code: 0 12:43:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:23 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 0x10fcebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf857e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9d30>, '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 0x10f9f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fabebe8>, '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.V7bnlotoVI/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.fpqgJfjIxA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 12:43:23 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 12:43:23 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 12:43:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7bnlotoVI/Render', 12:43:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:23 INFO - 'HOME': '/Users/cltbld', 12:43:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:23 INFO - 'LOGNAME': 'cltbld', 12:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:23 INFO - 'MOZ_NO_REMOTE': '1', 12:43:23 INFO - 'NO_EM_RESTART': '1', 12:43:23 INFO - 'PAGER': '/bin/cat', 12:43:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:23 INFO - 'PWD': '/builds/slave/test', 12:43:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:23 INFO - 'SHELL': '/bin/bash', 12:43:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpqgJfjIxA/Listeners', 12:43:23 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 12:43:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:23 INFO - 'USER': 'cltbld', 12:43:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:23 INFO - 'XPC_FLAGS': '0x0', 12:43:23 INFO - 'XPC_SERVICE_NAME': '0', 12:43:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-OB2eFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-PDhTqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-cr86yM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-m0B3W3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-AuKB7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Z37fNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-DL4Svf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-LGRoIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-EsOL9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-3Cw91a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-CTIqe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-whgZk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-nu5eHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-vaK6ND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-3cIFSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-I5vPWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-gXGRAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:43:25 INFO - Running setup.py install for manifestparser 12:43:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:43:25 INFO - Running setup.py install for mozcrash 12:43:25 INFO - Running setup.py install for mozdebug 12:43:26 INFO - Running setup.py install for mozdevice 12:43:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:43:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:43:26 INFO - Running setup.py install for mozfile 12:43:26 INFO - Running setup.py install for mozhttpd 12:43:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:43:26 INFO - Running setup.py install for mozinfo 12:43:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:43:26 INFO - Running setup.py install for mozInstall 12:43:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:43:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:43:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:43:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:43:26 INFO - Running setup.py install for mozleak 12:43:27 INFO - Running setup.py install for mozlog 12:43:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:43:27 INFO - Running setup.py install for moznetwork 12:43:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:43:27 INFO - Running setup.py install for mozprocess 12:43:27 INFO - Running setup.py install for mozprofile 12:43:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:43:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:43:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:43:27 INFO - Running setup.py install for mozrunner 12:43:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:43:27 INFO - Running setup.py install for mozscreenshot 12:43:27 INFO - Running setup.py install for moztest 12:43:28 INFO - Running setup.py install for mozversion 12:43:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:43:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:43:28 INFO - Cleaning up... 12:43:28 INFO - Return code: 0 12:43:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:28 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 0x10fcebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf857e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9d30>, '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 0x10f9f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fabebe8>, '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.V7bnlotoVI/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.fpqgJfjIxA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 12:43:28 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 12:43:28 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 12:43:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7bnlotoVI/Render', 12:43:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:28 INFO - 'HOME': '/Users/cltbld', 12:43:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:28 INFO - 'LOGNAME': 'cltbld', 12:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:28 INFO - 'MOZ_NO_REMOTE': '1', 12:43:28 INFO - 'NO_EM_RESTART': '1', 12:43:28 INFO - 'PAGER': '/bin/cat', 12:43:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:28 INFO - 'PWD': '/builds/slave/test', 12:43:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:28 INFO - 'SHELL': '/bin/bash', 12:43:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpqgJfjIxA/Listeners', 12:43:28 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 12:43:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:28 INFO - 'USER': 'cltbld', 12:43:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:28 INFO - 'XPC_FLAGS': '0x0', 12:43:28 INFO - 'XPC_SERVICE_NAME': '0', 12:43:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:28 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-bn6uHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:28 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)) 12:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:28 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Q1TVTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 12:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:28 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-xt9KiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:28 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)) 12:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:28 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-T7tYwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 12:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:28 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-fEm4NA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:29 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)) 12:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-hfJYPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:29 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)) 12:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-2EvvGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:29 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)) 12:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-_ATn6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:29 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)) 12:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-bc_IXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:29 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)) 12:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-4erEEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 12:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-hw150z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:29 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)) 12:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-yhB3H6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 12:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-zXVnkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:29 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)) 12:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-fxet2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 12:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-lNHnZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:30 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)) 12:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-9_gOJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 12:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-IoBshe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:30 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)) 12:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:43:30 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)) 12:43:30 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:43:30 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:43:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:33 INFO - Downloading blessings-1.6.tar.gz 12:43:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:43:33 INFO - Installing collected packages: blessings 12:43:33 INFO - Running setup.py install for blessings 12:43:33 INFO - Successfully installed blessings 12:43:33 INFO - Cleaning up... 12:43:33 INFO - Return code: 0 12:43:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:43:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:34 INFO - Reading from file tmpfile_stdout 12:43:34 INFO - Current package versions: 12:43:34 INFO - blessings == 1.6 12:43:34 INFO - blobuploader == 1.2.4 12:43:34 INFO - docopt == 0.6.1 12:43:34 INFO - functools32 == 3.2.3-2 12:43:34 INFO - jsonschema == 2.5.1 12:43:34 INFO - manifestparser == 1.1 12:43:34 INFO - mozInstall == 1.12 12:43:34 INFO - mozcrash == 1.0 12:43:34 INFO - mozdebug == 0.1 12:43:34 INFO - mozdevice == 0.49 12:43:34 INFO - mozfile == 1.2 12:43:34 INFO - mozhttpd == 0.7 12:43:34 INFO - mozinfo == 0.9 12:43:34 INFO - mozleak == 0.1 12:43:34 INFO - mozlog == 3.4 12:43:34 INFO - moznetwork == 0.27 12:43:34 INFO - mozprocess == 0.24 12:43:34 INFO - mozprofile == 0.28 12:43:34 INFO - mozrunner == 6.13 12:43:34 INFO - mozscreenshot == 0.1 12:43:34 INFO - mozsystemmonitor == 0.3 12:43:34 INFO - moztest == 0.8 12:43:34 INFO - mozversion == 1.4 12:43:34 INFO - psutil == 3.1.1 12:43:34 INFO - requests == 1.2.3 12:43:34 INFO - wsgiref == 0.1.2 12:43:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:34 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 0x10fcebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf857e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9d30>, '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 0x10f9f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fabebe8>, '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.V7bnlotoVI/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.fpqgJfjIxA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 12:43:34 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 12:43:34 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 12:43:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7bnlotoVI/Render', 12:43:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:34 INFO - 'HOME': '/Users/cltbld', 12:43:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:34 INFO - 'LOGNAME': 'cltbld', 12:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:34 INFO - 'MOZ_NO_REMOTE': '1', 12:43:34 INFO - 'NO_EM_RESTART': '1', 12:43:34 INFO - 'PAGER': '/bin/cat', 12:43:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:34 INFO - 'PWD': '/builds/slave/test', 12:43:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:34 INFO - 'SHELL': '/bin/bash', 12:43:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpqgJfjIxA/Listeners', 12:43:34 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 12:43:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:34 INFO - 'USER': 'cltbld', 12:43:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:34 INFO - 'XPC_FLAGS': '0x0', 12:43:34 INFO - 'XPC_SERVICE_NAME': '0', 12:43:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:34 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)) 12:43:34 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)) 12:43:34 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)) 12:43:34 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)) 12:43:34 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)) 12:43:34 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)) 12:43:34 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)) 12:43:34 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)) 12:43:34 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)) 12:43:34 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)) 12:43:34 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)) 12:43:34 INFO - Cleaning up... 12:43:34 INFO - Return code: 0 12:43:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:43:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:34 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 0x10fcebb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcee768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf857e7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9d30>, '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 0x10f9f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fabebe8>, '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.V7bnlotoVI/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.fpqgJfjIxA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 12:43:34 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 12:43:34 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 12:43:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7bnlotoVI/Render', 12:43:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:34 INFO - 'HOME': '/Users/cltbld', 12:43:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:34 INFO - 'LOGNAME': 'cltbld', 12:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:34 INFO - 'MOZ_NO_REMOTE': '1', 12:43:34 INFO - 'NO_EM_RESTART': '1', 12:43:34 INFO - 'PAGER': '/bin/cat', 12:43:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:34 INFO - 'PWD': '/builds/slave/test', 12:43:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:34 INFO - 'SHELL': '/bin/bash', 12:43:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpqgJfjIxA/Listeners', 12:43:34 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 12:43:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:34 INFO - 'USER': 'cltbld', 12:43:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:34 INFO - 'XPC_FLAGS': '0x0', 12:43:34 INFO - 'XPC_SERVICE_NAME': '0', 12:43:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:43:34 INFO - Cleaning up... 12:43:34 INFO - Return code: 0 12:43:34 INFO - Running post-action listener: _resource_record_post_action 12:43:34 INFO - Running post-action listener: _start_resource_monitoring 12:43:34 INFO - Starting resource monitoring. 12:43:34 INFO - [mozharness: 2017-02-27 20:43:34.988345Z] Finished create-virtualenv step (success) 12:43:34 INFO - [mozharness: 2017-02-27 20:43:34.989272Z] Running install step. 12:43:34 INFO - Running pre-action listener: _resource_record_pre_action 12:43:34 INFO - Running main action method: install 12:43:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:35 INFO - Reading from file tmpfile_stdout 12:43:35 INFO - Detecting whether we're running mozinstall >=1.0... 12:43:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:43:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:43:35 INFO - Reading from file tmpfile_stdout 12:43:35 INFO - Output received: 12:43:35 INFO - Usage: mozinstall [options] installer 12:43:35 INFO - Options: 12:43:35 INFO - -h, --help show this help message and exit 12:43:35 INFO - -d DEST, --destination=DEST 12:43:35 INFO - Directory to install application into. [default: 12:43:35 INFO - "/builds/slave/test"] 12:43:35 INFO - --app=APP Application being installed. [default: firefox] 12:43:35 INFO - mkdir: /builds/slave/test/build/application 12:43:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:43:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 12:43:55 INFO - Reading from file tmpfile_stdout 12:43:55 INFO - Output received: 12:43:55 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:43:55 INFO - Running post-action listener: _resource_record_post_action 12:43:55 INFO - [mozharness: 2017-02-27 20:43:55.906695Z] Finished install step (success) 12:43:55 INFO - [mozharness: 2017-02-27 20:43:55.906883Z] Running run-tests step. 12:43:55 INFO - Running pre-action listener: _resource_record_pre_action 12:43:55 INFO - Running main action method: run_tests 12:43:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:43:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:43:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:43:55 INFO - 2017-02-27 12:43:55.921 screenresolution[1629:7345] starting screenresolution argv=screenresolution get 12:43:55 INFO - 2017-02-27 12:43:55.924 screenresolution[1629:7345] Display 0: 1600x1200x32@60 12:43:55 INFO - 2017-02-27 12:43:55.930 screenresolution[1630:7347] starting screenresolution argv=screenresolution list 12:43:55 INFO - Available Modes on Display 0 12:43:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:43:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:43:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:43:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:43:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:43:56 INFO - Intel Iris: 12:43:56 INFO - Chipset Model: Intel Iris 12:43:56 INFO - Type: GPU 12:43:56 INFO - Bus: Built-In 12:43:56 INFO - VRAM (Dynamic, Max): 1536 MB 12:43:56 INFO - Vendor: Intel (0x8086) 12:43:56 INFO - Device ID: 0x0a2e 12:43:56 INFO - Revision ID: 0x0009 12:43:56 INFO - Displays: 12:43:56 INFO - Display: 12:43:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:43:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:43:56 INFO - Display Serial Number: 1600x1200 60 12:43:56 INFO - Main Display: Yes 12:43:56 INFO - Mirror: Off 12:43:56 INFO - Online: Yes 12:43:56 INFO - Rotation: Supported 12:43:56 INFO - Return code: 0 12:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:43:56 INFO - Python 2.7.3 12:43:56 INFO - Return code: 0 12:43:56 INFO - grabbing minidump binary from tooltool 12:43:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:56 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 0x10fac9d30>, '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 0x10f9f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fabebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:43:56 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 12:43:56 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 12:43:56 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 12:43:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:43:56 INFO - Return code: 0 12:43:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:43:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:43:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:43:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:43:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 12:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --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 12:43:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7bnlotoVI/Render', 12:43:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:56 INFO - 'HOME': '/Users/cltbld', 12:43:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:56 INFO - 'LOGNAME': 'cltbld', 12:43:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:43:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:56 INFO - 'MOZ_NO_REMOTE': '1', 12:43:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:43:56 INFO - 'NO_EM_RESTART': '1', 12:43:56 INFO - 'PAGER': '/bin/cat', 12:43:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:56 INFO - 'PWD': '/builds/slave/test', 12:43:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:43:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:56 INFO - 'SHELL': '/bin/bash', 12:43:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpqgJfjIxA/Listeners', 12:43:56 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 12:43:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:56 INFO - 'USER': 'cltbld', 12:43:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:56 INFO - 'XPC_FLAGS': '0x0', 12:43:56 INFO - 'XPC_SERVICE_NAME': '0', 12:43:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 12:43:56 INFO - mozversion application_buildid: 20170227120121 12:43:56 INFO - mozversion application_changeset: 66e9dc9f094f790c94c7f2a5df0757c8f3b81e78 12:43:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:43:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:43:56 INFO - mozversion application_name: Firefox 12:43:56 INFO - mozversion application_remotingname: firefox-dev 12:43:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:43:56 INFO - mozversion application_vendor: Mozilla 12:43:56 INFO - mozversion application_version: 53.0a2 12:43:56 INFO - mozversion platform_buildid: 20170227120121 12:43:56 INFO - mozversion platform_changeset: 66e9dc9f094f790c94c7f2a5df0757c8f3b81e78 12:43:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:43:56 INFO - mozversion platform_version: 53.0a2 12:43:56 INFO - using testdate: 1488228236 12:43:56 INFO - actual date: 1488228236 12:43:56 INFO - starting webserver on 'localhost:49242' 12:43:56 INFO - SUITE-START | Running 2 tests 12:43:56 INFO - TEST-START | dromaeo_css 12:43:56 INFO - operating with platform_type : mac_ 12:43:56 INFO - Initialising browser for dromaeo_css test... 12:43:56 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpUZhWYT/profile http://localhost:49242/getInfo.html) 12:43:59 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 12:43:59 INFO - PROCESS | 1640 | colorDepth:24 12:43:59 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 12:43:59 INFO - PROCESS | 1640 | __metrics 12:43:59 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:43:59 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:43:59 INFO - TEST-INFO | 1640: exit 0 12:43:59 INFO - Browser initialized. 12:43:59 INFO - Running cycle 1/1 for dromaeo_css test... 12:43:59 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpUZhWYT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:44:12 INFO - PROCESS | 1642 | RSS: Main: 213106688 12:44:12 INFO - PROCESS | 1642 | 12:47:16 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 12:47:17 INFO - PROCESS | 1642 | RSS: Main: 345137152 12:47:17 INFO - PROCESS | 1642 | 12:49:02 INFO - PROCESS | 1642 | ************************* 12:49:02 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 12:49:02 INFO - PROCESS | 1642 | 12:49:02 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:49:02 INFO - PROCESS | 1642 | Full stack: 12:49:02 INFO - PROCESS | 1642 | ************************* 12:50:20 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 12:50:21 INFO - PROCESS | 1642 | RSS: Main: 352980992 12:50:21 INFO - PROCESS | 1642 | 12:53:23 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 12:53:24 INFO - PROCESS | 1642 | RSS: Main: 324190208 12:53:24 INFO - PROCESS | 1642 | 12:56:26 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 12:56:27 INFO - PROCESS | 1642 | RSS: Main: 331345920 12:56:27 INFO - PROCESS | 1642 | 12:59:30 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 12:59:31 INFO - PROCESS | 1642 | RSS: Main: 313384960 12:59:31 INFO - PROCESS | 1642 | 13:02:34 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 13:02:35 INFO - PROCESS | 1642 | RSS: Main: 358137856 13:02:35 INFO - PROCESS | 1642 | 13:02:35 INFO - PROCESS | 1642 | __start_tp_report 13:02:35 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 13:02:35 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 13:02:35 INFO - PROCESS | 1642 | |i|pagename|runs| 13:02:35 INFO - PROCESS | 1642 | |0;dojo.html;3333.2833440810227;3407.148212946763;3422.8117453540062;3423.845926933288;3426.3489936911983;5793.594448388614;5826.096954971976;5831.970840145798;5848.883022339562;5863.237779088723;5808.361080281165;5886.146508756227;5894.852628684274;5901.144334071568;5914.112883067532;5302.973485132588;5314.3091398118195;5379.677219366831;5400.29796126503;5417.322834645669;5256.8160114396005;5266.157414813631;5269.76286067126;5412.377576578685;5421.457854214586;5342.813001544947;5350.866228344284;5360.91958620621;5363.678179309234;5364.463553644643;5371.623986320959;5371.811986580451;5373.059714549977;5383.488568586017;5384.488473595022;5190.818321358772;5306.920396194021;5312;5322.068637988336;5351.57187425005;5873.618214816023;5880.529557635422;5882.382349853289;5884.529237660977;5889.823305300848;6267.153934218868;6296.6536840473755;6306.432421082125;6310.7791227306825;6317.620942743404;6377.07532407803;6411.67941602918;6420.0690899819265;6422.743090276384;6434.967825160891;5850.180974663551;5853.88292234153;5856.063029915235;5867.266591676041;5879.67661778602;5017.3226614406585;6323.30443651198;6388.584741991755;6395;6413.134226879405;6193.938060619426;6212.9378706213265;6300.779472718433;6307.621542707452;6312.810615681537;6391.488680905516;6394.328595497499;6397.52018598607;6397.872042559123;6421.261554921244;6374.139491168726;6385.169927909435;6385.265694445198;6392.20097487814;6393.392627700361;5895.056790913433;6036.0644100164545;6048.848778780566;6114.57197996136;6328.968355158195;4937.975310123498;5007.499250074963;5051.595872330205;5061.6962982221185;5081.74591270435;4487.349334346502;4487.708298960622;4490.416245888014;4499.662525310615;4524.16302983949;5724.227229324071;5762.250907382014;5871.148683440877;5913.040018698939;5945.16767652529;6297.842553936188;6368.458681012074;6369.299377068519;6371.23545174582;6378;5709;5850.9414905851245;5860.2967643883;5872.853178670567;5884.440978107073;5455.372632147274;5510.311211098613;5537.612367134342;5541.501264886099;5545.833624991256;6211.409916058057;6275.184226050585;6333.398327158912;6343.714532846126;6376.3623637635865;6318.241810982711;6356.237251529846;6364.109024736633;6369.20384951881;6382.521310901608;6359.427651511386;6362.522810789302;6385.68071596409;6401.903971440525;6434.871302574016;6232;6343.429091381798;6354.93645063562;6358.459530939737;6359.96820015897;5055.216441451581;6167.383261673976;6254.593451425642;6299.244090708961;6372.713227904848;6158.414950579688;6284.780032698834;6301.0863424804065;6301.338359472373;6306.621602703853;6140.232470941132;6284.842878928063;6285.340039295808;6289.842753931189;6300.369963003846;5909.113632955091;5928.614640048556;6095.146679464967;6172.135900973777;6173.074038894022;6166.167567378347;6217.751289948352;6261.405166509175;6277.71750271248;6296.275928268308;6143.754249829957;6155.230596175478;6158.692065396623;6164.537659675632;6166.630002199882 13:02:35 INFO - PROCESS | 1642 | |1;ext.html;453.7141600791501;497.0258293744261;503.40598094248793;510.71655231346597;541.8618252345653;37991;40538.98652533685;40552;40555.797221013854;40677.983050423754;42424.57575424245;42962.78518607403;43015.56984430155;43133.92165195864;43215;8160.387970902177;8367.581620918929;8403.789905252357;8921.553922303876;9250.537473126351;8342.457740246864;8422.83154336913;8443.704470343539;11002.174836887265;11310.37792921389;11319.603813866517;11413.25813822103;11423.314601123959;11426.542938282459;11438.084953203725;11096.833547496713;11101.111911047097;11158.944205278922;11169.106471482262;11189.713182983938;8089.757307280791;8313.584320783937;10897.455127243606;10946.945265273702;11065.280756750786;39102.80448597767;40798.38802417966;40876;40876.1824763506;40929.976750581176;3866.3427217372832;3897.7466464679987;3947.131631041166;3950.8419663213435;3959.049828041278;29319.560206596918;30307.848460757774;30861.69138308633;31236.843815781;31625.57684904185;3133.388989147117;3241.2707140893344;3246.4318744219668;3253.170441537393;3301.4387554115856;346590;346817;349254;350274;350645;63062.054069189;63365.68317158385;63563.36436635667;63607;63660;66241;66246;66284.66857665681;66504;67310.32689673139;16148.596285092966;16264.674706505804;16511.83488165103;16520.256588453547;16548.33806647745;12730.618081457571;12829.294388808705;12841.22952622827;12845.550405735754;12862.099653024386;14764.40942362315;15104;15122.168280744665;17182.054986975585;17422.65154696899;6272.153259310026;6579.769708060195;6582.605043697394;6623.701933413008;6636.502262330345;868.934829887761;872.0189786490198;875.2341701011615;893.3701740273092;907.4827348411342;30359.089227323217;30391;30651.233719156753;30828.685258964142;30858.228544286125;1058.9788204235872;1067.887871773468;1078.660222030058;1099.6041425086962;1214.665966859103;15149;15160.393584256506;15618.984765990173;15628;16039.518814435585;594684;597880;598303;598400;600344;61771.691141544004;62064;62195.37804621986;62211.37788622146;62370;1406.367134789349;1445.6024593236943;1456.7960485532246;1461.3423959218608;1462.181178540021;28768.136955891358;29547.85226073856;29612.407751845272;30164;30345.848270758506;51597.71005724887;51932.74033629808;52019.959600807015;52040.47959520508;52087.739561301954;493887.5305623449;498479;501301;502202;505882.4705876447;40748.79625601972;41430.585694143876;41494.1701165981;41567.37648935208;41751;36182.7805257242;47306.76346618245;47395;49265.50734492609;51407.71480713012;30813.845930770203;37054.703085391884;38300;39705.80882573527;41438.79280603577;33066.33867322592;39054.80472597732;39186.804065979486;39602.801985991035;40398.798006010955;37516;38107.047323817125;38257.80871095627;38712.41931371088;39006.4149037759;33033.131705373875;34560.8501407943;34855.82572087123;35225;35416.64583354237;25175.741212939647;25262.494750104528;25435.982560698107;25515.617265740657;25857.87071064708 13:02:35 INFO - PROCESS | 1642 | |2;jquery.html;385.99421008684857;388.31850103069115;394.8164103691783;397.3860385704087;420.8527015544558;14255.78616320756;20246.6962995555;21381.465463363424;21484.677729834028;21513.67729484057;21222.363329100113;21444.4638884028;21803.781962180372;21811.454713632167;22025.22911698091;5790.189373487705;6100.877982440348;6123.234595675541;6124.663143527104;6140.3859614038465;4752.833650822222;5980.073088671263;6088.756449742005;6674.432673222782;6753.932460675404;6751.797446076601;6765.627890466047;6766.898496522556;6779.593224406552;6788.321167883197;6455.32219116993;6595.604263744191;6629.535932484728;6695.732170713166;6716.496262780287;5146.922796158061;5376.91934620981;5749.741261643194;5858.443447872445;5879.470847623692;13481.59555213345;13641.317934103256;13687.452501899912;13713;24350.512989740106;2481.565725997943;2550.885210165547;2559.628853816205;2580.7290234525294;2617.149426436397;9940.558619000205;10014.849777253346;10100.444475553842;10456.58173673052;10499.580016799318;1747.1700942052423;1797.532641513216;1802.4772815883377;1812.628411175719;1818.627181427804;131034.44827758573;131642.3417882914;140394.29802851024;141610;143618;11740.70648233801;11809.40573022631;11991.280523168638;12069.637910862513;12137.939310303393;13843.4462621494;14560.344784484723;15784.763228551581;15799.36802527909;15811.972221805776;6923.580665963566;8146;8773.649054037895;8837.425567338103;8874.334424918157;8446.746597602081;8633.568321583896;8720.825583488295;8746.825063498694;8764.605592748341;3879.767213967171;4673.742944138037;4781.832635857728;4858.149823780825;4859.222524396079;1984.4641946674317;2027.5032617008633;2044.2231951858198;2047.7235573197427;2051.3640771360924;912.9315301352425;965.6861520005885;1002.2783595811004;1034.818906691326;1064.8722153341648;20730.896345518177;21364.786352136278;21874.562508749736;21886.45283867884;22060.227892024024;1019.1235537437798;1042.8435734639713;1053.72603123187;1085.1427372375736;1087.8096333141827;8396.748097557083;10136.695899123039;10489.370637761605;10895.455227238765;11431.657050288504;702463;747628;755113;765579;769438;120834.39582802205;140862;147461.052212433;148827.25586372215;155760;944.4097439100562;950.8811398575178;976.1848856205148;978.882534095913;985.8422652375729;18358.265669373075;18958.43124706261;19016.714749278493;19048.42854714361;19072.23711051598;45532.77233613943;57938;58616.827663447344;59324;59617.50956226129;72265.6386718063;86706;87926;89260;91780.28087331692;8028.558429286211;8146.714864979697;8173.6321865515;8252.752417427488;8369.163083691583;11304.152188585724;13005.544805931748;13124.475020999053;13144.211347319191;13178.802317965046;9104.817903641757;9191.77020574491;11400.885991139983;11479.713007174887;11705.297682139098;11221.831672525082;11347.829782553103;11352.035077018545;11505.712357191138;11602.013828824645;10836.945815270874;11571.479283432434;11605.941970290432;11776;11802;7255.673494692646;7550.811229719301;8374.83250335002;8413.242808147295;8481.660733570834;5662.292213473316;7026.648667566704;8520.531370774666;10438.060574548326;10972.396518191576 13:02:35 INFO - PROCESS | 1642 | |3;mootools.html;1227.9386030698463;1438.4102517967633;1451.0930668332285;1452.6295794572382;1454.8908831837614;8053.557054362008;8317.376196785235;8453.450525715823;8459.32325413967;8465.280451161658;7473.215312392202;7693.384529237662;7697.191794861529;7998.720044798433;8211.589420528979;2280.7719228077144;2341.4029422497238;2343.742188359279;2347.6830627865193;2348.283773449097;2290.6449500327476;2329.336139200328;2335.8481698689616;2337.637666161739;2337.6610391493223;2020.3029954665617;2088.1960445228547;2244.3267019894047;2283.7716228377194;2299.5171014087064;2298.5517824024323;2307.3654744945106;2311.28350211435;2312.664663623782;2320.2575175943703;2234.6424572068554;2284.5430913817304;2296.494771150361;2333.346662934381;2335.381124002141;7035;8337.249647531691;8400.537970411626;8402.537860417675;8411.369147313975;5040.243963405482;5187.948120518784;5221;5227.921581176285;5227.973860130675;3325.96674033259;3482.460218666111;3512.209752805624;3555.0223688485617;3572.3391172633146;1160.1762748448612;1220.8229806677982;1246.4141853328922;1247.058470854499;1266.290877108822;10698.786024279549;10749.51627176771;10798.136149108132;10838.512266948006;10882.455877206108;4430.534793846664;4635.675502714845;4637.420322459692;4740.976295118502;4748.525147485293;9460.479673618018;9473.715788526355;9480.24158067353;9489.952550237344;9497.14525692691;5206.297149884793;5211.296474975906;5216.139337009351;5220.295260139908;5226.790928362899;4168.478940132483;4491.730496170175;4696.03731235096;4784.497627749106;4835.637327200474;3150.401423729484;3882.8446862125197;3945.7829819359636;4011.5988401159652;4020.4974378202724;1283.7175821319295;1299.2009913902882;1300.9804852927214;1313.159577870164;1316.407616572527;773.2847116417291;880.3221519430003;905.212465155306;905.6649039855164;927.7309580221795;5526.088195447786;5575.135853942646;5646.378898321182;5748.45389687979;5841.50347220491;1009.65671671632;1020.9030142136634;1036.388530766851;1047.225053460449;1061.045059446489;3666.3034023535442;3755.4366844973474;3795.6204379562373;3846.519185101862;3869.4195870619633;9637.18083962871;9977.600895964226;9985.151262142654;9988.101070903653;9993.350432221881;9827.656032038987;9923.255755818198;9925.255605829592;9932.404055756677;9947.010597880453;7683.308502234826;7791.688332466638;7848.7252946147755;7971.880421793678;8013.479123856814;4978.47725988766;5303.88618390127;5441.047816632153;5463.7814487420055;5731.312242530923;7636.732714354971;8414.116517765791;8951.41815781972;9212.355135140477;9291.256699463891;9012.41419307743;9345.15893569582;9364.719058428258;9374.437533747998;9478.38390504615;6581.308962559054;6805.829854253485;6934.930650693428;7089.7873063808165;7090.893636595352;7066.540674856118;7471.140818805689;7598.962005189938;7618.780995040767;7797.103333116765;7049.154101507852;7163.212046674966;7187.748428804966;7238.384737297178;7316.926830731624;5887.970560147171;6507.381798729113;6546.279909209888;7033.472489563405;7089.291070893076;5686;6312.652804095819;6441.710123044568;6444.8388790280615;6512.990486474604;4615.953840461552;4658.417697787777;4705.458872229738;4740.714282170771;4869.464358920587;4235.407043013919;4294.549072347359;4911.582515486224;4944.802207911644;5070.2141168119 13:02:35 INFO - PROCESS | 1642 | |4;prototype.html;338.9457686770116;347.1875810603188;353.45920741265866;354.7020502777666;357.558415357034;4450.643948484114;5397.811076612319;5442.999999999995;5465.72671366432;5473.589480788937;4981.526754958282;5076.340075790152;5130.4356520782685;5157.896842063156;5338.786448542063;3196.6004249468874;3279.360524697685;3365.5120007598885;3942.80285985701;4159.480064991876;3872.961270387302;3897.8051097445154;4106.1992911382295;4108.609682080212;4201.684873634475;3798.0504873781556;3980.6417422431973;4130.421740956269;4132.607402296777;4160.230357383879;3512.910997590755;3984.6015398460213;4003.339448990913;4007.3788562772525;4028.5568587455505;2802.607634931111;3472.322897035079;3477.600075991268;3501.4572741224897;3566.857325706969;3953.9802300988313;5147.871303217412;5155.819546315861;5167.741612919339;5186.636935414523;3872.9225415491533;4110.034141976633;4347.022104942275;4487.304467807462;4538.186324478845;4673.88315292117;5521.564393257741;5611.915821262684;5620.494155526022;5631.690257035862;3798.734088613798;3809.3714537101623;3815.790131542764;3820.732548721591;3836.8848934532007;5607.57943154261;5825;5844.211031510734;5881.382454842265;5928.466438020556;3664.120611053328;3674.797886116236;3881.86413475527;3893.53277606689;3899.922001559953;3317.817520036373;3454.689077982943;3812.2566099610863;3956.1296514766705;3997.400389941474;3959.7822119783687;4299.677524185636;4604.470485894165;4607.9078418431445;4618.538146185355;4908.055166899903;5306.442823503554;5609.719514024282;5619.634723742944;5705.914411283834;1207.8163399868179;1265.8354413926131;1271.5059804729406;1282.4870051979283;1283.4288741509938;789.8222899847489;794.8211652378169;808.6361137488154;851.7061613743373;869.2784988459564;4205.222033923734;4891.902161956812;4983.551480366712;4994.2531607615665;5022.522860328336;4778.856634300976;5566;5593.965116453388;5597.3003374578175;5602.411746766531;4337.46020162844;4756.762161891892;4756.9286460703115;4759.524047595282;4928.359313289249;2520.332111990324;2568.6368540942376;2886.321714397115;2887.4946884295587;2891;5478.24696097245;5530.9579731147705;5622.662640241517;5642.689652069093;5661.688607126647;4963.70217786934;5101.7194054327365;5242.082635538765;5595.21666966625;5629.8592535186945;5589.245451863946;5646.350669672958;5653.349864765522;5683.460071293221;5698.430156984268;4647.488776234679;4845.75771211445;5127.87180320495;5242.711650859239;5473.631592101974;5134.332536770196;5648.604597678123;5705.743241554057;5728.770849166153;5742.6217707749;5449.7275136243825;5974.910376344272;5992.820215393545;6011.879762404815;6015;3120.673713671635;3667.5965643779696;3726.4410338449447;3770.8868733938025;3820.5988371221733;5256.605754568499;5276.34045744282;5522.723863806874;5760.769569217185;5768.365479797135;4833.709977401367;5218.582513398995;5564;5592.972035139798;5682.431756824284;5092.9696830385865;5420.2408219684685;5558.638688485235;5583.972080139573;5643.463870932255;4758.976205118952;5175.689458632494;5511.944880551304;5512.724363781875;5532.419095994863;4207.579242075891;4844.685095468924;5018.770401251717;5058.848234552969;5591.524720398812;4980.975095124646;5089.9745501272255;5515.641483303572;5538.446155384429;5548.861278468071 13:02:35 INFO - PROCESS | 1642 | |5;yui.html;701.2776839854945;727.0875051809978;739.9307999940086;776.138486280229;793.9087004994424;14691;15103.697926041486;15124.697506049872;15409.46066887659;15513.612159695986;11767.588134415297;13529.729405411887;14227.146371217734;14419.711605767878;14479.710405791879;844.7845799321165;846.8814365988767;853.1255463150289;855.529458797662;855.5422848775906;666.4235436347573;684.8082536889679;687.9862402751942;836.0886633569409;857.2113655436982;736.8415790605019;911.9042500537414;913.8720579118929;914.2411798207505;915.3363811236867;901.1844280925707;906.9682561110362;907.2560500389716;907.5416914458157;907.7095329494564;513.8355726167628;529.9311089558371;652.5627829354297;656.8916128838736;679.100192245277;14908.403663853433;15280.847191528164;15306.846931530765;15337.6165595861;15363.923180384138;10481.842772358421;12651.557195498113;12793.680157996032;12911.289879056649;12935.223886566742;12153.69615759613;12219.755604887941;12328.32194229317;12370.938145309216;12387.380630968506;4233.786870592903;4241.257779888507;4351.934720979188;4367.934480982788;4500.032493013985;109328;110112;110879;111514;111671;9148.8627670585;10620.946895265473;10706.608140941627;10794.622188223531;11072.778544429066;21990.120395184014;22000.33998980033;22008.779912200993;22017.779822201574;22068.668969965463;7414.851702966019;7456.403487721078;7638.197989211164;7678.961605191938;7753.263439973193;4102.0993506752375;4207.747535147901;4228.471441069866;4230.703850730481;4263.829446822155;3348.6483919188136;3368.5620869287327;3411;3417.111550996709;3451.5340429041757;545.91265397537;638.8850006998692;643.089997971796;646.9320721324287;658.9423974520921;608.5405518833253;626.3048016701458;634.4385219081147;638.9297177310492;645.6255371884296;8754;9464.90535094654;9567.550677267509;9588.712338629713;9686.149613481086;590.6902086677368;595.2677211598782;655.9376859198369;659.9637019963948;661.9834504137435;4096.7844256770295;4320.910673577169;4470.284754439339;4600.60894823937;4623.745693986796;101382.4930875341;102950.97049029563;103488.44767328496;105483;109918;95147;96616;98177;99603;100863.99136008693;77065;82601.17398826055;86297;86687.56656216679;88194;8932.508712020901;8968.417052891542;9045.276377889884;9095.226905713089;9112.589933452879;52472.68818279573;52651.73674131758;53573.66065848385;53872.19191712206;54623.726881365335;60158;71682.64158679174;72767.63616182096;73155.26844731484;73950.26049739649;10940.343579385262;11004.449777511252;11173.944130279297;11372;11739.647810565697;11707.239029463057;11827.467763950472;11865;11936.880631193924;12169.33068681231;10606.416647084176;10864.42003941338;10886.51010704536;10980.286281391684;11385.715357116138;11216.2148649597;11394.658160255205;11582.36297003673;11623.825642615537;11971.700707482383;10897;10913.454327283445;10958.671239862817;10999.285046471954;11774.293542387484;9559.27188396512;9560.521973901416;9760.46317452547;9781;9920.702378928643;8877.600507977286;9510.667126650535;9612.807743844944;9670.903290967282;9747.853782193131 13:02:35 INFO - PROCESS | 1642 | __end_tp_report 13:02:35 INFO - PROCESS | 1642 | __start_cc_report 13:02:35 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1655 13:02:35 INFO - PROCESS | 1642 | __end_cc_report 13:02:35 INFO - PROCESS | 1642 | __startTimestamp1488229355013__endTimestamp 13:02:35 INFO - PROCESS | 1642 | 13:02:35 INFO - PROCESS | 1642 | ------- Summary: start ------- 13:02:35 INFO - PROCESS | 1642 | Number of tests: 6 13:02:35 INFO - PROCESS | 1642 | 13:02:35 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5849.02 Median:6095.15 stddev:649.45 (10.7%) stddev-sans-first:620.73 13:02:35 INFO - PROCESS | 1642 | Values: 3333.3 3407.1 3422.8 3423.8 3426.3 5793.6 5826.1 5832.0 5848.9 5863.2 5808.4 5886.1 5894.9 5901.1 5914.1 5303.0 5314.3 5379.7 5400.3 5417.3 5256.8 5266.2 5269.8 5412.4 5421.5 5342.8 5350.9 5360.9 5363.7 5364.5 5371.6 5371.8 5373.1 5383.5 5384.5 5190.8 5306.9 5312.0 5322.1 5351.6 5873.6 5880.5 5882.4 5884.5 5889.8 6267.2 6296.7 6306.4 6310.8 6317.6 6377.1 6411.7 6420.1 6422.7 6435.0 5850.2 5853.9 5856.1 5867.3 5879.7 5017.3 6323.3 6388.6 6395.0 6413.1 6193.9 6212.9 6300.8 6307.6 6312.8 6391.5 6394.3 6397.5 6397.9 6421.3 6374.1 6385.2 6385.3 6392.2 6393.4 5895.1 6036.1 6048.8 6114.6 6329.0 4938.0 5007.5 5051.6 5061.7 5081.7 4487.3 4487.7 4490.4 4499.7 4524.2 5724.2 5762.3 5871.1 5913.0 5945.2 6297.8 6368.5 6369.3 6371.2 6378.0 5709.0 5850.9 5860.3 5872.9 5884.4 5455.4 5510.3 5537.6 5541.5 5545.8 6211.4 6275.2 6333.4 6343.7 6376.4 6318.2 6356.2 6364.1 6369.2 6382.5 6359.4 6362.5 6385.7 6401.9 6434.9 6232.0 6343.4 6354.9 6358.5 6360.0 5055.2 6167.4 6254.6 6299.2 6372.7 6158.4 6284.8 6301.1 6301.3 6306.6 6140.2 6284.8 6285.3 6289.8 6300.4 5909.1 5928.6 6095.1 6172.1 6173.1 6166.2 6217.8 6261.4 6277.7 6296.3 6143.8 6155.2 6158.7 6164.5 6166.6 13:02:35 INFO - PROCESS | 1642 | 13:02:35 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:63782.52 Median:21305.08 stddev:131334.34 (616.4%) stddev-sans-first:131616.69 13:02:35 INFO - PROCESS | 1642 | Values: 453.7 497.0 503.4 510.7 541.9 37991.0 40539.0 40552.0 40555.8 40678.0 42424.6 42962.8 43015.6 43133.9 43215.0 8160.4 8367.6 8403.8 8921.6 9250.5 8342.5 8422.8 8443.7 11002.2 11310.4 11319.6 11413.3 11423.3 11426.5 11438.1 11096.8 11101.1 11158.9 11169.1 11189.7 8089.8 8313.6 10897.5 10946.9 11065.3 39102.8 40798.4 40876.0 40876.2 40930.0 3866.3 3897.7 3947.1 3950.8 3959.0 29319.6 30307.8 30861.7 31236.8 31625.6 3133.4 3241.3 3246.4 3253.2 3301.4 346590.0 346817.0 349254.0 350274.0 350645.0 63062.1 63365.7 63563.4 63607.0 63660.0 66241.0 66246.0 66284.7 66504.0 67310.3 16148.6 16264.7 16511.8 16520.3 16548.3 12730.6 12829.3 12841.2 12845.6 12862.1 14764.4 15104.0 15122.2 17182.1 17422.7 6272.2 6579.8 6582.6 6623.7 6636.5 868.9 872.0 875.2 893.4 907.5 30359.1 30391.0 30651.2 30828.7 30858.2 1059.0 1067.9 1078.7 1099.6 1214.7 15149.0 15160.4 15619.0 15628.0 16039.5 594684.0 597880.0 598303.0 598400.0 600344.0 61771.7 62064.0 62195.4 62211.4 62370.0 1406.4 1445.6 1456.8 1461.3 1462.2 28768.1 29547.9 29612.4 30164.0 30345.8 51597.7 51932.7 52020.0 52040.5 52087.7 493887.5 498479.0 501301.0 502202.0 505882.5 40748.8 41430.6 41494.2 41567.4 41751.0 36182.8 47306.8 47395.0 49265.5 51407.7 30813.8 37054.7 38300.0 39705.8 41438.8 33066.3 39054.8 39186.8 39602.8 40398.8 37516.0 38107.0 38257.8 38712.4 39006.4 33033.1 34560.9 34855.8 35225.0 35416.6 25175.7 25262.5 25436.0 25515.6 25857.9 13:02:35 INFO - PROCESS | 1642 | 13:02:35 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:40249.60 Median:13416.04 stddev:124572.32 (928.5%) stddev-sans-first:124885.82 13:02:35 INFO - PROCESS | 1642 | Values: 386.0 388.3 394.8 397.4 420.9 14255.8 20246.7 21381.5 21484.7 21513.7 21222.4 21444.5 21803.8 21811.5 22025.2 5790.2 6100.9 6123.2 6124.7 6140.4 4752.8 5980.1 6088.8 6674.4 6753.9 6751.8 6765.6 6766.9 6779.6 6788.3 6455.3 6595.6 6629.5 6695.7 6716.5 5146.9 5376.9 5749.7 5858.4 5879.5 13481.6 13641.3 13687.5 13713.0 24350.5 2481.6 2550.9 2559.6 2580.7 2617.1 9940.6 10014.8 10100.4 10456.6 10499.6 1747.2 1797.5 1802.5 1812.6 1818.6 131034.4 131642.3 140394.3 141610.0 143618.0 11740.7 11809.4 11991.3 12069.6 12137.9 13843.4 14560.3 15784.8 15799.4 15812.0 6923.6 8146.0 8773.6 8837.4 8874.3 8446.7 8633.6 8720.8 8746.8 8764.6 3879.8 4673.7 4781.8 4858.1 4859.2 1984.5 2027.5 2044.2 2047.7 2051.4 912.9 965.7 1002.3 1034.8 1064.9 20730.9 21364.8 21874.6 21886.5 22060.2 1019.1 1042.8 1053.7 1085.1 1087.8 8396.7 10136.7 10489.4 10895.5 11431.7 702463.0 747628.0 755113.0 765579.0 769438.0 120834.4 140862.0 147461.1 148827.3 155760.0 944.4 950.9 976.2 978.9 985.8 18358.3 18958.4 19016.7 19048.4 19072.2 45532.8 57938.0 58616.8 59324.0 59617.5 72265.6 86706.0 87926.0 89260.0 91780.3 8028.6 8146.7 8173.6 8252.8 8369.2 11304.2 13005.5 13124.5 13144.2 13178.8 9104.8 9191.8 11400.9 11479.7 11705.3 11221.8 11347.8 11352.0 11505.7 11602.0 10836.9 11571.5 11605.9 11776.0 11802.0 7255.7 7550.8 8374.8 8413.2 8481.7 5662.3 7026.6 8520.5 10438.1 10972.4 13:02:35 INFO - PROCESS | 1642 | 13:02:35 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5367.44 Median:5218.22 stddev:2912.20 (55.8%) stddev-sans-first:2903.74 13:02:35 INFO - PROCESS | 1642 | Values: 1227.9 1438.4 1451.1 1452.6 1454.9 8053.6 8317.4 8453.5 8459.3 8465.3 7473.2 7693.4 7697.2 7998.7 8211.6 2280.8 2341.4 2343.7 2347.7 2348.3 2290.6 2329.3 2335.8 2337.6 2337.7 2020.3 2088.2 2244.3 2283.8 2299.5 2298.6 2307.4 2311.3 2312.7 2320.3 2234.6 2284.5 2296.5 2333.3 2335.4 7035.0 8337.2 8400.5 8402.5 8411.4 5040.2 5187.9 5221.0 5227.9 5228.0 3326.0 3482.5 3512.2 3555.0 3572.3 1160.2 1220.8 1246.4 1247.1 1266.3 10698.8 10749.5 10798.1 10838.5 10882.5 4430.5 4635.7 4637.4 4741.0 4748.5 9460.5 9473.7 9480.2 9490.0 9497.1 5206.3 5211.3 5216.1 5220.3 5226.8 4168.5 4491.7 4696.0 4784.5 4835.6 3150.4 3882.8 3945.8 4011.6 4020.5 1283.7 1299.2 1301.0 1313.2 1316.4 773.3 880.3 905.2 905.7 927.7 5526.1 5575.1 5646.4 5748.5 5841.5 1009.7 1020.9 1036.4 1047.2 1061.0 3666.3 3755.4 3795.6 3846.5 3869.4 9637.2 9977.6 9985.2 9988.1 9993.4 9827.7 9923.3 9925.3 9932.4 9947.0 7683.3 7791.7 7848.7 7971.9 8013.5 4978.5 5303.9 5441.0 5463.8 5731.3 7636.7 8414.1 8951.4 9212.4 9291.3 9012.4 9345.2 9364.7 9374.4 9478.4 6581.3 6805.8 6934.9 7089.8 7090.9 7066.5 7471.1 7599.0 7618.8 7797.1 7049.2 7163.2 7187.7 7238.4 7316.9 5888.0 6507.4 6546.3 7033.5 7089.3 5686.0 6312.7 6441.7 6444.8 6513.0 4616.0 4658.4 4705.5 4740.7 4869.5 4235.4 4294.5 4911.6 4944.8 5070.2 13:02:35 INFO - PROCESS | 1642 | 13:02:35 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4436.39 Median:4982.54 stddev:1380.16 (27.7%) stddev-sans-first:1349.33 13:02:35 INFO - PROCESS | 1642 | Values: 338.9 347.2 353.5 354.7 357.6 4450.6 5397.8 5443.0 5465.7 5473.6 4981.5 5076.3 5130.4 5157.9 5338.8 3196.6 3279.4 3365.5 3942.8 4159.5 3873.0 3897.8 4106.2 4108.6 4201.7 3798.1 3980.6 4130.4 4132.6 4160.2 3512.9 3984.6 4003.3 4007.4 4028.6 2802.6 3472.3 3477.6 3501.5 3566.9 3954.0 5147.9 5155.8 5167.7 5186.6 3872.9 4110.0 4347.0 4487.3 4538.2 4673.9 5521.6 5611.9 5620.5 5631.7 3798.7 3809.4 3815.8 3820.7 3836.9 5607.6 5825.0 5844.2 5881.4 5928.5 3664.1 3674.8 3881.9 3893.5 3899.9 3317.8 3454.7 3812.3 3956.1 3997.4 3959.8 4299.7 4604.5 4607.9 4618.5 4908.1 5306.4 5609.7 5619.6 5705.9 1207.8 1265.8 1271.5 1282.5 1283.4 789.8 794.8 808.6 851.7 869.3 4205.2 4891.9 4983.6 4994.3 5022.5 4778.9 5566.0 5594.0 5597.3 5602.4 4337.5 4756.8 4756.9 4759.5 4928.4 2520.3 2568.6 2886.3 2887.5 2891.0 5478.2 5531.0 5622.7 5642.7 5661.7 4963.7 5101.7 5242.1 5595.2 5629.9 5589.2 5646.4 5653.3 5683.5 5698.4 4647.5 4845.8 5127.9 5242.7 5473.6 5134.3 5648.6 5705.7 5728.8 5742.6 5449.7 5974.9 5992.8 6011.9 6015.0 3120.7 3667.6 3726.4 3770.9 3820.6 5256.6 5276.3 5522.7 5760.8 5768.4 4833.7 5218.6 5564.0 5593.0 5682.4 5093.0 5420.2 5558.6 5584.0 5643.5 4759.0 5175.7 5511.9 5512.7 5532.4 4207.6 4844.7 5018.8 5058.8 5591.5 4981.0 5090.0 5515.6 5538.4 5548.9 13:02:35 INFO - PROCESS | 1642 | 13:02:35 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20766.30 Median:26493.26 stddev:31234.33 (117.9%) stddev-sans-first:31285.61 13:02:35 INFO - PROCESS | 1642 | Values: 701.3 727.1 739.9 776.1 793.9 14691.0 15103.7 15124.7 15409.5 15513.6 11767.6 13529.7 14227.1 14419.7 14479.7 844.8 846.9 853.1 855.5 855.5 666.4 684.8 688.0 836.1 857.2 736.8 911.9 913.9 914.2 915.3 901.2 907.0 907.3 907.5 907.7 513.8 529.9 652.6 656.9 679.1 14908.4 15280.8 15306.8 15337.6 15363.9 10481.8 12651.6 12793.7 12911.3 12935.2 12153.7 12219.8 12328.3 12370.9 12387.4 4233.8 4241.3 4351.9 4367.9 4500.0 109328.0 110112.0 110879.0 111514.0 111671.0 9148.9 10620.9 10706.6 10794.6 11072.8 21990.1 22000.3 22008.8 22017.8 22068.7 7414.9 7456.4 7638.2 7679.0 7753.3 4102.1 4207.7 4228.5 4230.7 4263.8 3348.6 3368.6 3411.0 3417.1 3451.5 545.9 638.9 643.1 646.9 658.9 608.5 626.3 634.4 638.9 645.6 8754.0 9464.9 9567.6 9588.7 9686.1 590.7 595.3 655.9 660.0 662.0 4096.8 4320.9 4470.3 4600.6 4623.7 101382.5 102951.0 103488.4 105483.0 109918.0 95147.0 96616.0 98177.0 99603.0 100864.0 77065.0 82601.2 86297.0 86687.6 88194.0 8932.5 8968.4 9045.3 9095.2 9112.6 52472.7 52651.7 53573.7 53872.2 54623.7 60158.0 71682.6 72767.6 73155.3 73950.3 10940.3 11004.4 11173.9 11372.0 11739.6 11707.2 11827.5 11865.0 11936.9 12169.3 10606.4 10864.4 10886.5 10980.3 11385.7 11216.2 11394.7 11582.4 11623.8 11971.7 10897.0 10913.5 10958.7 10999.3 11774.3 9559.3 9560.5 9760.5 9781.0 9920.7 8877.6 9510.7 9612.8 9670.9 9747.9 13:02:35 INFO - PROCESS | 1642 | -------- Summary: end -------- 13:02:35 INFO - PROCESS | 1642 | 13:02:35 INFO - TEST-INFO | 1642: exit 0 13:02:35 INFO - TEST-OK | dromaeo_css | took 1119126ms 13:02:35 INFO - TEST-START | kraken 13:02:35 INFO - operating with platform_type : mac_ 13:02:35 INFO - Initialising browser for kraken test... 13:02:35 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp1IKq4y/profile http://localhost:49242/getInfo.html) 13:02:38 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 13:02:38 INFO - PROCESS | 1651 | colorDepth:24 13:02:38 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 13:02:38 INFO - PROCESS | 1651 | __metrics 13:02:38 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:02:38 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:02:38 INFO - TEST-INFO | 1651: exit 0 13:02:38 INFO - Browser initialized. 13:02:38 INFO - Running cycle 1/1 for kraken test... 13:02:38 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp1IKq4y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:02:51 INFO - PROCESS | 1652 | RSS: Main: 212832256 13:02:51 INFO - PROCESS | 1652 | 13:02:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 13:02:54 INFO - PROCESS | 1652 | RSS: Main: 264450048 13:02:54 INFO - PROCESS | 1652 | 13:02:57 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 13:02:58 INFO - PROCESS | 1652 | RSS: Main: 274558976 13:02:58 INFO - PROCESS | 1652 | 13:03:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 13:03:01 INFO - PROCESS | 1652 | RSS: Main: 370716672 13:03:01 INFO - PROCESS | 1652 | 13:03:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 13:03:04 INFO - PROCESS | 1652 | RSS: Main: 275378176 13:03:04 INFO - PROCESS | 1652 | 13:03:06 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:03:07 INFO - PROCESS | 1652 | RSS: Main: 276963328 13:03:07 INFO - PROCESS | 1652 | 13:03:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 13:03:10 INFO - PROCESS | 1652 | RSS: Main: 316743680 13:03:10 INFO - PROCESS | 1652 | 13:03:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 13:03:14 INFO - PROCESS | 1652 | RSS: Main: 318115840 13:03:14 INFO - PROCESS | 1652 | 13:03:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 13:03:17 INFO - PROCESS | 1652 | RSS: Main: 318234624 13:03:17 INFO - PROCESS | 1652 | 13:03:19 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:03:20 INFO - PROCESS | 1652 | RSS: Main: 294551552 13:03:20 INFO - PROCESS | 1652 | 13:03:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:03:22 INFO - PROCESS | 1652 | RSS: Main: 299180032 13:03:22 INFO - PROCESS | 1652 | 13:03:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:03:25 INFO - PROCESS | 1652 | RSS: Main: 301211648 13:03:25 INFO - PROCESS | 1652 | 13:03:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:03:29 INFO - PROCESS | 1652 | RSS: Main: 319123456 13:03:29 INFO - PROCESS | 1652 | 13:03:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:03:32 INFO - PROCESS | 1652 | RSS: Main: 312209408 13:03:32 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 13:03:34 INFO - PROCESS | 1652 | RSS: Main: 356519936 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | __start_tp_report 13:03:34 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 13:03:34 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 13:03:34 INFO - PROCESS | 1652 | |i|pagename|runs| 13:03:34 INFO - PROCESS | 1652 | |0;ai-astar;105;167;163;114;115;116;114;115;115;119 13:03:34 INFO - PROCESS | 1652 | |1;audio-beat-detection;147;112;114;182;114;111;110;108;130;109 13:03:34 INFO - PROCESS | 1652 | |2;audio-dft;185;186;188;184;184;186;183;185;183;185 13:03:34 INFO - PROCESS | 1652 | |3;audio-fft;82;59;59;90;61;61;74;85;86;57 13:03:34 INFO - PROCESS | 1652 | |4;audio-oscillator;86;69;85;78;95;101;112;67;67;82 13:03:34 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;90;87;91;87;90;87;90;88;91;87 13:03:34 INFO - PROCESS | 1652 | |6;imaging-darkroom;95;95;96;97;96;96;97;96;96;95 13:03:34 INFO - PROCESS | 1652 | |7;imaging-desaturate;137;97;85;86;86;87;88;87;88;88 13:03:34 INFO - PROCESS | 1652 | |8;json-parse-financial;58;52;60;64;86;87;68;57;56;56 13:03:34 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;60;70;76;79;74;70;69;71;69;72 13:03:34 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;86;101;103;84;84;84;83;84;86;88 13:03:34 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;142;148;149;135;165;150;135;164;216;157 13:03:34 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;169;176;169;174;167;170;166;169;166;167 13:03:34 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;65;67;66;67;65;65;65;65;64;62 13:03:34 INFO - PROCESS | 1652 | __end_tp_report 13:03:34 INFO - PROCESS | 1652 | __start_cc_report 13:03:34 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2080 13:03:34 INFO - PROCESS | 1652 | __end_cc_report 13:03:34 INFO - PROCESS | 1652 | __startTimestamp1488229414800__endTimestamp 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | ------- Summary: start ------- 13:03:34 INFO - PROCESS | 1652 | Number of tests: 14 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:124.30 Median:115.50 stddev:21.76 (18.8%) stddev-sans-first:21.93 13:03:34 INFO - PROCESS | 1652 | Values: 105.0 167.0 163.0 114.0 115.0 116.0 114.0 115.0 115.0 119.0 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:123.70 Median:114.00 stddev:23.85 (20.9%) stddev-sans-first:23.76 13:03:34 INFO - PROCESS | 1652 | Values: 147.0 112.0 114.0 182.0 114.0 111.0 110.0 108.0 130.0 109.0 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.00 stddev:1.52 (0.8%) stddev-sans-first:1.62 13:03:34 INFO - PROCESS | 1652 | Values: 185.0 186.0 188.0 184.0 184.0 186.0 183.0 185.0 183.0 185.0 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:71.40 Median:78.00 stddev:13.31 (17.1%) stddev-sans-first:13.55 13:03:34 INFO - PROCESS | 1652 | Values: 82.0 59.0 59.0 90.0 61.0 61.0 74.0 85.0 86.0 57.0 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:84.20 Median:80.00 stddev:15.06 (18.8%) stddev-sans-first:15.96 13:03:34 INFO - PROCESS | 1652 | Values: 86.0 69.0 85.0 78.0 95.0 101.0 112.0 67.0 67.0 82.0 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:90.00 stddev:1.75 (1.9%) stddev-sans-first:1.80 13:03:34 INFO - PROCESS | 1652 | Values: 90.0 87.0 91.0 87.0 90.0 87.0 90.0 88.0 91.0 87.0 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 13:03:34 INFO - PROCESS | 1652 | Values: 95.0 95.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 95.0 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:92.90 Median:87.50 stddev:15.85 (18.1%) stddev-sans-first:3.54 13:03:34 INFO - PROCESS | 1652 | Values: 137.0 97.0 85.0 86.0 86.0 87.0 88.0 87.0 88.0 88.0 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:62.00 stddev:12.47 (20.1%) stddev-sans-first:13.01 13:03:34 INFO - PROCESS | 1652 | Values: 58.0 52.0 60.0 64.0 86.0 87.0 68.0 57.0 56.0 56.0 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.50 stddev:5.06 (7.1%) stddev-sans-first:3.46 13:03:34 INFO - PROCESS | 1652 | Values: 60.0 70.0 76.0 79.0 74.0 70.0 69.0 71.0 69.0 72.0 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:84.00 stddev:7.38 (8.8%) stddev-sans-first:7.78 13:03:34 INFO - PROCESS | 1652 | Values: 86.0 101.0 103.0 84.0 84.0 84.0 83.0 84.0 86.0 88.0 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:156.10 Median:153.50 stddev:23.51 (15.3%) stddev-sans-first:24.37 13:03:34 INFO - PROCESS | 1652 | Values: 142.0 148.0 149.0 135.0 165.0 150.0 135.0 164.0 216.0 157.0 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.00 stddev:3.33 (2.0%) stddev-sans-first:3.54 13:03:34 INFO - PROCESS | 1652 | Values: 169.0 176.0 169.0 174.0 167.0 170.0 166.0 169.0 166.0 167.0 13:03:34 INFO - PROCESS | 1652 | 13:03:34 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.45 (2.2%) stddev-sans-first:1.54 13:03:34 INFO - PROCESS | 1652 | Values: 65.0 67.0 66.0 67.0 65.0 65.0 65.0 65.0 64.0 62.0 13:03:34 INFO - PROCESS | 1652 | -------- Summary: end -------- 13:03:34 INFO - PROCESS | 1652 | 13:03:35 INFO - TEST-INFO | 1652: exit 0 13:03:35 INFO - TEST-OK | kraken | took 60046ms 13:03:35 INFO - SUITE-END | took 1179s 13:03:35 INFO - Completed test suite (00:19:39) 13:03:35 INFO - javascript benchmark 13:03:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3333.2833440810227, 3407.148212946763, 3422.8117453540062, 3423.845926933288, 3426.3489936911983, 5793.594448388614, 5826.096954971976, 5831.970840145798, 5848.883022339562, 5863.237779088723, 5808.361080281165, 5886.146508756227, 5894.852628684274, 5901.144334071568, 5914.112883067532, 5302.973485132588, 5314.3091398118195, 5379.677219366831, 5400.29796126503, 5417.322834645669, 5256.8160114396005, 5266.157414813631, 5269.76286067126, 5412.377576578685, 5421.457854214586, 5342.813001544947, 5350.866228344284, 5360.91958620621, 5363.678179309234, 5364.463553644643, 5371.623986320959, 5371.811986580451, 5373.059714549977, 5383.488568586017, 5384.488473595022, 5190.818321358772, 5306.920396194021, 5312.0, 5322.068637988336, 5351.57187425005, 5873.618214816023, 5880.529557635422, 5882.382349853289, 5884.529237660977, 5889.823305300848, 6267.153934218868, 6296.6536840473755, 6306.432421082125, 6310.7791227306825, 6317.620942743404, 6377.07532407803, 6411.67941602918, 6420.0690899819265, 6422.743090276384, 6434.967825160891, 5850.180974663551, 5853.88292234153, 5856.063029915235, 5867.266591676041, 5879.67661778602, 5017.3226614406585, 6323.30443651198, 6388.584741991755, 6395.0, 6413.134226879405, 6193.938060619426, 6212.9378706213265, 6300.779472718433, 6307.621542707452, 6312.810615681537, 6391.488680905516, 6394.328595497499, 6397.52018598607, 6397.872042559123, 6421.261554921244, 6374.139491168726, 6385.169927909435, 6385.265694445198, 6392.20097487814, 6393.392627700361, 5895.056790913433, 6036.0644100164545, 6048.848778780566, 6114.57197996136, 6328.968355158195, 4937.975310123498, 5007.499250074963, 5051.595872330205, 5061.6962982221185, 5081.74591270435, 4487.349334346502, 4487.708298960622, 4490.416245888014, 4499.662525310615, 4524.16302983949, 5724.227229324071, 5762.250907382014, 5871.148683440877, 5913.040018698939, 5945.16767652529, 6297.842553936188, 6368.458681012074, 6369.299377068519, 6371.23545174582, 6378.0, 5709.0, 5850.9414905851245, 5860.2967643883, 5872.853178670567, 5884.440978107073, 5455.372632147274, 5510.311211098613, 5537.612367134342, 5541.501264886099, 5545.833624991256, 6211.409916058057, 6275.184226050585, 6333.398327158912, 6343.714532846126, 6376.3623637635865, 6318.241810982711, 6356.237251529846, 6364.109024736633, 6369.20384951881, 6382.521310901608, 6359.427651511386, 6362.522810789302, 6385.68071596409, 6401.903971440525, 6434.871302574016, 6232.0, 6343.429091381798, 6354.93645063562, 6358.459530939737, 6359.96820015897, 5055.216441451581, 6167.383261673976, 6254.593451425642, 6299.244090708961, 6372.713227904848, 6158.414950579688, 6284.780032698834, 6301.0863424804065, 6301.338359472373, 6306.621602703853, 6140.232470941132, 6284.842878928063, 6285.340039295808, 6289.842753931189, 6300.369963003846, 5909.113632955091, 5928.614640048556, 6095.146679464967, 6172.135900973777, 6173.074038894022, 6166.167567378347, 6217.751289948352, 6261.405166509175, 6277.71750271248, 6296.275928268308, 6143.754249829957, 6155.230596175478, 6158.692065396623, 6164.537659675632, 6166.630002199882], "value": 5807.730361162981, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.7141600791501, 497.0258293744261, 503.40598094248793, 510.71655231346597, 541.8618252345653, 37991.0, 40538.98652533685, 40552.0, 40555.797221013854, 40677.983050423754, 42424.57575424245, 42962.78518607403, 43015.56984430155, 43133.92165195864, 43215.0, 8160.387970902177, 8367.581620918929, 8403.789905252357, 8921.553922303876, 9250.537473126351, 8342.457740246864, 8422.83154336913, 8443.704470343539, 11002.174836887265, 11310.37792921389, 11319.603813866517, 11413.25813822103, 11423.314601123959, 11426.542938282459, 11438.084953203725, 11096.833547496713, 11101.111911047097, 11158.944205278922, 11169.106471482262, 11189.713182983938, 8089.757307280791, 8313.584320783937, 10897.455127243606, 10946.945265273702, 11065.280756750786, 39102.80448597767, 40798.38802417966, 40876.0, 40876.1824763506, 40929.976750581176, 3866.3427217372832, 3897.7466464679987, 3947.131631041166, 3950.8419663213435, 3959.049828041278, 29319.560206596918, 30307.848460757774, 30861.69138308633, 31236.843815781, 31625.57684904185, 3133.388989147117, 3241.2707140893344, 3246.4318744219668, 3253.170441537393, 3301.4387554115856, 346590.0, 346817.0, 349254.0, 350274.0, 350645.0, 63062.054069189, 63365.68317158385, 63563.36436635667, 63607.0, 63660.0, 66241.0, 66246.0, 66284.66857665681, 66504.0, 67310.32689673139, 16148.596285092966, 16264.674706505804, 16511.83488165103, 16520.256588453547, 16548.33806647745, 12730.618081457571, 12829.294388808705, 12841.22952622827, 12845.550405735754, 12862.099653024386, 14764.40942362315, 15104.0, 15122.168280744665, 17182.054986975585, 17422.65154696899, 6272.153259310026, 6579.769708060195, 6582.605043697394, 6623.701933413008, 6636.502262330345, 868.934829887761, 872.0189786490198, 875.2341701011615, 893.3701740273092, 907.4827348411342, 30359.089227323217, 30391.0, 30651.233719156753, 30828.685258964142, 30858.228544286125, 1058.9788204235872, 1067.887871773468, 1078.660222030058, 1099.6041425086962, 1214.665966859103, 15149.0, 15160.393584256506, 15618.984765990173, 15628.0, 16039.518814435585, 594684.0, 597880.0, 598303.0, 598400.0, 600344.0, 61771.691141544004, 62064.0, 62195.37804621986, 62211.37788622146, 62370.0, 1406.367134789349, 1445.6024593236943, 1456.7960485532246, 1461.3423959218608, 1462.181178540021, 28768.136955891358, 29547.85226073856, 29612.407751845272, 30164.0, 30345.848270758506, 51597.71005724887, 51932.74033629808, 52019.959600807015, 52040.47959520508, 52087.739561301954, 493887.5305623449, 498479.0, 501301.0, 502202.0, 505882.4705876447, 40748.79625601972, 41430.585694143876, 41494.1701165981, 41567.37648935208, 41751.0, 36182.7805257242, 47306.76346618245, 47395.0, 49265.50734492609, 51407.71480713012, 30813.845930770203, 37054.703085391884, 38300.0, 39705.80882573527, 41438.79280603577, 33066.33867322592, 39054.80472597732, 39186.804065979486, 39602.801985991035, 40398.798006010955, 37516.0, 38107.047323817125, 38257.80871095627, 38712.41931371088, 39006.4149037759, 33033.131705373875, 34560.8501407943, 34855.82572087123, 35225.0, 35416.64583354237, 25175.741212939647, 25262.494750104528, 25435.982560698107, 25515.617265740657, 25857.87071064708], "value": 20088.914224264616, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.99421008684857, 388.31850103069115, 394.8164103691783, 397.3860385704087, 420.8527015544558, 14255.78616320756, 20246.6962995555, 21381.465463363424, 21484.677729834028, 21513.67729484057, 21222.363329100113, 21444.4638884028, 21803.781962180372, 21811.454713632167, 22025.22911698091, 5790.189373487705, 6100.877982440348, 6123.234595675541, 6124.663143527104, 6140.3859614038465, 4752.833650822222, 5980.073088671263, 6088.756449742005, 6674.432673222782, 6753.932460675404, 6751.797446076601, 6765.627890466047, 6766.898496522556, 6779.593224406552, 6788.321167883197, 6455.32219116993, 6595.604263744191, 6629.535932484728, 6695.732170713166, 6716.496262780287, 5146.922796158061, 5376.91934620981, 5749.741261643194, 5858.443447872445, 5879.470847623692, 13481.59555213345, 13641.317934103256, 13687.452501899912, 13713.0, 24350.512989740106, 2481.565725997943, 2550.885210165547, 2559.628853816205, 2580.7290234525294, 2617.149426436397, 9940.558619000205, 10014.849777253346, 10100.444475553842, 10456.58173673052, 10499.580016799318, 1747.1700942052423, 1797.532641513216, 1802.4772815883377, 1812.628411175719, 1818.627181427804, 131034.44827758573, 131642.3417882914, 140394.29802851024, 141610.0, 143618.0, 11740.70648233801, 11809.40573022631, 11991.280523168638, 12069.637910862513, 12137.939310303393, 13843.4462621494, 14560.344784484723, 15784.763228551581, 15799.36802527909, 15811.972221805776, 6923.580665963566, 8146.0, 8773.649054037895, 8837.425567338103, 8874.334424918157, 8446.746597602081, 8633.568321583896, 8720.825583488295, 8746.825063498694, 8764.605592748341, 3879.767213967171, 4673.742944138037, 4781.832635857728, 4858.149823780825, 4859.222524396079, 1984.4641946674317, 2027.5032617008633, 2044.2231951858198, 2047.7235573197427, 2051.3640771360924, 912.9315301352425, 965.6861520005885, 1002.2783595811004, 1034.818906691326, 1064.8722153341648, 20730.896345518177, 21364.786352136278, 21874.562508749736, 21886.45283867884, 22060.227892024024, 1019.1235537437798, 1042.8435734639713, 1053.72603123187, 1085.1427372375736, 1087.8096333141827, 8396.748097557083, 10136.695899123039, 10489.370637761605, 10895.455227238765, 11431.657050288504, 702463.0, 747628.0, 755113.0, 765579.0, 769438.0, 120834.39582802205, 140862.0, 147461.052212433, 148827.25586372215, 155760.0, 944.4097439100562, 950.8811398575178, 976.1848856205148, 978.882534095913, 985.8422652375729, 18358.265669373075, 18958.43124706261, 19016.714749278493, 19048.42854714361, 19072.23711051598, 45532.77233613943, 57938.0, 58616.827663447344, 59324.0, 59617.50956226129, 72265.6386718063, 86706.0, 87926.0, 89260.0, 91780.28087331692, 8028.558429286211, 8146.714864979697, 8173.6321865515, 8252.752417427488, 8369.163083691583, 11304.152188585724, 13005.544805931748, 13124.475020999053, 13144.211347319191, 13178.802317965046, 9104.817903641757, 9191.77020574491, 11400.885991139983, 11479.713007174887, 11705.297682139098, 11221.831672525082, 11347.829782553103, 11352.035077018545, 11505.712357191138, 11602.013828824645, 10836.945815270874, 11571.479283432434, 11605.941970290432, 11776.0, 11802.0, 7255.673494692646, 7550.811229719301, 8374.83250335002, 8413.242808147295, 8481.660733570834, 5662.292213473316, 7026.648667566704, 8520.531370774666, 10438.060574548326, 10972.396518191576], "value": 9765.589668662173, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1227.9386030698463, 1438.4102517967633, 1451.0930668332285, 1452.6295794572382, 1454.8908831837614, 8053.557054362008, 8317.376196785235, 8453.450525715823, 8459.32325413967, 8465.280451161658, 7473.215312392202, 7693.384529237662, 7697.191794861529, 7998.720044798433, 8211.589420528979, 2280.7719228077144, 2341.4029422497238, 2343.742188359279, 2347.6830627865193, 2348.283773449097, 2290.6449500327476, 2329.336139200328, 2335.8481698689616, 2337.637666161739, 2337.6610391493223, 2020.3029954665617, 2088.1960445228547, 2244.3267019894047, 2283.7716228377194, 2299.5171014087064, 2298.5517824024323, 2307.3654744945106, 2311.28350211435, 2312.664663623782, 2320.2575175943703, 2234.6424572068554, 2284.5430913817304, 2296.494771150361, 2333.346662934381, 2335.381124002141, 7035.0, 8337.249647531691, 8400.537970411626, 8402.537860417675, 8411.369147313975, 5040.243963405482, 5187.948120518784, 5221.0, 5227.921581176285, 5227.973860130675, 3325.96674033259, 3482.460218666111, 3512.209752805624, 3555.0223688485617, 3572.3391172633146, 1160.1762748448612, 1220.8229806677982, 1246.4141853328922, 1247.058470854499, 1266.290877108822, 10698.786024279549, 10749.51627176771, 10798.136149108132, 10838.512266948006, 10882.455877206108, 4430.534793846664, 4635.675502714845, 4637.420322459692, 4740.976295118502, 4748.525147485293, 9460.479673618018, 9473.715788526355, 9480.24158067353, 9489.952550237344, 9497.14525692691, 5206.297149884793, 5211.296474975906, 5216.139337009351, 5220.295260139908, 5226.790928362899, 4168.478940132483, 4491.730496170175, 4696.03731235096, 4784.497627749106, 4835.637327200474, 3150.401423729484, 3882.8446862125197, 3945.7829819359636, 4011.5988401159652, 4020.4974378202724, 1283.7175821319295, 1299.2009913902882, 1300.9804852927214, 1313.159577870164, 1316.407616572527, 773.2847116417291, 880.3221519430003, 905.212465155306, 905.6649039855164, 927.7309580221795, 5526.088195447786, 5575.135853942646, 5646.378898321182, 5748.45389687979, 5841.50347220491, 1009.65671671632, 1020.9030142136634, 1036.388530766851, 1047.225053460449, 1061.045059446489, 3666.3034023535442, 3755.4366844973474, 3795.6204379562373, 3846.519185101862, 3869.4195870619633, 9637.18083962871, 9977.600895964226, 9985.151262142654, 9988.101070903653, 9993.350432221881, 9827.656032038987, 9923.255755818198, 9925.255605829592, 9932.404055756677, 9947.010597880453, 7683.308502234826, 7791.688332466638, 7848.7252946147755, 7971.880421793678, 8013.479123856814, 4978.47725988766, 5303.88618390127, 5441.047816632153, 5463.7814487420055, 5731.312242530923, 7636.732714354971, 8414.116517765791, 8951.41815781972, 9212.355135140477, 9291.256699463891, 9012.41419307743, 9345.15893569582, 9364.719058428258, 9374.437533747998, 9478.38390504615, 6581.308962559054, 6805.829854253485, 6934.930650693428, 7089.7873063808165, 7090.893636595352, 7066.540674856118, 7471.140818805689, 7598.962005189938, 7618.780995040767, 7797.103333116765, 7049.154101507852, 7163.212046674966, 7187.748428804966, 7238.384737297178, 7316.926830731624, 5887.970560147171, 6507.381798729113, 6546.279909209888, 7033.472489563405, 7089.291070893076, 5686.0, 6312.652804095819, 6441.710123044568, 6444.8388790280615, 6512.990486474604, 4615.953840461552, 4658.417697787777, 4705.458872229738, 4740.714282170771, 4869.464358920587, 4235.407043013919, 4294.549072347359, 4911.582515486224, 4944.802207911644, 5070.2141168119], "value": 4388.160825151813, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.9457686770116, 347.1875810603188, 353.45920741265866, 354.7020502777666, 357.558415357034, 4450.643948484114, 5397.811076612319, 5442.999999999995, 5465.72671366432, 5473.589480788937, 4981.526754958282, 5076.340075790152, 5130.4356520782685, 5157.896842063156, 5338.786448542063, 3196.6004249468874, 3279.360524697685, 3365.5120007598885, 3942.80285985701, 4159.480064991876, 3872.961270387302, 3897.8051097445154, 4106.1992911382295, 4108.609682080212, 4201.684873634475, 3798.0504873781556, 3980.6417422431973, 4130.421740956269, 4132.607402296777, 4160.230357383879, 3512.910997590755, 3984.6015398460213, 4003.339448990913, 4007.3788562772525, 4028.5568587455505, 2802.607634931111, 3472.322897035079, 3477.600075991268, 3501.4572741224897, 3566.857325706969, 3953.9802300988313, 5147.871303217412, 5155.819546315861, 5167.741612919339, 5186.636935414523, 3872.9225415491533, 4110.034141976633, 4347.022104942275, 4487.304467807462, 4538.186324478845, 4673.88315292117, 5521.564393257741, 5611.915821262684, 5620.494155526022, 5631.690257035862, 3798.734088613798, 3809.3714537101623, 3815.790131542764, 3820.732548721591, 3836.8848934532007, 5607.57943154261, 5825.0, 5844.211031510734, 5881.382454842265, 5928.466438020556, 3664.120611053328, 3674.797886116236, 3881.86413475527, 3893.53277606689, 3899.922001559953, 3317.817520036373, 3454.689077982943, 3812.2566099610863, 3956.1296514766705, 3997.400389941474, 3959.7822119783687, 4299.677524185636, 4604.470485894165, 4607.9078418431445, 4618.538146185355, 4908.055166899903, 5306.442823503554, 5609.719514024282, 5619.634723742944, 5705.914411283834, 1207.8163399868179, 1265.8354413926131, 1271.5059804729406, 1282.4870051979283, 1283.4288741509938, 789.8222899847489, 794.8211652378169, 808.6361137488154, 851.7061613743373, 869.2784988459564, 4205.222033923734, 4891.902161956812, 4983.551480366712, 4994.2531607615665, 5022.522860328336, 4778.856634300976, 5566.0, 5593.965116453388, 5597.3003374578175, 5602.411746766531, 4337.46020162844, 4756.762161891892, 4756.9286460703115, 4759.524047595282, 4928.359313289249, 2520.332111990324, 2568.6368540942376, 2886.321714397115, 2887.4946884295587, 2891.0, 5478.24696097245, 5530.9579731147705, 5622.662640241517, 5642.689652069093, 5661.688607126647, 4963.70217786934, 5101.7194054327365, 5242.082635538765, 5595.21666966625, 5629.8592535186945, 5589.245451863946, 5646.350669672958, 5653.349864765522, 5683.460071293221, 5698.430156984268, 4647.488776234679, 4845.75771211445, 5127.87180320495, 5242.711650859239, 5473.631592101974, 5134.332536770196, 5648.604597678123, 5705.743241554057, 5728.770849166153, 5742.6217707749, 5449.7275136243825, 5974.910376344272, 5992.820215393545, 6011.879762404815, 6015.0, 3120.673713671635, 3667.5965643779696, 3726.4410338449447, 3770.8868733938025, 3820.5988371221733, 5256.605754568499, 5276.34045744282, 5522.723863806874, 5760.769569217185, 5768.365479797135, 4833.709977401367, 5218.582513398995, 5564.0, 5592.972035139798, 5682.431756824284, 5092.9696830385865, 5420.2408219684685, 5558.638688485235, 5583.972080139573, 5643.463870932255, 4758.976205118952, 5175.689458632494, 5511.944880551304, 5512.724363781875, 5532.419095994863, 4207.579242075891, 4844.685095468924, 5018.770401251717, 5058.848234552969, 5591.524720398812, 4980.975095124646, 5089.9745501272255, 5515.641483303572, 5538.446155384429, 5548.861278468071], "value": 4006.9158576798004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.2776839854945, 727.0875051809978, 739.9307999940086, 776.138486280229, 793.9087004994424, 14691.0, 15103.697926041486, 15124.697506049872, 15409.46066887659, 15513.612159695986, 11767.588134415297, 13529.729405411887, 14227.146371217734, 14419.711605767878, 14479.710405791879, 844.7845799321165, 846.8814365988767, 853.1255463150289, 855.529458797662, 855.5422848775906, 666.4235436347573, 684.8082536889679, 687.9862402751942, 836.0886633569409, 857.2113655436982, 736.8415790605019, 911.9042500537414, 913.8720579118929, 914.2411798207505, 915.3363811236867, 901.1844280925707, 906.9682561110362, 907.2560500389716, 907.5416914458157, 907.7095329494564, 513.8355726167628, 529.9311089558371, 652.5627829354297, 656.8916128838736, 679.100192245277, 14908.403663853433, 15280.847191528164, 15306.846931530765, 15337.6165595861, 15363.923180384138, 10481.842772358421, 12651.557195498113, 12793.680157996032, 12911.289879056649, 12935.223886566742, 12153.69615759613, 12219.755604887941, 12328.32194229317, 12370.938145309216, 12387.380630968506, 4233.786870592903, 4241.257779888507, 4351.934720979188, 4367.934480982788, 4500.032493013985, 109328.0, 110112.0, 110879.0, 111514.0, 111671.0, 9148.8627670585, 10620.946895265473, 10706.608140941627, 10794.622188223531, 11072.778544429066, 21990.120395184014, 22000.33998980033, 22008.779912200993, 22017.779822201574, 22068.668969965463, 7414.851702966019, 7456.403487721078, 7638.197989211164, 7678.961605191938, 7753.263439973193, 4102.0993506752375, 4207.747535147901, 4228.471441069866, 4230.703850730481, 4263.829446822155, 3348.6483919188136, 3368.5620869287327, 3411.0, 3417.111550996709, 3451.5340429041757, 545.91265397537, 638.8850006998692, 643.089997971796, 646.9320721324287, 658.9423974520921, 608.5405518833253, 626.3048016701458, 634.4385219081147, 638.9297177310492, 645.6255371884296, 8754.0, 9464.90535094654, 9567.550677267509, 9588.712338629713, 9686.149613481086, 590.6902086677368, 595.2677211598782, 655.9376859198369, 659.9637019963948, 661.9834504137435, 4096.7844256770295, 4320.910673577169, 4470.284754439339, 4600.60894823937, 4623.745693986796, 101382.4930875341, 102950.97049029563, 103488.44767328496, 105483.0, 109918.0, 95147.0, 96616.0, 98177.0, 99603.0, 100863.99136008693, 77065.0, 82601.17398826055, 86297.0, 86687.56656216679, 88194.0, 8932.508712020901, 8968.417052891542, 9045.276377889884, 9095.226905713089, 9112.589933452879, 52472.68818279573, 52651.73674131758, 53573.66065848385, 53872.19191712206, 54623.726881365335, 60158.0, 71682.64158679174, 72767.63616182096, 73155.26844731484, 73950.26049739649, 10940.343579385262, 11004.449777511252, 11173.944130279297, 11372.0, 11739.647810565697, 11707.239029463057, 11827.467763950472, 11865.0, 11936.880631193924, 12169.33068681231, 10606.416647084176, 10864.42003941338, 10886.51010704536, 10980.286281391684, 11385.715357116138, 11216.2148649597, 11394.658160255205, 11582.36297003673, 11623.825642615537, 11971.700707482383, 10897.0, 10913.454327283445, 10958.671239862817, 10999.285046471954, 11774.293542387484, 9559.27188396512, 9560.521973901416, 9760.46317452547, 9781.0, 9920.702378928643, 8877.600507977286, 9510.667126650535, 9612.807743844944, 9670.903290967282, 9747.853782193131], "value": 7193.4583378514635, "unit": "score"}], "name": "dromaeo_css", "value": 7240.859123240695, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 167.0, 163.0, 114.0, 115.0, 116.0, 114.0, 115.0, 115.0, 119.0], "value": 124.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 112.0, 114.0, 182.0, 114.0, 111.0, 110.0, 108.0, 130.0, 109.0], "value": 123.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 188.0, 184.0, 184.0, 186.0, 183.0, 185.0, 183.0, 185.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 59.0, 90.0, 61.0, 61.0, 74.0, 85.0, 86.0, 57.0], "value": 71.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 85.0, 78.0, 95.0, 101.0, 112.0, 67.0, 67.0, 82.0], "value": 84.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 91.0, 87.0, 90.0, 87.0, 90.0, 88.0, 91.0, 87.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 97.0, 85.0, 86.0, 86.0, 87.0, 88.0, 87.0, 88.0, 88.0], "value": 92.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 52.0, 60.0, 64.0, 86.0, 87.0, 68.0, 57.0, 56.0, 56.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 70.0, 76.0, 79.0, 74.0, 70.0, 69.0, 71.0, 69.0, 72.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 101.0, 103.0, 84.0, 84.0, 84.0, 83.0, 84.0, 86.0, 88.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 148.0, 149.0, 135.0, 165.0, 150.0, 135.0, 164.0, 216.0, 157.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 176.0, 169.0, 174.0, 167.0, 170.0, 166.0, 169.0, 166.0, 167.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 67.0, 65.0, 65.0, 65.0, 65.0, 64.0, 62.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1480.2999999999997, "alertThreshold": 2.0}]} 13:03:36 INFO - Return code: 0 13:03:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:03:36 ERROR - # TBPL SUCCESS # 13:03:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:03:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:03:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:03:36 INFO - 2017-02-27 13:03:36.125 screenresolution[1656:9644] starting screenresolution argv=screenresolution get 13:03:36 INFO - 2017-02-27 13:03:36.128 screenresolution[1656:9644] Display 0: 1600x1200x32@60 13:03:36 INFO - 2017-02-27 13:03:36.133 screenresolution[1657:9647] starting screenresolution argv=screenresolution list 13:03:36 INFO - Available Modes on Display 0 13:03:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:03:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:03:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:03:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:03:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:03:36 INFO - Intel Iris: 13:03:36 INFO - Chipset Model: Intel Iris 13:03:36 INFO - Type: GPU 13:03:36 INFO - Bus: Built-In 13:03:36 INFO - VRAM (Dynamic, Max): 1536 MB 13:03:36 INFO - Vendor: Intel (0x8086) 13:03:36 INFO - Device ID: 0x0a2e 13:03:36 INFO - Revision ID: 0x0009 13:03:36 INFO - Displays: 13:03:36 INFO - Display: 13:03:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:03:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:03:36 INFO - Display Serial Number: 1600x1200 60 13:03:36 INFO - Main Display: Yes 13:03:36 INFO - Mirror: Off 13:03:36 INFO - Online: Yes 13:03:36 INFO - Rotation: Supported 13:03:36 INFO - Return code: 0 13:03:36 INFO - Running post-action listener: _resource_record_post_action 13:03:36 INFO - [mozharness: 2017-02-27 21:03:36.380222Z] Finished run-tests step (success) 13:03:36 INFO - Running post-run listener: _resource_record_post_run 13:03:36 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 36574208; Write bytes: 506415104; Read time: 371; Write time: 1562 13:03:36 INFO - TinderboxPrint: CPU usage
53.6% 13:03:36 INFO - TinderboxPrint: I/O read bytes / time
36,574,208 / 371 13:03:36 INFO - TinderboxPrint: I/O write bytes / time
506,415,104 / 1,562 13:03:36 INFO - TinderboxPrint: CPU idle
2,228.4 (46.4%) 13:03:36 INFO - TinderboxPrint: CPU system
962.8 (20.1%) 13:03:36 INFO - TinderboxPrint: CPU user
1,610.5 (33.5%) 13:03:36 INFO - TinderboxPrint: Swap in / out
244,305,920 / 0 13:03:36 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 198177280; Write bytes: 193165312; Read time: 15787; Write time: 412 13:03:36 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 35587072; Write bytes: 294875136; Read time: 352; Write time: 1095 13:03:36 INFO - Running post-run listener: _upload_blobber_files 13:03:36 INFO - Blob upload gear active. 13:03:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:03:36 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 13:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:03:37 INFO - (blobuploader) - INFO - Open directory for files ... 13:03:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:03:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:03:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:38 INFO - (blobuploader) - INFO - Done attempting. 13:03:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:03:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:03:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:39 INFO - (blobuploader) - INFO - Done attempting. 13:03:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:03:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:03:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:40 INFO - (blobuploader) - INFO - Done attempting. 13:03:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:03:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:03:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:42 INFO - (blobuploader) - INFO - Done attempting. 13:03:42 INFO - (blobuploader) - INFO - Iteration through files over. 13:03:42 INFO - Return code: 0 13:03:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:03:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:03:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a582e156f98a03bd6bd77e7184b420b9a2c531552c0486e193bd18148490b4382192b284e2e5072d496ac1aa6ed520a03c5fecd04bad7ee3ca1bcf88e6b9c2df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8500fe22ef4c6591a837fb0ac047e3f944382430f088ea1802b227e2607a8a0b03ddc8def027a2ae721f00afd3c6cab88c7151ea97b4101efb042d3cbf61617a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9602e63cf4a1e7cc147d8413b93279986367d1de9ffaee52669ab5ff3a5fcec071166863128286d6dd403001b6e9ad78ffd571c1677209a0eee24dccbe5aee59", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f8c190b7e5504e468aa140daa925f3e8f67c37420727f5c968c9f57b1222a628a2e6f7ea233dc2d680184578db6897c85df4bc08e6afd2ca1d3f4c5761cd997"} 13:03:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:03:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:03:42 INFO - Contents: 13:03:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a582e156f98a03bd6bd77e7184b420b9a2c531552c0486e193bd18148490b4382192b284e2e5072d496ac1aa6ed520a03c5fecd04bad7ee3ca1bcf88e6b9c2df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8500fe22ef4c6591a837fb0ac047e3f944382430f088ea1802b227e2607a8a0b03ddc8def027a2ae721f00afd3c6cab88c7151ea97b4101efb042d3cbf61617a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9602e63cf4a1e7cc147d8413b93279986367d1de9ffaee52669ab5ff3a5fcec071166863128286d6dd403001b6e9ad78ffd571c1677209a0eee24dccbe5aee59", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f8c190b7e5504e468aa140daa925f3e8f67c37420727f5c968c9f57b1222a628a2e6f7ea233dc2d680184578db6897c85df4bc08e6afd2ca1d3f4c5761cd997"} 13:03:42 INFO - Running post-run listener: copy_logs_to_upload_dir 13:03:42 INFO - Copying logs to upload dir... 13:03:42 INFO - mkdir: /builds/slave/test/build/upload/logs 13:03:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.451820 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-27 13:03:42.507511) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 13:03:42.511721) ========= 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.V7bnlotoVI/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.fpqgJfjIxA/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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/Mozilla-Aurora/sha512/a582e156f98a03bd6bd77e7184b420b9a2c531552c0486e193bd18148490b4382192b284e2e5072d496ac1aa6ed520a03c5fecd04bad7ee3ca1bcf88e6b9c2df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8500fe22ef4c6591a837fb0ac047e3f944382430f088ea1802b227e2607a8a0b03ddc8def027a2ae721f00afd3c6cab88c7151ea97b4101efb042d3cbf61617a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9602e63cf4a1e7cc147d8413b93279986367d1de9ffaee52669ab5ff3a5fcec071166863128286d6dd403001b6e9ad78ffd571c1677209a0eee24dccbe5aee59", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f8c190b7e5504e468aa140daa925f3e8f67c37420727f5c968c9f57b1222a628a2e6f7ea233dc2d680184578db6897c85df4bc08e6afd2ca1d3f4c5761cd997"} build_url:https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/XjblRWLsQVCMZR-wpyb6ZA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a582e156f98a03bd6bd77e7184b420b9a2c531552c0486e193bd18148490b4382192b284e2e5072d496ac1aa6ed520a03c5fecd04bad7ee3ca1bcf88e6b9c2df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8500fe22ef4c6591a837fb0ac047e3f944382430f088ea1802b227e2607a8a0b03ddc8def027a2ae721f00afd3c6cab88c7151ea97b4101efb042d3cbf61617a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9602e63cf4a1e7cc147d8413b93279986367d1de9ffaee52669ab5ff3a5fcec071166863128286d6dd403001b6e9ad78ffd571c1677209a0eee24dccbe5aee59", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f8c190b7e5504e468aa140daa925f3e8f67c37420727f5c968c9f57b1222a628a2e6f7ea233dc2d680184578db6897c85df4bc08e6afd2ca1d3f4c5761cd997"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 13:03:42.549334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 13:03:42.549685) ========= 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.V7bnlotoVI/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.fpqgJfjIxA/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005556 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 13:03:42.598006) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 13:03:42.601341) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 13:03:42.601659) ========= ========= Total master_lag: 2.56 =========