builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0104 starttime: 1493743295.63 results: success (0) buildid: 20170502080920 builduid: ebce6a4603344c779b1e9bf542e2c5cf revision: 2bf6db48a260233ba421cd216aeeaea957887123 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 09:41:35.634378) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 09:41:35.634821) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 09:41:35.635108) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 09:41:35.662274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 09:41:35.662664) ========= 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.rV0P6hNVP0/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.f5YpxdoJXA/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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-05-02 09:41: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% 14.8M=0.001s 2017-05-02 09:41:35 (14.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143598 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 09:41:35.831680) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 09:41:35.832007) ========= 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.rV0P6hNVP0/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.f5YpxdoJXA/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.028691 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 09:41:35.883453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-02 09:41:35.883956) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2bf6db48a260233ba421cd216aeeaea957887123 --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-beta --rev 2bf6db48a260233ba421cd216aeeaea957887123 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rV0P6hNVP0/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.f5YpxdoJXA/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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-05-02 09:41:35,989 truncating revision to first 12 chars 2017-05-02 09:41:35,990 Setting DEBUG logging. 2017-05-02 09:41:35,990 attempt 1/10 2017-05-02 09:41:35,990 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2bf6db48a260?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-02 09:41:37,405 unpacking tar archive at: mozilla-beta-2bf6db48a260/testing/mozharness/ program finished with exit code 0 elapsedTime=1.691488 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-02 09:41:37.599609) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 09:41:37.599939) ========= script_repo_revision: 2bf6db48a260233ba421cd216aeeaea957887123 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 09:41:37.600315) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 09:41:37.600575) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 09:41:37.625069) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-02 09:41:37.625438) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rV0P6hNVP0/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.f5YpxdoJXA/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:41:37 INFO - MultiFileLogger online at 20170502 09:41:37 in /builds/slave/test 09:41:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:41:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:41:37 INFO - {'append_to_log': False, 09:41:37 INFO - 'base_work_dir': '/builds/slave/test', 09:41:37 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:41:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:41:37 INFO - 'branch': 'Mozilla-Beta', 09:41:37 INFO - 'buildbot_json_path': 'buildprops.json', 09:41:37 INFO - 'config_files': ('talos/mac_config.py',), 09:41:37 INFO - 'default_actions': ('clobber', 09:41:37 INFO - 'read-buildbot-config', 09:41:37 INFO - 'download-and-extract', 09:41:37 INFO - 'populate-webroot', 09:41:37 INFO - 'create-virtualenv', 09:41:37 INFO - 'install', 09:41:37 INFO - 'run-tests'), 09:41:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:41:37 INFO - 'download_minidump_stackwalk': True, 09:41:37 INFO - 'download_symbols': 'ondemand', 09:41:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:41:37 INFO - 'tooltool.py': '/tools/tooltool.py', 09:41:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:41:37 INFO - '/tools/misc-python/virtualenv.py')}, 09:41:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:41:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:41:37 INFO - 'gecko_profile': False, 09:41:37 INFO - 'gecko_profile_interval': 0, 09:41:37 INFO - 'installer_path': 'installer.exe', 09:41:37 INFO - 'log_level': 'info', 09:41:37 INFO - 'log_name': 'talos', 09:41:37 INFO - 'log_to_console': True, 09:41:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:41:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:41:37 INFO - 'opt_config_files': (), 09:41:37 INFO - 'pip_index': False, 09:41:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:41:37 INFO - 'cmd': ('bash', 09:41:37 INFO - '-c', 09:41:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:41:37 INFO - 'enabled': True, 09:41:37 INFO - 'halt_on_failure': False, 09:41:37 INFO - 'name': 'check_screen_resolution'},), 09:41:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:41:37 INFO - 'cmd': ('bash', 09:41:37 INFO - '-c', 09:41:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:41:37 INFO - 'enabled': True, 09:41:37 INFO - 'halt_on_failure': False, 09:41:37 INFO - 'name': 'check_screen_resolution'},), 09:41:37 INFO - 'run_cmd_checks_enabled': True, 09:41:37 INFO - 'suite': 'dromaeojs', 09:41:37 INFO - 'system_bits': '32', 09:41:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:41:37 INFO - 'title': 't-yosemite-r7-0104', 09:41:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:41:37 INFO - 'use_talos_json': True, 09:41:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:41:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:41:37 INFO - 'work_dir': 'build'} 09:41:37 INFO - [mozharness: 2017-05-02 16:41:37.842913Z] Running clobber step. 09:41:37 INFO - Running pre-action listener: _resource_record_pre_action 09:41:37 INFO - Running main action method: clobber 09:41:37 INFO - rmtree: /builds/slave/test/build 09:41:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:41:40 INFO - Running post-action listener: _resource_record_post_action 09:41:40 INFO - [mozharness: 2017-05-02 16:41:40.410699Z] Finished clobber step (success) 09:41:40 INFO - [mozharness: 2017-05-02 16:41:40.410847Z] Running read-buildbot-config step. 09:41:40 INFO - Running pre-action listener: _resource_record_pre_action 09:41:40 INFO - Running main action method: read_buildbot_config 09:41:40 INFO - Using buildbot properties: 09:41:40 INFO - { 09:41:40 INFO - "project": "", 09:41:40 INFO - "product": "firefox", 09:41:40 INFO - "script_repo_revision": "production", 09:41:40 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:41:40 INFO - "repository": "", 09:41:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:41:40 INFO - "buildid": "20170502080920", 09:41:40 INFO - "pgo_build": "False", 09:41:40 INFO - "basedir": "/builds/slave/test", 09:41:40 INFO - "buildnumber": 2, 09:41:40 INFO - "slavename": "t-yosemite-r7-0104", 09:41:40 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:41:40 INFO - "platform": "yosemite_r7", 09:41:40 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:41:40 INFO - "branch": "mozilla-beta", 09:41:40 INFO - "repo_path": "releases/mozilla-beta", 09:41:40 INFO - "revision": "2bf6db48a260233ba421cd216aeeaea957887123", 09:41:40 INFO - "stage_platform": "macosx64", 09:41:40 INFO - "builduid": "ebce6a4603344c779b1e9bf542e2c5cf", 09:41:40 INFO - "slavebuilddir": "test" 09:41:40 INFO - } 09:41:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 09:41:40 INFO - Running post-action listener: _resource_record_post_action 09:41:40 INFO - [mozharness: 2017-05-02 16:41:40.414365Z] Finished read-buildbot-config step (success) 09:41:40 INFO - [mozharness: 2017-05-02 16:41:40.414454Z] Running download-and-extract step. 09:41:40 INFO - Running pre-action listener: _resource_record_pre_action 09:41:40 INFO - Running main action method: download_and_extract 09:41:40 INFO - mkdir: /builds/slave/test/build/tests 09:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:40 INFO - trying https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 09:41:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 09:41:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 09:41:41 INFO - Downloaded 1165 bytes. 09:41:41 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 09:41:41 INFO - Using the following test package requirements: 09:41:41 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 09:41:41 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:41:41 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 09:41:41 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:41:41 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 09:41:41 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:41:41 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:41:41 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 09:41:41 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 09:41:41 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:41:41 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 09:41:41 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:41:41 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 09:41:41 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:41:41 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 09:41:41 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:41:41 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 09:41:41 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 09:41:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 09:41:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 09:41:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 09:41:43 INFO - Expected file size: 51226783 09:41:43 INFO - Obtained file size: 51226783 09:41:59 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:41:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 09:41:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 09:41:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 09:42:01 INFO - Expected file size: 51226783 09:42:01 INFO - Obtained file size: 51226783 09:42:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 09:42:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 09:42:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 09:42:17 INFO - Expected file size: 14404449 09:42:17 INFO - Obtained file size: 14404449 09:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:17 INFO - trying https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:42:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 09:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 09:42:19 INFO - Downloaded 59540568 bytes. 09:42:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:42:19 INFO - mkdir: /builds/slave/test/properties 09:42:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:42:19 INFO - Writing to file /builds/slave/test/properties/build_url 09:42:19 INFO - Contents: 09:42:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:42:19 INFO - Running post-action listener: _resource_record_post_action 09:42:19 INFO - Running post-action listener: set_extra_try_arguments 09:42:19 INFO - [mozharness: 2017-05-02 16:42:19.891065Z] Finished download-and-extract step (success) 09:42:19 INFO - [mozharness: 2017-05-02 16:42:19.891182Z] Running populate-webroot step. 09:42:19 INFO - Running pre-action listener: _resource_record_pre_action 09:42:19 INFO - Running main action method: populate_webroot 09:42:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:42:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:42:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:42:19 INFO - '--tppagecycles', 09:42:19 INFO - '7'], 09:42:19 INFO - 'tests': ['tsvgm']}}, 09:42:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:42:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:42:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:42:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:42:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:42:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:42:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:42:19 INFO - 'talos_options': ['--disable-e10s'], 09:42:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:42:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:42:19 INFO - 'talos_options': ['--disable-e10s'], 09:42:19 INFO - 'tests': ['damp', 'tps']}, 09:42:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:42:19 INFO - 'tests': ['damp', 'tps']}, 09:42:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:42:19 INFO - 'tests': ['dromaeo_dom']}, 09:42:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:42:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:42:19 INFO - 'tests': ['basic_compositor_video']}, 09:42:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:42:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:42:19 INFO - 'tests': ['a11yr', 09:42:19 INFO - 'ts_paint', 09:42:19 INFO - 'tpaint', 09:42:19 INFO - 'sessionrestore', 09:42:19 INFO - 'sessionrestore_no_auto_restore', 09:42:19 INFO - 'tabpaint']}, 09:42:19 INFO - 'other-e10s': {'tests': ['a11yr', 09:42:19 INFO - 'ts_paint', 09:42:19 INFO - 'tpaint', 09:42:19 INFO - 'sessionrestore', 09:42:19 INFO - 'sessionrestore_no_auto_restore', 09:42:19 INFO - 'tabpaint']}, 09:42:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:42:19 INFO - 'ts_paint', 09:42:19 INFO - 'tpaint', 09:42:19 INFO - 'sessionrestore', 09:42:19 INFO - 'sessionrestore_no_auto_restore', 09:42:19 INFO - 'tabpaint']}, 09:42:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:42:19 INFO - 'ts_paint', 09:42:19 INFO - 'tpaint', 09:42:19 INFO - 'sessionrestore', 09:42:19 INFO - 'sessionrestore_no_auto_restore', 09:42:19 INFO - 'tabpaint']}, 09:42:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:42:19 INFO - 'tests': ['a11yr', 09:42:19 INFO - 'ts_paint', 09:42:19 INFO - 'tpaint', 09:42:19 INFO - 'sessionrestore', 09:42:19 INFO - 'sessionrestore_no_auto_restore', 09:42:19 INFO - 'tabpaint']}, 09:42:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:42:19 INFO - 'tests': ['a11yr', 09:42:19 INFO - 'ts_paint', 09:42:19 INFO - 'tpaint', 09:42:19 INFO - 'sessionrestore', 09:42:19 INFO - 'sessionrestore_no_auto_restore', 09:42:19 INFO - 'tabpaint']}, 09:42:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:42:19 INFO - 'tests': ['tsvgx', 09:42:19 INFO - 'tsvgr_opacity', 09:42:19 INFO - 'tart', 09:42:19 INFO - 'tscrollx', 09:42:19 INFO - 'cart', 09:42:19 INFO - 'tsvg_static']}, 09:42:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:42:19 INFO - 'tsvgr_opacity', 09:42:19 INFO - 'tart', 09:42:19 INFO - 'tscrollx', 09:42:19 INFO - 'cart', 09:42:19 INFO - 'tsvg_static']}, 09:42:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:42:19 INFO - 'talos_options': ['--disable-e10s'], 09:42:19 INFO - 'tests': ['tp5o']}, 09:42:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:42:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:42:19 INFO - 'talos_options': ['--disable-e10s', 09:42:19 INFO - '--xperf_path', 09:42:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:19 INFO - 'tests': ['tp5n']}, 09:42:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:42:19 INFO - 'talos_options': ['--xperf_path', 09:42:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:19 INFO - 'tests': ['tp5n']}}, 09:42:19 INFO - 'talos.zip': {'path': '', 09:42:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:42:19 INFO - Running post-action listener: _resource_record_post_action 09:42:19 INFO - [mozharness: 2017-05-02 16:42:19.910045Z] Finished populate-webroot step (success) 09:42:19 INFO - [mozharness: 2017-05-02 16:42:19.910163Z] Running create-virtualenv step. 09:42:19 INFO - Running pre-action listener: _resource_record_pre_action 09:42:19 INFO - Running main action method: create_virtualenv 09:42:19 INFO - Creating virtualenv /builds/slave/test/build/venv 09:42:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:42:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:42:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:42:20 INFO - Using real prefix '/tools/python27' 09:42:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:42:20 INFO - Installing distribute.............................................................................................................................................................................................done. 09:42:23 INFO - Installing pip.................done. 09:42:23 INFO - Return code: 0 09:42:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:42:23 INFO - Reading from file tmpfile_stdout 09:42:23 INFO - Output received: 09:42:23 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) 09:42:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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')]} 09:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1081cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff070d943c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa8d30>, '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 0x107ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f9dbe8>, '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.rV0P6hNVP0/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.f5YpxdoJXA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:42:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:42:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rV0P6hNVP0/Render', 09:42:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:23 INFO - 'HOME': '/Users/cltbld', 09:42:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:23 INFO - 'LOGNAME': 'cltbld', 09:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:23 INFO - 'MOZ_NO_REMOTE': '1', 09:42:23 INFO - 'NO_EM_RESTART': '1', 09:42:23 INFO - 'PAGER': '/bin/cat', 09:42:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:23 INFO - 'PWD': '/builds/slave/test', 09:42:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:23 INFO - 'SHELL': '/bin/bash', 09:42:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f5YpxdoJXA/Listeners', 09:42:23 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:23 INFO - 'USER': 'cltbld', 09:42:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:23 INFO - 'XPC_FLAGS': '0x0', 09:42:23 INFO - 'XPC_SERVICE_NAME': '0', 09:42:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:42:24 INFO - Cleaning up... 09:42:24 INFO - Return code: 0 09:42:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:42:24 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')]} 09:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:24 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')]} 09:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:24 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 0x1081cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff070d943c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa8d30>, '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 0x107ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f9dbe8>, '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.rV0P6hNVP0/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.f5YpxdoJXA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:42:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rV0P6hNVP0/Render', 09:42:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:24 INFO - 'HOME': '/Users/cltbld', 09:42:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:24 INFO - 'LOGNAME': 'cltbld', 09:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:24 INFO - 'MOZ_NO_REMOTE': '1', 09:42:24 INFO - 'NO_EM_RESTART': '1', 09:42:24 INFO - 'PAGER': '/bin/cat', 09:42:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:24 INFO - 'PWD': '/builds/slave/test', 09:42:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:24 INFO - 'SHELL': '/bin/bash', 09:42:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f5YpxdoJXA/Listeners', 09:42:24 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:24 INFO - 'USER': 'cltbld', 09:42:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:24 INFO - 'XPC_FLAGS': '0x0', 09:42:24 INFO - 'XPC_SERVICE_NAME': '0', 09:42:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:24 INFO - Downloading/unpacking psutil>=3.1.1 09:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:42:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:27 INFO - Installing collected packages: psutil 09:42:27 INFO - Running setup.py install for psutil 09:42:28 INFO - building 'psutil._psutil_osx' extension 09:42:28 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 09:42:28 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 09:42:28 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 09:42:28 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 09:42:28 INFO - building 'psutil._psutil_posix' extension 09:42:28 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 09:42:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:42:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:42:28 INFO - ^ 09:42:29 INFO - 1 warning generated. 09:42:29 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 09:42:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:29 INFO - Successfully installed psutil 09:42:29 INFO - Cleaning up... 09:42:29 INFO - Return code: 0 09:42:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:30 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 0x1081cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff070d943c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa8d30>, '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 0x107ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f9dbe8>, '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.rV0P6hNVP0/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.f5YpxdoJXA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:42:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:42:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rV0P6hNVP0/Render', 09:42:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:30 INFO - 'HOME': '/Users/cltbld', 09:42:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:30 INFO - 'LOGNAME': 'cltbld', 09:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:30 INFO - 'MOZ_NO_REMOTE': '1', 09:42:30 INFO - 'NO_EM_RESTART': '1', 09:42:30 INFO - 'PAGER': '/bin/cat', 09:42:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:30 INFO - 'PWD': '/builds/slave/test', 09:42:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:30 INFO - 'SHELL': '/bin/bash', 09:42:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f5YpxdoJXA/Listeners', 09:42:30 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:30 INFO - 'USER': 'cltbld', 09:42:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:30 INFO - 'XPC_FLAGS': '0x0', 09:42:30 INFO - 'XPC_SERVICE_NAME': '0', 09:42:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:42:33 INFO - Installing collected packages: mozsystemmonitor 09:42:33 INFO - Running setup.py install for mozsystemmonitor 09:42:33 INFO - Successfully installed mozsystemmonitor 09:42:33 INFO - Cleaning up... 09:42:33 INFO - Return code: 0 09:42:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:33 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 0x1081cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff070d943c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa8d30>, '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 0x107ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f9dbe8>, '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.rV0P6hNVP0/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.f5YpxdoJXA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:42:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:42:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rV0P6hNVP0/Render', 09:42:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:33 INFO - 'HOME': '/Users/cltbld', 09:42:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:33 INFO - 'LOGNAME': 'cltbld', 09:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:33 INFO - 'MOZ_NO_REMOTE': '1', 09:42:33 INFO - 'NO_EM_RESTART': '1', 09:42:33 INFO - 'PAGER': '/bin/cat', 09:42:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:33 INFO - 'PWD': '/builds/slave/test', 09:42:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:33 INFO - 'SHELL': '/bin/bash', 09:42:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f5YpxdoJXA/Listeners', 09:42:33 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:33 INFO - 'USER': 'cltbld', 09:42:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:33 INFO - 'XPC_FLAGS': '0x0', 09:42:33 INFO - 'XPC_SERVICE_NAME': '0', 09:42:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:33 INFO - Downloading/unpacking jsonschema==2.5.1 09:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:42:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:36 INFO - Downloading functools32-3.2.3-2.tar.gz 09:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:42:37 INFO - warning: no files found matching '*.txt' 09:42:37 INFO - no previously-included directories found matching 'build' 09:42:37 INFO - no previously-included directories found matching 'dist' 09:42:37 INFO - no previously-included directories found matching '.git*' 09:42:37 INFO - Installing collected packages: jsonschema, functools32 09:42:37 INFO - Running setup.py install for functools32 09:42:37 INFO - warning: no files found matching '*.txt' 09:42:37 INFO - no previously-included directories found matching 'build' 09:42:37 INFO - no previously-included directories found matching 'dist' 09:42:37 INFO - no previously-included directories found matching '.git*' 09:42:37 INFO - Successfully installed jsonschema functools32 09:42:37 INFO - Cleaning up... 09:42:37 INFO - Return code: 0 09:42:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:42:37 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')]} 09:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:37 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')]} 09:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:37 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 0x1081cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff070d943c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa8d30>, '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 0x107ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f9dbe8>, '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.rV0P6hNVP0/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.f5YpxdoJXA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:42:37 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 09:42:37 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 09:42:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rV0P6hNVP0/Render', 09:42:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:37 INFO - 'HOME': '/Users/cltbld', 09:42:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:37 INFO - 'LOGNAME': 'cltbld', 09:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:37 INFO - 'MOZ_NO_REMOTE': '1', 09:42:37 INFO - 'NO_EM_RESTART': '1', 09:42:37 INFO - 'PAGER': '/bin/cat', 09:42:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:37 INFO - 'PWD': '/builds/slave/test', 09:42:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:37 INFO - 'SHELL': '/bin/bash', 09:42:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f5YpxdoJXA/Listeners', 09:42:37 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:37 INFO - 'USER': 'cltbld', 09:42:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:37 INFO - 'XPC_FLAGS': '0x0', 09:42:37 INFO - 'XPC_SERVICE_NAME': '0', 09:42:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:42:37 INFO - Cleaning up... 09:42:37 INFO - Return code: 0 09:42:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:42:37 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')]} 09:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:37 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')]} 09:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:37 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 0x1081cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff070d943c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa8d30>, '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 0x107ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f9dbe8>, '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.rV0P6hNVP0/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.f5YpxdoJXA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:42:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:42:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rV0P6hNVP0/Render', 09:42:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:37 INFO - 'HOME': '/Users/cltbld', 09:42:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:37 INFO - 'LOGNAME': 'cltbld', 09:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:37 INFO - 'MOZ_NO_REMOTE': '1', 09:42:37 INFO - 'NO_EM_RESTART': '1', 09:42:37 INFO - 'PAGER': '/bin/cat', 09:42:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:37 INFO - 'PWD': '/builds/slave/test', 09:42:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:37 INFO - 'SHELL': '/bin/bash', 09:42:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f5YpxdoJXA/Listeners', 09:42:37 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:37 INFO - 'USER': 'cltbld', 09:42:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:37 INFO - 'XPC_FLAGS': '0x0', 09:42:37 INFO - 'XPC_SERVICE_NAME': '0', 09:42:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:37 INFO - Downloading/unpacking blobuploader==1.2.4 09:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:40 INFO - Downloading blobuploader-1.2.4.tar.gz 09:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:42:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:42:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:41 INFO - Downloading docopt-0.6.1.tar.gz 09:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:42:41 INFO - Installing collected packages: blobuploader, requests, docopt 09:42:41 INFO - Running setup.py install for blobuploader 09:42:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:42:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:42:41 INFO - Running setup.py install for requests 09:42:42 INFO - Running setup.py install for docopt 09:42:42 INFO - Successfully installed blobuploader requests docopt 09:42:42 INFO - Cleaning up... 09:42:42 INFO - Return code: 0 09:42:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:42 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 0x1081cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff070d943c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa8d30>, '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 0x107ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f9dbe8>, '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.rV0P6hNVP0/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.f5YpxdoJXA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:42:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rV0P6hNVP0/Render', 09:42:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:42 INFO - 'HOME': '/Users/cltbld', 09:42:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:42 INFO - 'LOGNAME': 'cltbld', 09:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:42 INFO - 'MOZ_NO_REMOTE': '1', 09:42:42 INFO - 'NO_EM_RESTART': '1', 09:42:42 INFO - 'PAGER': '/bin/cat', 09:42:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:42 INFO - 'PWD': '/builds/slave/test', 09:42:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:42 INFO - 'SHELL': '/bin/bash', 09:42:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f5YpxdoJXA/Listeners', 09:42:42 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:42 INFO - 'USER': 'cltbld', 09:42:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:42 INFO - 'XPC_FLAGS': '0x0', 09:42:42 INFO - 'XPC_SERVICE_NAME': '0', 09:42:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:42 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-UKWk14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:42 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-iRtj8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:43 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-qNh0LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:43 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-de15yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:43 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-qyHqkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:43 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-gW3CdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:43 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-7eaVEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:43 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-GWF99g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:43 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-ONMux7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:43 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-vQcBGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:43 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-K6hkZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-Zl0Yv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-3ZSi3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-Z3DHsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-JW6CA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-2wlMkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:44 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-dcn5_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:42:44 INFO - Running setup.py install for manifestparser 09:42:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:42:44 INFO - Running setup.py install for mozcrash 09:42:44 INFO - Running setup.py install for mozdebug 09:42:45 INFO - Running setup.py install for mozdevice 09:42:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Running setup.py install for mozfile 09:42:45 INFO - Running setup.py install for mozhttpd 09:42:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Running setup.py install for mozinfo 09:42:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Running setup.py install for mozInstall 09:42:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Running setup.py install for mozleak 09:42:45 INFO - Running setup.py install for mozlog 09:42:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Running setup.py install for moznetwork 09:42:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Running setup.py install for mozprocess 09:42:46 INFO - Running setup.py install for mozprofile 09:42:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Running setup.py install for mozrunner 09:42:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Running setup.py install for mozscreenshot 09:42:46 INFO - Running setup.py install for moztest 09:42:47 INFO - Running setup.py install for mozversion 09:42:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:42:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:42:47 INFO - Cleaning up... 09:42:47 INFO - Return code: 0 09:42:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:47 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')]} 09:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:47 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')]} 09:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:47 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 0x1081cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff070d943c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa8d30>, '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 0x107ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f9dbe8>, '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.rV0P6hNVP0/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.f5YpxdoJXA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rV0P6hNVP0/Render', 09:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:47 INFO - 'HOME': '/Users/cltbld', 09:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:47 INFO - 'LOGNAME': 'cltbld', 09:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:47 INFO - 'MOZ_NO_REMOTE': '1', 09:42:47 INFO - 'NO_EM_RESTART': '1', 09:42:47 INFO - 'PAGER': '/bin/cat', 09:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:47 INFO - 'PWD': '/builds/slave/test', 09:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:47 INFO - 'SHELL': '/bin/bash', 09:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f5YpxdoJXA/Listeners', 09:42:47 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:47 INFO - 'USER': 'cltbld', 09:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:47 INFO - 'XPC_FLAGS': '0x0', 09:42:47 INFO - 'XPC_SERVICE_NAME': '0', 09:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:47 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-Eh_rpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:47 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-QuwqX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:47 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)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:47 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-ShpxRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:47 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-s6w7TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:47 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)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:47 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-Jv7Pbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:48 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-m8MPSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:48 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-7NJRff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:48 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-7SG00c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:48 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-p8VBhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:48 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-aozH96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:48 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)) 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:48 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-ltwvpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:48 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-QGEgAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:48 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-Qx8RhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:48 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-ynh02e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:48 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)) 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:48 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-2tvSpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:49 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-gX2sQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:49 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)) 09:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:49 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-aiufGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:42:49 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)) 09:42:49 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)) 09:42:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:42:49 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)) 09:42:49 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)) 09:42:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:51 INFO - Downloading blessings-1.6.tar.gz 09:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:42:52 INFO - Installing collected packages: blessings 09:42:52 INFO - Running setup.py install for blessings 09:42:52 INFO - Successfully installed blessings 09:42:52 INFO - Cleaning up... 09:42:52 INFO - Return code: 0 09:42:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:52 INFO - Reading from file tmpfile_stdout 09:42:52 INFO - Current package versions: 09:42:52 INFO - blessings == 1.6 09:42:52 INFO - blobuploader == 1.2.4 09:42:52 INFO - docopt == 0.6.1 09:42:52 INFO - functools32 == 3.2.3-2 09:42:52 INFO - jsonschema == 2.5.1 09:42:52 INFO - manifestparser == 1.1 09:42:52 INFO - mozInstall == 1.12 09:42:52 INFO - mozcrash == 1.0 09:42:52 INFO - mozdebug == 0.1 09:42:52 INFO - mozdevice == 0.49 09:42:52 INFO - mozfile == 1.2 09:42:52 INFO - mozhttpd == 0.7 09:42:52 INFO - mozinfo == 0.9 09:42:52 INFO - mozleak == 0.1 09:42:52 INFO - mozlog == 3.4 09:42:52 INFO - moznetwork == 0.27 09:42:52 INFO - mozprocess == 0.25 09:42:52 INFO - mozprofile == 0.28 09:42:52 INFO - mozrunner == 6.13 09:42:52 INFO - mozscreenshot == 0.1 09:42:52 INFO - mozsystemmonitor == 0.3 09:42:52 INFO - moztest == 0.8 09:42:52 INFO - mozversion == 1.4 09:42:52 INFO - psutil == 3.1.1 09:42:52 INFO - requests == 1.2.3 09:42:52 INFO - wsgiref == 0.1.2 09:42:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:52 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 0x1081cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff070d943c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa8d30>, '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 0x107ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f9dbe8>, '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.rV0P6hNVP0/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.f5YpxdoJXA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:42:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rV0P6hNVP0/Render', 09:42:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:52 INFO - 'HOME': '/Users/cltbld', 09:42:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:52 INFO - 'LOGNAME': 'cltbld', 09:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:52 INFO - 'MOZ_NO_REMOTE': '1', 09:42:52 INFO - 'NO_EM_RESTART': '1', 09:42:52 INFO - 'PAGER': '/bin/cat', 09:42:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:52 INFO - 'PWD': '/builds/slave/test', 09:42:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:52 INFO - 'SHELL': '/bin/bash', 09:42:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f5YpxdoJXA/Listeners', 09:42:52 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:52 INFO - 'USER': 'cltbld', 09:42:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:52 INFO - 'XPC_FLAGS': '0x0', 09:42:52 INFO - 'XPC_SERVICE_NAME': '0', 09:42:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:42:52 INFO - Cleaning up... 09:42:52 INFO - Return code: 0 09:42:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1081cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff070d943c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fa8d30>, '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 0x107ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f9dbe8>, '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.rV0P6hNVP0/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.f5YpxdoJXA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:42:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rV0P6hNVP0/Render', 09:42:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:42:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:42:52 INFO - 'HOME': '/Users/cltbld', 09:42:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:42:52 INFO - 'LOGNAME': 'cltbld', 09:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:52 INFO - 'MOZ_NO_REMOTE': '1', 09:42:52 INFO - 'NO_EM_RESTART': '1', 09:42:52 INFO - 'PAGER': '/bin/cat', 09:42:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:52 INFO - 'PWD': '/builds/slave/test', 09:42:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:42:52 INFO - 'SHELL': '/bin/bash', 09:42:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f5YpxdoJXA/Listeners', 09:42:52 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:42:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:42:52 INFO - 'USER': 'cltbld', 09:42:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:42:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:52 INFO - 'XPC_FLAGS': '0x0', 09:42:52 INFO - 'XPC_SERVICE_NAME': '0', 09:42:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:42:53 INFO - Cleaning up... 09:42:53 INFO - Return code: 0 09:42:53 INFO - Running post-action listener: _resource_record_post_action 09:42:53 INFO - Running post-action listener: _start_resource_monitoring 09:42:53 INFO - Starting resource monitoring. 09:42:53 INFO - [mozharness: 2017-05-02 16:42:53.193198Z] Finished create-virtualenv step (success) 09:42:53 INFO - [mozharness: 2017-05-02 16:42:53.194021Z] Running install step. 09:42:53 INFO - Running pre-action listener: _resource_record_pre_action 09:42:53 INFO - Running main action method: install 09:42:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:53 INFO - Reading from file tmpfile_stdout 09:42:53 INFO - Detecting whether we're running mozinstall >=1.0... 09:42:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:42:53 INFO - Reading from file tmpfile_stdout 09:42:53 INFO - Output received: 09:42:53 INFO - Usage: mozinstall [options] installer 09:42:53 INFO - Options: 09:42:53 INFO - -h, --help show this help message and exit 09:42:53 INFO - -d DEST, --destination=DEST 09:42:53 INFO - Directory to install application into. [default: 09:42:53 INFO - "/builds/slave/test"] 09:42:53 INFO - --app=APP Application being installed. [default: firefox] 09:42:53 INFO - mkdir: /builds/slave/test/build/application 09:42:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:43:08 INFO - Reading from file tmpfile_stdout 09:43:08 INFO - Output received: 09:43:08 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:43:08 INFO - Running post-action listener: _resource_record_post_action 09:43:08 INFO - [mozharness: 2017-05-02 16:43:08.619337Z] Finished install step (success) 09:43:08 INFO - [mozharness: 2017-05-02 16:43:08.619438Z] Running run-tests step. 09:43:08 INFO - Running pre-action listener: _resource_record_pre_action 09:43:08 INFO - Running main action method: run_tests 09:43:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:43:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:43:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:43:08 INFO - 2017-05-02 09:43:08.632 screenresolution[1618:7384] starting screenresolution argv=screenresolution get 09:43:08 INFO - 2017-05-02 09:43:08.635 screenresolution[1618:7384] Display 0: 1600x1200x32@60 09:43:08 INFO - 2017-05-02 09:43:08.640 screenresolution[1619:7386] starting screenresolution argv=screenresolution list 09:43:08 INFO - Available Modes on Display 0 09:43:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:43:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:43:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:43:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:43:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:43:08 INFO - Intel Iris: 09:43:08 INFO - Chipset Model: Intel Iris 09:43:08 INFO - Type: GPU 09:43:08 INFO - Bus: Built-In 09:43:08 INFO - VRAM (Dynamic, Max): 1536 MB 09:43:08 INFO - Vendor: Intel (0x8086) 09:43:08 INFO - Device ID: 0x0a2e 09:43:08 INFO - Revision ID: 0x0009 09:43:08 INFO - Displays: 09:43:08 INFO - Display: 09:43:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:43:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:43:08 INFO - Display Serial Number: 1600x1200 60 09:43:08 INFO - Main Display: Yes 09:43:08 INFO - Mirror: Off 09:43:08 INFO - Online: Yes 09:43:08 INFO - Rotation: Supported 09:43:08 INFO - Return code: 0 09:43:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:43:08 INFO - Python 2.7.3 09:43:08 INFO - Return code: 0 09:43:08 INFO - grabbing minidump binary from tooltool 09:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:08 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 0x107fa8d30>, '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 0x107ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f9dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:43:08 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 09:43:08 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 09:43:08 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 09:43:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:43:08 INFO - Return code: 0 09:43:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:43:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:43:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:43:08 INFO - ENV: RUST_BACKTRACE is now 1 09:43:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:43:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:43:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--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 09:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0104 --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 09:43:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rV0P6hNVP0/Render', 09:43:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:43:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:43:09 INFO - 'HOME': '/Users/cltbld', 09:43:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:43:09 INFO - 'LOGNAME': 'cltbld', 09:43:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:43:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:09 INFO - 'MOZ_NO_REMOTE': '1', 09:43:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:43:09 INFO - 'NO_EM_RESTART': '1', 09:43:09 INFO - 'PAGER': '/bin/cat', 09:43:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:09 INFO - 'PWD': '/builds/slave/test', 09:43:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:43:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:43:09 INFO - 'RUST_BACKTRACE': '1', 09:43:09 INFO - 'SHELL': '/bin/bash', 09:43:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f5YpxdoJXA/Listeners', 09:43:09 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:43:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:43:09 INFO - 'USER': 'cltbld', 09:43:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:43:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:09 INFO - 'XPC_FLAGS': '0x0', 09:43:09 INFO - 'XPC_SERVICE_NAME': '0', 09:43:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:43:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--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 09:43:09 INFO - mozversion application_buildid: 20170502080920 09:43:09 INFO - mozversion application_changeset: 2bf6db48a260233ba421cd216aeeaea957887123 09:43:09 INFO - mozversion application_display_name: Firefox 09:43:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:43:09 INFO - mozversion application_name: Firefox 09:43:09 INFO - mozversion application_remotingname: firefox 09:43:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:43:09 INFO - mozversion application_vendor: Mozilla 09:43:09 INFO - mozversion application_version: 54.0 09:43:09 INFO - mozversion platform_buildid: 20170502080920 09:43:09 INFO - mozversion platform_changeset: 2bf6db48a260233ba421cd216aeeaea957887123 09:43:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:43:09 INFO - mozversion platform_version: 54.0 09:43:09 INFO - using testdate: 1493743389 09:43:09 INFO - actual date: 1493743389 09:43:09 INFO - starting webserver on 'localhost:49235' 09:43:09 INFO - SUITE-START | Running 2 tests 09:43:09 INFO - TEST-START | dromaeo_css 09:43:09 INFO - operating with platform_type : mac_ 09:43:09 INFO - Initialising browser for dromaeo_css test... 09:43:09 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpQkdg9z/profile http://localhost:49235/getInfo.html) 09:43:11 INFO - PROCESS | 1629 | __metrics Screen width/height:1600/1200 09:43:11 INFO - PROCESS | 1629 | colorDepth:24 09:43:11 INFO - PROCESS | 1629 | Browser inner width/height: 1024/689 09:43:11 INFO - PROCESS | 1629 | __metrics 09:43:11 INFO - PROCESS | 1629 | 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" 09:43:11 INFO - PROCESS | 1629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:43:12 INFO - TEST-INFO | 1629: exit 0 09:43:12 INFO - Browser initialized. 09:43:12 INFO - Running cycle 1/1 for dromaeo_css test... 09:43:12 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpQkdg9z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:24 INFO - PROCESS | 1632 | RSS: Main: 165412864 09:43:24 INFO - PROCESS | 1632 | 09:46:28 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 09:46:29 INFO - PROCESS | 1632 | RSS: Main: 290279424 09:46:29 INFO - PROCESS | 1632 | 09:49:32 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 09:49:33 INFO - PROCESS | 1632 | RSS: Main: 303489024 09:49:33 INFO - PROCESS | 1632 | 09:52:35 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 09:52:36 INFO - PROCESS | 1632 | RSS: Main: 271917056 09:52:36 INFO - PROCESS | 1632 | 09:55:38 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 09:55:39 INFO - PROCESS | 1632 | RSS: Main: 267460608 09:55:39 INFO - PROCESS | 1632 | 09:58:42 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 09:58:43 INFO - PROCESS | 1632 | RSS: Main: 264130560 09:58:43 INFO - PROCESS | 1632 | 10:01:46 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 10:01:46 INFO - PROCESS | 1632 | RSS: Main: 323665920 10:01:46 INFO - PROCESS | 1632 | 10:01:46 INFO - PROCESS | 1632 | __start_tp_report 10:01:46 INFO - PROCESS | 1632 | _x_x_mozilla_page_load 10:01:46 INFO - PROCESS | 1632 | _x_x_mozilla_page_load_details 10:01:46 INFO - PROCESS | 1632 | |i|pagename|runs| 10:01:46 INFO - PROCESS | 1632 | |0;dojo.html;2913.970860291397;3532.43481043033;3541.185527328715;3547.1841476460413;3578.338007468617;6070.635761854292;6108.450239478446;6110.755569777203;6134.938650613503;6173.259208894928;6080.361562035978;6128.417800308964;6139.478144357735;6141.60079594826;6148.692565371724;5391.56867450603;5392.78428862845;5427.158790387476;5454.972725136368;5538;5323.8136665216725;5359.410464848864;5390.6226564140525;5419.3225846769155;5540.3983221191875;5391.676499410029;5401.000814849246;5411.080116380225;5422.593305502083;5432.103702889019;5442.346918369782;5480.890382192354;5487.039768040577;5490.066688662937;5496.422875598085;5300.628955973083;5416.83749487516;5421.2952316199035;5461.617686761889;5473.534749546293;5859.384764599741;5863.413658634103;5905.173275741399;6098.237720284965;6111.327753947062;6335.11308416822;6373.5857169283845;6422.4862011039;6446.161998940154;6454.257760357572;6439.581427207217;6440.581362211441;6489.675516224217;6497.967510162419;6513.804585862432;5958.582899197101;6203.8138855834395;6217.129601855744;6221.9377806222265;6224.315325314212;5455.672659640434;6475.287718350977;6509.479241660656;6549.770758023446;6639.269680335159;6365.236171659338;6372.840678983062;6378.043293506012;6378.298387177407;6381.202349706286;6421.422072013541;6442.903356449657;6465.579737317059;6494.188226471691;6501.317361676955;5136.614753893473;6310.5267104967315;6352.36476352361;6390.840228994312;6398.2641996170105;6115.088229002436;6146.4775494082605;6306.621602703853;6377.8724425512155;6416.743330266737;5127.4872512748425;5131.230315452712;5134;5140.331756871583;5141.71720555373;4588.449386073693;4597.241455159861;4648.651351148677;4662.0209755950955;4671.182543054952;6227.314995350508;6255.562110652301;6257.124002639634;6258.593191442542;6265.749370025148;6272.8118156455375;6454.903176452357;6490.675466226764;6490.740370385226;6505.186851643544;6100.328963813977;6136.3965394158;6147.72335244915;6233.0338797486465;6259.2488901332135;5729.398413166641;5731.168980497804;5735.254416925856;5738.254026976467;5745;6642.6014439133805;6699.933000670126;6747;6760.357766012221;6768.830779230559;6257.56197066201;6278;6417.294097649162;6467.094606755152;6537.607743535403;5595.524380427709;6733.663316834237;6739.932600674127;6747.190337159573;6748.460123190232;6394.968025159845;6446.9032964506505;6458.54790164684;6458.741650333934;6464.0627109069865;6266.498680105672;6273.592216505913;6378.840528986812;6440.098386225838;6526.314736952551;6351.68241587928;6379.776707815204;6405.583637063576;6407.8398040047505;6414.166158399378;6187.443130118311;6378.968105159444;6379.330170332234;6384.808455746335;6407.103005579316;5584.832455026356;6136.365905528278;6161.599496032743;6303.36966303366;6346.3019067903415;6049.758009679564;6311.084892690443;6373.3945275198785;6378.2983871774995;6384.138141351044;6308.463780578519;6325.746970121144;6329.90505142414;6353.4599559038;6358.682065896594 10:01:46 INFO - PROCESS | 1632 | |1;ext.html;788.88561158632;812.7033632724056;831.6798032757387;882.2765332427408;894.061235702513;28570.57144142837;28849.13452596423;40813.7959310203;41182.58817411825;41191.38212926809;40734.38898416518;42756;42764.78617606908;42889.14221715564;42934.57065429352;9657.95171024144;9831.803363932717;9832.90167098327;9846.753831154207;9848.753781155458;7745;7907.090684571262;11872.168948173632;12128.151029427943;12140.210886292363;11936.343501107436;11955.701107472296;11979.161458697894;11988.100892433058;11991.22057066288;11900.880991190108;11956.043516518745;11957.760844783055;11961.700957476045;11974.9821265193;11573.42132893352;11622.94188529052;11640.18518703691;11641.88358116425;11644.301341919512;39848;40101.799491002355;40129.39805902914;40145.59854401477;40201.798991004856;4026.134381108076;4062.228176646457;4088.325426304656;4099.282625540519;4099.754014759094;24162;28060.298492537644;29969.70030299691;30791.7683292668;30831.383372332653;3130.264387868849;3248.642649308574;3263.983680081584;3314.93370132596;3324.1523411529906;303337.9999999978;304739;305339;306018;307272;52779;52859;52999.47000530022;52999.73500132475;53002.469975300526;55118.72440637851;55156;55168.724156378965;55318.72340638271;55330.17004744932;14744.631384215267;15044.623884402978;15055.698886022219;15072.095674259579;15079.170645614377;11241.494132764044;12858.228506289652;13041.673958151123;13091.869081309065;13100.737985240241;10458.581656733646;10496.107830834311;10513.264071514921;10514.26400151982;10514.369137851754;4841.276488818148;5433.945660543344;5446.319210098738;5474.315710536183;5493.148561972821;1135.5230803062734;1148.4487446025787;1152.181950814914;1162.773259214462;1200.6818193178815;27113.593296100575;27497.725022749917;27905.302367440978;28048.579271310948;28108.578371324445;1248.2510493703705;1259.5780413561376;1270.8602053774077;1302.8501722301867;1319.399673148715;14187.929060354632;14258.786118208027;14517.419303227964;14560.927195363955;14563.271836408137;469486;475705;476084;477233;479113.2088679138;45720.54279457163;46023.76988115038;55870;56135.43864561302;57958.7102064487;1490.9552713418616;1496.6632507685683;1501.4894935721907;1502.5867886331346;1510.7280689476;29353.853230734563;30262.34228469733;30438.74365880247;30623;30838.53742193824;46117.76941115273;46217.76891115523;46295.53704463047;46342;46346;468470;480355;484089;495376;505574;35198;35964.82017589895;36018.09954751152;36065.27869442544;36216.09459763527;43760.113520377425;45570.772146139054;45658;45952.540474596164;45960.54039459563;29830.850845745634;30745.53881691821;30869.845650771604;31570.526442102928;32007.839960800047;30585.54121688132;31267.06198814039;31559;31732.682673172974;32001.199970000936;36802.8159859199;37680.43479347867;38033.23933521259;38038;38106.428403573416;30056.849715751283;30754.077377678706;31233.538191395743;31407.685923140478;31702.207444814063;22131.114755409602;23536;24561;24961.87566748599;25251.62122568126 10:01:46 INFO - PROCESS | 1632 | |2;jquery.html;429.40312964978705;439.6988063176722;444.1383715591751;448.3498926556494;452.3712040264033;20629;21509.892450537744;22531.54936901261;22761.658575121386;22881.855907204637;21178.152873885065;23494.765052349514;23574;23696.763032369672;24202.75797242027;6842.281560436158;6873.553219040771;7090.468214883878;7239.71041158353;7240.348368646821;7064.364207221349;7172.067631207936;7185.173705023937;7190.101237345332;7199.280071992785;6829.726810927557;7110.751123710671;7187.460940429462;7196.064511613509;7206.603636799974;6832.487563432713;7044.36600705939;7084.539504932189;7125.572465652026;7160.248173941739;6923.58458492487;6955.374016338554;6957.65211739411;6965.129358830146;6978.197507286676;28599.9990000349;28853.711462885312;28873.855630721922;28920.566191507143;29549;2632.5129850977632;2644.2331723800266;2666.1868130220273;2670.8664566771586;2725.5639097744265;17009.574760631083;17015.893966892112;17052.744208836877;17563.94616323025;17629;1883.896385698786;1974.7926467720827;2108.2831837175436;2126.670366093258;2134.1036764558767;134159.65840341666;136588;141615.2919235397;142302.28848855794;144975;22847.885760571422;22953.540929181658;23000.769992300196;23183.420414489436;23216.53566928652;37992.810035949646;38028.61971380306;38821.80589097036;38848.611513885066;38935.610643893764;8208.58957052145;10694.304870183412;10860.782784344268;10947.945260273647;11077.335359878432;8992.965808931925;9026.684066057656;9027.322950778718;9037.819243615091;9214.35499515041;8847.955760221157;8958.10418958099;9730.464824434583;9898.851517227247;9905.108540231413;3494.668006539375;3704.4626480011034;3933.8229779659982;3953.5058117735284;3954.2289253595272;1045.7856139491387;1064.4305296666246;1064.7072055184885;1076.8923107689168;1144.5993902134187;22822.42943926415;22888.542229155322;22895.198668046538;23218.3034508965;23302.3009309721;1086.4296244471716;1094.261373572835;1100.2628239079836;1103.9944800276107;1113.9275947063577;10959.726006849893;11826.940865295619;11981.580644677395;11988.820167697491;11999.520019199308;668287;760470;773057;785890;789651;156193;159031;161168;162745.18627407023;166084;1239.3617287097152;1258.4211262819022;1291.754566632337;1296.2999980010877;1299.1166007115064;19232.59592550931;20216.898915505328;20271.391858244275;20328.89835550813;20337.186512539334;63134.73730525456;63470.730585388956;63511.682441587494;64380;65532;72998.63500682462;90006;90201;90465;91748;11275.210735248455;11664.329704849275;11849.111316651113;11890.643280701594;11985.520579177084;10596.841047384141;10647.627333043307;12856.292903890377;12900.225986440844;13087.083904127001;10969.396683182502;11134.777304453704;11271.436428178722;11433.542658293907;11510.30938143714;10209.38743675352;10280.742981425225;10314.484275786332;10412.895871041193;10490.685279441628;11424.48589813477;11466.885331146581;11594.594189203337;11711.599122180103;11721.296722196696;11688.70778230551;11787.292762433939;11849.763004739685;11874.52501899949;12039.578614748441;10680.786384272427;10987.61543345979;11098.889011109786;11210.775784484102;11254.549818007188 10:01:46 INFO - PROCESS | 1632 | |3;mootools.html;1333.9923415260032;1628.9511314660565;1658.046623191665;1659.925303361349;1672.4982505248422;9412.717618471448;9853.408795472276;11192.552297908083;11345.546178152865;11355.375454350007;11037.944810275958;11252.831207531874;11359.318440893532;11368.09055275578;11396.14528910333;2113.8097571218586;2160.8919554022277;2491.813114016447;2492.5513407586627;2498.9750102498924;2160.12514931453;2430.149447693302;2534.0750626021554;2545.1346542175656;2549.783268422177;2469.2098528470897;2497.725250222474;2524.4951009798024;2527.19129878439;2527.317624241454;2488.6515887775727;2506.862122583257;2512.7612876776675;2515.7987361011164;2524.066095544642;2466.2971053249917;2483.565376059182;2505.523950449427;2520.6345079963303;2527.936801579957;11472.369019703912;11566.710832229177;11571.594994175164;11572.363520006396;11587.884121158764;6022.909656355158;6195.535334849904;6205.472534834545;6206.751729930843;6212.844678883064;3452.2577645806273;3625.800580968072;3836.8081595920094;3847.769133851978;3848.615138486157;1238.6098379010582;1250.6498180509473;1271.45327509171;1281.884760258581;1284.800855867342;15551.922240388725;15760.68478630421;15860.841391586051;15862.127582982932;15869.444569440015;4864.975675121602;5134.358205224347;5184.326037615086;5193.68837869729;5215.973920130375;13115.672108197181;13130.540431084866;13133.540326088541;13139.277339746215;13145.868541314465;6225.097360882647;6232.065190221503;6245.125682404467;6246.718897649616;6246.843828904223;4746.121967436035;5420.7560659769615;5422.186671999153;5443.319585051869;5517.089680202802;3726.459663348799;3817.7900215487857;3920.627540383659;4220.78896055196;4324.437823082979;1176.5529098942347;1183.4319526627096;1186.430513353578;1204.879512048788;1212.5089338817793;964.286428043243;991.5686676295834;998.1964518562627;1002.2783595811004;1008.6016023670609;6499.6675681485185;6639;6710.530262881552;6849.520533562602;6874.793756187322;1021.2442792333619;1042.5725452564564;1085.3976043295888;1092.4373947417087;1113.5156207049959;4288.442502474658;4412;4414.690971632019;4431.135928493913;4535.9773201133785;13301.06892517534;13807.240601767;14040.789388159186;14057.43770249199;14067.226302553254;13430.664233394047;13848.723025539633;13872.306384680725;13886.09740366873;13893.305334733222;10102.949485252673;10360;10453.163746900229;10485.790284194274;10503.159747220358;5657;6591.670416479253;6638.601683898982;6762.729490820312;6783.4573234142135;11043.337399756041;12246.326452045223;12573.1198816082;12707.237565746085;12762.808557871454;12637.17858339205;12660;12749.235045896905;12869.742605147658;12887.033472489788;9261.490618015805;9358.766030849283;9417.058294170529;9461.95269023678;9475.005124461832;8930.732078037669;9157.725268241964;9858.704238872846;10184.949075254577;10234.53944572511;8473.279771219515;8508.404411691123;8619.741407757778;8641.654333826827;8697.391182617155;8345.41582089248;8399.95800020996;8433.53615551126;8463.788405289917;8501.362397820065;7918.168592297726;7963.92036079655;8028.357731381592;8092.271695547429;8096.068952070587;5835.387284335084;5875.911861321998;5908.202392677105;6065.2418447694035;6088.543359247986;5973.522118230618;6051.213342265477;6055.394460553909;6150.985087460519;6161.075838624242 10:01:46 INFO - PROCESS | 1632 | |4;prototype.html;387.0922686300624;390.40073487197157;390.79678567145083;398.1539229138082;400.403398935586;4087.713860029799;4871.75641217939;4874.9275159464905;4922.261660750889;5001.324821149153;4078.4494093297394;4312.762798046107;4516.0967806438675;4883.853484395474;4896.657233993622;3323.767336286455;3494.4408894576873;3611.8735844245457;3657.4513822926506;4031.717779755418;3701.8889433317045;4144.626983571478;4168.416421700964;4172.4784401949755;4250.511191213003;3671.889843304705;3957.940630890539;4168.395582640515;4205.873823785291;4250.638695710868;3780.3006443807985;3913.610668212772;4239.724417912826;4243.130158317537;4289.742615443083;3255.951160732591;3515.8945231643092;3693.353663108945;3826.9808650956566;3833.5783063862955;3991.381335892941;4228;4775.474697783241;4835.540623640783;4870.902581948377;4307.353896915456;4848.733319667417;4850.126977144113;4875.318015284756;4942.975285123552;4753.429588449409;5261.552768014723;5269.682579355162;5270.367555893279;5278.81524146653;4295.012147206129;4307.224699554079;4323.481182258118;4339.437802391137;4351.216780979423;4139.834406623761;5124;5290.550303224192;5413.350397952271;5584.301962254718;3551.3074950384944;3902.8829135125993;4166.1461898599555;4173.582641735863;4249.022724773319;4401.119776044804;4416;4427;4456.041950980555;4511.62395469385;3458.8962331130106;4103.4870641169855;4791.904161916742;4803.95196048042;4830.275458681155;5233.738313084406;5256.789728410898;5264.894702106013;5293.232481290192;5308.327876718821;1503.1356969742442;1518.764591488299;1522.6802371501888;1527.6410043639735;1527.9923600381926;998.9200863930868;1049.5044561499833;1098.5770478365887;1113.7828123515837;1157.9652610421701;4396.956030439718;4534.463118767367;4605.848537865533;4619.076184762994;5011.298418221452;4745.572898439157;5138.76463738275;5523.9894257629685;5531.621402796836;5588.636738611977;4182.9581704182565;4346.217680817484;4428.482947393641;4664.416947881515;5061.544460998528;2376.4771750214927;2760.6963234044238;2823.277800541668;2841.403305305909;2860.885564577394;4741.644376671763;4887.975560122177;5283.762230699628;5658.830235092953;5670.7731690732735;4772.49888761682;5119.69447790811;5593.615862403188;5624.806325533045;5660.349059858087;5047.551937310402;5683.744231509592;5694.010644411717;5696.715164241771;5722.656640601577;4687.789049492849;5482.424345443671;5489.862753431196;5498.340199176125;5549.500544950974;5093.7707803148205;5362.731863406892;5382.085045542189;5385.649932754359;5404.270423492778;4708.317293992421;5126.103341763572;5478.45215478449;5533.474319939599;5558.777648893999;3680.429533422324;3968.5275384038964;4199.391088292242;4299.678173786246;4389.780510974502;4817.79616555001;5051.974740126276;5463.644863083887;5472.6990015547935;5530.668159910419;4262.744235345889;4886.877828054327;5067.733066733316;5216.843494695166;5384.227123031564;4845.44945617399;5115.521445417152;5248.8425347239645;5287.4976877196605;5305.734713264244;4231.87304380869;4865.513448655106;4918.95081049185;5173.560247379015;5236.581073514186;4430.357598148186;5031.899362012666;5256;5264.73676316175;5400.054990376747;5162.716050617102;5197.688138711689;5288.550473209821;5290.65610735301;5301.019311427398 10:01:46 INFO - PROCESS | 1632 | |5;yui.html;744.118219909407;761.6953218712514;781.9882701759475;880.4673172730498;888.2938064238928;15769.84230157698;17532.386366477174;17605.82394176058;17623.823761762378;17651.382201622946;16211.513654590352;16299.592510187222;16428.260728267225;16447.917760411183;16455.670886582262;942.8255772682076;953.504177827531;1007.8135544924176;1017.1811691588268;1041.1046500010023;1019.2508506247939;1021.3922715983978;1021.7343490692399;1021.9284650074497;1024.7182024943163;1070.2454769387602;1071.5767271927584;1072.5441687282912;1073.002108039523;1074.1943542343242;1055.883852776194;1066.1524088349781;1066.3495267886544;1067.754416484213;1068.6046162919731;791.4657606115907;793.309820456201;793.4683761879554;793.9126696063429;794.916533763958;16610.58473538159;17001.91499042509;17505.336992985645;17615.943043417436;17703.84924979872;14678.339474723663;14730.55808325752;14805.03767255125;14813.111213327235;14824.184669843155;12056.095792815573;12136.171144496482;12146.696332591668;12186.75626487474;12423.006159507218;3788.7103583579496;3912.5500567434824;3930.6265904739003;3985.2826491231567;4080.204360149772;112973.87026129715;122726.38636806849;125790;127444.36277818552;129873;10997.450127493594;11262.682029520864;11575.363355015386;11646.359450230319;11741;21970;22236.332910012727;23227;23793.286201413986;23864.880675596512;8305.709300174585;8331.29184019353;8408.705695300636;8510.063892971768;8537.231649151607;4532.5694059064335;4550.590446859732;4639.443266808004;4653.744044077608;4670.832291927019;3594.6405359463843;3693.7414380993073;3701.1117331840164;3703;3703.333399988028;580.4833698008775;649.5031301054697;664.2958464028146;679.4428568573821;680.2551206428952;714.953528020677;724.9093863267092;727.3053784681679;751.3876190904396;751.8759404698163;10737.83893241602;10764.782606539491;10785.227108544768;10873.728156796144;10890.782184356269;702.6276073680957;734.9706011759577;739.4712780362067;746.2761121711931;751.3275618321571;4746.881327966828;5016.2224855147515;5018.774155163026;5020.523050310215;5057.772400241998;73554.63222683853;109905.80188396187;112369.87630123757;114547.42726286316;114870.4256478729;95037;96185;98261.03477930401;98561.50719246358;98705.50647246718;61706;79464;79838;79957.60021199856;81016.59491702622;9746.415215087118;9768.169705574821;9790.118889299998;9793.755156121155;9841.557129929028;36760.81619591885;48402.273965889835;54123.458765411844;54154.187687183934;56573;55061.72469137629;67878;68689.31310686829;71966.28033719806;72593.27406725865;13559.389827457591;13589.320533973065;13799.172049677052;13963.952703547071;14004;15313.234338283264;15403;15615.141167235912;16089.195540222709;16358.933367755753;14016.719665606426;14442.350094245994;14825.851741482447;14827.555173344817;15466.381344746535;13455.798163027366;13933.930330348283;14563.41746330135;14624.634384140481;15122.924385378003;13567.728645427234;13767.724645506833;13800.37898294559;14150.00949933536;14541.709165816414;9929.950350248202;10086.142677872464;10245.590176392861;10637.468126593794;11079.224454288122;11348.602798901999;11418.828717569077;11672.70818229551;11775.470103845177;11821 10:01:46 INFO - PROCESS | 1632 | __end_tp_report 10:01:46 INFO - PROCESS | 1632 | __start_cc_report 10:01:46 INFO - PROCESS | 1632 | _x_x_mozilla_cycle_collect,1366 10:01:46 INFO - PROCESS | 1632 | __end_cc_report 10:01:46 INFO - PROCESS | 1632 | __startTimestamp1493744506909__endTimestamp 10:01:46 INFO - PROCESS | 1632 | 10:01:46 INFO - PROCESS | 1632 | ------- Summary: start ------- 10:01:46 INFO - PROCESS | 1632 | Number of tests: 6 10:01:46 INFO - PROCESS | 1632 | 10:01:46 INFO - PROCESS | 1632 | [#0] dojo.html Cycles:165 Average:5990.93 Median:6257.56 stddev:674.26 (10.8%) stddev-sans-first:631.65 10:01:46 INFO - PROCESS | 1632 | Values: 2914.0 3532.4 3541.2 3547.2 3578.3 6070.6 6108.5 6110.8 6134.9 6173.3 6080.4 6128.4 6139.5 6141.6 6148.7 5391.6 5392.8 5427.2 5455.0 5538.0 5323.8 5359.4 5390.6 5419.3 5540.4 5391.7 5401.0 5411.1 5422.6 5432.1 5442.3 5480.9 5487.0 5490.1 5496.4 5300.6 5416.8 5421.3 5461.6 5473.5 5859.4 5863.4 5905.2 6098.2 6111.3 6335.1 6373.6 6422.5 6446.2 6454.3 6439.6 6440.6 6489.7 6498.0 6513.8 5958.6 6203.8 6217.1 6221.9 6224.3 5455.7 6475.3 6509.5 6549.8 6639.3 6365.2 6372.8 6378.0 6378.3 6381.2 6421.4 6442.9 6465.6 6494.2 6501.3 5136.6 6310.5 6352.4 6390.8 6398.3 6115.1 6146.5 6306.6 6377.9 6416.7 5127.5 5131.2 5134.0 5140.3 5141.7 4588.4 4597.2 4648.7 4662.0 4671.2 6227.3 6255.6 6257.1 6258.6 6265.7 6272.8 6454.9 6490.7 6490.7 6505.2 6100.3 6136.4 6147.7 6233.0 6259.2 5729.4 5731.2 5735.3 5738.3 5745.0 6642.6 6699.9 6747.0 6760.4 6768.8 6257.6 6278.0 6417.3 6467.1 6537.6 5595.5 6733.7 6739.9 6747.2 6748.5 6395.0 6446.9 6458.5 6458.7 6464.1 6266.5 6273.6 6378.8 6440.1 6526.3 6351.7 6379.8 6405.6 6407.8 6414.2 6187.4 6379.0 6379.3 6384.8 6407.1 5584.8 6136.4 6161.6 6303.4 6346.3 6049.8 6311.1 6373.4 6378.3 6384.1 6308.5 6325.7 6329.9 6353.5 6358.7 10:01:46 INFO - PROCESS | 1632 | 10:01:46 INFO - PROCESS | 1632 | [#1] ext.html Cycles:180 Average:56725.39 Median:31564.76 stddev:114375.80 (362.4%) stddev-sans-first:114619.55 10:01:46 INFO - PROCESS | 1632 | Values: 788.9 812.7 831.7 882.3 894.1 28570.6 28849.1 40813.8 41182.6 41191.4 40734.4 42756.0 42764.8 42889.1 42934.6 9658.0 9831.8 9832.9 9846.8 9848.8 7745.0 7907.1 11872.2 12128.2 12140.2 11936.3 11955.7 11979.2 11988.1 11991.2 11900.9 11956.0 11957.8 11961.7 11975.0 11573.4 11622.9 11640.2 11641.9 11644.3 39848.0 40101.8 40129.4 40145.6 40201.8 4026.1 4062.2 4088.3 4099.3 4099.8 24162.0 28060.3 29969.7 30791.8 30831.4 3130.3 3248.6 3264.0 3314.9 3324.2 303338.0 304739.0 305339.0 306018.0 307272.0 52779.0 52859.0 52999.5 52999.7 53002.5 55118.7 55156.0 55168.7 55318.7 55330.2 14744.6 15044.6 15055.7 15072.1 15079.2 11241.5 12858.2 13041.7 13091.9 13100.7 10458.6 10496.1 10513.3 10514.3 10514.4 4841.3 5433.9 5446.3 5474.3 5493.1 1135.5 1148.4 1152.2 1162.8 1200.7 27113.6 27497.7 27905.3 28048.6 28108.6 1248.3 1259.6 1270.9 1302.9 1319.4 14187.9 14258.8 14517.4 14560.9 14563.3 469486.0 475705.0 476084.0 477233.0 479113.2 45720.5 46023.8 55870.0 56135.4 57958.7 1491.0 1496.7 1501.5 1502.6 1510.7 29353.9 30262.3 30438.7 30623.0 30838.5 46117.8 46217.8 46295.5 46342.0 46346.0 468470.0 480355.0 484089.0 495376.0 505574.0 35198.0 35964.8 36018.1 36065.3 36216.1 43760.1 45570.8 45658.0 45952.5 45960.5 29830.9 30745.5 30869.8 31570.5 32007.8 30585.5 31267.1 31559.0 31732.7 32001.2 36802.8 37680.4 38033.2 38038.0 38106.4 30056.8 30754.1 31233.5 31407.7 31702.2 22131.1 23536.0 24561.0 24961.9 25251.6 10:01:46 INFO - PROCESS | 1632 | 10:01:46 INFO - PROCESS | 1632 | [#2] jquery.html Cycles:180 Average:43664.72 Median:22864.87 stddev:125971.45 (550.9%) stddev-sans-first:126283.00 10:01:46 INFO - PROCESS | 1632 | Values: 429.4 439.7 444.1 448.3 452.4 20629.0 21509.9 22531.5 22761.7 22881.9 21178.2 23494.8 23574.0 23696.8 24202.8 6842.3 6873.6 7090.5 7239.7 7240.3 7064.4 7172.1 7185.2 7190.1 7199.3 6829.7 7110.8 7187.5 7196.1 7206.6 6832.5 7044.4 7084.5 7125.6 7160.2 6923.6 6955.4 6957.7 6965.1 6978.2 28600.0 28853.7 28873.9 28920.6 29549.0 2632.5 2644.2 2666.2 2670.9 2725.6 17009.6 17015.9 17052.7 17563.9 17629.0 1883.9 1974.8 2108.3 2126.7 2134.1 134159.7 136588.0 141615.3 142302.3 144975.0 22847.9 22953.5 23000.8 23183.4 23216.5 37992.8 38028.6 38821.8 38848.6 38935.6 8208.6 10694.3 10860.8 10947.9 11077.3 8993.0 9026.7 9027.3 9037.8 9214.4 8848.0 8958.1 9730.5 9898.9 9905.1 3494.7 3704.5 3933.8 3953.5 3954.2 1045.8 1064.4 1064.7 1076.9 1144.6 22822.4 22888.5 22895.2 23218.3 23302.3 1086.4 1094.3 1100.3 1104.0 1113.9 10959.7 11826.9 11981.6 11988.8 11999.5 668287.0 760470.0 773057.0 785890.0 789651.0 156193.0 159031.0 161168.0 162745.2 166084.0 1239.4 1258.4 1291.8 1296.3 1299.1 19232.6 20216.9 20271.4 20328.9 20337.2 63134.7 63470.7 63511.7 64380.0 65532.0 72998.6 90006.0 90201.0 90465.0 91748.0 11275.2 11664.3 11849.1 11890.6 11985.5 10596.8 10647.6 12856.3 12900.2 13087.1 10969.4 11134.8 11271.4 11433.5 11510.3 10209.4 10280.7 10314.5 10412.9 10490.7 11424.5 11466.9 11594.6 11711.6 11721.3 11688.7 11787.3 11849.8 11874.5 12039.6 10680.8 10987.6 11098.9 11210.8 11254.5 10:01:46 INFO - PROCESS | 1632 | 10:01:46 INFO - PROCESS | 1632 | [#3] mootools.html Cycles:180 Average:6893.80 Median:2525.84 stddev:4290.20 (169.9%) stddev-sans-first:4281.89 10:01:46 INFO - PROCESS | 1632 | Values: 1334.0 1629.0 1658.0 1659.9 1672.5 9412.7 9853.4 11192.6 11345.5 11355.4 11037.9 11252.8 11359.3 11368.1 11396.1 2113.8 2160.9 2491.8 2492.6 2499.0 2160.1 2430.1 2534.1 2545.1 2549.8 2469.2 2497.7 2524.5 2527.2 2527.3 2488.7 2506.9 2512.8 2515.8 2524.1 2466.3 2483.6 2505.5 2520.6 2527.9 11472.4 11566.7 11571.6 11572.4 11587.9 6022.9 6195.5 6205.5 6206.8 6212.8 3452.3 3625.8 3836.8 3847.8 3848.6 1238.6 1250.6 1271.5 1281.9 1284.8 15551.9 15760.7 15860.8 15862.1 15869.4 4865.0 5134.4 5184.3 5193.7 5216.0 13115.7 13130.5 13133.5 13139.3 13145.9 6225.1 6232.1 6245.1 6246.7 6246.8 4746.1 5420.8 5422.2 5443.3 5517.1 3726.5 3817.8 3920.6 4220.8 4324.4 1176.6 1183.4 1186.4 1204.9 1212.5 964.3 991.6 998.2 1002.3 1008.6 6499.7 6639.0 6710.5 6849.5 6874.8 1021.2 1042.6 1085.4 1092.4 1113.5 4288.4 4412.0 4414.7 4431.1 4536.0 13301.1 13807.2 14040.8 14057.4 14067.2 13430.7 13848.7 13872.3 13886.1 13893.3 10102.9 10360.0 10453.2 10485.8 10503.2 5657.0 6591.7 6638.6 6762.7 6783.5 11043.3 12246.3 12573.1 12707.2 12762.8 12637.2 12660.0 12749.2 12869.7 12887.0 9261.5 9358.8 9417.1 9462.0 9475.0 8930.7 9157.7 9858.7 10184.9 10234.5 8473.3 8508.4 8619.7 8641.7 8697.4 8345.4 8400.0 8433.5 8463.8 8501.4 7918.2 7963.9 8028.4 8092.3 8096.1 5835.4 5875.9 5908.2 6065.2 6088.5 5973.5 6051.2 6055.4 6151.0 6161.1 10:01:46 INFO - PROCESS | 1632 | 10:01:46 INFO - PROCESS | 1632 | [#4] prototype.html Cycles:180 Average:4384.18 Median:4773.99 stddev:1230.47 (25.8%) stddev-sans-first:1196.79 10:01:46 INFO - PROCESS | 1632 | Values: 387.1 390.4 390.8 398.2 400.4 4087.7 4871.8 4874.9 4922.3 5001.3 4078.4 4312.8 4516.1 4883.9 4896.7 3323.8 3494.4 3611.9 3657.5 4031.7 3701.9 4144.6 4168.4 4172.5 4250.5 3671.9 3957.9 4168.4 4205.9 4250.6 3780.3 3913.6 4239.7 4243.1 4289.7 3256.0 3515.9 3693.4 3827.0 3833.6 3991.4 4228.0 4775.5 4835.5 4870.9 4307.4 4848.7 4850.1 4875.3 4943.0 4753.4 5261.6 5269.7 5270.4 5278.8 4295.0 4307.2 4323.5 4339.4 4351.2 4139.8 5124.0 5290.6 5413.4 5584.3 3551.3 3902.9 4166.1 4173.6 4249.0 4401.1 4416.0 4427.0 4456.0 4511.6 3458.9 4103.5 4791.9 4804.0 4830.3 5233.7 5256.8 5264.9 5293.2 5308.3 1503.1 1518.8 1522.7 1527.6 1528.0 998.9 1049.5 1098.6 1113.8 1158.0 4397.0 4534.5 4605.8 4619.1 5011.3 4745.6 5138.8 5524.0 5531.6 5588.6 4183.0 4346.2 4428.5 4664.4 5061.5 2376.5 2760.7 2823.3 2841.4 2860.9 4741.6 4888.0 5283.8 5658.8 5670.8 4772.5 5119.7 5593.6 5624.8 5660.3 5047.6 5683.7 5694.0 5696.7 5722.7 4687.8 5482.4 5489.9 5498.3 5549.5 5093.8 5362.7 5382.1 5385.6 5404.3 4708.3 5126.1 5478.5 5533.5 5558.8 3680.4 3968.5 4199.4 4299.7 4389.8 4817.8 5052.0 5463.6 5472.7 5530.7 4262.7 4886.9 5067.7 5216.8 5384.2 4845.4 5115.5 5248.8 5287.5 5305.7 4231.9 4865.5 4919.0 5173.6 5236.6 4430.4 5031.9 5256.0 5264.7 5400.1 5162.7 5197.7 5288.6 5290.7 5301.0 10:01:46 INFO - PROCESS | 1632 | 10:01:46 INFO - PROCESS | 1632 | [#5] yui.html Cycles:180 Average:21688.07 Median:17569.11 stddev:31598.46 (179.9%) stddev-sans-first:31647.97 10:01:46 INFO - PROCESS | 1632 | Values: 744.1 761.7 782.0 880.5 888.3 15769.8 17532.4 17605.8 17623.8 17651.4 16211.5 16299.6 16428.3 16447.9 16455.7 942.8 953.5 1007.8 1017.2 1041.1 1019.3 1021.4 1021.7 1021.9 1024.7 1070.2 1071.6 1072.5 1073.0 1074.2 1055.9 1066.2 1066.3 1067.8 1068.6 791.5 793.3 793.5 793.9 794.9 16610.6 17001.9 17505.3 17615.9 17703.8 14678.3 14730.6 14805.0 14813.1 14824.2 12056.1 12136.2 12146.7 12186.8 12423.0 3788.7 3912.6 3930.6 3985.3 4080.2 112973.9 122726.4 125790.0 127444.4 129873.0 10997.5 11262.7 11575.4 11646.4 11741.0 21970.0 22236.3 23227.0 23793.3 23864.9 8305.7 8331.3 8408.7 8510.1 8537.2 4532.6 4550.6 4639.4 4653.7 4670.8 3594.6 3693.7 3701.1 3703.0 3703.3 580.5 649.5 664.3 679.4 680.3 715.0 724.9 727.3 751.4 751.9 10737.8 10764.8 10785.2 10873.7 10890.8 702.6 735.0 739.5 746.3 751.3 4746.9 5016.2 5018.8 5020.5 5057.8 73554.6 109905.8 112369.9 114547.4 114870.4 95037.0 96185.0 98261.0 98561.5 98705.5 61706.0 79464.0 79838.0 79957.6 81016.6 9746.4 9768.2 9790.1 9793.8 9841.6 36760.8 48402.3 54123.5 54154.2 56573.0 55061.7 67878.0 68689.3 71966.3 72593.3 13559.4 13589.3 13799.2 13964.0 14004.0 15313.2 15403.0 15615.1 16089.2 16358.9 14016.7 14442.4 14825.9 14827.6 15466.4 13455.8 13933.9 14563.4 14624.6 15122.9 13567.7 13767.7 13800.4 14150.0 14541.7 9930.0 10086.1 10245.6 10637.5 11079.2 11348.6 11418.8 11672.7 11775.5 11821.0 10:01:46 INFO - PROCESS | 1632 | -------- Summary: end -------- 10:01:46 INFO - PROCESS | 1632 | 10:01:47 INFO - TEST-INFO | 1632: exit 0 10:01:47 INFO - TEST-OK | dromaeo_css | took 1118273ms 10:01:47 INFO - TEST-START | kraken 10:01:47 INFO - operating with platform_type : mac_ 10:01:47 INFO - Initialising browser for kraken test... 10:01:47 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpQ_RV4z/profile http://localhost:49235/getInfo.html) 10:01:49 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 10:01:49 INFO - PROCESS | 1642 | colorDepth:24 10:01:49 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 10:01:49 INFO - PROCESS | 1642 | __metrics 10:01:49 INFO - PROCESS | 1642 | 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" 10:01:49 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:01:50 INFO - TEST-INFO | 1642: exit 0 10:01:50 INFO - Browser initialized. 10:01:50 INFO - Running cycle 1/1 for kraken test... 10:01:50 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpQ_RV4z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:02 INFO - PROCESS | 1644 | RSS: Main: 169484288 10:02:02 INFO - PROCESS | 1644 | 10:02:05 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 10:02:06 INFO - PROCESS | 1644 | RSS: Main: 221470720 10:02:06 INFO - PROCESS | 1644 | 10:02:08 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 10:02:09 INFO - PROCESS | 1644 | RSS: Main: 231989248 10:02:09 INFO - PROCESS | 1644 | 10:02:12 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 10:02:12 INFO - PROCESS | 1644 | RSS: Main: 327811072 10:02:12 INFO - PROCESS | 1644 | 10:02:14 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 10:02:15 INFO - PROCESS | 1644 | RSS: Main: 228737024 10:02:15 INFO - PROCESS | 1644 | 10:02:17 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:02:18 INFO - PROCESS | 1644 | RSS: Main: 231591936 10:02:18 INFO - PROCESS | 1644 | 10:02:21 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 10:02:21 INFO - PROCESS | 1644 | RSS: Main: 270176256 10:02:21 INFO - PROCESS | 1644 | 10:02:24 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 10:02:25 INFO - PROCESS | 1644 | RSS: Main: 271724544 10:02:25 INFO - PROCESS | 1644 | 10:02:28 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 10:02:28 INFO - PROCESS | 1644 | RSS: Main: 270782464 10:02:28 INFO - PROCESS | 1644 | 10:02:30 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:02:31 INFO - PROCESS | 1644 | RSS: Main: 249298944 10:02:31 INFO - PROCESS | 1644 | 10:02:32 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:02:33 INFO - PROCESS | 1644 | RSS: Main: 251641856 10:02:33 INFO - PROCESS | 1644 | 10:02:35 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:02:36 INFO - PROCESS | 1644 | RSS: Main: 258027520 10:02:36 INFO - PROCESS | 1644 | 10:02:39 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:02:39 INFO - PROCESS | 1644 | RSS: Main: 272441344 10:02:39 INFO - PROCESS | 1644 | 10:02:42 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:02:43 INFO - PROCESS | 1644 | RSS: Main: 266031104 10:02:43 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 10:02:45 INFO - PROCESS | 1644 | RSS: Main: 310816768 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | __start_tp_report 10:02:45 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 10:02:45 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 10:02:45 INFO - PROCESS | 1644 | |i|pagename|runs| 10:02:45 INFO - PROCESS | 1644 | |0;ai-astar;116;115;115;114;114;114;114;114;113;114 10:02:45 INFO - PROCESS | 1644 | |1;audio-beat-detection;134;105;99;139;95;131;133;106;126;109 10:02:45 INFO - PROCESS | 1644 | |2;audio-dft;185;184;185;185;186;182;184;184;184;184 10:02:45 INFO - PROCESS | 1644 | |3;audio-fft;80;59;59;91;62;60;59;59;75;59 10:02:45 INFO - PROCESS | 1644 | |4;audio-oscillator;86;70;87;68;69;68;85;98;86;81 10:02:45 INFO - PROCESS | 1644 | |5;imaging-gaussian-blur;89;91;135;88;89;89;88;89;87;89 10:02:45 INFO - PROCESS | 1644 | |6;imaging-darkroom;94;95;95;95;95;94;96;94;95;95 10:02:45 INFO - PROCESS | 1644 | |7;imaging-desaturate;82;83;83;84;84;101;130;137;86;81 10:02:45 INFO - PROCESS | 1644 | |8;json-parse-financial;59;59;63;63;64;64;64;63;63;62 10:02:45 INFO - PROCESS | 1644 | |9;json-stringify-tinderbox;54;61;62;64;58;58;57;57;58;58 10:02:45 INFO - PROCESS | 1644 | |10;stanford-crypto-aes;83;81;81;84;79;81;76;82;82;90 10:02:45 INFO - PROCESS | 1644 | |11;stanford-crypto-ccm;137;135;138;131;136;127;137;138;174;141 10:02:45 INFO - PROCESS | 1644 | |12;stanford-crypto-pbkdf2;161;163;165;163;162;162;207;160;160;211 10:02:45 INFO - PROCESS | 1644 | |13;stanford-crypto-sha256-iterative;65;64;65;63;64;62;63;63;63;63 10:02:45 INFO - PROCESS | 1644 | __end_tp_report 10:02:45 INFO - PROCESS | 1644 | __start_cc_report 10:02:45 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,2054 10:02:45 INFO - PROCESS | 1644 | __end_cc_report 10:02:45 INFO - PROCESS | 1644 | __startTimestamp1493744565369__endTimestamp 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | ------- Summary: start ------- 10:02:45 INFO - PROCESS | 1644 | Number of tests: 14 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.60 10:02:45 INFO - PROCESS | 1644 | Values: 116.0 115.0 115.0 114.0 114.0 114.0 114.0 114.0 113.0 114.0 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:133.50 stddev:16.46 (12.3%) stddev-sans-first:16.37 10:02:45 INFO - PROCESS | 1644 | Values: 134.0 105.0 99.0 139.0 95.0 131.0 133.0 106.0 126.0 109.0 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.50 stddev:1.06 (0.6%) stddev-sans-first:1.09 10:02:45 INFO - PROCESS | 1644 | Values: 185.0 184.0 185.0 185.0 186.0 182.0 184.0 184.0 184.0 184.0 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | [#3] audio-fft Cycles:10 Average:66.30 Median:61.00 stddev:11.54 (18.9%) stddev-sans-first:11.12 10:02:45 INFO - PROCESS | 1644 | Values: 80.0 59.0 59.0 91.0 62.0 60.0 59.0 59.0 75.0 59.0 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:85.50 stddev:10.43 (12.2%) stddev-sans-first:10.82 10:02:45 INFO - PROCESS | 1644 | Values: 86.0 70.0 87.0 68.0 69.0 68.0 85.0 98.0 86.0 81.0 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | [#5] imaging-gaussian-blur Cycles:10 Average:93.40 Median:89.00 stddev:14.65 (16.5%) stddev-sans-first:15.46 10:02:45 INFO - PROCESS | 1644 | Values: 89.0 91.0 135.0 88.0 89.0 89.0 88.0 89.0 87.0 89.0 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 10:02:45 INFO - PROCESS | 1644 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 96.0 94.0 95.0 95.0 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:83.00 stddev:21.08 (25.4%) stddev-sans-first:21.82 10:02:45 INFO - PROCESS | 1644 | Values: 82.0 83.0 83.0 84.0 84.0 101.0 130.0 137.0 86.0 81.0 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:63.00 stddev:1.90 (3.0%) stddev-sans-first:1.56 10:02:45 INFO - PROCESS | 1644 | Values: 59.0 59.0 63.0 63.0 64.0 64.0 64.0 63.0 63.0 62.0 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:58.00 stddev:2.87 (4.9%) stddev-sans-first:2.49 10:02:45 INFO - PROCESS | 1644 | Values: 54.0 61.0 62.0 64.0 58.0 58.0 57.0 57.0 58.0 58.0 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:3.60 (4.4%) stddev-sans-first:3.80 10:02:45 INFO - PROCESS | 1644 | Values: 83.0 81.0 81.0 84.0 79.0 81.0 76.0 82.0 82.0 90.0 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:137.50 stddev:12.78 (9.3%) stddev-sans-first:13.53 10:02:45 INFO - PROCESS | 1644 | Values: 137.0 135.0 138.0 131.0 136.0 127.0 137.0 138.0 174.0 141.0 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:163.00 stddev:19.90 (12.2%) stddev-sans-first:20.74 10:02:45 INFO - PROCESS | 1644 | Values: 161.0 163.0 165.0 163.0 162.0 162.0 207.0 160.0 160.0 211.0 10:02:45 INFO - PROCESS | 1644 | 10:02:45 INFO - PROCESS | 1644 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:0.97 (1.5%) stddev-sans-first:0.87 10:02:45 INFO - PROCESS | 1644 | Values: 65.0 64.0 65.0 63.0 64.0 62.0 63.0 63.0 63.0 63.0 10:02:45 INFO - PROCESS | 1644 | -------- Summary: end -------- 10:02:45 INFO - PROCESS | 1644 | 10:02:46 INFO - TEST-INFO | 1644: exit 0 10:02:46 INFO - TEST-OK | kraken | took 58725ms 10:02:46 INFO - SUITE-END | took 1177s 10:02:46 INFO - Completed test suite (00:19:37) 10:02:46 INFO - javascript benchmark 10:02:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7872.852221482972, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2913.970860291397, 3532.43481043033, 3541.185527328715, 3547.1841476460413, 3578.338007468617, 6070.635761854292, 6108.450239478446, 6110.755569777203, 6134.938650613503, 6173.259208894928, 6080.361562035978, 6128.417800308964, 6139.478144357735, 6141.60079594826, 6148.692565371724, 5391.56867450603, 5392.78428862845, 5427.158790387476, 5454.972725136368, 5538.0, 5323.8136665216725, 5359.410464848864, 5390.6226564140525, 5419.3225846769155, 5540.3983221191875, 5391.676499410029, 5401.000814849246, 5411.080116380225, 5422.593305502083, 5432.103702889019, 5442.346918369782, 5480.890382192354, 5487.039768040577, 5490.066688662937, 5496.422875598085, 5300.628955973083, 5416.83749487516, 5421.2952316199035, 5461.617686761889, 5473.534749546293, 5859.384764599741, 5863.413658634103, 5905.173275741399, 6098.237720284965, 6111.327753947062, 6335.11308416822, 6373.5857169283845, 6422.4862011039, 6446.161998940154, 6454.257760357572, 6439.581427207217, 6440.581362211441, 6489.675516224217, 6497.967510162419, 6513.804585862432, 5958.582899197101, 6203.8138855834395, 6217.129601855744, 6221.9377806222265, 6224.315325314212, 5455.672659640434, 6475.287718350977, 6509.479241660656, 6549.770758023446, 6639.269680335159, 6365.236171659338, 6372.840678983062, 6378.043293506012, 6378.298387177407, 6381.202349706286, 6421.422072013541, 6442.903356449657, 6465.579737317059, 6494.188226471691, 6501.317361676955, 5136.614753893473, 6310.5267104967315, 6352.36476352361, 6390.840228994312, 6398.2641996170105, 6115.088229002436, 6146.4775494082605, 6306.621602703853, 6377.8724425512155, 6416.743330266737, 5127.4872512748425, 5131.230315452712, 5134.0, 5140.331756871583, 5141.71720555373, 4588.449386073693, 4597.241455159861, 4648.651351148677, 4662.0209755950955, 4671.182543054952, 6227.314995350508, 6255.562110652301, 6257.124002639634, 6258.593191442542, 6265.749370025148, 6272.8118156455375, 6454.903176452357, 6490.675466226764, 6490.740370385226, 6505.186851643544, 6100.328963813977, 6136.3965394158, 6147.72335244915, 6233.0338797486465, 6259.2488901332135, 5729.398413166641, 5731.168980497804, 5735.254416925856, 5738.254026976467, 5745.0, 6642.6014439133805, 6699.933000670126, 6747.0, 6760.357766012221, 6768.830779230559, 6257.56197066201, 6278.0, 6417.294097649162, 6467.094606755152, 6537.607743535403, 5595.524380427709, 6733.663316834237, 6739.932600674127, 6747.190337159573, 6748.460123190232, 6394.968025159845, 6446.9032964506505, 6458.54790164684, 6458.741650333934, 6464.0627109069865, 6266.498680105672, 6273.592216505913, 6378.840528986812, 6440.098386225838, 6526.314736952551, 6351.68241587928, 6379.776707815204, 6405.583637063576, 6407.8398040047505, 6414.166158399378, 6187.443130118311, 6378.968105159444, 6379.330170332234, 6384.808455746335, 6407.103005579316, 5584.832455026356, 6136.365905528278, 6161.599496032743, 6303.36966303366, 6346.3019067903415, 6049.758009679564, 6311.084892690443, 6373.3945275198785, 6378.2983871774995, 6384.138141351044, 6308.463780578519, 6325.746970121144, 6329.90505142414, 6353.4599559038, 6358.682065896594], "value": 5947.607902669956, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.88561158632, 812.7033632724056, 831.6798032757387, 882.2765332427408, 894.061235702513, 28570.57144142837, 28849.13452596423, 40813.7959310203, 41182.58817411825, 41191.38212926809, 40734.38898416518, 42756.0, 42764.78617606908, 42889.14221715564, 42934.57065429352, 9657.95171024144, 9831.803363932717, 9832.90167098327, 9846.753831154207, 9848.753781155458, 7745.0, 7907.090684571262, 11872.168948173632, 12128.151029427943, 12140.210886292363, 11936.343501107436, 11955.701107472296, 11979.161458697894, 11988.100892433058, 11991.22057066288, 11900.880991190108, 11956.043516518745, 11957.760844783055, 11961.700957476045, 11974.9821265193, 11573.42132893352, 11622.94188529052, 11640.18518703691, 11641.88358116425, 11644.301341919512, 39848.0, 40101.799491002355, 40129.39805902914, 40145.59854401477, 40201.798991004856, 4026.134381108076, 4062.228176646457, 4088.325426304656, 4099.282625540519, 4099.754014759094, 24162.0, 28060.298492537644, 29969.70030299691, 30791.7683292668, 30831.383372332653, 3130.264387868849, 3248.642649308574, 3263.983680081584, 3314.93370132596, 3324.1523411529906, 303337.9999999978, 304739.0, 305339.0, 306018.0, 307272.0, 52779.0, 52859.0, 52999.47000530022, 52999.73500132475, 53002.469975300526, 55118.72440637851, 55156.0, 55168.724156378965, 55318.72340638271, 55330.17004744932, 14744.631384215267, 15044.623884402978, 15055.698886022219, 15072.095674259579, 15079.170645614377, 11241.494132764044, 12858.228506289652, 13041.673958151123, 13091.869081309065, 13100.737985240241, 10458.581656733646, 10496.107830834311, 10513.264071514921, 10514.26400151982, 10514.369137851754, 4841.276488818148, 5433.945660543344, 5446.319210098738, 5474.315710536183, 5493.148561972821, 1135.5230803062734, 1148.4487446025787, 1152.181950814914, 1162.773259214462, 1200.6818193178815, 27113.593296100575, 27497.725022749917, 27905.302367440978, 28048.579271310948, 28108.578371324445, 1248.2510493703705, 1259.5780413561376, 1270.8602053774077, 1302.8501722301867, 1319.399673148715, 14187.929060354632, 14258.786118208027, 14517.419303227964, 14560.927195363955, 14563.271836408137, 469486.0, 475705.0, 476084.0, 477233.0, 479113.2088679138, 45720.54279457163, 46023.76988115038, 55870.0, 56135.43864561302, 57958.7102064487, 1490.9552713418616, 1496.6632507685683, 1501.4894935721907, 1502.5867886331346, 1510.7280689476, 29353.853230734563, 30262.34228469733, 30438.74365880247, 30623.0, 30838.53742193824, 46117.76941115273, 46217.76891115523, 46295.53704463047, 46342.0, 46346.0, 468470.0, 480355.0, 484089.0, 495376.0, 505574.0, 35198.0, 35964.82017589895, 36018.09954751152, 36065.27869442544, 36216.09459763527, 43760.113520377425, 45570.772146139054, 45658.0, 45952.540474596164, 45960.54039459563, 29830.850845745634, 30745.53881691821, 30869.845650771604, 31570.526442102928, 32007.839960800047, 30585.54121688132, 31267.06198814039, 31559.0, 31732.682673172974, 32001.199970000936, 36802.8159859199, 37680.43479347867, 38033.23933521259, 38038.0, 38106.428403573416, 30056.849715751283, 30754.077377678706, 31233.538191395743, 31407.685923140478, 31702.207444814063, 22131.114755409602, 23536.0, 24561.0, 24961.87566748599, 25251.62122568126], "value": 19365.538868542397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.40312964978705, 439.6988063176722, 444.1383715591751, 448.3498926556494, 452.3712040264033, 20629.0, 21509.892450537744, 22531.54936901261, 22761.658575121386, 22881.855907204637, 21178.152873885065, 23494.765052349514, 23574.0, 23696.763032369672, 24202.75797242027, 6842.281560436158, 6873.553219040771, 7090.468214883878, 7239.71041158353, 7240.348368646821, 7064.364207221349, 7172.067631207936, 7185.173705023937, 7190.101237345332, 7199.280071992785, 6829.726810927557, 7110.751123710671, 7187.460940429462, 7196.064511613509, 7206.603636799974, 6832.487563432713, 7044.36600705939, 7084.539504932189, 7125.572465652026, 7160.248173941739, 6923.58458492487, 6955.374016338554, 6957.65211739411, 6965.129358830146, 6978.197507286676, 28599.9990000349, 28853.711462885312, 28873.855630721922, 28920.566191507143, 29549.0, 2632.5129850977632, 2644.2331723800266, 2666.1868130220273, 2670.8664566771586, 2725.5639097744265, 17009.574760631083, 17015.893966892112, 17052.744208836877, 17563.94616323025, 17629.0, 1883.896385698786, 1974.7926467720827, 2108.2831837175436, 2126.670366093258, 2134.1036764558767, 134159.65840341666, 136588.0, 141615.2919235397, 142302.28848855794, 144975.0, 22847.885760571422, 22953.540929181658, 23000.769992300196, 23183.420414489436, 23216.53566928652, 37992.810035949646, 38028.61971380306, 38821.80589097036, 38848.611513885066, 38935.610643893764, 8208.58957052145, 10694.304870183412, 10860.782784344268, 10947.945260273647, 11077.335359878432, 8992.965808931925, 9026.684066057656, 9027.322950778718, 9037.819243615091, 9214.35499515041, 8847.955760221157, 8958.10418958099, 9730.464824434583, 9898.851517227247, 9905.108540231413, 3494.668006539375, 3704.4626480011034, 3933.8229779659982, 3953.5058117735284, 3954.2289253595272, 1045.7856139491387, 1064.4305296666246, 1064.7072055184885, 1076.8923107689168, 1144.5993902134187, 22822.42943926415, 22888.542229155322, 22895.198668046538, 23218.3034508965, 23302.3009309721, 1086.4296244471716, 1094.261373572835, 1100.2628239079836, 1103.9944800276107, 1113.9275947063577, 10959.726006849893, 11826.940865295619, 11981.580644677395, 11988.820167697491, 11999.520019199308, 668287.0, 760470.0, 773057.0, 785890.0, 789651.0, 156193.0, 159031.0, 161168.0, 162745.18627407023, 166084.0, 1239.3617287097152, 1258.4211262819022, 1291.754566632337, 1296.2999980010877, 1299.1166007115064, 19232.59592550931, 20216.898915505328, 20271.391858244275, 20328.89835550813, 20337.186512539334, 63134.73730525456, 63470.730585388956, 63511.682441587494, 64380.0, 65532.0, 72998.63500682462, 90006.0, 90201.0, 90465.0, 91748.0, 11275.210735248455, 11664.329704849275, 11849.111316651113, 11890.643280701594, 11985.520579177084, 10596.841047384141, 10647.627333043307, 12856.292903890377, 12900.225986440844, 13087.083904127001, 10969.396683182502, 11134.777304453704, 11271.436428178722, 11433.542658293907, 11510.30938143714, 10209.38743675352, 10280.742981425225, 10314.484275786332, 10412.895871041193, 10490.685279441628, 11424.48589813477, 11466.885331146581, 11594.594189203337, 11711.599122180103, 11721.296722196696, 11688.70778230551, 11787.292762433939, 11849.763004739685, 11874.52501899949, 12039.578614748441, 10680.786384272427, 10987.61543345979, 11098.889011109786, 11210.775784484102, 11254.549818007188], "value": 11966.086033766103, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.9923415260032, 1628.9511314660565, 1658.046623191665, 1659.925303361349, 1672.4982505248422, 9412.717618471448, 9853.408795472276, 11192.552297908083, 11345.546178152865, 11355.375454350007, 11037.944810275958, 11252.831207531874, 11359.318440893532, 11368.09055275578, 11396.14528910333, 2113.8097571218586, 2160.8919554022277, 2491.813114016447, 2492.5513407586627, 2498.9750102498924, 2160.12514931453, 2430.149447693302, 2534.0750626021554, 2545.1346542175656, 2549.783268422177, 2469.2098528470897, 2497.725250222474, 2524.4951009798024, 2527.19129878439, 2527.317624241454, 2488.6515887775727, 2506.862122583257, 2512.7612876776675, 2515.7987361011164, 2524.066095544642, 2466.2971053249917, 2483.565376059182, 2505.523950449427, 2520.6345079963303, 2527.936801579957, 11472.369019703912, 11566.710832229177, 11571.594994175164, 11572.363520006396, 11587.884121158764, 6022.909656355158, 6195.535334849904, 6205.472534834545, 6206.751729930843, 6212.844678883064, 3452.2577645806273, 3625.800580968072, 3836.8081595920094, 3847.769133851978, 3848.615138486157, 1238.6098379010582, 1250.6498180509473, 1271.45327509171, 1281.884760258581, 1284.800855867342, 15551.922240388725, 15760.68478630421, 15860.841391586051, 15862.127582982932, 15869.444569440015, 4864.975675121602, 5134.358205224347, 5184.326037615086, 5193.68837869729, 5215.973920130375, 13115.672108197181, 13130.540431084866, 13133.540326088541, 13139.277339746215, 13145.868541314465, 6225.097360882647, 6232.065190221503, 6245.125682404467, 6246.718897649616, 6246.843828904223, 4746.121967436035, 5420.7560659769615, 5422.186671999153, 5443.319585051869, 5517.089680202802, 3726.459663348799, 3817.7900215487857, 3920.627540383659, 4220.78896055196, 4324.437823082979, 1176.5529098942347, 1183.4319526627096, 1186.430513353578, 1204.879512048788, 1212.5089338817793, 964.286428043243, 991.5686676295834, 998.1964518562627, 1002.2783595811004, 1008.6016023670609, 6499.6675681485185, 6639.0, 6710.530262881552, 6849.520533562602, 6874.793756187322, 1021.2442792333619, 1042.5725452564564, 1085.3976043295888, 1092.4373947417087, 1113.5156207049959, 4288.442502474658, 4412.0, 4414.690971632019, 4431.135928493913, 4535.9773201133785, 13301.06892517534, 13807.240601767, 14040.789388159186, 14057.43770249199, 14067.226302553254, 13430.664233394047, 13848.723025539633, 13872.306384680725, 13886.09740366873, 13893.305334733222, 10102.949485252673, 10360.0, 10453.163746900229, 10485.790284194274, 10503.159747220358, 5657.0, 6591.670416479253, 6638.601683898982, 6762.729490820312, 6783.4573234142135, 11043.337399756041, 12246.326452045223, 12573.1198816082, 12707.237565746085, 12762.808557871454, 12637.17858339205, 12660.0, 12749.235045896905, 12869.742605147658, 12887.033472489788, 9261.490618015805, 9358.766030849283, 9417.058294170529, 9461.95269023678, 9475.005124461832, 8930.732078037669, 9157.725268241964, 9858.704238872846, 10184.949075254577, 10234.53944572511, 8473.279771219515, 8508.404411691123, 8619.741407757778, 8641.654333826827, 8697.391182617155, 8345.41582089248, 8399.95800020996, 8433.53615551126, 8463.788405289917, 8501.362397820065, 7918.168592297726, 7963.92036079655, 8028.357731381592, 8092.271695547429, 8096.068952070587, 5835.387284335084, 5875.911861321998, 5908.202392677105, 6065.2418447694035, 6088.543359247986, 5973.522118230618, 6051.213342265477, 6055.394460553909, 6150.985087460519, 6161.075838624242], "value": 5299.6559294691615, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.0922686300624, 390.40073487197157, 390.79678567145083, 398.1539229138082, 400.403398935586, 4087.713860029799, 4871.75641217939, 4874.9275159464905, 4922.261660750889, 5001.324821149153, 4078.4494093297394, 4312.762798046107, 4516.0967806438675, 4883.853484395474, 4896.657233993622, 3323.767336286455, 3494.4408894576873, 3611.8735844245457, 3657.4513822926506, 4031.717779755418, 3701.8889433317045, 4144.626983571478, 4168.416421700964, 4172.4784401949755, 4250.511191213003, 3671.889843304705, 3957.940630890539, 4168.395582640515, 4205.873823785291, 4250.638695710868, 3780.3006443807985, 3913.610668212772, 4239.724417912826, 4243.130158317537, 4289.742615443083, 3255.951160732591, 3515.8945231643092, 3693.353663108945, 3826.9808650956566, 3833.5783063862955, 3991.381335892941, 4228.0, 4775.474697783241, 4835.540623640783, 4870.902581948377, 4307.353896915456, 4848.733319667417, 4850.126977144113, 4875.318015284756, 4942.975285123552, 4753.429588449409, 5261.552768014723, 5269.682579355162, 5270.367555893279, 5278.81524146653, 4295.012147206129, 4307.224699554079, 4323.481182258118, 4339.437802391137, 4351.216780979423, 4139.834406623761, 5124.0, 5290.550303224192, 5413.350397952271, 5584.301962254718, 3551.3074950384944, 3902.8829135125993, 4166.1461898599555, 4173.582641735863, 4249.022724773319, 4401.119776044804, 4416.0, 4427.0, 4456.041950980555, 4511.62395469385, 3458.8962331130106, 4103.4870641169855, 4791.904161916742, 4803.95196048042, 4830.275458681155, 5233.738313084406, 5256.789728410898, 5264.894702106013, 5293.232481290192, 5308.327876718821, 1503.1356969742442, 1518.764591488299, 1522.6802371501888, 1527.6410043639735, 1527.9923600381926, 998.9200863930868, 1049.5044561499833, 1098.5770478365887, 1113.7828123515837, 1157.9652610421701, 4396.956030439718, 4534.463118767367, 4605.848537865533, 4619.076184762994, 5011.298418221452, 4745.572898439157, 5138.76463738275, 5523.9894257629685, 5531.621402796836, 5588.636738611977, 4182.9581704182565, 4346.217680817484, 4428.482947393641, 4664.416947881515, 5061.544460998528, 2376.4771750214927, 2760.6963234044238, 2823.277800541668, 2841.403305305909, 2860.885564577394, 4741.644376671763, 4887.975560122177, 5283.762230699628, 5658.830235092953, 5670.7731690732735, 4772.49888761682, 5119.69447790811, 5593.615862403188, 5624.806325533045, 5660.349059858087, 5047.551937310402, 5683.744231509592, 5694.010644411717, 5696.715164241771, 5722.656640601577, 4687.789049492849, 5482.424345443671, 5489.862753431196, 5498.340199176125, 5549.500544950974, 5093.7707803148205, 5362.731863406892, 5382.085045542189, 5385.649932754359, 5404.270423492778, 4708.317293992421, 5126.103341763572, 5478.45215478449, 5533.474319939599, 5558.777648893999, 3680.429533422324, 3968.5275384038964, 4199.391088292242, 4299.678173786246, 4389.780510974502, 4817.79616555001, 5051.974740126276, 5463.644863083887, 5472.6990015547935, 5530.668159910419, 4262.744235345889, 4886.877828054327, 5067.733066733316, 5216.843494695166, 5384.227123031564, 4845.44945617399, 5115.521445417152, 5248.8425347239645, 5287.4976877196605, 5305.734713264244, 4231.87304380869, 4865.513448655106, 4918.95081049185, 5173.560247379015, 5236.581073514186, 4430.357598148186, 5031.899362012666, 5256.0, 5264.73676316175, 5400.054990376747, 5162.716050617102, 5197.688138711689, 5288.550473209821, 5290.65610735301, 5301.019311427398], "value": 4036.8803235954097, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.118219909407, 761.6953218712514, 781.9882701759475, 880.4673172730498, 888.2938064238928, 15769.84230157698, 17532.386366477174, 17605.82394176058, 17623.823761762378, 17651.382201622946, 16211.513654590352, 16299.592510187222, 16428.260728267225, 16447.917760411183, 16455.670886582262, 942.8255772682076, 953.504177827531, 1007.8135544924176, 1017.1811691588268, 1041.1046500010023, 1019.2508506247939, 1021.3922715983978, 1021.7343490692399, 1021.9284650074497, 1024.7182024943163, 1070.2454769387602, 1071.5767271927584, 1072.5441687282912, 1073.002108039523, 1074.1943542343242, 1055.883852776194, 1066.1524088349781, 1066.3495267886544, 1067.754416484213, 1068.6046162919731, 791.4657606115907, 793.309820456201, 793.4683761879554, 793.9126696063429, 794.916533763958, 16610.58473538159, 17001.91499042509, 17505.336992985645, 17615.943043417436, 17703.84924979872, 14678.339474723663, 14730.55808325752, 14805.03767255125, 14813.111213327235, 14824.184669843155, 12056.095792815573, 12136.171144496482, 12146.696332591668, 12186.75626487474, 12423.006159507218, 3788.7103583579496, 3912.5500567434824, 3930.6265904739003, 3985.2826491231567, 4080.204360149772, 112973.87026129715, 122726.38636806849, 125790.0, 127444.36277818552, 129873.0, 10997.450127493594, 11262.682029520864, 11575.363355015386, 11646.359450230319, 11741.0, 21970.0, 22236.332910012727, 23227.0, 23793.286201413986, 23864.880675596512, 8305.709300174585, 8331.29184019353, 8408.705695300636, 8510.063892971768, 8537.231649151607, 4532.5694059064335, 4550.590446859732, 4639.443266808004, 4653.744044077608, 4670.832291927019, 3594.6405359463843, 3693.7414380993073, 3701.1117331840164, 3703.0, 3703.333399988028, 580.4833698008775, 649.5031301054697, 664.2958464028146, 679.4428568573821, 680.2551206428952, 714.953528020677, 724.9093863267092, 727.3053784681679, 751.3876190904396, 751.8759404698163, 10737.83893241602, 10764.782606539491, 10785.227108544768, 10873.728156796144, 10890.782184356269, 702.6276073680957, 734.9706011759577, 739.4712780362067, 746.2761121711931, 751.3275618321571, 4746.881327966828, 5016.2224855147515, 5018.774155163026, 5020.523050310215, 5057.772400241998, 73554.63222683853, 109905.80188396187, 112369.87630123757, 114547.42726286316, 114870.4256478729, 95037.0, 96185.0, 98261.03477930401, 98561.50719246358, 98705.50647246718, 61706.0, 79464.0, 79838.0, 79957.60021199856, 81016.59491702622, 9746.415215087118, 9768.169705574821, 9790.118889299998, 9793.755156121155, 9841.557129929028, 36760.81619591885, 48402.273965889835, 54123.458765411844, 54154.187687183934, 56573.0, 55061.72469137629, 67878.0, 68689.31310686829, 71966.28033719806, 72593.27406725865, 13559.389827457591, 13589.320533973065, 13799.172049677052, 13963.952703547071, 14004.0, 15313.234338283264, 15403.0, 15615.141167235912, 16089.195540222709, 16358.933367755753, 14016.719665606426, 14442.350094245994, 14825.851741482447, 14827.555173344817, 15466.381344746535, 13455.798163027366, 13933.930330348283, 14563.41746330135, 14624.634384140481, 15122.924385378003, 13567.728645427234, 13767.724645506833, 13800.37898294559, 14150.00949933536, 14541.709165816414, 9929.950350248202, 10086.142677872464, 10245.590176392861, 10637.468126593794, 11079.224454288122, 11348.602798901999, 11418.828717569077, 11672.70818229551, 11775.470103845177, 11821.0], "value": 8074.78467831953, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1423.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 105.0, 99.0, 139.0, 95.0, 131.0, 133.0, 106.0, 126.0, 109.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 185.0, 186.0, 182.0, 184.0, 184.0, 184.0, 184.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 91.0, 62.0, 60.0, 59.0, 59.0, 75.0, 59.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 87.0, 68.0, 69.0, 68.0, 85.0, 98.0, 86.0, 81.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 135.0, 88.0, 89.0, 89.0, 88.0, 89.0, 87.0, 89.0], "value": 93.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 84.0, 84.0, 101.0, 130.0, 137.0, 86.0, 81.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 63.0, 63.0, 64.0, 64.0, 64.0, 63.0, 63.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 61.0, 62.0, 64.0, 58.0, 58.0, 57.0, 57.0, 58.0, 58.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 81.0, 84.0, 79.0, 81.0, 76.0, 82.0, 82.0, 90.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 138.0, 131.0, 136.0, 127.0, 137.0, 138.0, 174.0, 141.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 165.0, 163.0, 162.0, 162.0, 207.0, 160.0, 160.0, 211.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 63.0, 64.0, 62.0, 63.0, 63.0, 63.0, 63.0], "value": 63.5, "unit": "score"}]}]} 10:02:46 INFO - Return code: 0 10:02:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:02:46 INFO - # TBPL SUCCESS # 10:02:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:02:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:02:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:02:46 INFO - 2017-05-02 10:02:46.712 screenresolution[1648:9768] starting screenresolution argv=screenresolution get 10:02:46 INFO - 2017-05-02 10:02:46.715 screenresolution[1648:9768] Display 0: 1600x1200x32@60 10:02:46 INFO - 2017-05-02 10:02:46.721 screenresolution[1649:9772] starting screenresolution argv=screenresolution list 10:02:46 INFO - Available Modes on Display 0 10:02:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:02:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:02:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:02:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:02:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:02:46 INFO - Intel Iris: 10:02:46 INFO - Chipset Model: Intel Iris 10:02:46 INFO - Type: GPU 10:02:46 INFO - Bus: Built-In 10:02:46 INFO - VRAM (Dynamic, Max): 1536 MB 10:02:46 INFO - Vendor: Intel (0x8086) 10:02:46 INFO - Device ID: 0x0a2e 10:02:46 INFO - Revision ID: 0x0009 10:02:46 INFO - Displays: 10:02:46 INFO - Display: 10:02:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:02:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:02:46 INFO - Display Serial Number: 1600x1200 60 10:02:46 INFO - Main Display: Yes 10:02:46 INFO - Mirror: Off 10:02:46 INFO - Online: Yes 10:02:46 INFO - Rotation: Supported 10:02:46 INFO - Return code: 0 10:02:46 INFO - Running post-action listener: _resource_record_post_action 10:02:46 INFO - [mozharness: 2017-05-02 17:02:46.957394Z] Finished run-tests step (success) 10:02:46 INFO - Running post-run listener: _resource_record_post_run 10:02:47 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 40780800; Write bytes: 423348224; Read time: 402; Write time: 1649 10:02:47 INFO - TinderboxPrint: CPU usage
53.7% 10:02:47 INFO - TinderboxPrint: I/O read bytes / time
40,780,800 / 402 10:02:47 INFO - TinderboxPrint: I/O write bytes / time
423,348,224 / 1,649 10:02:47 INFO - TinderboxPrint: CPU idle
2,209.8 (46.3%) 10:02:47 INFO - TinderboxPrint: CPU system
948.8 (19.9%) 10:02:47 INFO - TinderboxPrint: CPU user
1,615.1 (33.8%) 10:02:47 INFO - TinderboxPrint: Swap in / out
161,411,072 / 0 10:02:47 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 117504512; Write bytes: 114612224; Read time: 11107; Write time: 297 10:02:47 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 38646784; Write bytes: 297848832; Read time: 378; Write time: 1314 10:02:47 INFO - Running post-run listener: _upload_blobber_files 10:02:47 INFO - Blob upload gear active. 10:02:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:02:47 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 10:02:47 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:02:47 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:02:47 INFO - (blobuploader) - INFO - Open directory for files ... 10:02:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:02:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:02:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:49 INFO - (blobuploader) - INFO - Done attempting. 10:02:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:02:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:02:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:50 INFO - (blobuploader) - INFO - Done attempting. 10:02:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:02:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:02:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:51 INFO - (blobuploader) - INFO - Done attempting. 10:02:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:02:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:02:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:53 INFO - (blobuploader) - INFO - Done attempting. 10:02:53 INFO - (blobuploader) - INFO - Iteration through files over. 10:02:53 INFO - Return code: 0 10:02:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:02:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:02:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6c1e489781f345da58c2f21b7a01fcda0d057dab9e2ce9338034c22620c18a61d96c101c22fc99ad48156b2f75b53a4c667285d10a5d1ff27300f2f1894839b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4384eb7e0376a0a2c5c39abb03b2091b062c95eec7623b3da33c3d8709f5fe73dc0bde5f24078d6cc5268ac6e9ed6a3a3730c83f8d2139d937ba82d47e3baea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5dc9f3d352e759e3f94bd54818c3b5baa32ef5485795d53aba23a56d9728cc9d0c8c3e24d8c482d8dc41d5382d4e3a6314f18bd98ee7fc7591bed3aa70794637", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d6f9d6fa51590af23b6e3048daaa2f8dfcdf1c0d967c06fc61fb8d52e4b08774b1d4d7ffcf9566757d5cc28b86b6bcd5016d387aaeef042e3b17356d50312ba"} 10:02:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:02:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:02:53 INFO - Contents: 10:02:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6c1e489781f345da58c2f21b7a01fcda0d057dab9e2ce9338034c22620c18a61d96c101c22fc99ad48156b2f75b53a4c667285d10a5d1ff27300f2f1894839b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4384eb7e0376a0a2c5c39abb03b2091b062c95eec7623b3da33c3d8709f5fe73dc0bde5f24078d6cc5268ac6e9ed6a3a3730c83f8d2139d937ba82d47e3baea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5dc9f3d352e759e3f94bd54818c3b5baa32ef5485795d53aba23a56d9728cc9d0c8c3e24d8c482d8dc41d5382d4e3a6314f18bd98ee7fc7591bed3aa70794637", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d6f9d6fa51590af23b6e3048daaa2f8dfcdf1c0d967c06fc61fb8d52e4b08774b1d4d7ffcf9566757d5cc28b86b6bcd5016d387aaeef042e3b17356d50312ba"} 10:02:53 INFO - Running post-run listener: copy_logs_to_upload_dir 10:02:53 INFO - Copying logs to upload dir... 10:02:53 INFO - mkdir: /builds/slave/test/build/upload/logs 10:02:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.754159 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-02 10:02:53.420032) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 10:02:53.423279) ========= 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.rV0P6hNVP0/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.f5YpxdoJXA/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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-Beta/sha512/d6c1e489781f345da58c2f21b7a01fcda0d057dab9e2ce9338034c22620c18a61d96c101c22fc99ad48156b2f75b53a4c667285d10a5d1ff27300f2f1894839b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4384eb7e0376a0a2c5c39abb03b2091b062c95eec7623b3da33c3d8709f5fe73dc0bde5f24078d6cc5268ac6e9ed6a3a3730c83f8d2139d937ba82d47e3baea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5dc9f3d352e759e3f94bd54818c3b5baa32ef5485795d53aba23a56d9728cc9d0c8c3e24d8c482d8dc41d5382d4e3a6314f18bd98ee7fc7591bed3aa70794637", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d6f9d6fa51590af23b6e3048daaa2f8dfcdf1c0d967c06fc61fb8d52e4b08774b1d4d7ffcf9566757d5cc28b86b6bcd5016d387aaeef042e3b17356d50312ba"} build_url:https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/Kshckk4qQyS1fS-5Xgldug/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6c1e489781f345da58c2f21b7a01fcda0d057dab9e2ce9338034c22620c18a61d96c101c22fc99ad48156b2f75b53a4c667285d10a5d1ff27300f2f1894839b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4384eb7e0376a0a2c5c39abb03b2091b062c95eec7623b3da33c3d8709f5fe73dc0bde5f24078d6cc5268ac6e9ed6a3a3730c83f8d2139d937ba82d47e3baea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5dc9f3d352e759e3f94bd54818c3b5baa32ef5485795d53aba23a56d9728cc9d0c8c3e24d8c482d8dc41d5382d4e3a6314f18bd98ee7fc7591bed3aa70794637", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d6f9d6fa51590af23b6e3048daaa2f8dfcdf1c0d967c06fc61fb8d52e4b08774b1d4d7ffcf9566757d5cc28b86b6bcd5016d387aaeef042e3b17356d50312ba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 10:02:53.458756) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 10:02:53.459117) ========= 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.rV0P6hNVP0/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.f5YpxdoJXA/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.005044 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 10:02:53.507659) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 10:02:53.507975) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 10:02:53.508298) ========= ========= Total master_lag: 0.18 =========