builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0377 starttime: 1483335639.4 results: success (0) buildid: 20170101194819 builduid: 88c2aa907f6f42e8b48e065479ab9bb3 revision: addb771c9a728f749feea0328c7ffd4a56888c26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-01 21:40:39.397772) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-01 21:40:39.398140) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-01 21:40:39.398411) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-01 21:40:39.425383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 21:40:39.425715) ========= 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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-01-01 21:40:39-- 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% 157M=0s 2017-01-01 21:40:39 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120515 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 21:40:39.587685) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 21:40:39.588000) ========= 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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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.025169 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 21:40:39.649715) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 21:40:39.650064) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev addb771c9a728f749feea0328c7ffd4a56888c26 --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 addb771c9a728f749feea0328c7ffd4a56888c26 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mQjhw8YGwL/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.6wQa4K9rQR/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-01-01 21:40:39,747 truncating revision to first 12 chars 2017-01-01 21:40:39,747 Setting DEBUG logging. 2017-01-01 21:40:39,747 attempt 1/10 2017-01-01 21:40:39,747 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/addb771c9a72?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-01 21:40:40,381 unpacking tar archive at: mozilla-beta-addb771c9a72/testing/mozharness/ program finished with exit code 0 elapsedTime=0.917558 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 21:40:40.594747) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-01 21:40:40.595089) ========= script_repo_revision: addb771c9a728f749feea0328c7ffd4a56888c26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-01 21:40:40.595501) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-01 21:40:40.595801) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-01 21:40:40.631153) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-01-01 21:40:40.631438) ========= /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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 21:40:40 INFO - MultiFileLogger online at 20170101 21:40:40 in /builds/slave/test 21:40:40 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 21:40:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:40:40 INFO - {'append_to_log': False, 21:40:40 INFO - 'base_work_dir': '/builds/slave/test', 21:40:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:40:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:40:40 INFO - 'branch': 'Mozilla-Beta', 21:40:40 INFO - 'buildbot_json_path': 'buildprops.json', 21:40:40 INFO - 'config_files': ('talos/mac_config.py',), 21:40:40 INFO - 'default_actions': ('clobber', 21:40:40 INFO - 'read-buildbot-config', 21:40:40 INFO - 'download-and-extract', 21:40:40 INFO - 'populate-webroot', 21:40:40 INFO - 'create-virtualenv', 21:40:40 INFO - 'install', 21:40:40 INFO - 'run-tests'), 21:40:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:40:40 INFO - 'download_minidump_stackwalk': True, 21:40:40 INFO - 'download_symbols': 'ondemand', 21:40:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:40:40 INFO - 'tooltool.py': '/tools/tooltool.py', 21:40:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:40:40 INFO - '/tools/misc-python/virtualenv.py')}, 21:40:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:40:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:40:40 INFO - 'installer_path': 'installer.exe', 21:40:40 INFO - 'log_level': 'info', 21:40:40 INFO - 'log_name': 'talos', 21:40:40 INFO - 'log_to_console': True, 21:40:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:40:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:40:40 INFO - 'opt_config_files': (), 21:40:40 INFO - 'pip_index': False, 21:40:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:40:40 INFO - 'cmd': ('bash', 21:40:40 INFO - '-c', 21:40:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:40:40 INFO - 'enabled': True, 21:40:40 INFO - 'halt_on_failure': False, 21:40:40 INFO - 'name': 'check_screen_resolution'},), 21:40:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:40:40 INFO - 'cmd': ('bash', 21:40:40 INFO - '-c', 21:40:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:40:40 INFO - 'enabled': True, 21:40:40 INFO - 'halt_on_failure': False, 21:40:40 INFO - 'name': 'check_screen_resolution'},), 21:40:40 INFO - 'run_cmd_checks_enabled': True, 21:40:40 INFO - 'sps_profile': False, 21:40:40 INFO - 'sps_profile_interval': 0, 21:40:40 INFO - 'suite': 'dromaeojs', 21:40:40 INFO - 'system_bits': '32', 21:40:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:40:40 INFO - 'title': 't-yosemite-r7-0377', 21:40:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:40:40 INFO - 'use_talos_json': True, 21:40:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:40:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:40:40 INFO - 'work_dir': 'build'} 21:40:40 INFO - [mozharness: 2017-01-02 05:40:40.831057Z] Running clobber step. 21:40:40 INFO - Running pre-action listener: _resource_record_pre_action 21:40:40 INFO - Running main action method: clobber 21:40:40 INFO - rmtree: /builds/slave/test/build 21:40:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:40:43 INFO - Running post-action listener: _resource_record_post_action 21:40:43 INFO - [mozharness: 2017-01-02 05:40:43.168276Z] Finished clobber step (success) 21:40:43 INFO - [mozharness: 2017-01-02 05:40:43.168533Z] Running read-buildbot-config step. 21:40:43 INFO - Running pre-action listener: _resource_record_pre_action 21:40:43 INFO - Running main action method: read_buildbot_config 21:40:43 INFO - Using buildbot properties: 21:40:43 INFO - { 21:40:43 INFO - "project": "", 21:40:43 INFO - "product": "firefox", 21:40:43 INFO - "script_repo_revision": "production", 21:40:43 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 21:40:43 INFO - "repository": "", 21:40:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 21:40:43 INFO - "buildid": "20170101194819", 21:40:43 INFO - "pgo_build": "False", 21:40:43 INFO - "basedir": "/builds/slave/test", 21:40:43 INFO - "buildnumber": 1, 21:40:43 INFO - "slavename": "t-yosemite-r7-0377", 21:40:43 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 21:40:43 INFO - "platform": "yosemite_r7", 21:40:43 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 21:40:43 INFO - "branch": "mozilla-beta", 21:40:43 INFO - "repo_path": "releases/mozilla-beta", 21:40:43 INFO - "revision": "addb771c9a728f749feea0328c7ffd4a56888c26", 21:40:43 INFO - "stage_platform": "macosx64", 21:40:43 INFO - "builduid": "88c2aa907f6f42e8b48e065479ab9bb3", 21:40:43 INFO - "slavebuilddir": "test" 21:40:43 INFO - } 21:40:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 21:40:43 INFO - Running post-action listener: _resource_record_post_action 21:40:43 INFO - [mozharness: 2017-01-02 05:40:43.174207Z] Finished read-buildbot-config step (success) 21:40:43 INFO - [mozharness: 2017-01-02 05:40:43.174416Z] Running download-and-extract step. 21:40:43 INFO - Running pre-action listener: _resource_record_pre_action 21:40:43 INFO - Running main action method: download_and_extract 21:40:43 INFO - mkdir: /builds/slave/test/build/tests 21:40:43 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')]} 21:40:43 INFO - trying https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 21:40:43 INFO - Downloading https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 21:40:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 21:40:44 INFO - Downloaded 1165 bytes. 21:40:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 21:40:44 INFO - Using the following test package requirements: 21:40:44 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 21:40:44 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:40:44 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 21:40:44 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:40:44 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 21:40:44 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 21:40:44 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:40:44 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 21:40:44 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 21:40:44 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:40:44 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 21:40:44 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:40:44 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 21:40:44 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:40:44 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 21:40:44 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:40:44 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 21:40:44 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 21:40:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 21:40:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 21:40:44 INFO - Fetch https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 21:40:45 INFO - Expected file size: 16232817 21:40:52 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 21:40:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 21:40:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 21:40:52 INFO - Fetch https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 21:40:52 INFO - Expected file size: 16232817 21:40:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 21:40:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 21:40:59 INFO - Fetch https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 21:41:00 INFO - Expected file size: 14414089 21:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:00 INFO - trying https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 21:41:00 INFO - Downloading https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 21:41:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 21:41:03 INFO - Downloaded 85938657 bytes. 21:41:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 21:41:03 INFO - mkdir: /builds/slave/test/properties 21:41:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:41:03 INFO - Writing to file /builds/slave/test/properties/build_url 21:41:03 INFO - Contents: 21:41:03 INFO - build_url:https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 21:41:03 INFO - Running post-action listener: _resource_record_post_action 21:41:03 INFO - Running post-action listener: set_extra_try_arguments 21:41:03 INFO - [mozharness: 2017-01-02 05:41:03.840713Z] Finished download-and-extract step (success) 21:41:03 INFO - [mozharness: 2017-01-02 05:41:03.840833Z] Running populate-webroot step. 21:41:03 INFO - Running pre-action listener: _resource_record_pre_action 21:41:03 INFO - Running main action method: populate_webroot 21:41:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:41:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:41:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:41:03 INFO - '--tppagecycles', 21:41:03 INFO - '7'], 21:41:03 INFO - 'tests': ['tsvgm']}}, 21:41:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:41:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:41:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:41:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:41:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:41:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:41:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:03 INFO - 'talos_options': ['--disable-e10s'], 21:41:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:41:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:41:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:03 INFO - 'talos_options': ['--disable-e10s'], 21:41:03 INFO - 'tests': ['damp', 'tps']}, 21:41:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:03 INFO - 'tests': ['damp', 'tps']}, 21:41:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:41:03 INFO - 'tests': ['dromaeo_dom']}, 21:41:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:41:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:41:03 INFO - 'tests': ['basic_compositor_video']}, 21:41:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:41:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:41:03 INFO - 'tests': ['a11yr', 21:41:03 INFO - 'ts_paint', 21:41:03 INFO - 'tpaint', 21:41:03 INFO - 'sessionrestore', 21:41:03 INFO - 'sessionrestore_no_auto_restore', 21:41:03 INFO - 'tabpaint']}, 21:41:03 INFO - 'other-e10s': {'tests': ['a11yr', 21:41:03 INFO - 'ts_paint', 21:41:03 INFO - 'tpaint', 21:41:03 INFO - 'sessionrestore', 21:41:03 INFO - 'sessionrestore_no_auto_restore', 21:41:03 INFO - 'tabpaint']}, 21:41:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:41:03 INFO - 'ts_paint', 21:41:03 INFO - 'tpaint', 21:41:03 INFO - 'sessionrestore', 21:41:03 INFO - 'sessionrestore_no_auto_restore', 21:41:03 INFO - 'tabpaint']}, 21:41:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:41:03 INFO - 'ts_paint', 21:41:03 INFO - 'tpaint', 21:41:03 INFO - 'sessionrestore', 21:41:03 INFO - 'sessionrestore_no_auto_restore', 21:41:03 INFO - 'tabpaint']}, 21:41:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:41:03 INFO - 'tests': ['a11yr', 21:41:03 INFO - 'ts_paint', 21:41:03 INFO - 'tpaint', 21:41:03 INFO - 'sessionrestore', 21:41:03 INFO - 'sessionrestore_no_auto_restore', 21:41:03 INFO - 'tabpaint']}, 21:41:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:41:03 INFO - 'tests': ['a11yr', 21:41:03 INFO - 'ts_paint', 21:41:03 INFO - 'tpaint', 21:41:03 INFO - 'sessionrestore', 21:41:03 INFO - 'sessionrestore_no_auto_restore', 21:41:03 INFO - 'tabpaint']}, 21:41:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:41:03 INFO - 'tests': ['tsvgx', 21:41:03 INFO - 'tsvgr_opacity', 21:41:03 INFO - 'tart', 21:41:03 INFO - 'tscrollx', 21:41:03 INFO - 'cart']}, 21:41:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:41:03 INFO - 'tsvgr_opacity', 21:41:03 INFO - 'tart', 21:41:03 INFO - 'tscrollx', 21:41:03 INFO - 'cart']}, 21:41:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:03 INFO - 'talos_options': ['--disable-e10s'], 21:41:03 INFO - 'tests': ['tp5o']}, 21:41:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:03 INFO - 'tests': ['tp5o']}, 21:41:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:03 INFO - 'talos_options': ['--disable-e10s', 21:41:03 INFO - '--xperf_path', 21:41:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:41:03 INFO - 'tests': ['tp5n']}, 21:41:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:03 INFO - 'talos_options': ['--xperf_path', 21:41:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:41:03 INFO - 'tests': ['tp5n']}}, 21:41:03 INFO - 'talos.zip': {'path': '', 21:41:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:41:03 INFO - Running post-action listener: _resource_record_post_action 21:41:03 INFO - [mozharness: 2017-01-02 05:41:03.859748Z] Finished populate-webroot step (success) 21:41:03 INFO - [mozharness: 2017-01-02 05:41:03.859864Z] Running create-virtualenv step. 21:41:03 INFO - Running pre-action listener: _resource_record_pre_action 21:41:03 INFO - Running main action method: create_virtualenv 21:41:03 INFO - Creating virtualenv /builds/slave/test/build/venv 21:41:03 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 21:41:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:41:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:41:03 INFO - Using real prefix '/tools/python27' 21:41:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:41:04 INFO - Installing distribute.............................................................................................................................................................................................done. 21:41:07 INFO - Installing pip.................done. 21:41:07 INFO - Return code: 0 21:41:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:41:07 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')]} 21:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:07 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')]} 21:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:07 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 0x10a08d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a003570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4aa55d5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea1d30>, '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 0x109d07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e99b20>, '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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 21:41:07 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 21:41:07 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 21:41:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQjhw8YGwL/Render', 21:41:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:07 INFO - 'HOME': '/Users/cltbld', 21:41:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:07 INFO - 'LOGNAME': 'cltbld', 21:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:07 INFO - 'MOZ_NO_REMOTE': '1', 21:41:07 INFO - 'NO_EM_RESTART': '1', 21:41:07 INFO - 'PAGER': '/bin/cat', 21:41:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:07 INFO - 'PWD': '/builds/slave/test', 21:41:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:07 INFO - 'SHELL': '/bin/bash', 21:41:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wQa4K9rQR/Listeners', 21:41:07 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 21:41:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:07 INFO - 'USER': 'cltbld', 21:41:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:07 INFO - 'XPC_FLAGS': '0x0', 21:41:07 INFO - 'XPC_SERVICE_NAME': '0', 21:41:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:07 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 21:41:07 INFO - Cleaning up... 21:41:07 INFO - Return code: 0 21:41:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:41:07 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')]} 21:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:07 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')]} 21:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:07 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 0x10a08d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a003570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4aa55d5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea1d30>, '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 0x109d07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e99b20>, '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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 21:41:07 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 21:41:07 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 21:41:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQjhw8YGwL/Render', 21:41:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:07 INFO - 'HOME': '/Users/cltbld', 21:41:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:07 INFO - 'LOGNAME': 'cltbld', 21:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:07 INFO - 'MOZ_NO_REMOTE': '1', 21:41:07 INFO - 'NO_EM_RESTART': '1', 21:41:07 INFO - 'PAGER': '/bin/cat', 21:41:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:07 INFO - 'PWD': '/builds/slave/test', 21:41:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:07 INFO - 'SHELL': '/bin/bash', 21:41:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wQa4K9rQR/Listeners', 21:41:07 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 21:41:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:07 INFO - 'USER': 'cltbld', 21:41:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:07 INFO - 'XPC_FLAGS': '0x0', 21:41:07 INFO - 'XPC_SERVICE_NAME': '0', 21:41:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:08 INFO - Downloading/unpacking psutil>=3.1.1 21:41:08 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 21:41:08 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 21:41:08 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 21:41:08 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 21:41:08 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 21:41:08 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 21:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:41:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:41:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:41:11 INFO - Installing collected packages: psutil 21:41:11 INFO - Running setup.py install for psutil 21:41:11 INFO - building 'psutil._psutil_osx' extension 21:41:11 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 21:41:12 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 21:41:12 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 21:41:12 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 21:41:12 INFO - building 'psutil._psutil_posix' extension 21:41:12 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 21:41:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:41:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:41:12 INFO - ^ 21:41:12 INFO - 1 warning generated. 21:41:12 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 21:41:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:41:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:41:12 INFO - Successfully installed psutil 21:41:12 INFO - Cleaning up... 21:41:12 INFO - Return code: 0 21:41:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a08d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a003570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4aa55d5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea1d30>, '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 0x109d07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e99b20>, '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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 21:41:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:41:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQjhw8YGwL/Render', 21:41:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:12 INFO - 'HOME': '/Users/cltbld', 21:41:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:12 INFO - 'LOGNAME': 'cltbld', 21:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:12 INFO - 'MOZ_NO_REMOTE': '1', 21:41:12 INFO - 'NO_EM_RESTART': '1', 21:41:12 INFO - 'PAGER': '/bin/cat', 21:41:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:12 INFO - 'PWD': '/builds/slave/test', 21:41:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:12 INFO - 'SHELL': '/bin/bash', 21:41:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wQa4K9rQR/Listeners', 21:41:12 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 21:41:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:12 INFO - 'USER': 'cltbld', 21:41:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:12 INFO - 'XPC_FLAGS': '0x0', 21:41:12 INFO - 'XPC_SERVICE_NAME': '0', 21:41:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:41:13 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 21:41:13 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 21:41:13 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 21:41:13 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 21:41:13 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 21:41:13 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 21:41:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:41:15 INFO - Installing collected packages: mozsystemmonitor 21:41:15 INFO - Running setup.py install for mozsystemmonitor 21:41:15 INFO - Successfully installed mozsystemmonitor 21:41:15 INFO - Cleaning up... 21:41:15 INFO - Return code: 0 21:41:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:41:15 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')]} 21:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:15 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')]} 21:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:15 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 0x10a08d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a003570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4aa55d5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea1d30>, '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 0x109d07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e99b20>, '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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 21:41:15 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 21:41:15 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 21:41:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQjhw8YGwL/Render', 21:41:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:15 INFO - 'HOME': '/Users/cltbld', 21:41:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:15 INFO - 'LOGNAME': 'cltbld', 21:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:15 INFO - 'MOZ_NO_REMOTE': '1', 21:41:15 INFO - 'NO_EM_RESTART': '1', 21:41:15 INFO - 'PAGER': '/bin/cat', 21:41:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:15 INFO - 'PWD': '/builds/slave/test', 21:41:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:15 INFO - 'SHELL': '/bin/bash', 21:41:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wQa4K9rQR/Listeners', 21:41:15 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 21:41:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:15 INFO - 'USER': 'cltbld', 21:41:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:15 INFO - 'XPC_FLAGS': '0x0', 21:41:15 INFO - 'XPC_SERVICE_NAME': '0', 21:41:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:16 INFO - Downloading/unpacking jsonschema==2.5.1 21:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:41:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:19 INFO - Downloading functools32-3.2.3-2.tar.gz 21:41:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:41:19 INFO - warning: no files found matching '*.txt' 21:41:19 INFO - no previously-included directories found matching 'build' 21:41:19 INFO - no previously-included directories found matching 'dist' 21:41:19 INFO - no previously-included directories found matching '.git*' 21:41:19 INFO - Installing collected packages: jsonschema, functools32 21:41:19 INFO - Running setup.py install for functools32 21:41:19 INFO - warning: no files found matching '*.txt' 21:41:19 INFO - no previously-included directories found matching 'build' 21:41:19 INFO - no previously-included directories found matching 'dist' 21:41:19 INFO - no previously-included directories found matching '.git*' 21:41:19 INFO - Successfully installed jsonschema functools32 21:41:19 INFO - Cleaning up... 21:41:19 INFO - Return code: 0 21:41:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a08d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a003570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4aa55d5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea1d30>, '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 0x109d07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e99b20>, '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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 21:41:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:41:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQjhw8YGwL/Render', 21:41:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:19 INFO - 'HOME': '/Users/cltbld', 21:41:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:19 INFO - 'LOGNAME': 'cltbld', 21:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:19 INFO - 'MOZ_NO_REMOTE': '1', 21:41:19 INFO - 'NO_EM_RESTART': '1', 21:41:19 INFO - 'PAGER': '/bin/cat', 21:41:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:19 INFO - 'PWD': '/builds/slave/test', 21:41:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:19 INFO - 'SHELL': '/bin/bash', 21:41:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wQa4K9rQR/Listeners', 21:41:19 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 21:41:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:19 INFO - 'USER': 'cltbld', 21:41:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:19 INFO - 'XPC_FLAGS': '0x0', 21:41:19 INFO - 'XPC_SERVICE_NAME': '0', 21:41:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:41:19 INFO - Cleaning up... 21:41:19 INFO - Return code: 0 21:41:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a08d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a003570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4aa55d5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea1d30>, '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 0x109d07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e99b20>, '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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 21:41:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:41:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQjhw8YGwL/Render', 21:41:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:19 INFO - 'HOME': '/Users/cltbld', 21:41:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:19 INFO - 'LOGNAME': 'cltbld', 21:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:19 INFO - 'MOZ_NO_REMOTE': '1', 21:41:19 INFO - 'NO_EM_RESTART': '1', 21:41:19 INFO - 'PAGER': '/bin/cat', 21:41:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:19 INFO - 'PWD': '/builds/slave/test', 21:41:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:19 INFO - 'SHELL': '/bin/bash', 21:41:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wQa4K9rQR/Listeners', 21:41:19 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 21:41:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:19 INFO - 'USER': 'cltbld', 21:41:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:19 INFO - 'XPC_FLAGS': '0x0', 21:41:19 INFO - 'XPC_SERVICE_NAME': '0', 21:41:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:20 INFO - Downloading/unpacking blobuploader==1.2.4 21:41:20 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 21:41:20 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 21:41:20 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 21:41:20 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 21:41:20 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 21:41:20 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 21:41:22 INFO - Downloading blobuploader-1.2.4.tar.gz 21:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:41:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:41:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:23 INFO - Downloading docopt-0.6.1.tar.gz 21:41:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:41:23 INFO - Installing collected packages: blobuploader, requests, docopt 21:41:23 INFO - Running setup.py install for blobuploader 21:41:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:41:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:41:24 INFO - Running setup.py install for requests 21:41:24 INFO - Running setup.py install for docopt 21:41:24 INFO - Successfully installed blobuploader requests docopt 21:41:24 INFO - Cleaning up... 21:41:24 INFO - Return code: 0 21:41:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41: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')]} 21:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41: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')]} 21:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:24 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 0x10a08d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a003570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4aa55d5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea1d30>, '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 0x109d07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e99b20>, '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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 21:41:24 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 21:41:24 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 21:41:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQjhw8YGwL/Render', 21:41:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:24 INFO - 'HOME': '/Users/cltbld', 21:41:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:24 INFO - 'LOGNAME': 'cltbld', 21:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:24 INFO - 'MOZ_NO_REMOTE': '1', 21:41:24 INFO - 'NO_EM_RESTART': '1', 21:41:24 INFO - 'PAGER': '/bin/cat', 21:41:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:24 INFO - 'PWD': '/builds/slave/test', 21:41:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:24 INFO - 'SHELL': '/bin/bash', 21:41:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wQa4K9rQR/Listeners', 21:41:24 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 21:41:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:24 INFO - 'USER': 'cltbld', 21:41:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:24 INFO - 'XPC_FLAGS': '0x0', 21:41:24 INFO - 'XPC_SERVICE_NAME': '0', 21:41:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:41:25 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-vwMx4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:41:25 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-v1KUeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:41:25 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-UG9jO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:41:25 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-32gATh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:41:25 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-ZWi_9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:41:25 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-ULUhX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:41:25 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-RWZTgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:41:25 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-sufmUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:41:25 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-lSxftu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:41:26 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-LuseVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:41:26 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-DdnxBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:41:26 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-zFoVyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:41:26 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-lVr8Cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:41:26 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-C0NoTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:26 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-cGzLx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:41:26 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-dIq_rJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:41:26 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-HESUH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:41:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:41:26 INFO - Running setup.py install for manifestparser 21:41:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:41:27 INFO - Running setup.py install for mozcrash 21:41:27 INFO - Running setup.py install for mozdebug 21:41:27 INFO - Running setup.py install for mozdevice 21:41:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:41:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:41:27 INFO - Running setup.py install for mozfile 21:41:27 INFO - Running setup.py install for mozhttpd 21:41:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:41:27 INFO - Running setup.py install for mozinfo 21:41:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:41:27 INFO - Running setup.py install for mozInstall 21:41:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:41:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:41:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:41:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:41:28 INFO - Running setup.py install for mozleak 21:41:28 INFO - Running setup.py install for mozlog 21:41:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:41:28 INFO - Running setup.py install for moznetwork 21:41:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:41:28 INFO - Running setup.py install for mozprocess 21:41:28 INFO - Running setup.py install for mozprofile 21:41:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:41:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:41:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:41:28 INFO - Running setup.py install for mozrunner 21:41:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:41:29 INFO - Running setup.py install for mozscreenshot 21:41:29 INFO - Running setup.py install for moztest 21:41:29 INFO - Running setup.py install for mozversion 21:41:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:41:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:41:29 INFO - Cleaning up... 21:41:29 INFO - Return code: 0 21:41:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41: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')]} 21:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41: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')]} 21:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:29 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 0x10a08d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a003570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4aa55d5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea1d30>, '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 0x109d07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e99b20>, '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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 21:41:29 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 21:41:29 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 21:41:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQjhw8YGwL/Render', 21:41:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:29 INFO - 'HOME': '/Users/cltbld', 21:41:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:29 INFO - 'LOGNAME': 'cltbld', 21:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:29 INFO - 'MOZ_NO_REMOTE': '1', 21:41:29 INFO - 'NO_EM_RESTART': '1', 21:41:29 INFO - 'PAGER': '/bin/cat', 21:41:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:29 INFO - 'PWD': '/builds/slave/test', 21:41:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:29 INFO - 'SHELL': '/bin/bash', 21:41:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wQa4K9rQR/Listeners', 21:41:29 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 21:41:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:29 INFO - 'USER': 'cltbld', 21:41:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:29 INFO - 'XPC_FLAGS': '0x0', 21:41:29 INFO - 'XPC_SERVICE_NAME': '0', 21:41:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:41:29 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-_yKo4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:41:29 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)) 21:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:41:29 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-na_2fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:41:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:41:29 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Z7EAga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:41:30 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)) 21:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:41:30 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-IJGofY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:41:30 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-JDsu_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:41:30 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)) 21:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:41:30 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-WI0SRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:41:30 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)) 21:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:41:30 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-T0ozN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:41:30 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)) 21:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:41:30 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-KXZ9PZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:41:30 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)) 21:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:41:30 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-g8ESUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:41:30 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)) 21:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:41:30 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-K2h2Qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:41:30 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)) 21:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:41:30 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-4Wsf6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:41:30 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)) 21:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:41:30 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-gPmTnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:41:31 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-twFP_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:41:31 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:41:31 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-sdj6Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:31 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-J01ycW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:31 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:41:31 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-RuMV3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:41:31 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-AJAWit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:41:31 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)) 21:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:41:31 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)) 21:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:41:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:41:31 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 21:41:31 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 21:41:31 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 21:41:31 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 21:41:31 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 21:41:31 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 21:41:34 INFO - Downloading blessings-1.6.tar.gz 21:41:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:41:34 INFO - Installing collected packages: blessings 21:41:34 INFO - Running setup.py install for blessings 21:41:34 INFO - Successfully installed blessings 21:41:34 INFO - Cleaning up... 21:41:34 INFO - Return code: 0 21:41:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:41:34 INFO - Reading from file tmpfile_stdout 21:41:34 INFO - Current package versions: 21:41:34 INFO - blessings == 1.6 21:41:34 INFO - blobuploader == 1.2.4 21:41:34 INFO - docopt == 0.6.1 21:41:34 INFO - functools32 == 3.2.3-2 21:41:34 INFO - jsonschema == 2.5.1 21:41:34 INFO - manifestparser == 1.1 21:41:34 INFO - mozInstall == 1.12 21:41:34 INFO - mozcrash == 0.17 21:41:34 INFO - mozdebug == 0.1 21:41:34 INFO - mozdevice == 0.48 21:41:34 INFO - mozfile == 1.2 21:41:34 INFO - mozhttpd == 0.7 21:41:34 INFO - mozinfo == 0.9 21:41:34 INFO - mozleak == 0.1 21:41:34 INFO - mozlog == 3.4 21:41:34 INFO - moznetwork == 0.27 21:41:34 INFO - mozprocess == 0.23 21:41:34 INFO - mozprofile == 0.28 21:41:34 INFO - mozrunner == 6.12 21:41:34 INFO - mozscreenshot == 0.1 21:41:34 INFO - mozsystemmonitor == 0.3 21:41:34 INFO - moztest == 0.7 21:41:34 INFO - mozversion == 1.4 21:41:34 INFO - psutil == 3.1.1 21:41:34 INFO - requests == 1.2.3 21:41:34 INFO - wsgiref == 0.1.2 21:41:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a08d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a003570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4aa55d5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea1d30>, '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 0x109d07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e99b20>, '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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 21:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:41:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQjhw8YGwL/Render', 21:41:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:34 INFO - 'HOME': '/Users/cltbld', 21:41:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:34 INFO - 'LOGNAME': 'cltbld', 21:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:34 INFO - 'MOZ_NO_REMOTE': '1', 21:41:34 INFO - 'NO_EM_RESTART': '1', 21:41:34 INFO - 'PAGER': '/bin/cat', 21:41:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:34 INFO - 'PWD': '/builds/slave/test', 21:41:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:34 INFO - 'SHELL': '/bin/bash', 21:41:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wQa4K9rQR/Listeners', 21:41:34 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 21:41:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:34 INFO - 'USER': 'cltbld', 21:41:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:34 INFO - 'XPC_FLAGS': '0x0', 21:41:34 INFO - 'XPC_SERVICE_NAME': '0', 21:41:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:35 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)) 21:41:35 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)) 21:41:35 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)) 21:41:35 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)) 21:41:35 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)) 21:41:35 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)) 21:41:35 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)) 21:41:35 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)) 21:41:35 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)) 21:41:35 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)) 21:41:35 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)) 21:41:35 INFO - Cleaning up... 21:41:35 INFO - Return code: 0 21:41:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:35 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 0x10a08d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a003570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4aa55d5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ea1d30>, '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 0x109d07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e99b20>, '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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 21:41:35 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 21:41:35 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 21:41:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQjhw8YGwL/Render', 21:41:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:35 INFO - 'HOME': '/Users/cltbld', 21:41:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:35 INFO - 'LOGNAME': 'cltbld', 21:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:35 INFO - 'MOZ_NO_REMOTE': '1', 21:41:35 INFO - 'NO_EM_RESTART': '1', 21:41:35 INFO - 'PAGER': '/bin/cat', 21:41:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:35 INFO - 'PWD': '/builds/slave/test', 21:41:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:35 INFO - 'SHELL': '/bin/bash', 21:41:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wQa4K9rQR/Listeners', 21:41:35 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 21:41:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:35 INFO - 'USER': 'cltbld', 21:41:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:35 INFO - 'XPC_FLAGS': '0x0', 21:41:35 INFO - 'XPC_SERVICE_NAME': '0', 21:41:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:41:35 INFO - Cleaning up... 21:41:35 INFO - Return code: 0 21:41:35 INFO - Running post-action listener: _resource_record_post_action 21:41:35 INFO - Running post-action listener: _start_resource_monitoring 21:41:35 INFO - Starting resource monitoring. 21:41:35 INFO - [mozharness: 2017-01-02 05:41:35.435711Z] Finished create-virtualenv step (success) 21:41:35 INFO - [mozharness: 2017-01-02 05:41:35.436678Z] Running install step. 21:41:35 INFO - Running pre-action listener: _resource_record_pre_action 21:41:35 INFO - Running main action method: install 21:41:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:41:35 INFO - Reading from file tmpfile_stdout 21:41:35 INFO - Detecting whether we're running mozinstall >=1.0... 21:41:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:41:35 INFO - Reading from file tmpfile_stdout 21:41:35 INFO - Output received: 21:41:35 INFO - Usage: mozinstall [options] installer 21:41:35 INFO - Options: 21:41:35 INFO - -h, --help show this help message and exit 21:41:35 INFO - -d DEST, --destination=DEST 21:41:35 INFO - Directory to install application into. [default: 21:41:35 INFO - "/builds/slave/test"] 21:41:35 INFO - --app=APP Application being installed. [default: firefox] 21:41:35 INFO - mkdir: /builds/slave/test/build/application 21:41:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 21:41:57 INFO - Reading from file tmpfile_stdout 21:41:57 INFO - Output received: 21:41:57 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 21:41:57 INFO - Running post-action listener: _resource_record_post_action 21:41:57 INFO - [mozharness: 2017-01-02 05:41:57.781401Z] Finished install step (success) 21:41:57 INFO - [mozharness: 2017-01-02 05:41:57.781564Z] Running run-tests step. 21:41:57 INFO - Running pre-action listener: _resource_record_pre_action 21:41:57 INFO - Running main action method: run_tests 21:41:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:41:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:41:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:41:57 INFO - 2017-01-01 21:41:57.796 screenresolution[1620:7647] starting screenresolution argv=screenresolution get 21:41:57 INFO - 2017-01-01 21:41:57.798 screenresolution[1620:7647] Display 0: 1600x1200x32@60 21:41:57 INFO - 2017-01-01 21:41:57.804 screenresolution[1621:7650] starting screenresolution argv=screenresolution list 21:41:57 INFO - Available Modes on Display 0 21:41:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:41:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:41:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:41:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:41:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:41:58 INFO - Intel Iris: 21:41:58 INFO - Chipset Model: Intel Iris 21:41:58 INFO - Type: GPU 21:41:58 INFO - Bus: Built-In 21:41:58 INFO - VRAM (Dynamic, Max): 1536 MB 21:41:58 INFO - Vendor: Intel (0x8086) 21:41:58 INFO - Device ID: 0x0a2e 21:41:58 INFO - Revision ID: 0x0009 21:41:58 INFO - Displays: 21:41:58 INFO - Display: 21:41:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:41:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:41:58 INFO - Display Serial Number: 1600x1200 60 21:41:58 INFO - Main Display: Yes 21:41:58 INFO - Mirror: Off 21:41:58 INFO - Online: Yes 21:41:58 INFO - Rotation: Supported 21:41:58 INFO - Return code: 0 21:41:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:41:58 INFO - Python 2.7.3 21:41:58 INFO - Return code: 0 21:41:58 INFO - grabbing minidump binary from tooltool 21:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:58 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 0x109ea1d30>, '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 0x109d07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e99b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:41:58 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 21:41:58 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 21:41:58 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 21:41:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:41:58 INFO - Return code: 0 21:41:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:41:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:41:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:41:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:41:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:41:58 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/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--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 21:41:58 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/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0377 --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 21:41:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQjhw8YGwL/Render', 21:41:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:58 INFO - 'HOME': '/Users/cltbld', 21:41:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:58 INFO - 'LOGNAME': 'cltbld', 21:41:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:41:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:58 INFO - 'MOZ_NO_REMOTE': '1', 21:41:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:41:58 INFO - 'NO_EM_RESTART': '1', 21:41:58 INFO - 'PAGER': '/bin/cat', 21:41:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:58 INFO - 'PWD': '/builds/slave/test', 21:41:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:41:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:58 INFO - 'SHELL': '/bin/bash', 21:41:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wQa4K9rQR/Listeners', 21:41:58 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 21:41:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:58 INFO - 'USER': 'cltbld', 21:41:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:58 INFO - 'XPC_FLAGS': '0x0', 21:41:58 INFO - 'XPC_SERVICE_NAME': '0', 21:41:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:58 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/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--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 21:41:58 INFO - mozversion application_buildid: 20170101194819 21:41:58 INFO - mozversion application_changeset: addb771c9a728f749feea0328c7ffd4a56888c26 21:41:58 INFO - mozversion application_display_name: Firefox 21:41:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:41:58 INFO - mozversion application_name: Firefox 21:41:58 INFO - mozversion application_remotingname: firefox 21:41:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:41:58 INFO - mozversion application_vendor: Mozilla 21:41:58 INFO - mozversion application_version: 51.0 21:41:58 INFO - mozversion platform_buildid: 20170101194819 21:41:58 INFO - mozversion platform_changeset: addb771c9a728f749feea0328c7ffd4a56888c26 21:41:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:41:58 INFO - mozversion platform_version: 51.0 21:41:58 INFO - using testdate: 1483335718 21:41:58 INFO - actual date: 1483335718 21:41:58 INFO - starting webserver on 'localhost:49248' 21:41:58 INFO - SUITE-START | Running 2 tests 21:41:58 INFO - TEST-START | dromaeo_css 21:41:58 INFO - operating with platform_type : mac_ 21:41:58 INFO - Initialising browser for dromaeo_css test... 21:41:58 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpF1tBTA/profile http://localhost:49248/getInfo.html) 21:42:00 INFO - PROCESS | 1631 | __metrics Screen width/height:1600/1200 21:42:00 INFO - PROCESS | 1631 | colorDepth:24 21:42:00 INFO - PROCESS | 1631 | Browser inner width/height: 1024/689 21:42:00 INFO - PROCESS | 1631 | __metrics 21:42:00 INFO - PROCESS | 1631 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:42:00 INFO - PROCESS | 1631 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:42:01 INFO - TEST-INFO | 1631: exit 0 21:42:01 INFO - Browser initialized. 21:42:01 INFO - Running cycle 1/1 for dromaeo_css test... 21:42:01 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpF1tBTA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:13 INFO - PROCESS | 1634 | RSS: Main: 168980480 21:42:13 INFO - PROCESS | 1634 | 21:43:04 INFO - PROCESS | 1634 | 1483335784993 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:45:15 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 21:45:16 INFO - PROCESS | 1634 | RSS: Main: 277426176 21:45:16 INFO - PROCESS | 1634 | 21:48:19 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 21:48:19 INFO - PROCESS | 1634 | RSS: Main: 299769856 21:48:19 INFO - PROCESS | 1634 | 21:51:22 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 21:51:22 INFO - PROCESS | 1634 | RSS: Main: 279384064 21:51:22 INFO - PROCESS | 1634 | 21:54:25 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 21:54:25 INFO - PROCESS | 1634 | RSS: Main: 300081152 21:54:25 INFO - PROCESS | 1634 | 21:57:28 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 21:57:29 INFO - PROCESS | 1634 | RSS: Main: 265953280 21:57:29 INFO - PROCESS | 1634 | 22:00:31 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 22:00:32 INFO - PROCESS | 1634 | RSS: Main: 323522560 22:00:32 INFO - PROCESS | 1634 | 22:00:32 INFO - PROCESS | 1634 | __start_tp_report 22:00:32 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 22:00:32 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 22:00:32 INFO - PROCESS | 1634 | |i|pagename|runs| 22:00:32 INFO - PROCESS | 1634 | |0;dojo.html;3217.276112874603;3372.6290108088106;3417.572803399575;3426.948595771062;3454.6718061784154;5706.51494622957;5718.971405142974;5779.82660520184;5791.739371728272;5795;5756.338021127572;5829.475347218749;5844.766209351632;5852.736626851792;5862.530997520199;5209;5244.554212891909;5259.737013149346;5264.763085661135;5313.149896016638;5199.662021968579;5210.843674689765;5228.294180285669;5338.946610533903;5347.973260133714;5234.162533994561;5253.789848406059;5256.632035757499;5261.8947621047555;5273;5248.632595718283;5255.9750848584545;5315.202719592054;5323.22813192085;5325.227841962894;5122.436531981479;5190.532852043334;5234.319538459976;5249.790008399659;5285.814996475105;4749.7387643679585;5671.376148623648;5689.516391106761;5754.079347304411;5824.213731146326;6203.596766210227;6245;6251.718672659696;6282.654454005028;6293.751652770943;6220.7511699532415;6234.625922444668;6245.812625621239;6250.406211409909;6282.717277722468;5741.712914354307;5801.332846722638;5838.299404071538;5861.912071318934;5867.823965281048;6237.625742455467;6271.05934109878;6276.184096067482;6290.025046117859;6303.495720342362;5584.099378881988;6123.601965872204;6215.285242197115;6245.937540624626;6255.374462553799;6188.535859810442;6222.471089957314;6241.968790156111;6265.373462653698;6281.7173227204885;5595.440455954372;6041.399029257251;6278.937210627927;6283.622982621057;6287.276963149205;6225.28409232935;6264.874702505925;6312.337204593543;6326.082718005955;6333.366663333722;4954.801807927714;5002.449730529639;5013.298138260647;5019.774110165052;5110.233464980209;4500.099980003947;4509.977450112729;4514.932276015862;4553.658475614342;4569.383133276965;5749.367569567345;5798.101294299306;5803.970980145073;5809.854753631109;5835.708214589254;6185.474234690012;6225.501959843202;6266.592671476431;6269.5611307208055;6271.341509141565;5489.64317319373;5681.517071049007;5748.45389687979;5868.911966320508;5873.148393482921;5476.58925580583;5515.641483303572;5529.30883639545;5548.112302031655;5548.140038294071;6311;6323.051542268697;6332.145160403379;6332.4934005279465;6333.461655759312;6122.855605810045;6213.782517611862;6233.594816336924;6251.218597675291;6275.341089185752;6350.1744773181035;6352.841178970378;6352.872942541031;6361.968190159019;6371.585846919936;6260.843478912881;6299.4015568522755;6300.495960323072;6308.08532762756;6311.305756366704;6154.692265386623;6197.25632924052;6217.129601855834;6225.719842607003;6248.187735594343;5129.846104616868;6198.721057552511;6213.1922850029205;6216.689165541795;6232.532560057924;6198.008318668992;6218.751249950133;6220.688965551613;6229.96885015572;6238.313785483684;5571.303587051619;5995.010823214121;6051.818445446644;6061.605995610271;6116.908246376219;6258.906116408349;6258.968705156445;6286.339934307015;6289.339619339903;6294.71673774672;6086.543509236736;6168.475679567287;6172.22847144107;6178.382161783786;6179.16581261524 22:00:32 INFO - PROCESS | 1634 | |1;ext.html;482.9130756463835;495.6505663507228;526.7761201489368;535.5902734408179;544.1293929712463;32777.67222327776;41433.378499322534;43824.780876095654;43834.78082609591;43908.341374879405;45042.32436513455;45262.32106518405;45375;45386.54613453864;45517.54482455175;10030.348027378215;10204.591816327338;10207.081362677358;10209.183265338792;10210.897891021106;7873.645685944118;9428.057194280585;12252.142350035501;12581;12610.621681349528;12582.496700131984;12658.683532911658;12684.936575317157;12689.921356684692;12697.555585554508;10992.945035274852;12502.187357821758;12557.183783054072;12560.81158782619;12567.937160314232;6699.062131301622;6723.193216813965;6742.662866856637;6923.896141557881;6967.303269673042;42704;42870.713878583694;42961.35557966633;42999.78500107479;43101.70694879159;3354.7819391739704;3480.6519348065244;4034.415009823559;4072.8981775455554;4299.204647140289;25465.872670636712;30820.537691934638;30825.537616935762;30860.2284942876;31208.687913120804;3302.7192688621494;3389.559357283562;3513.472979053137;3540.150363912668;3553.1472446612884;514747;523212;523359;614059;665279;59039.70480147572;62643;62647.68676156681;63350.68324658439;63432.68283658644;66050.0092498613;66454.33545664579;66458.66770666212;66525.66737166283;66546.33453665498;16900.492985210465;17059.402920897708;17147.74278385825;17295.56761080983;17297.740533892003;12149.5140194393;12403.875961240452;13426;13530.120542164925;13558.932205339108;15753.369865205492;15940.282687279101;16152.434664786912;16593.585160370847;16605.750913736305;6270.9372906270355;6830.897536536956;7309.269073092648;7325.7802265932105;7346.228645992201;825.5211977053294;997.7705127820642;1036.6423583863555;1110.5169251375678;1174.2836869509592;29153.27116822054;31100.066997990096;31279.530807037914;31709.682903171135;32028;1090.2967585907204;1114.509615769059;1124.3928278729395;1152.0438036429912;1187.7683851648846;15574.922125389527;16156.030638161748;16319.265633046542;16438;16527.669446611002;669261;932952;951748;951981;954422;60616.69691651602;61363;61441.38558614446;61508.69245653743;61518;1289.4197611074867;1334.6396472952442;1407.2049292150107;1431.520440652393;1446.9710605787825;29579.852100739357;31136.065918022494;31719.841400792848;32488.512672310408;32491;56518.434815651315;57265.427345726006;57273.140902887324;57296.14055789083;57362.85274294574;630630;639605;640981;641626.7918660376;642873;23430.64854027157;23990.52018959646;26117.73882261229;26235.86882065654;26777.19668409951;45120.77439612781;46715.766421167675;46732.83167920693;47429;47600;38665.6133438662;39120.413193802684;39998.60001399949;41143.588564113976;42091.789541053324;39607.60392396039;40261.798691006356;40456.786296411155;41439.79280103701;41781.955451113965;38235.61764382321;38585.421218682306;39337.01657458586;39837.203255935296;39895.80052099721;32840.67159328376;34067.82966085154;34294.48558271578;34975.82512087423;35176.82411588028;26132.34669133287;26580.867095665173;26594.468110637292;26733.732662673123;27121.86439067792 22:00:32 INFO - PROCESS | 1634 | |2;jquery.html;362.28087246815085;372.36325882740493;383.73905744094014;392.46820558143713;412.99847868917885;15172.620684482894;15693.607659808482;19274.939878306704;21107.2612458564;21243.256486022972;16924.83075169248;20799.584008319864;21001.789982100174;21175.470613234676;21306.254281100166;5939.67331796751;5956.7319470623925;6137.294211165706;6251.624902505841;6258.311585725566;6097.51219902409;6182.41267079629;6195.659238741868;6200.255969283692;6207.348228436017;4319.524852266248;5391.406945236021;6162.907556386658;6731.899021514681;6783.050372947791;5557.277553918006;6800.65996700163;6840.179178498612;6845.452363810908;6857.07429497019;5928.7924922627935;5938.049912014057;5939.881202375971;5943.791967281124;5946.226990491252;25913;26193.214203573923;26195.73804261952;26334.6049809253;26467.338316542242;2098.559302546452;2299.7930186283147;2322.9767702323097;2342.273895092527;2352.764723527651;10161.390316581028;16211.432599858948;16652.250648720837;16675.49973500797;16884.07137607431;1821.653885761701;1979.2874565156533;1983.8908860012693;1993.1728332741895;2011.3463124484456;103202;133539;139740;150990;156414.99999999886;20612.381628551168;21985.67021494679;22020.926128666248;22185.667214991787;22230.77769222287;36163.638363616556;36712.63287367146;36889.07777305535;36911.96984165897;37024.25951480955;9856.359336643096;11129.777404451866;11229.71925701864;11264.605738799102;11436;9201.861972070425;9230.307726920508;9232.7691807704;9374.812503749887;9399.389039712396;9682.9031709682;9882.505874706236;9884.901150988542;9906.455144967096;9970.850437243447;3743.5320584926885;3826.5408151022057;3826.693864490834;3843.2313537292653;3845.115623406632;719.1251634375388;830.4104086098816;885.3979294080087;903.5075883643431;924.6393906376519;19844.90077549632;20816.791832081788;20842.853643049475;21034.47413814667;21076.946152692304;856.5545916123581;878.508035500122;942.6276620734772;1009.369144284822;1010.9443980581138;10441.477926103664;10809.729756755987;10872.67381978542;10893.07408870255;10902.018818306391;618788;626530;632533;637484;638358;89233;128385.51527592404;132066.358672826;134638.3268083673;146436;933.5892207428845;935.9625614975461;955.6416343871049;957.2581249531669;959.5010594490965;18157.909210453865;18343.26626934908;18602;18634.534136646693;18721.438356849318;43574.564254358316;54248.45751542434;55039.79840806323;55677.72161139168;57078.85842283214;75693;80492.59753701194;80549.3890122206;80919.59540202262;81930;8069.83860322802;8108.189181082081;8148.755537333889;8296.87554686668;8461.196186362286;12170.39148042612;12239.571614993432;12492.750144996868;12577.30824804608;12958.28729419891;10943.179261555575;11054.723631908944;11200.327980321206;11213.66359009231;11392.94303528477;10792.406417647106;10872.347659140476;11083.285490863636;11261.493232804707;11361.261518001635;11035.558577656804;11240.4379781009;11341.26281791681;11522.654320370402;11603.767924641628;8189.631466584137;8222.424430289822;8410.831783364176;8426.241638252586;8486.61810218554;9619.663311784054;11136.220464567403;11144.275622084539;11251.887481125084;11397.658070257905 22:00:32 INFO - PROCESS | 1634 | |3;mootools.html;1374.7044385457127;1542.884283678724;1734.2716059255113;1930.8938008409532;1932.9323473678423;8932.732018039453;9456.621735130586;9458.290628202887;9465.006174351698;9481.956984731674;8079.515229086259;8304.252617264445;8368.665253389872;8561.700340488083;8569.657213711444;1871.925122995082;2207.9006444710026;2232.5088480534337;2408.2414039577566;2413;2364.337985364101;2379.940501487459;2408.1451084864884;2411.8311718179734;2416.142269494331;2382.094803974496;2389.904403823845;2390.043982407042;2408.7109546854313;2419.7096348438213;2361.020176626715;2382.7728719709276;2383.6067048936993;2387.820913431482;2398.100712232895;2357.705286839145;2378.120095564635;2379.0008196557487;2384.0463814474174;2389.0682633772844;9140.954295228481;9405.059494050609;9408.247340212767;9412.341136120474;9413.62345506179;5460.699661518614;5636.577256705723;5641.971790141023;5644.74598643062;5649.322081350264;3574.6067932527403;3659.359612067904;3695.815209239527;3728.2357116790995;3730.682891954187;973.3429934794057;1117.7876203521387;1130.6212418839698;1138.6071805227184;1145.7823013627385;12443.564475243413;12503.56237531682;12547.686307842285;12560.371981400986;12560.748785024249;4528.275475923902;4578.427696537933;4773.04539092176;4774.355462012653;4776.8566942991765;9494.95252523733;9499.145076943109;9504.239660827117;9505.762355941019;9514;5386.811461598903;5440.727963601883;5443.918341224885;5447.237386765856;5448.37343705471;4609.677322587454;4813.831515896927;5100.438951715309;5105.795768169306;5113.53978141969;3264.5103234515013;3916.3929590913453;3959.247742928834;3993.281209382281;4033.91932161361;1197.862245841722;1203.7712834561405;1208.9455974480993;1216.6593353860933;1217.592106644284;835.1231207232381;901.378049146087;907.5825120444538;908.9954550227206;939.8825146856643;5841.591088623841;5869.618474799125;5904.704764761745;6173.6913154343;6290.968545157337;434.4959846577954;446.2658926066602;455.1193440692271;455.897423079811;456.7442232349895;3862.4978752761963;3942.113024569449;3974.3044967130636;4016.1365306458665;4023.657989070962;10040.146587539995;11106.777864442827;11194.832077518844;11207.551697932155;11223.719407014727;10816.351018938889;10978.560857565768;11184.496697648625;11193.94403027996;11206.887931120584;6761;8502.234798868009;8508.446950948168;8624.00823905259;8624.827503449897;5895.086261629454;5981.940180598138;5983.581149319506;6042.728077236623;6196;10088.798224035332;10476;10664.306820056672;10707.892921071001;10715.35707857531;10446.164306855586;10548.525316360628;10602.151827853908;10712.785744284914;10959.452027398758;7170.96414517924;7371.41028717712;7632.084149902047;7758.844823103619;7981.561014144278;8718.346124040596;8897.065808090058;8898.822023559364;8914.86627700598;8920.55397230123;7793.805154871174;7879.724209652634;7919.406044546798;8004.439689221698;8073.15231900642;7635.656395462106;7728.652210650422;7737;7814.843703126019;7827.647755850887;6143.508519318354;7084.25615310385;7209.0988626421695;7216.134063912364;7219.494635375473;4948.356713627206;5066.771995260148;5081.669691470042;5219.060569097599;5352.090144675492;5113.974430127825;5128.051310507568;5158.690478571298;5384.784608615611;5411.891762164813 22:00:32 INFO - PROCESS | 1634 | |4;prototype.html;283.61570072551694;300.7383576288629;310.10225397474306;311.26386096880884;321.69599728256776;5079.720615366154;5133.691978481289;5317.331041581307;5337.332833395825;5380.21986811912;4123.299039163342;4146.025683964266;4328.783560821962;4989.501049895009;5274.498922602346;3709.7959612221316;4069.250222404365;4097.877063688086;4101.692373072016;4129.669626429878;3336.6663333666684;3797.8670746523876;3998.580149084348;4135.813888375031;4152.691902050859;3241.6658423187214;3621.149029977953;3759.9624003759886;4128.97935510322;4148.336266197409;3699.5375578052744;3716.447351993813;4019.4774679291795;4059.1272876331436;4078.5105787305415;2912.2137023003884;3455.4125798614295;3469.6877281044826;3494.3884820156372;3496.9825150874335;4301.612854843079;5137.691738495702;5173.741312934339;5177.145770947789;5187.377514698261;3708.7575662153213;4029.4157347184496;4531.705439146445;4637.5130611286;4669.2062349400685;5120.769565369567;5462.453754624546;5556.249906262643;5670.291213598301;5685.204071430003;3768.302863970147;3847.576766555677;3900.2394533066063;3907.9804600976813;3908.921821563581;5327.493888080588;5504.174373843955;5784.479396854304;5878.2358293421585;5932.851678708023;3762.266358060152;3876.282887665791;3879.767213967171;3891.280113179071;3891.416287556889;3175.6189257289275;3291.901242962715;3957.604239576019;3961.3859851723028;3972.7355407417494;3798.772073675588;4285.764282964405;4557.111363284194;4591.530710172713;4598.3102534620075;4491.775411229491;4884.755762211947;5539.667619942817;5613.550915926716;5681.857953551194;1342.590509894472;1355.8881716991973;1358.6807100331414;1360.251861476184;1365.6244532753572;785.5483097219122;822.9629666665014;841.9326453883674;841.9579021048924;845.8604330285557;3882.5340959084524;4414.953681959502;4431.889202769892;4482.529334419839;4559.338895860082;4036;4215.683823713233;4378.868633940987;4602.470715867651;4799.928001079987;4068.497873807646;4485.474938520919;4493.59557639814;4511.593956543927;4557.5442455754155;2121.4166104321125;2293.988530057339;2381.9761802381754;2395.73646898841;2570.7686308231973;4086.4687590613626;4147.647449966787;4304.74171549708;4832.414658157869;5031.52200540948;4392.824287028483;4978.850634480971;4986.7257300848805;4994.70031798086;5668.291463567054;4855.6601037927;5860.472557469848;5953.226080609493;6023.638581685201;6041.365656606169;5704.229928959703;5795.275590551181;5809.564282678901;5821.679807610622;5830;5504.944950550604;5657.773689052392;5693.174489699053;5724.195144379308;5737.627054241461;5099.69401835891;5921.644701317935;5926.911096333472;5964.373740757332;6012;3314.8176850272503;3863.111484358557;3902.317094508506;3903.9609603904732;3921.6862650988423;5523.779048838162;5751.798687045934;5774.9133762994425;5805.10020946754;5811.651300921958;4369.388285640077;4702.318163866152;4948.653594248368;5626.539678098022;5678.602497825278;5402.810901618424;5515.58633102527;5641.351244606923;5677.240055582783;5681.147827825859;5504.53211477029;5542.528885044816;5550.611457197957;5554.111342185231;5554.527865131509;5598.804041858515;5621.915671264853;5637.520810731134;5642.887142257214;5654.660720356792;5119.74401279927;5459.972700136474;5488.643238189505;5537.944620553904;5581.134924086773 22:00:32 INFO - PROCESS | 1634 | |5;yui.html;700.8493173967596;731.7109741652044;753.190320405564;783.2950344689779;839.8866153069338;15846.128462934534;16613.169341532906;16636.66726665466;16638.584035399104;16668.333266669335;14951.626209344771;15015.849841501582;15034.624134396645;15056.774148387783;15127;712.657924196386;734.9706011759523;886.4592598514917;886.521278509604;923.3029063057415;889.7419748273026;905.7237542549519;905.7916679163764;906.6464079009158;908.5184852028435;956.273232343417;956.4930586788978;956.956936937836;957.4638202606562;958.0993865766193;952.1573407534347;955.6941778630841;956.1729104324744;956.6556039825692;958.5542722633938;712.1525384792133;712.3802292005988;712.704227745485;712.8823744082221;713.4114355656552;15390.461333853373;15423;15441.0735355879;15447.922760386125;15455.227238638136;14273.643158921006;14503.637409064751;14554.053986490844;14554.781678274834;14657.60752728489;11674.70813229676;11827.172097953147;12159.331236781973;12362.44369003397;12867.678308042281;3905.6484916357663;3960.841566337343;3968.603139686037;4001.9399709004097;4096.836126554964;118926.40536797348;123419;123737;123780;123831;11217.270877392943;11545.249558778652;11623.6512904613;11667.88332116685;11700;22822.31533054011;23263.41841453977;23316.7668323318;23472.061117555448;23520.411989700053;7199.388052015533;7952.005999250094;7959.562224077731;8031.718889838944;8089.514629122272;4458.175237581057;4485.686001979895;4568;4669.929951050737;4810.062037902575;3702.259548090393;3849.0762217068263;3855.132595166065;3858.6720128789366;3859.845606175778;690.7824035428924;691.5988726538595;693.3551796828897;698.5773606967813;700.3941590524262;586.1442294250357;611.9296280927662;711.6335087429977;720.5712601002396;738.9519681220703;9038.548072596344;9740.381855433356;9973.30186886911;10058.765623601683;10127.657872902071;568.4486048532916;607.9787207447719;680.2415306932834;698.3261152987392;743.9256074392625;4613;4670.462896766848;4865.172920603506;4871.342368780241;4923.926141107886;78104;91168;92003.539982301;147843;152295;100579;127292.36353818171;130722;130940;135222;110647;111624.44187779009;112227.31659024958;113090.43454782838;113515;9258.35191536613;9432.811343773223;9499.287553433382;9512.809743805223;9519.666811661835;49084;49997.75001124971;60729;60746.69626651838;62512.37487625066;60813.08780368386;74087;83219.7517037257;96254.03745962451;97441;11754.529818807494;12010.159288849696;12089.697757556132;12175.695607609881;12236.938815305866;13409.798853017408;13610.659733506345;13752.31238438094;13890.58328250154;14410.42358305656;12217.144799863925;12451.937740311241;12517.247585338242;12558.686032849251;12627.715504414171;12620.495180193057;12723.681907952376;12730;12963.481460741841;13283.535076272285;11873.287602743863;12279.815802763145;12525.185862918881;12549.623511294676;13074.954003679873;10323.32898361604;10506.422146782;10867.673969780919;10984.568161838137;11056.170787190831;9325.440473571607;10216.722909636295;11001.889981100087;11304.378259195822;11305.604303849655 22:00:32 INFO - PROCESS | 1634 | __end_tp_report 22:00:32 INFO - PROCESS | 1634 | __start_cc_report 22:00:32 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,1092 22:00:32 INFO - PROCESS | 1634 | __end_cc_report 22:00:32 INFO - PROCESS | 1634 | __startTimestamp1483336832043__endTimestamp 22:00:32 INFO - PROCESS | 1634 | 22:00:32 INFO - PROCESS | 1634 | ------- Summary: start ------- 22:00:32 INFO - PROCESS | 1634 | Number of tests: 6 22:00:32 INFO - PROCESS | 1634 | 22:00:32 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:5787.20 Median:6061.61 stddev:641.56 (10.6%) stddev-sans-first:611.03 22:00:32 INFO - PROCESS | 1634 | Values: 3217.3 3372.6 3417.6 3426.9 3454.7 5706.5 5719.0 5779.8 5791.7 5795.0 5756.3 5829.5 5844.8 5852.7 5862.5 5209.0 5244.6 5259.7 5264.8 5313.1 5199.7 5210.8 5228.3 5338.9 5348.0 5234.2 5253.8 5256.6 5261.9 5273.0 5248.6 5256.0 5315.2 5323.2 5325.2 5122.4 5190.5 5234.3 5249.8 5285.8 4749.7 5671.4 5689.5 5754.1 5824.2 6203.6 6245.0 6251.7 6282.7 6293.8 6220.8 6234.6 6245.8 6250.4 6282.7 5741.7 5801.3 5838.3 5861.9 5867.8 6237.6 6271.1 6276.2 6290.0 6303.5 5584.1 6123.6 6215.3 6245.9 6255.4 6188.5 6222.5 6242.0 6265.4 6281.7 5595.4 6041.4 6278.9 6283.6 6287.3 6225.3 6264.9 6312.3 6326.1 6333.4 4954.8 5002.4 5013.3 5019.8 5110.2 4500.1 4510.0 4514.9 4553.7 4569.4 5749.4 5798.1 5804.0 5809.9 5835.7 6185.5 6225.5 6266.6 6269.6 6271.3 5489.6 5681.5 5748.5 5868.9 5873.1 5476.6 5515.6 5529.3 5548.1 5548.1 6311.0 6323.1 6332.1 6332.5 6333.5 6122.9 6213.8 6233.6 6251.2 6275.3 6350.2 6352.8 6352.9 6362.0 6371.6 6260.8 6299.4 6300.5 6308.1 6311.3 6154.7 6197.3 6217.1 6225.7 6248.2 5129.8 6198.7 6213.2 6216.7 6232.5 6198.0 6218.8 6220.7 6230.0 6238.3 5571.3 5995.0 6051.8 6061.6 6116.9 6258.9 6259.0 6286.3 6289.3 6294.7 6086.5 6168.5 6172.2 6178.4 6179.2 22:00:32 INFO - PROCESS | 1634 | 22:00:32 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:82083.14 Median:38625.52 stddev:193153.26 (500.1%) stddev-sans-first:193597.93 22:00:32 INFO - PROCESS | 1634 | Values: 482.9 495.7 526.8 535.6 544.1 32777.7 41433.4 43824.8 43834.8 43908.3 45042.3 45262.3 45375.0 45386.5 45517.5 10030.3 10204.6 10207.1 10209.2 10210.9 7873.6 9428.1 12252.1 12581.0 12610.6 12582.5 12658.7 12684.9 12689.9 12697.6 10992.9 12502.2 12557.2 12560.8 12567.9 6699.1 6723.2 6742.7 6923.9 6967.3 42704.0 42870.7 42961.4 42999.8 43101.7 3354.8 3480.7 4034.4 4072.9 4299.2 25465.9 30820.5 30825.5 30860.2 31208.7 3302.7 3389.6 3513.5 3540.2 3553.1 514747.0 523212.0 523359.0 614059.0 665279.0 59039.7 62643.0 62647.7 63350.7 63432.7 66050.0 66454.3 66458.7 66525.7 66546.3 16900.5 17059.4 17147.7 17295.6 17297.7 12149.5 12403.9 13426.0 13530.1 13558.9 15753.4 15940.3 16152.4 16593.6 16605.8 6270.9 6830.9 7309.3 7325.8 7346.2 825.5 997.8 1036.6 1110.5 1174.3 29153.3 31100.1 31279.5 31709.7 32028.0 1090.3 1114.5 1124.4 1152.0 1187.8 15574.9 16156.0 16319.3 16438.0 16527.7 669261.0 932952.0 951748.0 951981.0 954422.0 60616.7 61363.0 61441.4 61508.7 61518.0 1289.4 1334.6 1407.2 1431.5 1447.0 29579.9 31136.1 31719.8 32488.5 32491.0 56518.4 57265.4 57273.1 57296.1 57362.9 630630.0 639605.0 640981.0 641626.8 642873.0 23430.6 23990.5 26117.7 26235.9 26777.2 45120.8 46715.8 46732.8 47429.0 47600.0 38665.6 39120.4 39998.6 41143.6 42091.8 39607.6 40261.8 40456.8 41439.8 41782.0 38235.6 38585.4 39337.0 39837.2 39895.8 32840.7 34067.8 34294.5 34975.8 35176.8 26132.3 26580.9 26594.5 26733.7 27121.9 22:00:32 INFO - PROCESS | 1634 | 22:00:32 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:37807.80 Median:18537.46 stddev:105269.33 (567.9%) stddev-sans-first:105527.09 22:00:32 INFO - PROCESS | 1634 | Values: 362.3 372.4 383.7 392.5 413.0 15172.6 15693.6 19274.9 21107.3 21243.3 16924.8 20799.6 21001.8 21175.5 21306.3 5939.7 5956.7 6137.3 6251.6 6258.3 6097.5 6182.4 6195.7 6200.3 6207.3 4319.5 5391.4 6162.9 6731.9 6783.1 5557.3 6800.7 6840.2 6845.5 6857.1 5928.8 5938.0 5939.9 5943.8 5946.2 25913.0 26193.2 26195.7 26334.6 26467.3 2098.6 2299.8 2323.0 2342.3 2352.8 10161.4 16211.4 16652.3 16675.5 16884.1 1821.7 1979.3 1983.9 1993.2 2011.3 103202.0 133539.0 139740.0 150990.0 156415.0 20612.4 21985.7 22020.9 22185.7 22230.8 36163.6 36712.6 36889.1 36912.0 37024.3 9856.4 11129.8 11229.7 11264.6 11436.0 9201.9 9230.3 9232.8 9374.8 9399.4 9682.9 9882.5 9884.9 9906.5 9970.9 3743.5 3826.5 3826.7 3843.2 3845.1 719.1 830.4 885.4 903.5 924.6 19844.9 20816.8 20842.9 21034.5 21076.9 856.6 878.5 942.6 1009.4 1010.9 10441.5 10809.7 10872.7 10893.1 10902.0 618788.0 626530.0 632533.0 637484.0 638358.0 89233.0 128385.5 132066.4 134638.3 146436.0 933.6 936.0 955.6 957.3 959.5 18157.9 18343.3 18602.0 18634.5 18721.4 43574.6 54248.5 55039.8 55677.7 57078.9 75693.0 80492.6 80549.4 80919.6 81930.0 8069.8 8108.2 8148.8 8296.9 8461.2 12170.4 12239.6 12492.8 12577.3 12958.3 10943.2 11054.7 11200.3 11213.7 11392.9 10792.4 10872.3 11083.3 11261.5 11361.3 11035.6 11240.4 11341.3 11522.7 11603.8 8189.6 8222.4 8410.8 8426.2 8486.6 9619.7 11136.2 11144.3 11251.9 11397.7 22:00:32 INFO - PROCESS | 1634 | 22:00:32 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:5870.82 Median:4881.09 stddev:3373.09 (69.1%) stddev-sans-first:3365.63 22:00:32 INFO - PROCESS | 1634 | Values: 1374.7 1542.9 1734.3 1930.9 1932.9 8932.7 9456.6 9458.3 9465.0 9482.0 8079.5 8304.3 8368.7 8561.7 8569.7 1871.9 2207.9 2232.5 2408.2 2413.0 2364.3 2379.9 2408.1 2411.8 2416.1 2382.1 2389.9 2390.0 2408.7 2419.7 2361.0 2382.8 2383.6 2387.8 2398.1 2357.7 2378.1 2379.0 2384.0 2389.1 9141.0 9405.1 9408.2 9412.3 9413.6 5460.7 5636.6 5642.0 5644.7 5649.3 3574.6 3659.4 3695.8 3728.2 3730.7 973.3 1117.8 1130.6 1138.6 1145.8 12443.6 12503.6 12547.7 12560.4 12560.7 4528.3 4578.4 4773.0 4774.4 4776.9 9495.0 9499.1 9504.2 9505.8 9514.0 5386.8 5440.7 5443.9 5447.2 5448.4 4609.7 4813.8 5100.4 5105.8 5113.5 3264.5 3916.4 3959.2 3993.3 4033.9 1197.9 1203.8 1208.9 1216.7 1217.6 835.1 901.4 907.6 909.0 939.9 5841.6 5869.6 5904.7 6173.7 6291.0 434.5 446.3 455.1 455.9 456.7 3862.5 3942.1 3974.3 4016.1 4023.7 10040.1 11106.8 11194.8 11207.6 11223.7 10816.4 10978.6 11184.5 11193.9 11206.9 6761.0 8502.2 8508.4 8624.0 8624.8 5895.1 5981.9 5983.6 6042.7 6196.0 10088.8 10476.0 10664.3 10707.9 10715.4 10446.2 10548.5 10602.2 10712.8 10959.5 7171.0 7371.4 7632.1 7758.8 7981.6 8718.3 8897.1 8898.8 8914.9 8920.6 7793.8 7879.7 7919.4 8004.4 8073.2 7635.7 7728.7 7737.0 7814.8 7827.6 6143.5 7084.3 7209.1 7216.1 7219.5 4948.4 5066.8 5081.7 5219.1 5352.1 5114.0 5128.1 5158.7 5384.8 5411.9 22:00:32 INFO - PROCESS | 1634 | 22:00:32 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4376.76 Median:4600.39 stddev:1387.73 (30.2%) stddev-sans-first:1357.19 22:00:32 INFO - PROCESS | 1634 | Values: 283.6 300.7 310.1 311.3 321.7 5079.7 5133.7 5317.3 5337.3 5380.2 4123.3 4146.0 4328.8 4989.5 5274.5 3709.8 4069.3 4097.9 4101.7 4129.7 3336.7 3797.9 3998.6 4135.8 4152.7 3241.7 3621.1 3760.0 4129.0 4148.3 3699.5 3716.4 4019.5 4059.1 4078.5 2912.2 3455.4 3469.7 3494.4 3497.0 4301.6 5137.7 5173.7 5177.1 5187.4 3708.8 4029.4 4531.7 4637.5 4669.2 5120.8 5462.5 5556.2 5670.3 5685.2 3768.3 3847.6 3900.2 3908.0 3908.9 5327.5 5504.2 5784.5 5878.2 5932.9 3762.3 3876.3 3879.8 3891.3 3891.4 3175.6 3291.9 3957.6 3961.4 3972.7 3798.8 4285.8 4557.1 4591.5 4598.3 4491.8 4884.8 5539.7 5613.6 5681.9 1342.6 1355.9 1358.7 1360.3 1365.6 785.5 823.0 841.9 842.0 845.9 3882.5 4415.0 4431.9 4482.5 4559.3 4036.0 4215.7 4378.9 4602.5 4799.9 4068.5 4485.5 4493.6 4511.6 4557.5 2121.4 2294.0 2382.0 2395.7 2570.8 4086.5 4147.6 4304.7 4832.4 5031.5 4392.8 4978.9 4986.7 4994.7 5668.3 4855.7 5860.5 5953.2 6023.6 6041.4 5704.2 5795.3 5809.6 5821.7 5830.0 5504.9 5657.8 5693.2 5724.2 5737.6 5099.7 5921.6 5926.9 5964.4 6012.0 3314.8 3863.1 3902.3 3904.0 3921.7 5523.8 5751.8 5774.9 5805.1 5811.7 4369.4 4702.3 4948.7 5626.5 5678.6 5402.8 5515.6 5641.4 5677.2 5681.1 5504.5 5542.5 5550.6 5554.1 5554.5 5598.8 5621.9 5637.5 5642.9 5654.7 5119.7 5460.0 5488.6 5537.9 5581.1 22:00:32 INFO - PROCESS | 1634 | 22:00:32 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:23780.78 Median:3856.90 stddev:37375.66 (969.1%) stddev-sans-first:37440.33 22:00:32 INFO - PROCESS | 1634 | Values: 700.8 731.7 753.2 783.3 839.9 15846.1 16613.2 16636.7 16638.6 16668.3 14951.6 15015.8 15034.6 15056.8 15127.0 712.7 735.0 886.5 886.5 923.3 889.7 905.7 905.8 906.6 908.5 956.3 956.5 957.0 957.5 958.1 952.2 955.7 956.2 956.7 958.6 712.2 712.4 712.7 712.9 713.4 15390.5 15423.0 15441.1 15447.9 15455.2 14273.6 14503.6 14554.1 14554.8 14657.6 11674.7 11827.2 12159.3 12362.4 12867.7 3905.6 3960.8 3968.6 4001.9 4096.8 118926.4 123419.0 123737.0 123780.0 123831.0 11217.3 11545.2 11623.7 11667.9 11700.0 22822.3 23263.4 23316.8 23472.1 23520.4 7199.4 7952.0 7959.6 8031.7 8089.5 4458.2 4485.7 4568.0 4669.9 4810.1 3702.3 3849.1 3855.1 3858.7 3859.8 690.8 691.6 693.4 698.6 700.4 586.1 611.9 711.6 720.6 739.0 9038.5 9740.4 9973.3 10058.8 10127.7 568.4 608.0 680.2 698.3 743.9 4613.0 4670.5 4865.2 4871.3 4923.9 78104.0 91168.0 92003.5 147843.0 152295.0 100579.0 127292.4 130722.0 130940.0 135222.0 110647.0 111624.4 112227.3 113090.4 113515.0 9258.4 9432.8 9499.3 9512.8 9519.7 49084.0 49997.8 60729.0 60746.7 62512.4 60813.1 74087.0 83219.8 96254.0 97441.0 11754.5 12010.2 12089.7 12175.7 12236.9 13409.8 13610.7 13752.3 13890.6 14410.4 12217.1 12451.9 12517.2 12558.7 12627.7 12620.5 12723.7 12730.0 12963.5 13283.5 11873.3 12279.8 12525.2 12549.6 13075.0 10323.3 10506.4 10867.7 10984.6 11056.2 9325.4 10216.7 11001.9 11304.4 11305.6 22:00:32 INFO - PROCESS | 1634 | -------- Summary: end -------- 22:00:32 INFO - PROCESS | 1634 | 22:00:32 INFO - TEST-INFO | 1634: exit 0 22:00:32 INFO - TEST-OK | dromaeo_css | took 1114269ms 22:00:32 INFO - TEST-START | kraken 22:00:32 INFO - operating with platform_type : mac_ 22:00:32 INFO - Initialising browser for kraken test... 22:00:32 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpsP4EqD/profile http://localhost:49248/getInfo.html) 22:00:34 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 22:00:34 INFO - PROCESS | 1644 | colorDepth:24 22:00:34 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 22:00:34 INFO - PROCESS | 1644 | __metrics 22:00:34 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:00:34 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:00:35 INFO - TEST-INFO | 1644: exit 0 22:00:35 INFO - Browser initialized. 22:00:35 INFO - Running cycle 1/1 for kraken test... 22:00:35 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpsP4EqD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:47 INFO - PROCESS | 1646 | RSS: Main: 168701952 22:00:47 INFO - PROCESS | 1646 | 22:00:50 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 22:00:51 INFO - PROCESS | 1646 | RSS: Main: 219422720 22:00:51 INFO - PROCESS | 1646 | 22:00:53 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 22:00:54 INFO - PROCESS | 1646 | RSS: Main: 233672704 22:00:54 INFO - PROCESS | 1646 | 22:00:57 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 22:00:58 INFO - PROCESS | 1646 | RSS: Main: 328224768 22:00:58 INFO - PROCESS | 1646 | 22:00:59 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 22:01:00 INFO - PROCESS | 1646 | RSS: Main: 229703680 22:01:00 INFO - PROCESS | 1646 | 22:01:02 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:01:03 INFO - PROCESS | 1646 | RSS: Main: 230551552 22:01:03 INFO - PROCESS | 1646 | 22:01:05 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 22:01:06 INFO - PROCESS | 1646 | RSS: Main: 267575296 22:01:06 INFO - PROCESS | 1646 | 22:01:09 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 22:01:09 INFO - PROCESS | 1646 | RSS: Main: 269455360 22:01:09 INFO - PROCESS | 1646 | 22:01:12 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 22:01:13 INFO - PROCESS | 1646 | RSS: Main: 267984896 22:01:13 INFO - PROCESS | 1646 | 22:01:14 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:01:15 INFO - PROCESS | 1646 | RSS: Main: 240381952 22:01:15 INFO - PROCESS | 1646 | 22:01:17 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:01:17 INFO - PROCESS | 1646 | RSS: Main: 246484992 22:01:17 INFO - PROCESS | 1646 | 22:01:20 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:01:20 INFO - PROCESS | 1646 | RSS: Main: 254976000 22:01:20 INFO - PROCESS | 1646 | 22:01:23 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:01:24 INFO - PROCESS | 1646 | RSS: Main: 260890624 22:01:24 INFO - PROCESS | 1646 | 22:01:27 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:01:27 INFO - PROCESS | 1646 | RSS: Main: 260886528 22:01:27 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 22:01:29 INFO - PROCESS | 1646 | RSS: Main: 304214016 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | __start_tp_report 22:01:29 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 22:01:29 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 22:01:29 INFO - PROCESS | 1646 | |i|pagename|runs| 22:01:29 INFO - PROCESS | 1646 | |0;ai-astar;112;112;112;113;114;114;113;116;162;168 22:01:29 INFO - PROCESS | 1646 | |1;audio-beat-detection;141;109;110;139;107;106;107;108;138;107 22:01:29 INFO - PROCESS | 1646 | |2;audio-dft;183;180;182;183;183;185;180;183;195;260 22:01:29 INFO - PROCESS | 1646 | |3;audio-fft;80;58;56;88;61;58;59;57;81;58 22:01:29 INFO - PROCESS | 1646 | |4;audio-oscillator;85;70;92;68;68;68;91;68;68;89 22:01:29 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;88;86;88;85;89;84;88;85;88;85 22:01:29 INFO - PROCESS | 1646 | |6;imaging-darkroom;93;106;146;93;93;92;92;94;95;92 22:01:29 INFO - PROCESS | 1646 | |7;imaging-desaturate;84;86;86;86;85;86;86;84;83;84 22:01:29 INFO - PROCESS | 1646 | |8;json-parse-financial;56;53;53;52;53;56;57;56;54;54 22:01:29 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;64;71;68;73;75;70;67;68;69;68 22:01:29 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;98;90;84;80;83;83;81;82;89;84 22:01:29 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;132;138;143;142;145;133;137;140;167;145 22:01:29 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;159;160;157;160;159;171;157;217;214;160 22:01:29 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;63;65;66;57;56;75;81;84;81;66 22:01:29 INFO - PROCESS | 1646 | __end_tp_report 22:01:29 INFO - PROCESS | 1646 | __start_cc_report 22:01:29 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1864 22:01:29 INFO - PROCESS | 1646 | __end_cc_report 22:01:29 INFO - PROCESS | 1646 | __startTimestamp1483336889679__endTimestamp 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | ------- Summary: start ------- 22:01:29 INFO - PROCESS | 1646 | Number of tests: 14 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:123.60 Median:114.00 stddev:21.90 (19.2%) stddev-sans-first:22.82 22:01:29 INFO - PROCESS | 1646 | Values: 112.0 112.0 112.0 113.0 114.0 114.0 113.0 116.0 162.0 168.0 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:109.50 stddev:15.33 (14.0%) stddev-sans-first:13.63 22:01:29 INFO - PROCESS | 1646 | Values: 141.0 109.0 110.0 139.0 107.0 106.0 107.0 108.0 138.0 107.0 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:191.40 Median:183.00 stddev:24.47 (13.4%) stddev-sans-first:25.77 22:01:29 INFO - PROCESS | 1646 | Values: 183.0 180.0 182.0 183.0 183.0 185.0 180.0 183.0 195.0 260.0 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:65.60 Median:60.00 stddev:12.25 (20.4%) stddev-sans-first:11.83 22:01:29 INFO - PROCESS | 1646 | Values: 80.0 58.0 56.0 88.0 61.0 58.0 59.0 57.0 81.0 58.0 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:77.50 stddev:10.97 (14.1%) stddev-sans-first:11.21 22:01:29 INFO - PROCESS | 1646 | Values: 85.0 70.0 92.0 68.0 68.0 68.0 91.0 68.0 68.0 89.0 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:88.00 stddev:1.78 (2.0%) stddev-sans-first:1.81 22:01:29 INFO - PROCESS | 1646 | Values: 88.0 86.0 88.0 85.0 89.0 84.0 88.0 85.0 88.0 85.0 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:99.60 Median:93.00 stddev:16.83 (18.1%) stddev-sans-first:17.68 22:01:29 INFO - PROCESS | 1646 | Values: 93.0 106.0 146.0 93.0 93.0 92.0 92.0 94.0 95.0 92.0 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:86.00 stddev:1.15 (1.3%) stddev-sans-first:1.17 22:01:29 INFO - PROCESS | 1646 | Values: 84.0 86.0 86.0 86.0 85.0 86.0 86.0 84.0 83.0 84.0 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:1.71 (3.1%) stddev-sans-first:1.72 22:01:29 INFO - PROCESS | 1646 | Values: 56.0 53.0 53.0 52.0 53.0 56.0 57.0 56.0 54.0 54.0 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:3.13 (4.5%) stddev-sans-first:2.67 22:01:29 INFO - PROCESS | 1646 | Values: 64.0 71.0 68.0 73.0 75.0 70.0 67.0 68.0 69.0 68.0 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.00 stddev:5.46 (6.5%) stddev-sans-first:3.39 22:01:29 INFO - PROCESS | 1646 | Values: 98.0 90.0 84.0 80.0 83.0 83.0 81.0 82.0 89.0 84.0 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:142.50 stddev:9.83 (6.9%) stddev-sans-first:9.71 22:01:29 INFO - PROCESS | 1646 | Values: 132.0 138.0 143.0 142.0 145.0 133.0 137.0 140.0 167.0 145.0 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:160.00 stddev:23.59 (14.7%) stddev-sans-first:24.59 22:01:29 INFO - PROCESS | 1646 | Values: 159.0 160.0 157.0 160.0 159.0 171.0 157.0 217.0 214.0 160.0 22:01:29 INFO - PROCESS | 1646 | 22:01:29 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.50 stddev:10.17 (14.4%) stddev-sans-first:10.52 22:01:29 INFO - PROCESS | 1646 | Values: 63.0 65.0 66.0 57.0 56.0 75.0 81.0 84.0 81.0 66.0 22:01:29 INFO - PROCESS | 1646 | -------- Summary: end -------- 22:01:29 INFO - PROCESS | 1646 | 22:01:30 INFO - TEST-INFO | 1646: exit 0 22:01:30 INFO - TEST-OK | kraken | took 57826ms 22:01:30 INFO - SUITE-END | took 1172s 22:01:30 INFO - Completed test suite (00:19:32) 22:01:30 INFO - javascript benchmark 22:01:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3217.276112874603, 3372.6290108088106, 3417.572803399575, 3426.948595771062, 3454.6718061784154, 5706.51494622957, 5718.971405142974, 5779.82660520184, 5791.739371728272, 5795.0, 5756.338021127572, 5829.475347218749, 5844.766209351632, 5852.736626851792, 5862.530997520199, 5209.0, 5244.554212891909, 5259.737013149346, 5264.763085661135, 5313.149896016638, 5199.662021968579, 5210.843674689765, 5228.294180285669, 5338.946610533903, 5347.973260133714, 5234.162533994561, 5253.789848406059, 5256.632035757499, 5261.8947621047555, 5273.0, 5248.632595718283, 5255.9750848584545, 5315.202719592054, 5323.22813192085, 5325.227841962894, 5122.436531981479, 5190.532852043334, 5234.319538459976, 5249.790008399659, 5285.814996475105, 4749.7387643679585, 5671.376148623648, 5689.516391106761, 5754.079347304411, 5824.213731146326, 6203.596766210227, 6245.0, 6251.718672659696, 6282.654454005028, 6293.751652770943, 6220.7511699532415, 6234.625922444668, 6245.812625621239, 6250.406211409909, 6282.717277722468, 5741.712914354307, 5801.332846722638, 5838.299404071538, 5861.912071318934, 5867.823965281048, 6237.625742455467, 6271.05934109878, 6276.184096067482, 6290.025046117859, 6303.495720342362, 5584.099378881988, 6123.601965872204, 6215.285242197115, 6245.937540624626, 6255.374462553799, 6188.535859810442, 6222.471089957314, 6241.968790156111, 6265.373462653698, 6281.7173227204885, 5595.440455954372, 6041.399029257251, 6278.937210627927, 6283.622982621057, 6287.276963149205, 6225.28409232935, 6264.874702505925, 6312.337204593543, 6326.082718005955, 6333.366663333722, 4954.801807927714, 5002.449730529639, 5013.298138260647, 5019.774110165052, 5110.233464980209, 4500.099980003947, 4509.977450112729, 4514.932276015862, 4553.658475614342, 4569.383133276965, 5749.367569567345, 5798.101294299306, 5803.970980145073, 5809.854753631109, 5835.708214589254, 6185.474234690012, 6225.501959843202, 6266.592671476431, 6269.5611307208055, 6271.341509141565, 5489.64317319373, 5681.517071049007, 5748.45389687979, 5868.911966320508, 5873.148393482921, 5476.58925580583, 5515.641483303572, 5529.30883639545, 5548.112302031655, 5548.140038294071, 6311.0, 6323.051542268697, 6332.145160403379, 6332.4934005279465, 6333.461655759312, 6122.855605810045, 6213.782517611862, 6233.594816336924, 6251.218597675291, 6275.341089185752, 6350.1744773181035, 6352.841178970378, 6352.872942541031, 6361.968190159019, 6371.585846919936, 6260.843478912881, 6299.4015568522755, 6300.495960323072, 6308.08532762756, 6311.305756366704, 6154.692265386623, 6197.25632924052, 6217.129601855834, 6225.719842607003, 6248.187735594343, 5129.846104616868, 6198.721057552511, 6213.1922850029205, 6216.689165541795, 6232.532560057924, 6198.008318668992, 6218.751249950133, 6220.688965551613, 6229.96885015572, 6238.313785483684, 5571.303587051619, 5995.010823214121, 6051.818445446644, 6061.605995610271, 6116.908246376219, 6258.906116408349, 6258.968705156445, 6286.339934307015, 6289.339619339903, 6294.71673774672, 6086.543509236736, 6168.475679567287, 6172.22847144107, 6178.382161783786, 6179.16581261524], "value": 5746.645320015829, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.9130756463835, 495.6505663507228, 526.7761201489368, 535.5902734408179, 544.1293929712463, 32777.67222327776, 41433.378499322534, 43824.780876095654, 43834.78082609591, 43908.341374879405, 45042.32436513455, 45262.32106518405, 45375.0, 45386.54613453864, 45517.54482455175, 10030.348027378215, 10204.591816327338, 10207.081362677358, 10209.183265338792, 10210.897891021106, 7873.645685944118, 9428.057194280585, 12252.142350035501, 12581.0, 12610.621681349528, 12582.496700131984, 12658.683532911658, 12684.936575317157, 12689.921356684692, 12697.555585554508, 10992.945035274852, 12502.187357821758, 12557.183783054072, 12560.81158782619, 12567.937160314232, 6699.062131301622, 6723.193216813965, 6742.662866856637, 6923.896141557881, 6967.303269673042, 42704.0, 42870.713878583694, 42961.35557966633, 42999.78500107479, 43101.70694879159, 3354.7819391739704, 3480.6519348065244, 4034.415009823559, 4072.8981775455554, 4299.204647140289, 25465.872670636712, 30820.537691934638, 30825.537616935762, 30860.2284942876, 31208.687913120804, 3302.7192688621494, 3389.559357283562, 3513.472979053137, 3540.150363912668, 3553.1472446612884, 514747.0, 523212.0, 523359.0, 614059.0, 665279.0, 59039.70480147572, 62643.0, 62647.68676156681, 63350.68324658439, 63432.68283658644, 66050.0092498613, 66454.33545664579, 66458.66770666212, 66525.66737166283, 66546.33453665498, 16900.492985210465, 17059.402920897708, 17147.74278385825, 17295.56761080983, 17297.740533892003, 12149.5140194393, 12403.875961240452, 13426.0, 13530.120542164925, 13558.932205339108, 15753.369865205492, 15940.282687279101, 16152.434664786912, 16593.585160370847, 16605.750913736305, 6270.9372906270355, 6830.897536536956, 7309.269073092648, 7325.7802265932105, 7346.228645992201, 825.5211977053294, 997.7705127820642, 1036.6423583863555, 1110.5169251375678, 1174.2836869509592, 29153.27116822054, 31100.066997990096, 31279.530807037914, 31709.682903171135, 32028.0, 1090.2967585907204, 1114.509615769059, 1124.3928278729395, 1152.0438036429912, 1187.7683851648846, 15574.922125389527, 16156.030638161748, 16319.265633046542, 16438.0, 16527.669446611002, 669261.0, 932952.0, 951748.0, 951981.0, 954422.0, 60616.69691651602, 61363.0, 61441.38558614446, 61508.69245653743, 61518.0, 1289.4197611074867, 1334.6396472952442, 1407.2049292150107, 1431.520440652393, 1446.9710605787825, 29579.852100739357, 31136.065918022494, 31719.841400792848, 32488.512672310408, 32491.0, 56518.434815651315, 57265.427345726006, 57273.140902887324, 57296.14055789083, 57362.85274294574, 630630.0, 639605.0, 640981.0, 641626.7918660376, 642873.0, 23430.64854027157, 23990.52018959646, 26117.73882261229, 26235.86882065654, 26777.19668409951, 45120.77439612781, 46715.766421167675, 46732.83167920693, 47429.0, 47600.0, 38665.6133438662, 39120.413193802684, 39998.60001399949, 41143.588564113976, 42091.789541053324, 39607.60392396039, 40261.798691006356, 40456.786296411155, 41439.79280103701, 41781.955451113965, 38235.61764382321, 38585.421218682306, 39337.01657458586, 39837.203255935296, 39895.80052099721, 32840.67159328376, 34067.82966085154, 34294.48558271578, 34975.82512087423, 35176.82411588028, 26132.34669133287, 26580.867095665173, 26594.468110637292, 26733.732662673123, 27121.86439067792], "value": 21014.747565071044, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.28087246815085, 372.36325882740493, 383.73905744094014, 392.46820558143713, 412.99847868917885, 15172.620684482894, 15693.607659808482, 19274.939878306704, 21107.2612458564, 21243.256486022972, 16924.83075169248, 20799.584008319864, 21001.789982100174, 21175.470613234676, 21306.254281100166, 5939.67331796751, 5956.7319470623925, 6137.294211165706, 6251.624902505841, 6258.311585725566, 6097.51219902409, 6182.41267079629, 6195.659238741868, 6200.255969283692, 6207.348228436017, 4319.524852266248, 5391.406945236021, 6162.907556386658, 6731.899021514681, 6783.050372947791, 5557.277553918006, 6800.65996700163, 6840.179178498612, 6845.452363810908, 6857.07429497019, 5928.7924922627935, 5938.049912014057, 5939.881202375971, 5943.791967281124, 5946.226990491252, 25913.0, 26193.214203573923, 26195.73804261952, 26334.6049809253, 26467.338316542242, 2098.559302546452, 2299.7930186283147, 2322.9767702323097, 2342.273895092527, 2352.764723527651, 10161.390316581028, 16211.432599858948, 16652.250648720837, 16675.49973500797, 16884.07137607431, 1821.653885761701, 1979.2874565156533, 1983.8908860012693, 1993.1728332741895, 2011.3463124484456, 103202.0, 133539.0, 139740.0, 150990.0, 156414.99999999886, 20612.381628551168, 21985.67021494679, 22020.926128666248, 22185.667214991787, 22230.77769222287, 36163.638363616556, 36712.63287367146, 36889.07777305535, 36911.96984165897, 37024.25951480955, 9856.359336643096, 11129.777404451866, 11229.71925701864, 11264.605738799102, 11436.0, 9201.861972070425, 9230.307726920508, 9232.7691807704, 9374.812503749887, 9399.389039712396, 9682.9031709682, 9882.505874706236, 9884.901150988542, 9906.455144967096, 9970.850437243447, 3743.5320584926885, 3826.5408151022057, 3826.693864490834, 3843.2313537292653, 3845.115623406632, 719.1251634375388, 830.4104086098816, 885.3979294080087, 903.5075883643431, 924.6393906376519, 19844.90077549632, 20816.791832081788, 20842.853643049475, 21034.47413814667, 21076.946152692304, 856.5545916123581, 878.508035500122, 942.6276620734772, 1009.369144284822, 1010.9443980581138, 10441.477926103664, 10809.729756755987, 10872.67381978542, 10893.07408870255, 10902.018818306391, 618788.0, 626530.0, 632533.0, 637484.0, 638358.0, 89233.0, 128385.51527592404, 132066.358672826, 134638.3268083673, 146436.0, 933.5892207428845, 935.9625614975461, 955.6416343871049, 957.2581249531669, 959.5010594490965, 18157.909210453865, 18343.26626934908, 18602.0, 18634.534136646693, 18721.438356849318, 43574.564254358316, 54248.45751542434, 55039.79840806323, 55677.72161139168, 57078.85842283214, 75693.0, 80492.59753701194, 80549.3890122206, 80919.59540202262, 81930.0, 8069.83860322802, 8108.189181082081, 8148.755537333889, 8296.87554686668, 8461.196186362286, 12170.39148042612, 12239.571614993432, 12492.750144996868, 12577.30824804608, 12958.28729419891, 10943.179261555575, 11054.723631908944, 11200.327980321206, 11213.66359009231, 11392.94303528477, 10792.406417647106, 10872.347659140476, 11083.285490863636, 11261.493232804707, 11361.261518001635, 11035.558577656804, 11240.4379781009, 11341.26281791681, 11522.654320370402, 11603.767924641628, 8189.631466584137, 8222.424430289822, 8410.831783364176, 8426.241638252586, 8486.61810218554, 9619.663311784054, 11136.220464567403, 11144.275622084539, 11251.887481125084, 11397.658070257905], "value": 10743.042504519743, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.7044385457127, 1542.884283678724, 1734.2716059255113, 1930.8938008409532, 1932.9323473678423, 8932.732018039453, 9456.621735130586, 9458.290628202887, 9465.006174351698, 9481.956984731674, 8079.515229086259, 8304.252617264445, 8368.665253389872, 8561.700340488083, 8569.657213711444, 1871.925122995082, 2207.9006444710026, 2232.5088480534337, 2408.2414039577566, 2413.0, 2364.337985364101, 2379.940501487459, 2408.1451084864884, 2411.8311718179734, 2416.142269494331, 2382.094803974496, 2389.904403823845, 2390.043982407042, 2408.7109546854313, 2419.7096348438213, 2361.020176626715, 2382.7728719709276, 2383.6067048936993, 2387.820913431482, 2398.100712232895, 2357.705286839145, 2378.120095564635, 2379.0008196557487, 2384.0463814474174, 2389.0682633772844, 9140.954295228481, 9405.059494050609, 9408.247340212767, 9412.341136120474, 9413.62345506179, 5460.699661518614, 5636.577256705723, 5641.971790141023, 5644.74598643062, 5649.322081350264, 3574.6067932527403, 3659.359612067904, 3695.815209239527, 3728.2357116790995, 3730.682891954187, 973.3429934794057, 1117.7876203521387, 1130.6212418839698, 1138.6071805227184, 1145.7823013627385, 12443.564475243413, 12503.56237531682, 12547.686307842285, 12560.371981400986, 12560.748785024249, 4528.275475923902, 4578.427696537933, 4773.04539092176, 4774.355462012653, 4776.8566942991765, 9494.95252523733, 9499.145076943109, 9504.239660827117, 9505.762355941019, 9514.0, 5386.811461598903, 5440.727963601883, 5443.918341224885, 5447.237386765856, 5448.37343705471, 4609.677322587454, 4813.831515896927, 5100.438951715309, 5105.795768169306, 5113.53978141969, 3264.5103234515013, 3916.3929590913453, 3959.247742928834, 3993.281209382281, 4033.91932161361, 1197.862245841722, 1203.7712834561405, 1208.9455974480993, 1216.6593353860933, 1217.592106644284, 835.1231207232381, 901.378049146087, 907.5825120444538, 908.9954550227206, 939.8825146856643, 5841.591088623841, 5869.618474799125, 5904.704764761745, 6173.6913154343, 6290.968545157337, 434.4959846577954, 446.2658926066602, 455.1193440692271, 455.897423079811, 456.7442232349895, 3862.4978752761963, 3942.113024569449, 3974.3044967130636, 4016.1365306458665, 4023.657989070962, 10040.146587539995, 11106.777864442827, 11194.832077518844, 11207.551697932155, 11223.719407014727, 10816.351018938889, 10978.560857565768, 11184.496697648625, 11193.94403027996, 11206.887931120584, 6761.0, 8502.234798868009, 8508.446950948168, 8624.00823905259, 8624.827503449897, 5895.086261629454, 5981.940180598138, 5983.581149319506, 6042.728077236623, 6196.0, 10088.798224035332, 10476.0, 10664.306820056672, 10707.892921071001, 10715.35707857531, 10446.164306855586, 10548.525316360628, 10602.151827853908, 10712.785744284914, 10959.452027398758, 7170.96414517924, 7371.41028717712, 7632.084149902047, 7758.844823103619, 7981.561014144278, 8718.346124040596, 8897.065808090058, 8898.822023559364, 8914.86627700598, 8920.55397230123, 7793.805154871174, 7879.724209652634, 7919.406044546798, 8004.439689221698, 8073.15231900642, 7635.656395462106, 7728.652210650422, 7737.0, 7814.843703126019, 7827.647755850887, 6143.508519318354, 7084.25615310385, 7209.0988626421695, 7216.134063912364, 7219.494635375473, 4948.356713627206, 5066.771995260148, 5081.669691470042, 5219.060569097599, 5352.090144675492, 5113.974430127825, 5128.051310507568, 5158.690478571298, 5384.784608615611, 5411.891762164813], "value": 4599.591176407058, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.61570072551694, 300.7383576288629, 310.10225397474306, 311.26386096880884, 321.69599728256776, 5079.720615366154, 5133.691978481289, 5317.331041581307, 5337.332833395825, 5380.21986811912, 4123.299039163342, 4146.025683964266, 4328.783560821962, 4989.501049895009, 5274.498922602346, 3709.7959612221316, 4069.250222404365, 4097.877063688086, 4101.692373072016, 4129.669626429878, 3336.6663333666684, 3797.8670746523876, 3998.580149084348, 4135.813888375031, 4152.691902050859, 3241.6658423187214, 3621.149029977953, 3759.9624003759886, 4128.97935510322, 4148.336266197409, 3699.5375578052744, 3716.447351993813, 4019.4774679291795, 4059.1272876331436, 4078.5105787305415, 2912.2137023003884, 3455.4125798614295, 3469.6877281044826, 3494.3884820156372, 3496.9825150874335, 4301.612854843079, 5137.691738495702, 5173.741312934339, 5177.145770947789, 5187.377514698261, 3708.7575662153213, 4029.4157347184496, 4531.705439146445, 4637.5130611286, 4669.2062349400685, 5120.769565369567, 5462.453754624546, 5556.249906262643, 5670.291213598301, 5685.204071430003, 3768.302863970147, 3847.576766555677, 3900.2394533066063, 3907.9804600976813, 3908.921821563581, 5327.493888080588, 5504.174373843955, 5784.479396854304, 5878.2358293421585, 5932.851678708023, 3762.266358060152, 3876.282887665791, 3879.767213967171, 3891.280113179071, 3891.416287556889, 3175.6189257289275, 3291.901242962715, 3957.604239576019, 3961.3859851723028, 3972.7355407417494, 3798.772073675588, 4285.764282964405, 4557.111363284194, 4591.530710172713, 4598.3102534620075, 4491.775411229491, 4884.755762211947, 5539.667619942817, 5613.550915926716, 5681.857953551194, 1342.590509894472, 1355.8881716991973, 1358.6807100331414, 1360.251861476184, 1365.6244532753572, 785.5483097219122, 822.9629666665014, 841.9326453883674, 841.9579021048924, 845.8604330285557, 3882.5340959084524, 4414.953681959502, 4431.889202769892, 4482.529334419839, 4559.338895860082, 4036.0, 4215.683823713233, 4378.868633940987, 4602.470715867651, 4799.928001079987, 4068.497873807646, 4485.474938520919, 4493.59557639814, 4511.593956543927, 4557.5442455754155, 2121.4166104321125, 2293.988530057339, 2381.9761802381754, 2395.73646898841, 2570.7686308231973, 4086.4687590613626, 4147.647449966787, 4304.74171549708, 4832.414658157869, 5031.52200540948, 4392.824287028483, 4978.850634480971, 4986.7257300848805, 4994.70031798086, 5668.291463567054, 4855.6601037927, 5860.472557469848, 5953.226080609493, 6023.638581685201, 6041.365656606169, 5704.229928959703, 5795.275590551181, 5809.564282678901, 5821.679807610622, 5830.0, 5504.944950550604, 5657.773689052392, 5693.174489699053, 5724.195144379308, 5737.627054241461, 5099.69401835891, 5921.644701317935, 5926.911096333472, 5964.373740757332, 6012.0, 3314.8176850272503, 3863.111484358557, 3902.317094508506, 3903.9609603904732, 3921.6862650988423, 5523.779048838162, 5751.798687045934, 5774.9133762994425, 5805.10020946754, 5811.651300921958, 4369.388285640077, 4702.318163866152, 4948.653594248368, 5626.539678098022, 5678.602497825278, 5402.810901618424, 5515.58633102527, 5641.351244606923, 5677.240055582783, 5681.147827825859, 5504.53211477029, 5542.528885044816, 5550.611457197957, 5554.111342185231, 5554.527865131509, 5598.804041858515, 5621.915671264853, 5637.520810731134, 5642.887142257214, 5654.660720356792, 5119.74401279927, 5459.972700136474, 5488.643238189505, 5537.944620553904, 5581.134924086773], "value": 3940.7797782000366, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.8493173967596, 731.7109741652044, 753.190320405564, 783.2950344689779, 839.8866153069338, 15846.128462934534, 16613.169341532906, 16636.66726665466, 16638.584035399104, 16668.333266669335, 14951.626209344771, 15015.849841501582, 15034.624134396645, 15056.774148387783, 15127.0, 712.657924196386, 734.9706011759523, 886.4592598514917, 886.521278509604, 923.3029063057415, 889.7419748273026, 905.7237542549519, 905.7916679163764, 906.6464079009158, 908.5184852028435, 956.273232343417, 956.4930586788978, 956.956936937836, 957.4638202606562, 958.0993865766193, 952.1573407534347, 955.6941778630841, 956.1729104324744, 956.6556039825692, 958.5542722633938, 712.1525384792133, 712.3802292005988, 712.704227745485, 712.8823744082221, 713.4114355656552, 15390.461333853373, 15423.0, 15441.0735355879, 15447.922760386125, 15455.227238638136, 14273.643158921006, 14503.637409064751, 14554.053986490844, 14554.781678274834, 14657.60752728489, 11674.70813229676, 11827.172097953147, 12159.331236781973, 12362.44369003397, 12867.678308042281, 3905.6484916357663, 3960.841566337343, 3968.603139686037, 4001.9399709004097, 4096.836126554964, 118926.40536797348, 123419.0, 123737.0, 123780.0, 123831.0, 11217.270877392943, 11545.249558778652, 11623.6512904613, 11667.88332116685, 11700.0, 22822.31533054011, 23263.41841453977, 23316.7668323318, 23472.061117555448, 23520.411989700053, 7199.388052015533, 7952.005999250094, 7959.562224077731, 8031.718889838944, 8089.514629122272, 4458.175237581057, 4485.686001979895, 4568.0, 4669.929951050737, 4810.062037902575, 3702.259548090393, 3849.0762217068263, 3855.132595166065, 3858.6720128789366, 3859.845606175778, 690.7824035428924, 691.5988726538595, 693.3551796828897, 698.5773606967813, 700.3941590524262, 586.1442294250357, 611.9296280927662, 711.6335087429977, 720.5712601002396, 738.9519681220703, 9038.548072596344, 9740.381855433356, 9973.30186886911, 10058.765623601683, 10127.657872902071, 568.4486048532916, 607.9787207447719, 680.2415306932834, 698.3261152987392, 743.9256074392625, 4613.0, 4670.462896766848, 4865.172920603506, 4871.342368780241, 4923.926141107886, 78104.0, 91168.0, 92003.539982301, 147843.0, 152295.0, 100579.0, 127292.36353818171, 130722.0, 130940.0, 135222.0, 110647.0, 111624.44187779009, 112227.31659024958, 113090.43454782838, 113515.0, 9258.35191536613, 9432.811343773223, 9499.287553433382, 9512.809743805223, 9519.666811661835, 49084.0, 49997.75001124971, 60729.0, 60746.69626651838, 62512.37487625066, 60813.08780368386, 74087.0, 83219.7517037257, 96254.03745962451, 97441.0, 11754.529818807494, 12010.159288849696, 12089.697757556132, 12175.695607609881, 12236.938815305866, 13409.798853017408, 13610.659733506345, 13752.31238438094, 13890.58328250154, 14410.42358305656, 12217.144799863925, 12451.937740311241, 12517.247585338242, 12558.686032849251, 12627.715504414171, 12620.495180193057, 12723.681907952376, 12730.0, 12963.481460741841, 13283.535076272285, 11873.287602743863, 12279.815802763145, 12525.185862918881, 12549.623511294676, 13074.954003679873, 10323.32898361604, 10506.422146782, 10867.673969780919, 10984.568161838137, 11056.170787190831, 9325.440473571607, 10216.722909636295, 11001.889981100087, 11304.378259195822, 11305.604303849655], "value": 7865.080720304225, "unit": "score"}], "name": "dromaeo_css", "value": 7548.377688323477, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 112.0, 113.0, 114.0, 114.0, 113.0, 116.0, 162.0, 168.0], "value": 123.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 110.0, 139.0, 107.0, 106.0, 107.0, 108.0, 138.0, 107.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 182.0, 183.0, 183.0, 185.0, 180.0, 183.0, 195.0, 260.0], "value": 191.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 56.0, 88.0, 61.0, 58.0, 59.0, 57.0, 81.0, 58.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 92.0, 68.0, 68.0, 68.0, 91.0, 68.0, 68.0, 89.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 85.0, 89.0, 84.0, 88.0, 85.0, 88.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 106.0, 146.0, 93.0, 93.0, 92.0, 92.0, 94.0, 95.0, 92.0], "value": 99.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 86.0, 86.0, 85.0, 86.0, 86.0, 84.0, 83.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 52.0, 53.0, 56.0, 57.0, 56.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 68.0, 73.0, 75.0, 70.0, 67.0, 68.0, 69.0, 68.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 90.0, 84.0, 80.0, 83.0, 83.0, 81.0, 82.0, 89.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 138.0, 143.0, 142.0, 145.0, 133.0, 137.0, 140.0, 167.0, 145.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 157.0, 160.0, 159.0, 171.0, 157.0, 217.0, 214.0, 160.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 66.0, 57.0, 56.0, 75.0, 81.0, 84.0, 81.0, 66.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1437.8000000000004, "alertThreshold": 2.0}]} 22:01:30 INFO - Return code: 0 22:01:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:01:30 INFO - # TBPL SUCCESS # 22:01:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:01:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:01:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:01:30 INFO - 2017-01-01 22:01:30.987 screenresolution[1650:10261] starting screenresolution argv=screenresolution get 22:01:30 INFO - 2017-01-01 22:01:30.990 screenresolution[1650:10261] Display 0: 1600x1200x32@60 22:01:30 INFO - 2017-01-01 22:01:30.996 screenresolution[1651:10264] starting screenresolution argv=screenresolution list 22:01:30 INFO - Available Modes on Display 0 22:01:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:01:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:01:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:01:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:01:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:01:31 INFO - Intel Iris: 22:01:31 INFO - Chipset Model: Intel Iris 22:01:31 INFO - Type: GPU 22:01:31 INFO - Bus: Built-In 22:01:31 INFO - VRAM (Dynamic, Max): 1536 MB 22:01:31 INFO - Vendor: Intel (0x8086) 22:01:31 INFO - Device ID: 0x0a2e 22:01:31 INFO - Revision ID: 0x0009 22:01:31 INFO - Displays: 22:01:31 INFO - Display: 22:01:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:01:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:01:31 INFO - Display Serial Number: 1600x1200 60 22:01:31 INFO - Main Display: Yes 22:01:31 INFO - Mirror: Off 22:01:31 INFO - Online: Yes 22:01:31 INFO - Rotation: Supported 22:01:31 INFO - Return code: 0 22:01:31 INFO - Running post-action listener: _resource_record_post_action 22:01:31 INFO - [mozharness: 2017-01-02 06:01:31.231421Z] Finished run-tests step (success) 22:01:31 INFO - Running post-run listener: _resource_record_post_run 22:01:31 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 37741568; Write bytes: 496755712; Read time: 241; Write time: 1597 22:01:31 INFO - TinderboxPrint: CPU usage
53.5% 22:01:31 INFO - TinderboxPrint: I/O read bytes / time
37,741,568 / 241 22:01:31 INFO - TinderboxPrint: I/O write bytes / time
496,755,712 / 1,597 22:01:31 INFO - TinderboxPrint: CPU idle
2,224.2 (46.5%) 22:01:31 INFO - TinderboxPrint: CPU system
958.9 (20.1%) 22:01:31 INFO - TinderboxPrint: CPU user
1,598.6 (33.4%) 22:01:31 INFO - TinderboxPrint: Swap in / out
233,054,208 / 0 22:01:31 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192619008; Write bytes: 187598848; Read time: 17682; Write time: 430 22:01:31 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 35701760; Write bytes: 297868288; Read time: 224; Write time: 1128 22:01:31 INFO - Running post-run listener: _upload_blobber_files 22:01:31 INFO - Blob upload gear active. 22:01:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:01:31 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 22:01:31 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'] 22:01:31 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 22:01:32 INFO - (blobuploader) - INFO - Open directory for files ... 22:01:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:01:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:01:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:01:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:32 INFO - (blobuploader) - INFO - Done attempting. 22:01:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:01:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:01:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:01:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:33 INFO - (blobuploader) - INFO - Done attempting. 22:01:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:01:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:01:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:01:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:36 INFO - (blobuploader) - INFO - Done attempting. 22:01:36 INFO - (blobuploader) - INFO - Iteration through files over. 22:01:36 INFO - Return code: 0 22:01:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:01:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:01:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/045f8358fdd6d509101168bbd28fd11c41d577c7d9f3d1ce50631c8d71ee0882a08d2cca0ec49efbe2308ac267b596af889d10ee2c95efcd0b38d4323992d097", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c4b28578240511d9ee451367907a5de4ff6f6f8dd0442e3c3b325e14143d3e7b53b36647232f3730959ead99204426823eaee7f2d5ef122aa413e7f742ff51a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d49bb729319af00659231256e90bf9027714d602655c5211a93b72d10d0942ecf85a5e70704039f5e94f68468b171acb8f14ec2148ca6f67b96715449cd03b5"} 22:01:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:01:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:01:36 INFO - Contents: 22:01:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/045f8358fdd6d509101168bbd28fd11c41d577c7d9f3d1ce50631c8d71ee0882a08d2cca0ec49efbe2308ac267b596af889d10ee2c95efcd0b38d4323992d097", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c4b28578240511d9ee451367907a5de4ff6f6f8dd0442e3c3b325e14143d3e7b53b36647232f3730959ead99204426823eaee7f2d5ef122aa413e7f742ff51a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d49bb729319af00659231256e90bf9027714d602655c5211a93b72d10d0942ecf85a5e70704039f5e94f68468b171acb8f14ec2148ca6f67b96715449cd03b5"} 22:01:36 INFO - Running post-run listener: copy_logs_to_upload_dir 22:01:36 INFO - Copying logs to upload dir... 22:01:36 INFO - mkdir: /builds/slave/test/build/upload/logs 22:01:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.543315 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-01-01 22:01:36.213808) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-01 22:01:36.217107) ========= 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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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/045f8358fdd6d509101168bbd28fd11c41d577c7d9f3d1ce50631c8d71ee0882a08d2cca0ec49efbe2308ac267b596af889d10ee2c95efcd0b38d4323992d097", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c4b28578240511d9ee451367907a5de4ff6f6f8dd0442e3c3b325e14143d3e7b53b36647232f3730959ead99204426823eaee7f2d5ef122aa413e7f742ff51a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d49bb729319af00659231256e90bf9027714d602655c5211a93b72d10d0942ecf85a5e70704039f5e94f68468b171acb8f14ec2148ca6f67b96715449cd03b5"} build_url:https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010911 build_url: 'https://queue.taskcluster.net/v1/task/b89KWTXcQOqmtPannuqdUA/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/045f8358fdd6d509101168bbd28fd11c41d577c7d9f3d1ce50631c8d71ee0882a08d2cca0ec49efbe2308ac267b596af889d10ee2c95efcd0b38d4323992d097", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c4b28578240511d9ee451367907a5de4ff6f6f8dd0442e3c3b325e14143d3e7b53b36647232f3730959ead99204426823eaee7f2d5ef122aa413e7f742ff51a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d49bb729319af00659231256e90bf9027714d602655c5211a93b72d10d0942ecf85a5e70704039f5e94f68468b171acb8f14ec2148ca6f67b96715449cd03b5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-01 22:01:36.250839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 22:01:36.251164) ========= 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.mQjhw8YGwL/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.6wQa4K9rQR/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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.005110 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-01 22:01:36.299663) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-01 22:01:36.299992) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-01 22:01:36.300366) ========= ========= Total master_lag: 0.21 =========