builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0346 starttime: 1479998955.92 results: success (0) buildid: 20161124041437 builduid: 47b065caa8894a05b753aae43ec92d6e revision: a2ccc1a66d96a413213b2433d3348c4a6884038e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 06:49:15.916302) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 06:49:15.916773) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 06:49:15.917050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 06:49:15.979098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 06:49:15.979578) ========= 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.UgnwXselT7/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.ewQFZGsgZX/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-24 06:49:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 176M=0s 2016-11-24 06:49:16 (176 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146342 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 06:49:16.150188) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 06:49:16.150545) ========= 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.UgnwXselT7/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.ewQFZGsgZX/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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.024396 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 06:49:16.199243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 06:49:16.199657) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a2ccc1a66d96a413213b2433d3348c4a6884038e --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 a2ccc1a66d96a413213b2433d3348c4a6884038e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UgnwXselT7/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.ewQFZGsgZX/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-24 06:49:16,296 truncating revision to first 12 chars 2016-11-24 06:49:16,296 Setting DEBUG logging. 2016-11-24 06:49:16,296 attempt 1/10 2016-11-24 06:49:16,296 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a2ccc1a66d96?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 06:49:17,069 unpacking tar archive at: mozilla-beta-a2ccc1a66d96/testing/mozharness/ program finished with exit code 0 elapsedTime=1.057313 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 06:49:17.281080) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 06:49:17.281569) ========= script_repo_revision: a2ccc1a66d96a413213b2433d3348c4a6884038e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 06:49:17.282131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 06:49:17.282520) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 06:49:17.302977) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-24 06:49:17.303380) ========= /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.UgnwXselT7/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.ewQFZGsgZX/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 06:49:17 INFO - MultiFileLogger online at 20161124 06:49:17 in /builds/slave/test 06:49:17 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 06:49:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:49:17 INFO - {'append_to_log': False, 06:49:17 INFO - 'base_work_dir': '/builds/slave/test', 06:49:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:49:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:49:17 INFO - 'branch': 'Mozilla-Beta', 06:49:17 INFO - 'buildbot_json_path': 'buildprops.json', 06:49:17 INFO - 'config_files': ('talos/mac_config.py',), 06:49:17 INFO - 'default_actions': ('clobber', 06:49:17 INFO - 'read-buildbot-config', 06:49:17 INFO - 'download-and-extract', 06:49:17 INFO - 'populate-webroot', 06:49:17 INFO - 'create-virtualenv', 06:49:17 INFO - 'install', 06:49:17 INFO - 'run-tests'), 06:49:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:49:17 INFO - 'download_minidump_stackwalk': True, 06:49:17 INFO - 'download_symbols': 'ondemand', 06:49:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:49:17 INFO - 'tooltool.py': '/tools/tooltool.py', 06:49:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:49:17 INFO - '/tools/misc-python/virtualenv.py')}, 06:49:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:49:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:49:17 INFO - 'installer_path': 'installer.exe', 06:49:17 INFO - 'log_level': 'info', 06:49:17 INFO - 'log_name': 'talos', 06:49:17 INFO - 'log_to_console': True, 06:49:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:49:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:49:17 INFO - 'opt_config_files': (), 06:49:17 INFO - 'pip_index': False, 06:49:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:49:17 INFO - 'cmd': ('bash', 06:49:17 INFO - '-c', 06:49:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:49:17 INFO - 'enabled': True, 06:49:17 INFO - 'halt_on_failure': False, 06:49:17 INFO - 'name': 'check_screen_resolution'},), 06:49:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:49:17 INFO - 'cmd': ('bash', 06:49:17 INFO - '-c', 06:49:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:49:17 INFO - 'enabled': True, 06:49:17 INFO - 'halt_on_failure': False, 06:49:17 INFO - 'name': 'check_screen_resolution'},), 06:49:17 INFO - 'run_cmd_checks_enabled': True, 06:49:17 INFO - 'sps_profile': False, 06:49:17 INFO - 'sps_profile_interval': 0, 06:49:17 INFO - 'suite': 'dromaeojs', 06:49:17 INFO - 'system_bits': '32', 06:49:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:49:17 INFO - 'title': 't-yosemite-r7-0346', 06:49:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:49:17 INFO - 'use_talos_json': True, 06:49:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:49:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:49:17 INFO - 'work_dir': 'build'} 06:49:17 INFO - [mozharness: 2016-11-24 14:49:17.500351Z] Running clobber step. 06:49:17 INFO - Running pre-action listener: _resource_record_pre_action 06:49:17 INFO - Running main action method: clobber 06:49:17 INFO - rmtree: /builds/slave/test/build 06:49:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:49:19 INFO - Running post-action listener: _resource_record_post_action 06:49:19 INFO - [mozharness: 2016-11-24 14:49:19.993914Z] Finished clobber step (success) 06:49:19 INFO - [mozharness: 2016-11-24 14:49:19.994121Z] Running read-buildbot-config step. 06:49:19 INFO - Running pre-action listener: _resource_record_pre_action 06:49:19 INFO - Running main action method: read_buildbot_config 06:49:19 INFO - Using buildbot properties: 06:49:19 INFO - { 06:49:19 INFO - "project": "", 06:49:19 INFO - "product": "firefox", 06:49:19 INFO - "script_repo_revision": "production", 06:49:19 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 06:49:19 INFO - "repository": "", 06:49:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 06:49:19 INFO - "buildid": "20161124041437", 06:49:19 INFO - "pgo_build": "False", 06:49:19 INFO - "basedir": "/builds/slave/test", 06:49:19 INFO - "buildnumber": 3, 06:49:19 INFO - "slavename": "t-yosemite-r7-0346", 06:49:19 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:49:19 INFO - "platform": "yosemite_r7", 06:49:19 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:49:19 INFO - "branch": "mozilla-beta", 06:49:19 INFO - "repo_path": "releases/mozilla-beta", 06:49:19 INFO - "revision": "a2ccc1a66d96a413213b2433d3348c4a6884038e", 06:49:19 INFO - "stage_platform": "macosx64", 06:49:19 INFO - "builduid": "47b065caa8894a05b753aae43ec92d6e", 06:49:19 INFO - "slavebuilddir": "test" 06:49:19 INFO - } 06:49:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 06:49:19 INFO - Running post-action listener: _resource_record_post_action 06:49:19 INFO - [mozharness: 2016-11-24 14:49:19.999608Z] Finished read-buildbot-config step (success) 06:49:19 INFO - [mozharness: 2016-11-24 14:49:19.999830Z] Running download-and-extract step. 06:49:20 INFO - Running pre-action listener: _resource_record_pre_action 06:49:20 INFO - Running main action method: download_and_extract 06:49:20 INFO - mkdir: /builds/slave/test/build/tests 06:49:20 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')]} 06:49:20 INFO - trying https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 06:49:20 INFO - Downloading https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/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 06:49:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/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 06:49:20 INFO - Downloaded 1165 bytes. 06:49:20 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 06:49:20 INFO - Using the following test package requirements: 06:49:20 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 06:49:20 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 06:49:20 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 06:49:20 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 06:49:20 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 06:49:20 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:49:20 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 06:49:20 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 06:49:20 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 06:49:20 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 06:49:20 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 06:49:20 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 06:49:20 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 06:49:20 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 06:49:20 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 06:49:20 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 06:49:20 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 06:49:20 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 06:49:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 06:49:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 06:49:20 INFO - Fetch https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 06:49:21 INFO - Expected file size: 16232594 06:49:28 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 06:49:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 06:49:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 06:49:28 INFO - Fetch https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 06:49:29 INFO - Expected file size: 16232594 06:49:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 06:49:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 06:49:36 INFO - Fetch https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 06:49:36 INFO - Expected file size: 14414089 06:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:37 INFO - trying https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 06:49:37 INFO - Downloading https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 06:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/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 06:49:39 INFO - Downloaded 86048289 bytes. 06:49:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 06:49:39 INFO - mkdir: /builds/slave/test/properties 06:49:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:49:39 INFO - Writing to file /builds/slave/test/properties/build_url 06:49:39 INFO - Contents: 06:49:39 INFO - build_url:https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 06:49:40 INFO - Running post-action listener: _resource_record_post_action 06:49:40 INFO - Running post-action listener: set_extra_try_arguments 06:49:40 INFO - [mozharness: 2016-11-24 14:49:40.625760Z] Finished download-and-extract step (success) 06:49:40 INFO - [mozharness: 2016-11-24 14:49:40.625912Z] Running populate-webroot step. 06:49:40 INFO - Running pre-action listener: _resource_record_pre_action 06:49:40 INFO - Running main action method: populate_webroot 06:49:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:49:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:49:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:49:40 INFO - '--tppagecycles', 06:49:40 INFO - '7'], 06:49:40 INFO - 'tests': ['tsvgm']}}, 06:49:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:49:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:49:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:49:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:49:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:49:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:49:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'talos_options': ['--disable-e10s'], 06:49:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'talos_options': ['--disable-e10s'], 06:49:40 INFO - 'tests': ['damp', 'tps']}, 06:49:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'tests': ['damp', 'tps']}, 06:49:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:49:40 INFO - 'tests': ['dromaeo_dom']}, 06:49:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:49:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:49:40 INFO - 'tests': ['basic_compositor_video']}, 06:49:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:49:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:49:40 INFO - 'tests': ['a11yr', 06:49:40 INFO - 'ts_paint', 06:49:40 INFO - 'tpaint', 06:49:40 INFO - 'sessionrestore', 06:49:40 INFO - 'sessionrestore_no_auto_restore', 06:49:40 INFO - 'tabpaint']}, 06:49:40 INFO - 'other-e10s': {'tests': ['a11yr', 06:49:40 INFO - 'ts_paint', 06:49:40 INFO - 'tpaint', 06:49:40 INFO - 'sessionrestore', 06:49:40 INFO - 'sessionrestore_no_auto_restore', 06:49:40 INFO - 'tabpaint']}, 06:49:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:49:40 INFO - 'ts_paint', 06:49:40 INFO - 'tpaint', 06:49:40 INFO - 'sessionrestore', 06:49:40 INFO - 'sessionrestore_no_auto_restore', 06:49:40 INFO - 'tabpaint']}, 06:49:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:49:40 INFO - 'ts_paint', 06:49:40 INFO - 'tpaint', 06:49:40 INFO - 'sessionrestore', 06:49:40 INFO - 'sessionrestore_no_auto_restore', 06:49:40 INFO - 'tabpaint']}, 06:49:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:49:40 INFO - 'tests': ['a11yr', 06:49:40 INFO - 'ts_paint', 06:49:40 INFO - 'tpaint', 06:49:40 INFO - 'sessionrestore', 06:49:40 INFO - 'sessionrestore_no_auto_restore', 06:49:40 INFO - 'tabpaint']}, 06:49:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:49:40 INFO - 'tests': ['a11yr', 06:49:40 INFO - 'ts_paint', 06:49:40 INFO - 'tpaint', 06:49:40 INFO - 'sessionrestore', 06:49:40 INFO - 'sessionrestore_no_auto_restore', 06:49:40 INFO - 'tabpaint']}, 06:49:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:49:40 INFO - 'tests': ['tsvgx', 06:49:40 INFO - 'tsvgr_opacity', 06:49:40 INFO - 'tart', 06:49:40 INFO - 'tscrollx', 06:49:40 INFO - 'cart']}, 06:49:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:49:40 INFO - 'tsvgr_opacity', 06:49:40 INFO - 'tart', 06:49:40 INFO - 'tscrollx', 06:49:40 INFO - 'cart']}, 06:49:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'talos_options': ['--disable-e10s'], 06:49:40 INFO - 'tests': ['tp5o']}, 06:49:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'tests': ['tp5o']}, 06:49:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'talos_options': ['--disable-e10s', 06:49:40 INFO - '--xperf_path', 06:49:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:40 INFO - 'tests': ['tp5n']}, 06:49:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'talos_options': ['--xperf_path', 06:49:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:40 INFO - 'tests': ['tp5n']}}, 06:49:40 INFO - 'talos.zip': {'path': '', 06:49:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:49:40 INFO - Running post-action listener: _resource_record_post_action 06:49:40 INFO - [mozharness: 2016-11-24 14:49:40.644947Z] Finished populate-webroot step (success) 06:49:40 INFO - [mozharness: 2016-11-24 14:49:40.645058Z] Running create-virtualenv step. 06:49:40 INFO - Running pre-action listener: _resource_record_pre_action 06:49:40 INFO - Running main action method: create_virtualenv 06:49:40 INFO - Creating virtualenv /builds/slave/test/build/venv 06:49:40 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 06:49:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:49:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:49:40 INFO - Using real prefix '/tools/python27' 06:49:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:49:41 INFO - Installing distribute.............................................................................................................................................................................................done. 06:49:44 INFO - Installing pip.................done. 06:49:44 INFO - Return code: 0 06:49:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:49:44 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')]} 06:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:44 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')]} 06:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:44 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 0x10a033490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9a1c65120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e47d30>, '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 0x109caddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e3fb20>, '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.UgnwXselT7/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.ewQFZGsgZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 06:49:44 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 06:49:44 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 06:49:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UgnwXselT7/Render', 06:49:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:44 INFO - 'HOME': '/Users/cltbld', 06:49:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:44 INFO - 'LOGNAME': 'cltbld', 06:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:44 INFO - 'MOZ_NO_REMOTE': '1', 06:49:44 INFO - 'NO_EM_RESTART': '1', 06:49:44 INFO - 'PAGER': '/bin/cat', 06:49:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:44 INFO - 'PWD': '/builds/slave/test', 06:49:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:44 INFO - 'SHELL': '/bin/bash', 06:49:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ewQFZGsgZX/Listeners', 06:49:44 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 06:49:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:44 INFO - 'USER': 'cltbld', 06:49:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:44 INFO - 'XPC_FLAGS': '0x0', 06:49:44 INFO - 'XPC_SERVICE_NAME': '0', 06:49:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:44 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 06:49:44 INFO - Cleaning up... 06:49:44 INFO - Return code: 0 06:49:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:49:44 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')]} 06:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:44 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')]} 06:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:44 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 0x10a033490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9a1c65120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e47d30>, '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 0x109caddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e3fb20>, '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.UgnwXselT7/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.ewQFZGsgZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 06:49:44 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 06:49:44 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 06:49:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UgnwXselT7/Render', 06:49:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:44 INFO - 'HOME': '/Users/cltbld', 06:49:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:44 INFO - 'LOGNAME': 'cltbld', 06:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:44 INFO - 'MOZ_NO_REMOTE': '1', 06:49:44 INFO - 'NO_EM_RESTART': '1', 06:49:44 INFO - 'PAGER': '/bin/cat', 06:49:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:44 INFO - 'PWD': '/builds/slave/test', 06:49:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:44 INFO - 'SHELL': '/bin/bash', 06:49:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ewQFZGsgZX/Listeners', 06:49:44 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 06:49:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:44 INFO - 'USER': 'cltbld', 06:49:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:44 INFO - 'XPC_FLAGS': '0x0', 06:49:44 INFO - 'XPC_SERVICE_NAME': '0', 06:49:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:44 INFO - Downloading/unpacking psutil>=3.1.1 06:49:44 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 06:49:44 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 06:49:44 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 06:49:44 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 06:49:44 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 06:49:44 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 06:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:49:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:48 INFO - Installing collected packages: psutil 06:49:48 INFO - Running setup.py install for psutil 06:49:48 INFO - building 'psutil._psutil_osx' extension 06:49:48 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 06:49:48 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 06:49:48 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 06:49:49 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 06:49:49 INFO - building 'psutil._psutil_posix' extension 06:49:49 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 06:49:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:49:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:49:49 INFO - ^ 06:49:49 INFO - 1 warning generated. 06:49:49 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 06:49:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:49 INFO - Successfully installed psutil 06:49:49 INFO - Cleaning up... 06:49:49 INFO - Return code: 0 06:49:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:49:49 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')]} 06:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:49 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')]} 06:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:49 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 0x10a033490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9a1c65120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e47d30>, '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 0x109caddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e3fb20>, '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.UgnwXselT7/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.ewQFZGsgZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 06:49:49 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 06:49:49 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 06:49:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UgnwXselT7/Render', 06:49:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:49 INFO - 'HOME': '/Users/cltbld', 06:49:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:49 INFO - 'LOGNAME': 'cltbld', 06:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:49 INFO - 'MOZ_NO_REMOTE': '1', 06:49:49 INFO - 'NO_EM_RESTART': '1', 06:49:49 INFO - 'PAGER': '/bin/cat', 06:49:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:49 INFO - 'PWD': '/builds/slave/test', 06:49:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:49 INFO - 'SHELL': '/bin/bash', 06:49:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ewQFZGsgZX/Listeners', 06:49:49 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 06:49:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:49 INFO - 'USER': 'cltbld', 06:49:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:49 INFO - 'XPC_FLAGS': '0x0', 06:49:49 INFO - 'XPC_SERVICE_NAME': '0', 06:49:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:49:52 INFO - Installing collected packages: mozsystemmonitor 06:49:52 INFO - Running setup.py install for mozsystemmonitor 06:49:52 INFO - Successfully installed mozsystemmonitor 06:49:52 INFO - Cleaning up... 06:49:52 INFO - Return code: 0 06:49:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a033490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9a1c65120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e47d30>, '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 0x109caddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e3fb20>, '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.UgnwXselT7/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.ewQFZGsgZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 06:49:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:49:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UgnwXselT7/Render', 06:49:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:52 INFO - 'HOME': '/Users/cltbld', 06:49:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:52 INFO - 'LOGNAME': 'cltbld', 06:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:52 INFO - 'MOZ_NO_REMOTE': '1', 06:49:52 INFO - 'NO_EM_RESTART': '1', 06:49:52 INFO - 'PAGER': '/bin/cat', 06:49:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:52 INFO - 'PWD': '/builds/slave/test', 06:49:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:52 INFO - 'SHELL': '/bin/bash', 06:49:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ewQFZGsgZX/Listeners', 06:49:52 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 06:49:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:52 INFO - 'USER': 'cltbld', 06:49:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:52 INFO - 'XPC_FLAGS': '0x0', 06:49:52 INFO - 'XPC_SERVICE_NAME': '0', 06:49:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:52 INFO - Downloading/unpacking jsonschema==2.5.1 06:49:52 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 06:49:52 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 06:49:52 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 06:49:52 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 06:49:52 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 06:49:52 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 06:49:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:49:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:49:55 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 06:49:55 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 06:49:55 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 06:49:55 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 06:49:55 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 06:49:55 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 06:49:55 INFO - Downloading functools32-3.2.3-2.tar.gz 06:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:49:55 INFO - warning: no files found matching '*.txt' 06:49:55 INFO - no previously-included directories found matching 'build' 06:49:55 INFO - no previously-included directories found matching 'dist' 06:49:55 INFO - no previously-included directories found matching '.git*' 06:49:55 INFO - Installing collected packages: jsonschema, functools32 06:49:56 INFO - Running setup.py install for functools32 06:49:56 INFO - warning: no files found matching '*.txt' 06:49:56 INFO - no previously-included directories found matching 'build' 06:49:56 INFO - no previously-included directories found matching 'dist' 06:49:56 INFO - no previously-included directories found matching '.git*' 06:49:56 INFO - Successfully installed jsonschema functools32 06:49:56 INFO - Cleaning up... 06:49:56 INFO - Return code: 0 06:49:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:56 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 0x10a033490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9a1c65120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e47d30>, '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 0x109caddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e3fb20>, '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.UgnwXselT7/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.ewQFZGsgZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 06:49:56 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 06:49:56 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 06:49:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UgnwXselT7/Render', 06:49:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:56 INFO - 'HOME': '/Users/cltbld', 06:49:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:56 INFO - 'LOGNAME': 'cltbld', 06:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:56 INFO - 'MOZ_NO_REMOTE': '1', 06:49:56 INFO - 'NO_EM_RESTART': '1', 06:49:56 INFO - 'PAGER': '/bin/cat', 06:49:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:56 INFO - 'PWD': '/builds/slave/test', 06:49:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:56 INFO - 'SHELL': '/bin/bash', 06:49:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ewQFZGsgZX/Listeners', 06:49:56 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 06:49:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:56 INFO - 'USER': 'cltbld', 06:49:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:56 INFO - 'XPC_FLAGS': '0x0', 06:49:56 INFO - 'XPC_SERVICE_NAME': '0', 06:49:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:49:56 INFO - Cleaning up... 06:49:56 INFO - Return code: 0 06:49:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:56 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 0x10a033490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9a1c65120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e47d30>, '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 0x109caddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e3fb20>, '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.UgnwXselT7/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.ewQFZGsgZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 06:49:56 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 06:49:56 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 06:49:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UgnwXselT7/Render', 06:49:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:56 INFO - 'HOME': '/Users/cltbld', 06:49:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:56 INFO - 'LOGNAME': 'cltbld', 06:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:56 INFO - 'MOZ_NO_REMOTE': '1', 06:49:56 INFO - 'NO_EM_RESTART': '1', 06:49:56 INFO - 'PAGER': '/bin/cat', 06:49:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:56 INFO - 'PWD': '/builds/slave/test', 06:49:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:56 INFO - 'SHELL': '/bin/bash', 06:49:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ewQFZGsgZX/Listeners', 06:49:56 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 06:49:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:56 INFO - 'USER': 'cltbld', 06:49:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:56 INFO - 'XPC_FLAGS': '0x0', 06:49:56 INFO - 'XPC_SERVICE_NAME': '0', 06:49:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:56 INFO - Downloading/unpacking blobuploader==1.2.4 06:49:56 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 06:49:56 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 06:49:56 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 06:49:56 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 06:49:56 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 06:49:56 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 06:49:59 INFO - Downloading blobuploader-1.2.4.tar.gz 06:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:49:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:49:59 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 06:49:59 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 06:49:59 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 06:49:59 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 06:49:59 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 06:49:59 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 06:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:50:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:50:00 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 06:50:00 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 06:50:00 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 06:50:00 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 06:50:00 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 06:50:00 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 06:50:00 INFO - Downloading docopt-0.6.1.tar.gz 06:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:50:00 INFO - Installing collected packages: blobuploader, requests, docopt 06:50:00 INFO - Running setup.py install for blobuploader 06:50:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:50:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:50:00 INFO - Running setup.py install for requests 06:50:01 INFO - Running setup.py install for docopt 06:50:01 INFO - Successfully installed blobuploader requests docopt 06:50:01 INFO - Cleaning up... 06:50:01 INFO - Return code: 0 06:50:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:01 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')]} 06:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:01 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')]} 06:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:01 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 0x10a033490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9a1c65120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e47d30>, '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 0x109caddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e3fb20>, '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.UgnwXselT7/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.ewQFZGsgZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 06:50:01 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 06:50:01 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 06:50:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UgnwXselT7/Render', 06:50:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:01 INFO - 'HOME': '/Users/cltbld', 06:50:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:01 INFO - 'LOGNAME': 'cltbld', 06:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:01 INFO - 'MOZ_NO_REMOTE': '1', 06:50:01 INFO - 'NO_EM_RESTART': '1', 06:50:01 INFO - 'PAGER': '/bin/cat', 06:50:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:01 INFO - 'PWD': '/builds/slave/test', 06:50:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:01 INFO - 'SHELL': '/bin/bash', 06:50:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ewQFZGsgZX/Listeners', 06:50:01 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 06:50:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:01 INFO - 'USER': 'cltbld', 06:50:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:01 INFO - 'XPC_FLAGS': '0x0', 06:50:01 INFO - 'XPC_SERVICE_NAME': '0', 06:50:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:01 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-eZ_lih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:01 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-GI7GYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:01 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-yEnvjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:02 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-aGjzin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:02 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-vAfxtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:02 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-joFOQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:02 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-bxNXfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:02 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-DbOkX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:02 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-aNDKUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:02 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-ObPUi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:02 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Dz9NLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:02 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-_S4aQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:02 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-4jKw4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:03 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-jLUBVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:03 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-ZAxq5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:03 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-q22QoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:03 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-zCp3jO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:50:03 INFO - Running setup.py install for manifestparser 06:50:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:50:03 INFO - Running setup.py install for mozcrash 06:50:03 INFO - Running setup.py install for mozdebug 06:50:03 INFO - Running setup.py install for mozdevice 06:50:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:50:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:50:04 INFO - Running setup.py install for mozfile 06:50:04 INFO - Running setup.py install for mozhttpd 06:50:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:50:04 INFO - Running setup.py install for mozinfo 06:50:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:50:04 INFO - Running setup.py install for mozInstall 06:50:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:50:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:50:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:50:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:50:04 INFO - Running setup.py install for mozleak 06:50:04 INFO - Running setup.py install for mozlog 06:50:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:50:04 INFO - Running setup.py install for moznetwork 06:50:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:50:05 INFO - Running setup.py install for mozprocess 06:50:05 INFO - Running setup.py install for mozprofile 06:50:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:50:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:50:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:50:05 INFO - Running setup.py install for mozrunner 06:50:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:50:05 INFO - Running setup.py install for mozscreenshot 06:50:05 INFO - Running setup.py install for moztest 06:50:05 INFO - Running setup.py install for mozversion 06:50:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:50:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:50:06 INFO - Cleaning up... 06:50:06 INFO - Return code: 0 06:50:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:06 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 0x10a033490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9a1c65120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e47d30>, '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 0x109caddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e3fb20>, '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.UgnwXselT7/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.ewQFZGsgZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 06:50:06 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 06:50:06 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 06:50:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UgnwXselT7/Render', 06:50:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:06 INFO - 'HOME': '/Users/cltbld', 06:50:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:06 INFO - 'LOGNAME': 'cltbld', 06:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:06 INFO - 'MOZ_NO_REMOTE': '1', 06:50:06 INFO - 'NO_EM_RESTART': '1', 06:50:06 INFO - 'PAGER': '/bin/cat', 06:50:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:06 INFO - 'PWD': '/builds/slave/test', 06:50:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:06 INFO - 'SHELL': '/bin/bash', 06:50:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ewQFZGsgZX/Listeners', 06:50:06 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 06:50:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:06 INFO - 'USER': 'cltbld', 06:50:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:06 INFO - 'XPC_FLAGS': '0x0', 06:50:06 INFO - 'XPC_SERVICE_NAME': '0', 06:50:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:06 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-wufq3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:06 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)) 06:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:06 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-CnR29k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:06 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)) 06:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:06 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-7QojiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:06 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)) 06:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:06 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-rPUhP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:06 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)) 06:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:06 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-UJ5I6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:06 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)) 06:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:06 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-__IN_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:06 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)) 06:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:06 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-XYsLya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:07 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)) 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:07 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-2a344N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:07 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)) 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:07 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-mpxfsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:07 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)) 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:07 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-V4n76N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:07 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)) 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:07 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-XuFyrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:07 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)) 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:07 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-w7E83h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:07 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)) 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:07 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Gn2xKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:07 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)) 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:07 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Q1kQTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:07 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)) 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:07 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-pBwSkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:07 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)) 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:07 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Hbuh0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:07 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)) 06:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:07 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-RKjIp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:08 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)) 06:50:08 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)) 06:50:08 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)) 06:50:08 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)) 06:50:08 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)) 06:50:08 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)) 06:50:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:10 INFO - Downloading blessings-1.6.tar.gz 06:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:50:10 INFO - Installing collected packages: blessings 06:50:10 INFO - Running setup.py install for blessings 06:50:10 INFO - Successfully installed blessings 06:50:10 INFO - Cleaning up... 06:50:10 INFO - Return code: 0 06:50:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:50:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:50:11 INFO - Reading from file tmpfile_stdout 06:50:11 INFO - Current package versions: 06:50:11 INFO - blessings == 1.6 06:50:11 INFO - blobuploader == 1.2.4 06:50:11 INFO - docopt == 0.6.1 06:50:11 INFO - functools32 == 3.2.3-2 06:50:11 INFO - jsonschema == 2.5.1 06:50:11 INFO - manifestparser == 1.1 06:50:11 INFO - mozInstall == 1.12 06:50:11 INFO - mozcrash == 0.17 06:50:11 INFO - mozdebug == 0.1 06:50:11 INFO - mozdevice == 0.48 06:50:11 INFO - mozfile == 1.2 06:50:11 INFO - mozhttpd == 0.7 06:50:11 INFO - mozinfo == 0.9 06:50:11 INFO - mozleak == 0.1 06:50:11 INFO - mozlog == 3.4 06:50:11 INFO - moznetwork == 0.27 06:50:11 INFO - mozprocess == 0.23 06:50:11 INFO - mozprofile == 0.28 06:50:11 INFO - mozrunner == 6.12 06:50:11 INFO - mozscreenshot == 0.1 06:50:11 INFO - mozsystemmonitor == 0.3 06:50:11 INFO - moztest == 0.7 06:50:11 INFO - mozversion == 1.4 06:50:11 INFO - psutil == 3.1.1 06:50:11 INFO - requests == 1.2.3 06:50:11 INFO - wsgiref == 0.1.2 06:50:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:11 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 0x10a033490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9a1c65120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e47d30>, '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 0x109caddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e3fb20>, '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.UgnwXselT7/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.ewQFZGsgZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 06:50:11 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 06:50:11 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 06:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UgnwXselT7/Render', 06:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:11 INFO - 'HOME': '/Users/cltbld', 06:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:11 INFO - 'LOGNAME': 'cltbld', 06:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:11 INFO - 'MOZ_NO_REMOTE': '1', 06:50:11 INFO - 'NO_EM_RESTART': '1', 06:50:11 INFO - 'PAGER': '/bin/cat', 06:50:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:11 INFO - 'PWD': '/builds/slave/test', 06:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:11 INFO - 'SHELL': '/bin/bash', 06:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ewQFZGsgZX/Listeners', 06:50:11 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 06:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:11 INFO - 'USER': 'cltbld', 06:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:11 INFO - 'XPC_FLAGS': '0x0', 06:50:11 INFO - 'XPC_SERVICE_NAME': '0', 06:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:11 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)) 06:50:11 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)) 06:50:11 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)) 06:50:11 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)) 06:50:11 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)) 06:50:11 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)) 06:50:11 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)) 06:50:11 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)) 06:50:11 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)) 06:50:11 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)) 06:50:11 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)) 06:50:11 INFO - Cleaning up... 06:50:11 INFO - Return code: 0 06:50:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a033490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fa9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9a1c65120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e47d30>, '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 0x109caddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e3fb20>, '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.UgnwXselT7/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.ewQFZGsgZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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 06:50:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UgnwXselT7/Render', 06:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:11 INFO - 'HOME': '/Users/cltbld', 06:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:11 INFO - 'LOGNAME': 'cltbld', 06:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:11 INFO - 'MOZ_NO_REMOTE': '1', 06:50:11 INFO - 'NO_EM_RESTART': '1', 06:50:11 INFO - 'PAGER': '/bin/cat', 06:50:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:11 INFO - 'PWD': '/builds/slave/test', 06:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:11 INFO - 'SHELL': '/bin/bash', 06:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ewQFZGsgZX/Listeners', 06:50:11 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 06:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:11 INFO - 'USER': 'cltbld', 06:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:11 INFO - 'XPC_FLAGS': '0x0', 06:50:11 INFO - 'XPC_SERVICE_NAME': '0', 06:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:50:11 INFO - Cleaning up... 06:50:11 INFO - Return code: 0 06:50:11 INFO - Running post-action listener: _resource_record_post_action 06:50:11 INFO - Running post-action listener: _start_resource_monitoring 06:50:11 INFO - Starting resource monitoring. 06:50:11 INFO - [mozharness: 2016-11-24 14:50:11.842722Z] Finished create-virtualenv step (success) 06:50:11 INFO - [mozharness: 2016-11-24 14:50:11.843692Z] Running install step. 06:50:11 INFO - Running pre-action listener: _resource_record_pre_action 06:50:11 INFO - Running main action method: install 06:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:50:12 INFO - Reading from file tmpfile_stdout 06:50:12 INFO - Detecting whether we're running mozinstall >=1.0... 06:50:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:50:12 INFO - Reading from file tmpfile_stdout 06:50:12 INFO - Output received: 06:50:12 INFO - Usage: mozinstall [options] installer 06:50:12 INFO - Options: 06:50:12 INFO - -h, --help show this help message and exit 06:50:12 INFO - -d DEST, --destination=DEST 06:50:12 INFO - Directory to install application into. [default: 06:50:12 INFO - "/builds/slave/test"] 06:50:12 INFO - --app=APP Application being installed. [default: firefox] 06:50:12 INFO - mkdir: /builds/slave/test/build/application 06:50:12 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'] 06:50:12 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 06:50:34 INFO - Reading from file tmpfile_stdout 06:50:34 INFO - Output received: 06:50:34 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:50:34 INFO - Running post-action listener: _resource_record_post_action 06:50:34 INFO - [mozharness: 2016-11-24 14:50:34.051917Z] Finished install step (success) 06:50:34 INFO - [mozharness: 2016-11-24 14:50:34.052064Z] Running run-tests step. 06:50:34 INFO - Running pre-action listener: _resource_record_pre_action 06:50:34 INFO - Running main action method: run_tests 06:50:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:50:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:50:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:50:34 INFO - 2016-11-24 06:50:34.066 screenresolution[1631:8045] starting screenresolution argv=screenresolution get 06:50:34 INFO - 2016-11-24 06:50:34.069 screenresolution[1631:8045] Display 0: 1600x1200x32@60 06:50:34 INFO - 2016-11-24 06:50:34.075 screenresolution[1632:8048] starting screenresolution argv=screenresolution list 06:50:34 INFO - Available Modes on Display 0 06:50:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:50:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:50:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:50:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:50:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:50:34 INFO - Intel Iris: 06:50:34 INFO - Chipset Model: Intel Iris 06:50:34 INFO - Type: GPU 06:50:34 INFO - Bus: Built-In 06:50:34 INFO - VRAM (Dynamic, Max): 1536 MB 06:50:34 INFO - Vendor: Intel (0x8086) 06:50:34 INFO - Device ID: 0x0a2e 06:50:34 INFO - Revision ID: 0x0009 06:50:34 INFO - Displays: 06:50:34 INFO - Display: 06:50:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:50:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:50:34 INFO - Display Serial Number: 1600x1200 60 06:50:34 INFO - Main Display: Yes 06:50:34 INFO - Mirror: Off 06:50:34 INFO - Online: Yes 06:50:34 INFO - Rotation: Supported 06:50:34 INFO - Return code: 0 06:50:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:50:34 INFO - Python 2.7.3 06:50:34 INFO - Return code: 0 06:50:34 INFO - grabbing minidump binary from tooltool 06:50: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')]} 06:50:34 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 0x109e47d30>, '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 0x109caddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e3fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:50:34 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 06:50:34 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 06:50:34 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 06:50:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:50:34 INFO - Return code: 0 06:50:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:50:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:50:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:50:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:50:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:50:34 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/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0346', '--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 06:50:34 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/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0346 --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 06:50:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UgnwXselT7/Render', 06:50:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:34 INFO - 'HOME': '/Users/cltbld', 06:50:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:34 INFO - 'LOGNAME': 'cltbld', 06:50:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:50:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:34 INFO - 'MOZ_NO_REMOTE': '1', 06:50:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:50:34 INFO - 'NO_EM_RESTART': '1', 06:50:34 INFO - 'PAGER': '/bin/cat', 06:50:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:34 INFO - 'PWD': '/builds/slave/test', 06:50:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:50:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:34 INFO - 'SHELL': '/bin/bash', 06:50:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ewQFZGsgZX/Listeners', 06:50:34 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 06:50:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:34 INFO - 'USER': 'cltbld', 06:50:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:34 INFO - 'XPC_FLAGS': '0x0', 06:50:34 INFO - 'XPC_SERVICE_NAME': '0', 06:50:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:34 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/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0346', '--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 06:50:34 INFO - mozversion application_buildid: 20161124041437 06:50:34 INFO - mozversion application_changeset: a2ccc1a66d96a413213b2433d3348c4a6884038e 06:50:34 INFO - mozversion application_display_name: Firefox 06:50:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:50:34 INFO - mozversion application_name: Firefox 06:50:34 INFO - mozversion application_remotingname: firefox 06:50:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:50:34 INFO - mozversion application_vendor: Mozilla 06:50:34 INFO - mozversion application_version: 51.0 06:50:34 INFO - mozversion platform_buildid: 20161124041437 06:50:34 INFO - mozversion platform_changeset: a2ccc1a66d96a413213b2433d3348c4a6884038e 06:50:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:50:34 INFO - mozversion platform_version: 51.0 06:50:34 INFO - using testdate: 1479999034 06:50:34 INFO - actual date: 1479999034 06:50:34 INFO - starting webserver on 'localhost:49241' 06:50:34 INFO - SUITE-START | Running 2 tests 06:50:34 INFO - TEST-START | dromaeo_css 06:50:34 INFO - operating with platform_type : mac_ 06:50:34 INFO - Initialising browser for dromaeo_css test... 06:50:34 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpY9M0B_/profile http://localhost:49241/getInfo.html) 06:50:37 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 06:50:37 INFO - PROCESS | 1642 | colorDepth:24 06:50:37 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 06:50:37 INFO - PROCESS | 1642 | __metrics 06:50:37 INFO - PROCESS | 1642 | 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" 06:50:37 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:50:37 INFO - TEST-INFO | 1642: exit 0 06:50:37 INFO - Browser initialized. 06:50:37 INFO - Running cycle 1/1 for dromaeo_css test... 06:50:37 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpY9M0B_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:50:49 INFO - PROCESS | 1646 | RSS: Main: 168120320 06:50:49 INFO - PROCESS | 1646 | 06:51:41 INFO - PROCESS | 1646 | 1479999101829 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] 06:53:51 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 06:53:53 INFO - PROCESS | 1646 | RSS: Main: 274935808 06:53:53 INFO - PROCESS | 1646 | 06:56:55 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 06:56:56 INFO - PROCESS | 1646 | RSS: Main: 300515328 06:56:56 INFO - PROCESS | 1646 | 06:59:58 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 06:59:59 INFO - PROCESS | 1646 | RSS: Main: 302268416 06:59:59 INFO - PROCESS | 1646 | 07:03:01 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 07:03:01 INFO - PROCESS | 1646 | RSS: Main: 290258944 07:03:01 INFO - PROCESS | 1646 | 07:06:05 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 07:06:05 INFO - PROCESS | 1646 | RSS: Main: 263176192 07:06:05 INFO - PROCESS | 1646 | 07:09:08 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 07:09:09 INFO - PROCESS | 1646 | RSS: Main: 425525248 07:09:09 INFO - PROCESS | 1646 | 07:09:09 INFO - PROCESS | 1646 | __start_tp_report 07:09:09 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 07:09:09 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 07:09:09 INFO - PROCESS | 1646 | |i|pagename|runs| 07:09:09 INFO - PROCESS | 1646 | |0;dojo.html;2942.7351538361545;3446.8621255149797;3485.9825700871475;3493.3188028334453;3532.3641744486;5763.5965482416195;5771.134329850524;5795.623284486505;5876.853078673024;5884.705764711769;5782.045962416207;5847.473727364536;5850.0932355484965;5857.707114644272;5873.500752436037;5223.164293712997;5266.368035835705;5286.497782710656;5331.200319952019;5359.517643412092;5193.792248310063;5212.713300768456;5243.161094224924;5364.517193452589;5379.435159308275;4317.568243175673;5252.422233554306;5266.262723218752;5268.236105764662;5307.867303317429;4368.650507959355;5280.12877875152;5370.033393989081;5377.4084850666395;5430.70131142787;5148.279240906276;5234.42421333653;5315.7873685052555;5323.254744335796;5353.304070470853;5588.776448942038;5684.914726279109;5690.886182276331;5741.1388291756575;5808.1578171165365;6106.2977757558;6142.84642883927;6169.568130230886;6203.2245969253845;6206;6116.119654120117;6196.225471816023;6262.87474250517;6263.373662633746;6270.623762574261;5800.390958949334;5813.128030795372;5886.087656413263;5905.881882362414;5981.850453738692;6291.496680265659;6300.936990630035;6315.778947736807;6332.461740751995;6343.5876668016435;6209.751609935643;6216.968915155395;6221.657808820468;6224.284207316126;6224.502039836802;6137.530208312589;6145.108959200891;6214.782482613087;6216.409441103088;6222.564420490522;6182.721777520022;6208.689565521706;6234.594751341239;6244.313125556185;6250.4374606285655;6173.938260617337;6208.875822483525;6223.253209614875;6233.532485063638;6274.623522588659;4950.207966725378;4995.375578052744;4996.625253106032;5080.618953578496;5117.104506711311;3869.5163104611925;4510.819567217274;4522.977385113053;4527.004059106991;4555.498895121534;5967.254093238345;6013.308469525973;6024.939750602525;6028.577999540078;6035.155078289043;6108.918862504643;6247.468965137923;6256.7810126645345;6258.655773932386;6289.559730818799;5832.88334233313;5854.443827836349;5864.266966629171;5932.19915311436;6022.156898034279;5464.863378415572;5511.5039646432015;5527.889442211133;5539.473749993744;5539.9169012464845;6410.551261411656;6412.871742565216;6429.7428102875365;6431.6462594556815;6431.839204019937;6131.682521312785;6153.969230153821;6154.415330543591;6173.876522469435;6205.720742566686;6435.581687190318;6481.675916204076;6482.513811464065;6488.351164883663;6494.415502604788;6184.103305020657;6228.065790131516;6237.812865614039;6241.126242326169;6254.21822272216;6130.581587308013;6167.136600875791;6180.289266734203;6211.3167551570195;6213.5339849510565;6073.5748497604745;6159.84600384994;6178.567500275118;6191.4387278576205;6198.0702894566175;6145.907811382922;6154;6173.59871608344;6182.412670796267;6188.133661287334;5911.438413350897;5975.521958243243;5977.760889564543;6023.712898862009;6033.939660603513;6141;6147.600405973776;6209.285932117864;6217.937820621736;6233.844153896189;6090.878182436415;6111.694415279308;6113.663748493697;6127.80043271483;6131.386861314011 07:09:09 INFO - PROCESS | 1646 | |1;ext.html;476.3283769884463;503.8362532177043;540.292217195474;544.0533471759136;544.6269305525715;32192.67807321926;41558.79220603897;43201.919952001175;43292.91767705809;45365;44670;45048.3242751359;45208.77395613026;45213.32180017294;45355.54644453563;10059.446730429823;10265.897341026568;10268.743281417987;10280.280380373377;10281.434521101337;9429.622815087389;9666.75833104171;12235.449404776762;12500;12522.436490357955;12504.874951250507;12584.182028168185;12593.937030314835;12600.747985040294;12606.684832879206;10313.639022634172;12457.252564846138;12488.438020289108;12554.686132846706;12622.242665440102;12402.875971240263;12493.312867792269;12510.687232819162;12526.624201273977;12531.93734031333;42127.57872421298;42290.365644515354;42370.57629423697;42392.152156956996;42528.57471425308;3542.6103128655827;3565.2691198304287;3580.212353282274;3705.4071348584366;3760.492333534965;30710.385792284254;31233.687663123306;31799.682003179903;33571.32857342864;33716.83141584301;3395.558577384949;3403.149212696826;3411.249525104498;3411.4882767584813;3474.5483087198504;493455;495483;495773.52113239566;496060;496617;34910.301793964485;35647.10882227913;61231.693841530505;61819.690901546106;61849;36393.45409818855;36955.445668315;36959.260814783556;36962.630373696455;37031.259374812355;16114.355425782838;16205.59486012859;16208.946418482761;16212.75680864788;16222.269997850126;12554.623361299176;12729.29988850622;12812.039097067756;12838.48646054166;12873.29196894161;7940.642671079815;8113.5131892086665;8118.472299300526;8156.265936065783;8251.29863961558;3366.1248075500057;3378.239896023424;3378.6959173674486;3388.745844061705;3441.0537102297067;952.8904176019707;971.5433746139303;1011.8431643095332;1113.7104352868312;1172.9589464368705;30904.918327858417;31066.53400198999;31251.687483125334;31666.366672666416;31982;1098.9560417583366;1112.7551938573502;1178.7838813251328;1248.3134276148264;1248.9750204995848;15812.97215680977;16472.0940348282;16513;16584.419545316097;16916.154192290338;756918;760664;762477;763147;763938;62435.687821560605;62613.37386626076;62643;62840.685796570724;62888.05667914985;1303.270168705509;1332.7734285171543;1408.4366253498683;1429.4710956945996;1444.8193975753031;24588.87705561461;29248.56127158137;32573.34853302968;32694.83652581722;33456.83271583724;51336.71658208575;51939.22091168711;52014;52028.95942081213;52041.7397913008;604546;605329;606191;606290;608351;24166.39584010414;25053.248402547953;25065.498690026463;25679.974354548813;27687.446251075267;47657;48211;49491.010179795485;49544.256836146764;49921;39723.80138099291;40393.59606403898;40516;40878.79560602178;42309;40841.18317633571;41256.29972977954;41565.79217103895;42075.15849682928;42394.78802605967;38831.2233755329;39537.209255815294;40195.79902100471;40305;40305.19389612132;28155;30687.846560767055;35187.94436166919;36020;36116;25484.362890927874;26461;26585.33536661599;26717.198484045508;27109.86445067762 07:09:09 INFO - PROCESS | 1646 | |2;jquery.html;367.83815121346606;373.3857803912564;378.585448933418;382.69766884161515;396.2688839091874;19541.609167816652;21436.678449823245;21439.57120857584;21661;21770.673439898415;21460.356189314305;21561.46096347592;21749.891250543766;21931.561368772615;22012.449688757788;5968.612040217372;5995.490383317401;6142.109394137848;6225.657588832612;6247;6134.4478996890275;6211;6226.844328891769;6234.158388617524;6240.968795156041;5908.61593996391;6129.5402844786595;6209.534284928626;6212.65830379329;6215.813525594217;5902;6138.508919286469;6155.169052177944;6188.257409110891;6195.50435965124;5412.810551630674;5425.969065877471;5428.321459817523;5428.511433970962;5445.074337362618;26151.60772588413;26659.066932657457;26746.19761407161;26912.327191820164;27075.323116922038;2348.859068455898;2412.9034838606435;2416.2630397728685;2438.1222759806456;3036.6052413186144;15173.544793656209;15644;15925.044497330196;16627.418040368528;16660.00039997604;1848.5471059590486;1904.2858927902037;1945.9513512162168;1946.1728765274702;2000.2798992362739;106983;107084;113940;115766.26350604747;121380;7642.47798226595;8243.587820608946;10059.195264378832;10171.796564068825;10351.223658225663;12496.312702801433;12584.685382865502;12591.874081259253;12609.621711348675;12619.558315459099;8322.958385208156;8462.61918213682;8519.361047921308;8589.484630922165;8619.051904290523;8987.865182022275;9016.684416045407;9030.774230644154;9181.862272065924;9197.540122993823;3905.6875449963936;3973.291484661623;3996.540397854226;4040.91918161641;4047.352423612208;1921.2603147788202;1941.1847024249848;1946.6593346164648;1960.882347059181;1980.3959792263497;895.3061377432542;898.1826537850656;916.074764487872;952.1383148250844;1012.2458768217725;18089.36687215941;20631.96840158016;22036.33890983273;22048.669269960963;22375.440613984454;939.4551160326994;945.7115579748105;947.6920000999703;986.6250824686573;995.0894931138073;11022.614208502664;11428.94285528567;11629.302241865515;11633.069354451623;11634.883651163549;653069;660246;663756;673504;675454;147549;149307;151473.24263378832;152599;154542;865.8874346334936;1020.4642562654666;1062.4846949229618;1072.544168728303;1074.8817630060687;19319.51701207481;19621.411357659294;19876.70184947198;20097.497562561053;20141.49646258855;58417;58865.82268354523;59186.26509879286;59892.10161847663;60054.09918851133;58304.708476457345;83039.58480207802;85854;85877.14122858942;89795;6192.841650758236;7820.296173344426;8347.624356903832;8424.578771061544;8752.868706969528;12925.870741292467;13353.465861365437;13391.196528208338;13463.663408414868;14135.222562759147;11571.826422603499;11576.710582235512;11661.24201926872;11844.526218951145;12000.03999680041;11637.185397022127;11681.88318116842;11786.410679466164;12027.398630068637;12131.45408456604;11515.366654834064;11729.613326471614;11994.700132496408;12045.81931271014;12129.939350303544;8255.380846436661;8306.418550701635;8505.957470212858;8635.82728345417;8663.133686631287;8385.706500272705;11053.336799792038;11297.71755706114;11464.31214127155;11859.407029648655 07:09:09 INFO - PROCESS | 1646 | |3;mootools.html;1403.866632669896;1547.8606925376714;1575.6927399157166;1782.4741701198145;1924.5188702824294;7128.821779455509;8602.2688071514;8606.61270242839;8618.655253789857;8648.91351086489;8655.870161947576;8953.462792232454;8958.776030599238;9042.54787260636;9043.140901614353;2223.8665680059166;2254.921077762279;2446.6819313489223;2451.754824517543;2452.91414800482;2403.435192729707;2437.7196622388387;2448.008556534606;2450.093465417789;2451.8774061296954;2410.385351735305;2425.405775584984;2444.40112172518;2445.6331550267514;2446.302803700946;2376.65538496917;2396.676448679423;2406.5307265083316;2407.1574948767966;2416.782489575929;2375;2389.593769059247;2394.365493144318;2400.663907053014;2401.03958416633;9034.32242581809;9054.366194366397;9135.954320228422;9148.634054637807;9151.725448236564;5297.205419187114;5348.946510534923;5487.314085739283;5529.806456773994;5534.252875861747;3641.7814931104217;3729.9067523311865;3796.867109651149;3803.4675145479655;3811.0472381904524;1103.382106020631;1127.1208457403238;1141.8520064396935;1152.3374059915498;1152.5332240442633;10206.540705668263;12046.759064818654;12096;12151.088668349908;12191.390430478441;4485.551444855553;4540.909181816345;4730.574248317668;4732.574068333866;4742.881427964328;8014.479058861155;9443.527823608792;9447.291453141042;9458.101480359355;9474;5406.675599464044;5409.188621706776;5418.322709661293;5421.864453388618;5421.864453388697;4603.631709463235;4763.428388593322;4914.72968986702;5050.722210278396;5083.822066227664;3338.315645292709;3351.463765797461;3849.9807500962315;3913.726039177287;3968.2857085724268;1139.139949338261;1144.6566030190909;1195.282830301812;1204.9819252711216;1209.5343292832322;829.788403956987;919.2186641354795;924.2328867040341;931.1200915135132;932.6828878181451;5814.622049566765;5853.268341457318;5882.794102206402;6026.728797204137;6174.475169610633;425.5106627378539;444.18387423733043;447.2910436957459;454.4818906446653;455.7857806830784;3973.443717879499;4000.0399904022825;4033.6168064034455;4038.8384464621085;4091.6112969267874;10761.892381076246;10943.616973405893;11171.329720216812;11280.492377843017;11292.209545331913;9685.564149613285;11064.05955493776;11094.611688591021;11120.277181983145;11130.276532025555;8194.22154895284;8462.449940753831;8550.700725474579;8559.358048146414;8560.887084678952;4898.804047838189;5659.122835960433;5776.162456443876;5781.075027995501;6266.373362663697;10113.949430252802;10246.897531024595;10261.74345641365;10312.517141816974;10417.635382761568;10274.589016439259;10536.157107431234;10567.52446139941;10636.30863993838;10711.25021248505;7189.532680375759;7497.0253866996945;7773.41699372538;7786.961065194638;7939.444238903452;8503.829923401621;8581.184787445183;8604.26863716566;8626.39615226928;8630.611622477129;7693.422993275639;7780.49426787257;7801.3368863644955;7910.52536847791;7952.403569732409;7560.092788865371;7649.694012239448;7665.42509311815;7684.923150768421;7711.0746710395115;6918.723251070102;7064.258252883579;7069.858602827811;7102.5028248022145;7115.75094871677;4502.752348620857;4945.184044632595;4970.105381031449;5190.8183213587345;5191.143461328838;5006.374203224597;5039.521245481674;5138.511841375063;5167.483251674803;5183.144781111226 07:09:09 INFO - PROCESS | 1646 | |4;prototype.html;293.8956670382014;294.5508100147274;301.80835169667256;308.36784591587246;315.80262336039976;4709.2936059591075;5014.016660087252;5269.76286067127;5472.972635136824;5474.808381706636;4289.528151903288;5259.684418934867;5266.552343050836;5279.934450473133;5340.305760251172;4108.603074954515;4137.648299894513;4163.68772342074;4173.749575025493;4206.516250631178;3906.863259785908;3997;4113.835446582133;4126.133511962492;4129.359949207863;3136.952945705816;3195.904122876306;3737.8131093445354;3912.0219945013746;4126.360414135814;3067.8619462124257;3301.7783420134706;4086.38587757834;4127.690423218256;4149.564295748964;2961.6446026476747;3563.2873425314783;3574.4995700601935;3577.5528058992627;3591.281743651254;5163.690178589259;5192.844214673528;5203.661761985497;5272.235525848769;5318.601104917147;4028.798560071985;4079.77561234132;4316.179925814116;4653.813847446098;4671.532846715335;4748.667593268473;5295.629305948585;5630.718464076821;5679.318481782213;5687.26065611472;3775.8861135964958;3855.6529912307747;3876.6898648108368;3905.4141878718137;3906.921861562781;4147.585241475828;5338.439463856317;5919;5939.46544810969;5962.612430192024;3224.339010502841;3263.379957808009;3881.825317860703;3894.065424298148;3905.535424215919;3506.7019303359502;3968.2460332536725;3968.353133449644;3980.3631418972827;3987.5613682494904;4326.329418940069;4456.866294011184;4631;4639.396878405786;4657;4329.069250111178;5450.672959622435;5662.546996240291;5679.375268720438;5695.686737229409;1278.8465384153776;1335.893128549733;1351.7499262636443;1356.8100465934776;1362.7206422683525;722.3751454991394;851.3572252949108;867.4751775176054;894.4365050018447;927.9421459536135;4627.981843994316;5149.845504634867;5293.841184764463;5295.669905241682;5296.841094767163;5637.633553818989;5800.419958004166;5807.186993820868;5817.360090390053;5840.328362238397;4969.478204788517;5233.371995360505;5270.130428479335;5311.575073994071;5317.404778566492;3023.5313526403443;3033.317503561725;3042.543618457249;3055.984720076385;3065.892693755708;5714.942850571441;5738.794853080816;5930.436608522184;5948.2862056553495;5975.312839023481;5650.7739690412745;6084.8174554762545;6085.939140608537;6087.726052327655;6124.540659450559;6110.175126357974;6125.1012186222415;6140.600860944024;6145.8156255312415;6170.352113028157;5039.697618142924;5272.99813035522;5909.6407826201075;5924.919042098171;5936.308152176609;4837.89551545079;5824.417558244142;5825.446582574648;5831.7375718091935;5834.533237341087;4873.975630121827;5690.345610254708;6088.817335479943;6129.84675383119;6162.661053642093;3333.4833100869405;3905.9218815624095;3950.6049395060263;3973.2450834341385;3984.422258772404;4858.392700912386;5401.3248343957;5677.977963966526;5913.881722365614;5967.731452084579;5278.736063196901;5532.585056120726;5696.262639894706;5792.9710351447975;5853.678047707417;4704.717716936994;4977.850664480072;5706.714664266687;5735.0214176109175;5748.9425105748405;4386.4736231652405;5394.946050539601;5557.722113894209;5569.805056822992;5614.606977511535;5007.624428167975;5620.26936498269;5692.743826527899;5712.457316554921;5823.4476969048;4775.498572649961;5501.862453438696;5619.662820230799;5668.801591944262;5672.716364181857 07:09:09 INFO - PROCESS | 1646 | |5;yui.html;672.6748305837501;722.8337482379053;749.7900587835408;809.8704207326825;819.229923871561;16070.437534686289;16823.49529514115;16824;16828;16839.98960062394;15244.923775381136;15353.769693454607;15412.229388530557;15423.997440166382;15424.228788560584;723.5839392349394;741.3179874515432;862.1464749897603;882.9470231786081;887.6138879587401;901.5987885391004;907.727681695492;909.8908131024286;909.9408538445012;912.6075787411411;966.6085235479642;966.7679756858373;966.7728083900278;967.8548217767321;968.3221744778648;962.9951850240774;963.5760265483165;966.0822218892046;966.1497881863914;967.1199208720101;708.7731925783751;709.8118998465411;712.184548691745;716;716.0691101567941;15384.461543846024;15739.685206295924;15762.448314309058;15769.526914192593;15777.921110394489;13953.3720982555;14074.92962535191;14130.50543230982;14213.076150050318;14452.205128717917;13113.934430327787;13518.256495892721;13688.52090176849;13804.93097534506;13965.650858728512;3985.3822657488136;4060.3909413587903;4228.217779710763;4761.095391875532;4796.208625576775;121052;123001;123309.38345308306;124894.75105249013;129750;10664.520096595517;10992.505337259843;11099.056580190612;11166.776664466664;11201;21303.68044479334;21364.679529807065;21406;21464.78535214628;21490.247841325792;7720.343770779435;7898.644560994769;8079;8221.712240071569;8567.271781898484;4421.845235416745;4443.314844439095;4588.678792484494;4613.792379342937;4732.313814496879;3690.6493883081066;3822.0444888777806;3833.0800607853917;3842.077901303667;3842.5965273646425;675.9019942108366;683.7095729306882;687.0552989639247;692.650211643117;707.8725829350664;487.5270987142466;656.937590928861;682.9078074459984;706.7914965085312;717.3006318839194;8592.785180370542;9747.56135973883;9843.360181588174;9882.308238423242;10157.796844063225;675.7668604331498;692.2973182220051;699.1226011355716;705.4074577355046;721.9566825990457;4585.564371384713;4833.178359678863;4846.709197448094;4846.8788280292565;4877.878053048702;138161;143096;144023;160352.59471107944;160963.39036609483;144695;148405.25797370943;148743.51256487513;150835;152788;103890.48054759677;106702.46648766861;121041;122428;128377;10087.646932357333;10271.178305735373;10279.743006424898;10285.53715082808;10348.896511035095;46084.847878803295;48040;65076.34923650703;65578.67210663916;68417.31582684109;92595;97082;98346.52480212659;99115.5132673025;100191;12730.809037864254;12793.87206127964;13280.335983200608;13553.79669304981;14121.2939353034;14601.780973285197;15465.690686185988;15776.13231272291;16307.429239976544;16312.429064982669;12255.632331030083;13176.736465270833;13919.443222270997;14050.016498844983;14073.648158796112;13944.559702052304;14372.568822935329;14471.27643617794;14561.762250208427;14618.269086545417;13078.476860925457;13730.794038089636;14226.626970647558;14280.214588197749;14309.928450357682;10044.196464282693;10681.359118452918;11409.714757131138;11561.768764624829;12176.147669663038;10091.495425228562;11537.942310288396;11787;11973.221740586834;12040.518379264731 07:09:09 INFO - PROCESS | 1646 | __end_tp_report 07:09:09 INFO - PROCESS | 1646 | __start_cc_report 07:09:09 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1072 07:09:09 INFO - PROCESS | 1646 | __end_cc_report 07:09:09 INFO - PROCESS | 1646 | __startTimestamp1480000149116__endTimestamp 07:09:09 INFO - PROCESS | 1646 | 07:09:09 INFO - PROCESS | 1646 | ------- Summary: start ------- 07:09:09 INFO - PROCESS | 1646 | Number of tests: 6 07:09:09 INFO - PROCESS | 1646 | 07:09:09 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5801.67 Median:6106.30 stddev:655.36 (10.7%) stddev-sans-first:617.81 07:09:09 INFO - PROCESS | 1646 | Values: 2942.7 3446.9 3486.0 3493.3 3532.4 5763.6 5771.1 5795.6 5876.9 5884.7 5782.0 5847.5 5850.1 5857.7 5873.5 5223.2 5266.4 5286.5 5331.2 5359.5 5193.8 5212.7 5243.2 5364.5 5379.4 4317.6 5252.4 5266.3 5268.2 5307.9 4368.7 5280.1 5370.0 5377.4 5430.7 5148.3 5234.4 5315.8 5323.3 5353.3 5588.8 5684.9 5690.9 5741.1 5808.2 6106.3 6142.8 6169.6 6203.2 6206.0 6116.1 6196.2 6262.9 6263.4 6270.6 5800.4 5813.1 5886.1 5905.9 5981.9 6291.5 6300.9 6315.8 6332.5 6343.6 6209.8 6217.0 6221.7 6224.3 6224.5 6137.5 6145.1 6214.8 6216.4 6222.6 6182.7 6208.7 6234.6 6244.3 6250.4 6173.9 6208.9 6223.3 6233.5 6274.6 4950.2 4995.4 4996.6 5080.6 5117.1 3869.5 4510.8 4523.0 4527.0 4555.5 5967.3 6013.3 6024.9 6028.6 6035.2 6108.9 6247.5 6256.8 6258.7 6289.6 5832.9 5854.4 5864.3 5932.2 6022.2 5464.9 5511.5 5527.9 5539.5 5539.9 6410.6 6412.9 6429.7 6431.6 6431.8 6131.7 6154.0 6154.4 6173.9 6205.7 6435.6 6481.7 6482.5 6488.4 6494.4 6184.1 6228.1 6237.8 6241.1 6254.2 6130.6 6167.1 6180.3 6211.3 6213.5 6073.6 6159.8 6178.6 6191.4 6198.1 6145.9 6154.0 6173.6 6182.4 6188.1 5911.4 5975.5 5977.8 6023.7 6033.9 6141.0 6147.6 6209.3 6217.9 6233.8 6090.9 6111.7 6113.7 6127.8 6131.4 07:09:09 INFO - PROCESS | 1646 | 07:09:09 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:74205.49 Median:19365.28 stddev:169213.15 (873.8%) stddev-sans-first:169597.29 07:09:09 INFO - PROCESS | 1646 | Values: 476.3 503.8 540.3 544.1 544.6 32192.7 41558.8 43201.9 43292.9 45365.0 44670.0 45048.3 45208.8 45213.3 45355.5 10059.4 10265.9 10268.7 10280.3 10281.4 9429.6 9666.8 12235.4 12500.0 12522.4 12504.9 12584.2 12593.9 12600.7 12606.7 10313.6 12457.3 12488.4 12554.7 12622.2 12402.9 12493.3 12510.7 12526.6 12531.9 42127.6 42290.4 42370.6 42392.2 42528.6 3542.6 3565.3 3580.2 3705.4 3760.5 30710.4 31233.7 31799.7 33571.3 33716.8 3395.6 3403.1 3411.2 3411.5 3474.5 493455.0 495483.0 495773.5 496060.0 496617.0 34910.3 35647.1 61231.7 61819.7 61849.0 36393.5 36955.4 36959.3 36962.6 37031.3 16114.4 16205.6 16208.9 16212.8 16222.3 12554.6 12729.3 12812.0 12838.5 12873.3 7940.6 8113.5 8118.5 8156.3 8251.3 3366.1 3378.2 3378.7 3388.7 3441.1 952.9 971.5 1011.8 1113.7 1173.0 30904.9 31066.5 31251.7 31666.4 31982.0 1099.0 1112.8 1178.8 1248.3 1249.0 15813.0 16472.1 16513.0 16584.4 16916.2 756918.0 760664.0 762477.0 763147.0 763938.0 62435.7 62613.4 62643.0 62840.7 62888.1 1303.3 1332.8 1408.4 1429.5 1444.8 24588.9 29248.6 32573.3 32694.8 33456.8 51336.7 51939.2 52014.0 52029.0 52041.7 604546.0 605329.0 606191.0 606290.0 608351.0 24166.4 25053.2 25065.5 25680.0 27687.4 47657.0 48211.0 49491.0 49544.3 49921.0 39723.8 40393.6 40516.0 40878.8 42309.0 40841.2 41256.3 41565.8 42075.2 42394.8 38831.2 39537.2 40195.8 40305.0 40305.2 28155.0 30687.8 35187.9 36020.0 36116.0 25484.4 26461.0 26585.3 26717.2 27109.9 07:09:09 INFO - PROCESS | 1646 | 07:09:09 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:37955.84 Median:14294.87 stddev:110964.71 (776.3%) stddev-sans-first:111240.10 07:09:09 INFO - PROCESS | 1646 | Values: 367.8 373.4 378.6 382.7 396.3 19541.6 21436.7 21439.6 21661.0 21770.7 21460.4 21561.5 21749.9 21931.6 22012.4 5968.6 5995.5 6142.1 6225.7 6247.0 6134.4 6211.0 6226.8 6234.2 6241.0 5908.6 6129.5 6209.5 6212.7 6215.8 5902.0 6138.5 6155.2 6188.3 6195.5 5412.8 5426.0 5428.3 5428.5 5445.1 26151.6 26659.1 26746.2 26912.3 27075.3 2348.9 2412.9 2416.3 2438.1 3036.6 15173.5 15644.0 15925.0 16627.4 16660.0 1848.5 1904.3 1946.0 1946.2 2000.3 106983.0 107084.0 113940.0 115766.3 121380.0 7642.5 8243.6 10059.2 10171.8 10351.2 12496.3 12584.7 12591.9 12609.6 12619.6 8323.0 8462.6 8519.4 8589.5 8619.1 8987.9 9016.7 9030.8 9181.9 9197.5 3905.7 3973.3 3996.5 4040.9 4047.4 1921.3 1941.2 1946.7 1960.9 1980.4 895.3 898.2 916.1 952.1 1012.2 18089.4 20632.0 22036.3 22048.7 22375.4 939.5 945.7 947.7 986.6 995.1 11022.6 11428.9 11629.3 11633.1 11634.9 653069.0 660246.0 663756.0 673504.0 675454.0 147549.0 149307.0 151473.2 152599.0 154542.0 865.9 1020.5 1062.5 1072.5 1074.9 19319.5 19621.4 19876.7 20097.5 20141.5 58417.0 58865.8 59186.3 59892.1 60054.1 58304.7 83039.6 85854.0 85877.1 89795.0 6192.8 7820.3 8347.6 8424.6 8752.9 12925.9 13353.5 13391.2 13463.7 14135.2 11571.8 11576.7 11661.2 11844.5 12000.0 11637.2 11681.9 11786.4 12027.4 12131.5 11515.4 11729.6 11994.7 12045.8 12129.9 8255.4 8306.4 8506.0 8635.8 8663.1 8385.7 11053.3 11297.7 11464.3 11859.4 07:09:09 INFO - PROCESS | 1646 | 07:09:09 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5780.77 Median:4753.15 stddev:3279.48 (69.0%) stddev-sans-first:3272.18 07:09:09 INFO - PROCESS | 1646 | Values: 1403.9 1547.9 1575.7 1782.5 1924.5 7128.8 8602.3 8606.6 8618.7 8648.9 8655.9 8953.5 8958.8 9042.5 9043.1 2223.9 2254.9 2446.7 2451.8 2452.9 2403.4 2437.7 2448.0 2450.1 2451.9 2410.4 2425.4 2444.4 2445.6 2446.3 2376.7 2396.7 2406.5 2407.2 2416.8 2375.0 2389.6 2394.4 2400.7 2401.0 9034.3 9054.4 9136.0 9148.6 9151.7 5297.2 5348.9 5487.3 5529.8 5534.3 3641.8 3729.9 3796.9 3803.5 3811.0 1103.4 1127.1 1141.9 1152.3 1152.5 10206.5 12046.8 12096.0 12151.1 12191.4 4485.6 4540.9 4730.6 4732.6 4742.9 8014.5 9443.5 9447.3 9458.1 9474.0 5406.7 5409.2 5418.3 5421.9 5421.9 4603.6 4763.4 4914.7 5050.7 5083.8 3338.3 3351.5 3850.0 3913.7 3968.3 1139.1 1144.7 1195.3 1205.0 1209.5 829.8 919.2 924.2 931.1 932.7 5814.6 5853.3 5882.8 6026.7 6174.5 425.5 444.2 447.3 454.5 455.8 3973.4 4000.0 4033.6 4038.8 4091.6 10761.9 10943.6 11171.3 11280.5 11292.2 9685.6 11064.1 11094.6 11120.3 11130.3 8194.2 8462.4 8550.7 8559.4 8560.9 4898.8 5659.1 5776.2 5781.1 6266.4 10113.9 10246.9 10261.7 10312.5 10417.6 10274.6 10536.2 10567.5 10636.3 10711.3 7189.5 7497.0 7773.4 7787.0 7939.4 8503.8 8581.2 8604.3 8626.4 8630.6 7693.4 7780.5 7801.3 7910.5 7952.4 7560.1 7649.7 7665.4 7684.9 7711.1 6918.7 7064.3 7069.9 7102.5 7115.8 4502.8 4945.2 4970.1 5190.8 5191.1 5006.4 5039.5 5138.5 5167.5 5183.1 07:09:09 INFO - PROCESS | 1646 | 07:09:09 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4568.97 Median:5218.52 stddev:1440.40 (27.6%) stddev-sans-first:1408.25 07:09:09 INFO - PROCESS | 1646 | Values: 293.9 294.6 301.8 308.4 315.8 4709.3 5014.0 5269.8 5473.0 5474.8 4289.5 5259.7 5266.6 5279.9 5340.3 4108.6 4137.6 4163.7 4173.7 4206.5 3906.9 3997.0 4113.8 4126.1 4129.4 3137.0 3195.9 3737.8 3912.0 4126.4 3067.9 3301.8 4086.4 4127.7 4149.6 2961.6 3563.3 3574.5 3577.6 3591.3 5163.7 5192.8 5203.7 5272.2 5318.6 4028.8 4079.8 4316.2 4653.8 4671.5 4748.7 5295.6 5630.7 5679.3 5687.3 3775.9 3855.7 3876.7 3905.4 3906.9 4147.6 5338.4 5919.0 5939.5 5962.6 3224.3 3263.4 3881.8 3894.1 3905.5 3506.7 3968.2 3968.4 3980.4 3987.6 4326.3 4456.9 4631.0 4639.4 4657.0 4329.1 5450.7 5662.5 5679.4 5695.7 1278.8 1335.9 1351.7 1356.8 1362.7 722.4 851.4 867.5 894.4 927.9 4628.0 5149.8 5293.8 5295.7 5296.8 5637.6 5800.4 5807.2 5817.4 5840.3 4969.5 5233.4 5270.1 5311.6 5317.4 3023.5 3033.3 3042.5 3056.0 3065.9 5714.9 5738.8 5930.4 5948.3 5975.3 5650.8 6084.8 6085.9 6087.7 6124.5 6110.2 6125.1 6140.6 6145.8 6170.4 5039.7 5273.0 5909.6 5924.9 5936.3 4837.9 5824.4 5825.4 5831.7 5834.5 4874.0 5690.3 6088.8 6129.8 6162.7 3333.5 3905.9 3950.6 3973.2 3984.4 4858.4 5401.3 5678.0 5913.9 5967.7 5278.7 5532.6 5696.3 5793.0 5853.7 4704.7 4977.9 5706.7 5735.0 5748.9 4386.5 5394.9 5557.7 5569.8 5614.6 5007.6 5620.3 5692.7 5712.5 5823.4 4775.5 5501.9 5619.7 5668.8 5672.7 07:09:09 INFO - PROCESS | 1646 | 07:09:09 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:26375.38 Median:16833.99 stddev:42642.57 (253.3%) stddev-sans-first:42718.52 07:09:09 INFO - PROCESS | 1646 | Values: 672.7 722.8 749.8 809.9 819.2 16070.4 16823.5 16824.0 16828.0 16840.0 15244.9 15353.8 15412.2 15424.0 15424.2 723.6 741.3 862.1 882.9 887.6 901.6 907.7 909.9 909.9 912.6 966.6 966.8 966.8 967.9 968.3 963.0 963.6 966.1 966.1 967.1 708.8 709.8 712.2 716.0 716.1 15384.5 15739.7 15762.4 15769.5 15777.9 13953.4 14074.9 14130.5 14213.1 14452.2 13113.9 13518.3 13688.5 13804.9 13965.7 3985.4 4060.4 4228.2 4761.1 4796.2 121052.0 123001.0 123309.4 124894.8 129750.0 10664.5 10992.5 11099.1 11166.8 11201.0 21303.7 21364.7 21406.0 21464.8 21490.2 7720.3 7898.6 8079.0 8221.7 8567.3 4421.8 4443.3 4588.7 4613.8 4732.3 3690.6 3822.0 3833.1 3842.1 3842.6 675.9 683.7 687.1 692.7 707.9 487.5 656.9 682.9 706.8 717.3 8592.8 9747.6 9843.4 9882.3 10157.8 675.8 692.3 699.1 705.4 722.0 4585.6 4833.2 4846.7 4846.9 4877.9 138161.0 143096.0 144023.0 160352.6 160963.4 144695.0 148405.3 148743.5 150835.0 152788.0 103890.5 106702.5 121041.0 122428.0 128377.0 10087.6 10271.2 10279.7 10285.5 10348.9 46084.8 48040.0 65076.3 65578.7 68417.3 92595.0 97082.0 98346.5 99115.5 100191.0 12730.8 12793.9 13280.3 13553.8 14121.3 14601.8 15465.7 15776.1 16307.4 16312.4 12255.6 13176.7 13919.4 14050.0 14073.6 13944.6 14372.6 14471.3 14561.8 14618.3 13078.5 13730.8 14226.6 14280.2 14309.9 10044.2 10681.4 11409.7 11561.8 12176.1 10091.5 11537.9 11787.0 11973.2 12040.5 07:09:09 INFO - PROCESS | 1646 | -------- Summary: end -------- 07:09:09 INFO - PROCESS | 1646 | 07:09:09 INFO - TEST-INFO | 1646: exit 0 07:09:09 INFO - TEST-OK | dromaeo_css | took 1115025ms 07:09:09 INFO - TEST-START | kraken 07:09:09 INFO - operating with platform_type : mac_ 07:09:09 INFO - Initialising browser for kraken test... 07:09:09 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpWIFzpl/profile http://localhost:49241/getInfo.html) 07:09:11 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 07:09:11 INFO - PROCESS | 1651 | colorDepth:24 07:09:11 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 07:09:11 INFO - PROCESS | 1651 | __metrics 07:09:11 INFO - PROCESS | 1651 | 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" 07:09:11 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:09:12 INFO - TEST-INFO | 1651: exit 0 07:09:12 INFO - Browser initialized. 07:09:12 INFO - Running cycle 1/1 for kraken test... 07:09:12 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpWIFzpl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:24 INFO - PROCESS | 1653 | RSS: Main: 168550400 07:09:24 INFO - PROCESS | 1653 | 07:09:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 07:09:28 INFO - PROCESS | 1653 | RSS: Main: 218771456 07:09:28 INFO - PROCESS | 1653 | 07:09:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 07:09:31 INFO - PROCESS | 1653 | RSS: Main: 229711872 07:09:31 INFO - PROCESS | 1653 | 07:09:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 07:09:34 INFO - PROCESS | 1653 | RSS: Main: 326361088 07:09:34 INFO - PROCESS | 1653 | 07:09:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 07:09:37 INFO - PROCESS | 1653 | RSS: Main: 229023744 07:09:37 INFO - PROCESS | 1653 | 07:09:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:09:40 INFO - PROCESS | 1653 | RSS: Main: 231055360 07:09:40 INFO - PROCESS | 1653 | 07:09:42 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 07:09:43 INFO - PROCESS | 1653 | RSS: Main: 266682368 07:09:43 INFO - PROCESS | 1653 | 07:09:46 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 07:09:46 INFO - PROCESS | 1653 | RSS: Main: 267960320 07:09:46 INFO - PROCESS | 1653 | 07:09:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 07:09:50 INFO - PROCESS | 1653 | RSS: Main: 265228288 07:09:50 INFO - PROCESS | 1653 | 07:09:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:09:52 INFO - PROCESS | 1653 | RSS: Main: 241197056 07:09:52 INFO - PROCESS | 1653 | 07:09:54 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:09:54 INFO - PROCESS | 1653 | RSS: Main: 244113408 07:09:54 INFO - PROCESS | 1653 | 07:09:57 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:09:57 INFO - PROCESS | 1653 | RSS: Main: 252096512 07:09:57 INFO - PROCESS | 1653 | 07:10:00 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:10:01 INFO - PROCESS | 1653 | RSS: Main: 265916416 07:10:01 INFO - PROCESS | 1653 | 07:10:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:10:04 INFO - PROCESS | 1653 | RSS: Main: 259633152 07:10:04 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 07:10:06 INFO - PROCESS | 1653 | RSS: Main: 303181824 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | __start_tp_report 07:10:06 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 07:10:06 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 07:10:06 INFO - PROCESS | 1653 | |i|pagename|runs| 07:10:06 INFO - PROCESS | 1653 | |0;ai-astar;113;112;113;111;111;112;111;111;112;111 07:10:06 INFO - PROCESS | 1653 | |1;audio-beat-detection;141;107;107;138;104;114;107;106;136;105 07:10:06 INFO - PROCESS | 1653 | |2;audio-dft;182;183;181;181;182;183;181;182;189;183 07:10:06 INFO - PROCESS | 1653 | |3;audio-fft;79;58;60;88;59;58;58;63;81;58 07:10:06 INFO - PROCESS | 1653 | |4;audio-oscillator;86;70;93;69;69;91;129;97;69;89 07:10:06 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;89;86;89;87;89;85;91;87;89;85 07:10:06 INFO - PROCESS | 1653 | |6;imaging-darkroom;94;93;94;94;94;94;94;95;93;94 07:10:06 INFO - PROCESS | 1653 | |7;imaging-desaturate;85;83;91;86;69;124;133;116;85;86 07:10:06 INFO - PROCESS | 1653 | |8;json-parse-financial;55;52;53;53;54;55;56;55;54;52 07:10:06 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;62;68;70;73;69;66;64;61;68;75 07:10:06 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;81;86;80;82;81;80;80;84;88;82 07:10:06 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;136;147;132;133;134;143;144;122;192;144 07:10:06 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;208;191;160;161;161;159;159;160;161;162 07:10:06 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;65;65;64;66;61;82;79;79;83;84 07:10:06 INFO - PROCESS | 1653 | __end_tp_report 07:10:06 INFO - PROCESS | 1653 | __start_cc_report 07:10:06 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1932 07:10:06 INFO - PROCESS | 1653 | __end_cc_report 07:10:06 INFO - PROCESS | 1653 | __startTimestamp1480000206735__endTimestamp 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | ------- Summary: start ------- 07:10:06 INFO - PROCESS | 1653 | Number of tests: 14 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 07:10:06 INFO - PROCESS | 1653 | Values: 113.0 112.0 113.0 111.0 111.0 112.0 111.0 111.0 112.0 111.0 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:116.50 Median:110.50 stddev:15.34 (13.9%) stddev-sans-first:13.47 07:10:06 INFO - PROCESS | 1653 | Values: 141.0 107.0 107.0 138.0 104.0 114.0 107.0 106.0 136.0 105.0 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:182.70 Median:182.50 stddev:2.36 (1.3%) stddev-sans-first:2.49 07:10:06 INFO - PROCESS | 1653 | Values: 182.0 183.0 181.0 181.0 182.0 183.0 181.0 182.0 189.0 183.0 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:66.20 Median:61.50 stddev:11.68 (19.0%) stddev-sans-first:11.43 07:10:06 INFO - PROCESS | 1653 | Values: 79.0 58.0 60.0 88.0 59.0 58.0 58.0 63.0 81.0 58.0 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:86.20 Median:87.50 stddev:18.78 (21.5%) stddev-sans-first:19.92 07:10:06 INFO - PROCESS | 1653 | Values: 86.0 70.0 93.0 69.0 69.0 91.0 129.0 97.0 69.0 89.0 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:89.00 stddev:2.00 (2.3%) stddev-sans-first:2.07 07:10:06 INFO - PROCESS | 1653 | Values: 89.0 86.0 89.0 87.0 89.0 85.0 91.0 87.0 89.0 85.0 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:10:06 INFO - PROCESS | 1653 | Values: 94.0 93.0 94.0 94.0 94.0 94.0 94.0 95.0 93.0 94.0 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:85.00 stddev:20.86 (24.5%) stddev-sans-first:21.76 07:10:06 INFO - PROCESS | 1653 | Values: 85.0 83.0 91.0 86.0 69.0 124.0 133.0 116.0 85.0 86.0 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.50 stddev:1.37 (2.5%) stddev-sans-first:1.39 07:10:06 INFO - PROCESS | 1653 | Values: 55.0 52.0 53.0 53.0 54.0 55.0 56.0 55.0 54.0 52.0 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.50 stddev:4.50 (6.6%) stddev-sans-first:4.29 07:10:06 INFO - PROCESS | 1653 | Values: 62.0 68.0 70.0 73.0 69.0 66.0 64.0 61.0 68.0 75.0 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:2.76 (3.4%) stddev-sans-first:2.88 07:10:06 INFO - PROCESS | 1653 | Values: 81.0 86.0 80.0 82.0 81.0 80.0 80.0 84.0 88.0 82.0 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:143.50 stddev:18.89 (13.2%) stddev-sans-first:19.88 07:10:06 INFO - PROCESS | 1653 | Values: 136.0 147.0 132.0 133.0 134.0 143.0 144.0 122.0 192.0 144.0 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:161.00 stddev:17.00 (10.6%) stddev-sans-first:10.26 07:10:06 INFO - PROCESS | 1653 | Values: 208.0 191.0 160.0 161.0 161.0 159.0 159.0 160.0 161.0 162.0 07:10:06 INFO - PROCESS | 1653 | 07:10:06 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:79.00 stddev:9.28 (11.8%) stddev-sans-first:9.41 07:10:06 INFO - PROCESS | 1653 | Values: 65.0 65.0 64.0 66.0 61.0 82.0 79.0 79.0 83.0 84.0 07:10:06 INFO - PROCESS | 1653 | -------- Summary: end -------- 07:10:06 INFO - PROCESS | 1653 | 07:10:07 INFO - TEST-INFO | 1653: exit 0 07:10:07 INFO - TEST-OK | kraken | took 57846ms 07:10:07 INFO - SUITE-END | took 1172s 07:10:07 INFO - Completed test suite (00:19:33) 07:10:07 INFO - javascript benchmark 07:10:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2942.7351538361545, 3446.8621255149797, 3485.9825700871475, 3493.3188028334453, 3532.3641744486, 5763.5965482416195, 5771.134329850524, 5795.623284486505, 5876.853078673024, 5884.705764711769, 5782.045962416207, 5847.473727364536, 5850.0932355484965, 5857.707114644272, 5873.500752436037, 5223.164293712997, 5266.368035835705, 5286.497782710656, 5331.200319952019, 5359.517643412092, 5193.792248310063, 5212.713300768456, 5243.161094224924, 5364.517193452589, 5379.435159308275, 4317.568243175673, 5252.422233554306, 5266.262723218752, 5268.236105764662, 5307.867303317429, 4368.650507959355, 5280.12877875152, 5370.033393989081, 5377.4084850666395, 5430.70131142787, 5148.279240906276, 5234.42421333653, 5315.7873685052555, 5323.254744335796, 5353.304070470853, 5588.776448942038, 5684.914726279109, 5690.886182276331, 5741.1388291756575, 5808.1578171165365, 6106.2977757558, 6142.84642883927, 6169.568130230886, 6203.2245969253845, 6206.0, 6116.119654120117, 6196.225471816023, 6262.87474250517, 6263.373662633746, 6270.623762574261, 5800.390958949334, 5813.128030795372, 5886.087656413263, 5905.881882362414, 5981.850453738692, 6291.496680265659, 6300.936990630035, 6315.778947736807, 6332.461740751995, 6343.5876668016435, 6209.751609935643, 6216.968915155395, 6221.657808820468, 6224.284207316126, 6224.502039836802, 6137.530208312589, 6145.108959200891, 6214.782482613087, 6216.409441103088, 6222.564420490522, 6182.721777520022, 6208.689565521706, 6234.594751341239, 6244.313125556185, 6250.4374606285655, 6173.938260617337, 6208.875822483525, 6223.253209614875, 6233.532485063638, 6274.623522588659, 4950.207966725378, 4995.375578052744, 4996.625253106032, 5080.618953578496, 5117.104506711311, 3869.5163104611925, 4510.819567217274, 4522.977385113053, 4527.004059106991, 4555.498895121534, 5967.254093238345, 6013.308469525973, 6024.939750602525, 6028.577999540078, 6035.155078289043, 6108.918862504643, 6247.468965137923, 6256.7810126645345, 6258.655773932386, 6289.559730818799, 5832.88334233313, 5854.443827836349, 5864.266966629171, 5932.19915311436, 6022.156898034279, 5464.863378415572, 5511.5039646432015, 5527.889442211133, 5539.473749993744, 5539.9169012464845, 6410.551261411656, 6412.871742565216, 6429.7428102875365, 6431.6462594556815, 6431.839204019937, 6131.682521312785, 6153.969230153821, 6154.415330543591, 6173.876522469435, 6205.720742566686, 6435.581687190318, 6481.675916204076, 6482.513811464065, 6488.351164883663, 6494.415502604788, 6184.103305020657, 6228.065790131516, 6237.812865614039, 6241.126242326169, 6254.21822272216, 6130.581587308013, 6167.136600875791, 6180.289266734203, 6211.3167551570195, 6213.5339849510565, 6073.5748497604745, 6159.84600384994, 6178.567500275118, 6191.4387278576205, 6198.0702894566175, 6145.907811382922, 6154.0, 6173.59871608344, 6182.412670796267, 6188.133661287334, 5911.438413350897, 5975.521958243243, 5977.760889564543, 6023.712898862009, 6033.939660603513, 6141.0, 6147.600405973776, 6209.285932117864, 6217.937820621736, 6233.844153896189, 6090.878182436415, 6111.694415279308, 6113.663748493697, 6127.80043271483, 6131.386861314011], "value": 5758.943957804251, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.3283769884463, 503.8362532177043, 540.292217195474, 544.0533471759136, 544.6269305525715, 32192.67807321926, 41558.79220603897, 43201.919952001175, 43292.91767705809, 45365.0, 44670.0, 45048.3242751359, 45208.77395613026, 45213.32180017294, 45355.54644453563, 10059.446730429823, 10265.897341026568, 10268.743281417987, 10280.280380373377, 10281.434521101337, 9429.622815087389, 9666.75833104171, 12235.449404776762, 12500.0, 12522.436490357955, 12504.874951250507, 12584.182028168185, 12593.937030314835, 12600.747985040294, 12606.684832879206, 10313.639022634172, 12457.252564846138, 12488.438020289108, 12554.686132846706, 12622.242665440102, 12402.875971240263, 12493.312867792269, 12510.687232819162, 12526.624201273977, 12531.93734031333, 42127.57872421298, 42290.365644515354, 42370.57629423697, 42392.152156956996, 42528.57471425308, 3542.6103128655827, 3565.2691198304287, 3580.212353282274, 3705.4071348584366, 3760.492333534965, 30710.385792284254, 31233.687663123306, 31799.682003179903, 33571.32857342864, 33716.83141584301, 3395.558577384949, 3403.149212696826, 3411.249525104498, 3411.4882767584813, 3474.5483087198504, 493455.0, 495483.0, 495773.52113239566, 496060.0, 496617.0, 34910.301793964485, 35647.10882227913, 61231.693841530505, 61819.690901546106, 61849.0, 36393.45409818855, 36955.445668315, 36959.260814783556, 36962.630373696455, 37031.259374812355, 16114.355425782838, 16205.59486012859, 16208.946418482761, 16212.75680864788, 16222.269997850126, 12554.623361299176, 12729.29988850622, 12812.039097067756, 12838.48646054166, 12873.29196894161, 7940.642671079815, 8113.5131892086665, 8118.472299300526, 8156.265936065783, 8251.29863961558, 3366.1248075500057, 3378.239896023424, 3378.6959173674486, 3388.745844061705, 3441.0537102297067, 952.8904176019707, 971.5433746139303, 1011.8431643095332, 1113.7104352868312, 1172.9589464368705, 30904.918327858417, 31066.53400198999, 31251.687483125334, 31666.366672666416, 31982.0, 1098.9560417583366, 1112.7551938573502, 1178.7838813251328, 1248.3134276148264, 1248.9750204995848, 15812.97215680977, 16472.0940348282, 16513.0, 16584.419545316097, 16916.154192290338, 756918.0, 760664.0, 762477.0, 763147.0, 763938.0, 62435.687821560605, 62613.37386626076, 62643.0, 62840.685796570724, 62888.05667914985, 1303.270168705509, 1332.7734285171543, 1408.4366253498683, 1429.4710956945996, 1444.8193975753031, 24588.87705561461, 29248.56127158137, 32573.34853302968, 32694.83652581722, 33456.83271583724, 51336.71658208575, 51939.22091168711, 52014.0, 52028.95942081213, 52041.7397913008, 604546.0, 605329.0, 606191.0, 606290.0, 608351.0, 24166.39584010414, 25053.248402547953, 25065.498690026463, 25679.974354548813, 27687.446251075267, 47657.0, 48211.0, 49491.010179795485, 49544.256836146764, 49921.0, 39723.80138099291, 40393.59606403898, 40516.0, 40878.79560602178, 42309.0, 40841.18317633571, 41256.29972977954, 41565.79217103895, 42075.15849682928, 42394.78802605967, 38831.2233755329, 39537.209255815294, 40195.79902100471, 40305.0, 40305.19389612132, 28155.0, 30687.846560767055, 35187.94436166919, 36020.0, 36116.0, 25484.362890927874, 26461.0, 26585.33536661599, 26717.198484045508, 27109.86445067762], "value": 19898.70093572792, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.83815121346606, 373.3857803912564, 378.585448933418, 382.69766884161515, 396.2688839091874, 19541.609167816652, 21436.678449823245, 21439.57120857584, 21661.0, 21770.673439898415, 21460.356189314305, 21561.46096347592, 21749.891250543766, 21931.561368772615, 22012.449688757788, 5968.612040217372, 5995.490383317401, 6142.109394137848, 6225.657588832612, 6247.0, 6134.4478996890275, 6211.0, 6226.844328891769, 6234.158388617524, 6240.968795156041, 5908.61593996391, 6129.5402844786595, 6209.534284928626, 6212.65830379329, 6215.813525594217, 5902.0, 6138.508919286469, 6155.169052177944, 6188.257409110891, 6195.50435965124, 5412.810551630674, 5425.969065877471, 5428.321459817523, 5428.511433970962, 5445.074337362618, 26151.60772588413, 26659.066932657457, 26746.19761407161, 26912.327191820164, 27075.323116922038, 2348.859068455898, 2412.9034838606435, 2416.2630397728685, 2438.1222759806456, 3036.6052413186144, 15173.544793656209, 15644.0, 15925.044497330196, 16627.418040368528, 16660.00039997604, 1848.5471059590486, 1904.2858927902037, 1945.9513512162168, 1946.1728765274702, 2000.2798992362739, 106983.0, 107084.0, 113940.0, 115766.26350604747, 121380.0, 7642.47798226595, 8243.587820608946, 10059.195264378832, 10171.796564068825, 10351.223658225663, 12496.312702801433, 12584.685382865502, 12591.874081259253, 12609.621711348675, 12619.558315459099, 8322.958385208156, 8462.61918213682, 8519.361047921308, 8589.484630922165, 8619.051904290523, 8987.865182022275, 9016.684416045407, 9030.774230644154, 9181.862272065924, 9197.540122993823, 3905.6875449963936, 3973.291484661623, 3996.540397854226, 4040.91918161641, 4047.352423612208, 1921.2603147788202, 1941.1847024249848, 1946.6593346164648, 1960.882347059181, 1980.3959792263497, 895.3061377432542, 898.1826537850656, 916.074764487872, 952.1383148250844, 1012.2458768217725, 18089.36687215941, 20631.96840158016, 22036.33890983273, 22048.669269960963, 22375.440613984454, 939.4551160326994, 945.7115579748105, 947.6920000999703, 986.6250824686573, 995.0894931138073, 11022.614208502664, 11428.94285528567, 11629.302241865515, 11633.069354451623, 11634.883651163549, 653069.0, 660246.0, 663756.0, 673504.0, 675454.0, 147549.0, 149307.0, 151473.24263378832, 152599.0, 154542.0, 865.8874346334936, 1020.4642562654666, 1062.4846949229618, 1072.544168728303, 1074.8817630060687, 19319.51701207481, 19621.411357659294, 19876.70184947198, 20097.497562561053, 20141.49646258855, 58417.0, 58865.82268354523, 59186.26509879286, 59892.10161847663, 60054.09918851133, 58304.708476457345, 83039.58480207802, 85854.0, 85877.14122858942, 89795.0, 6192.841650758236, 7820.296173344426, 8347.624356903832, 8424.578771061544, 8752.868706969528, 12925.870741292467, 13353.465861365437, 13391.196528208338, 13463.663408414868, 14135.222562759147, 11571.826422603499, 11576.710582235512, 11661.24201926872, 11844.526218951145, 12000.03999680041, 11637.185397022127, 11681.88318116842, 11786.410679466164, 12027.398630068637, 12131.45408456604, 11515.366654834064, 11729.613326471614, 11994.700132496408, 12045.81931271014, 12129.939350303544, 8255.380846436661, 8306.418550701635, 8505.957470212858, 8635.82728345417, 8663.133686631287, 8385.706500272705, 11053.336799792038, 11297.71755706114, 11464.31214127155, 11859.407029648655], "value": 9925.839848734093, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.866632669896, 1547.8606925376714, 1575.6927399157166, 1782.4741701198145, 1924.5188702824294, 7128.821779455509, 8602.2688071514, 8606.61270242839, 8618.655253789857, 8648.91351086489, 8655.870161947576, 8953.462792232454, 8958.776030599238, 9042.54787260636, 9043.140901614353, 2223.8665680059166, 2254.921077762279, 2446.6819313489223, 2451.754824517543, 2452.91414800482, 2403.435192729707, 2437.7196622388387, 2448.008556534606, 2450.093465417789, 2451.8774061296954, 2410.385351735305, 2425.405775584984, 2444.40112172518, 2445.6331550267514, 2446.302803700946, 2376.65538496917, 2396.676448679423, 2406.5307265083316, 2407.1574948767966, 2416.782489575929, 2375.0, 2389.593769059247, 2394.365493144318, 2400.663907053014, 2401.03958416633, 9034.32242581809, 9054.366194366397, 9135.954320228422, 9148.634054637807, 9151.725448236564, 5297.205419187114, 5348.946510534923, 5487.314085739283, 5529.806456773994, 5534.252875861747, 3641.7814931104217, 3729.9067523311865, 3796.867109651149, 3803.4675145479655, 3811.0472381904524, 1103.382106020631, 1127.1208457403238, 1141.8520064396935, 1152.3374059915498, 1152.5332240442633, 10206.540705668263, 12046.759064818654, 12096.0, 12151.088668349908, 12191.390430478441, 4485.551444855553, 4540.909181816345, 4730.574248317668, 4732.574068333866, 4742.881427964328, 8014.479058861155, 9443.527823608792, 9447.291453141042, 9458.101480359355, 9474.0, 5406.675599464044, 5409.188621706776, 5418.322709661293, 5421.864453388618, 5421.864453388697, 4603.631709463235, 4763.428388593322, 4914.72968986702, 5050.722210278396, 5083.822066227664, 3338.315645292709, 3351.463765797461, 3849.9807500962315, 3913.726039177287, 3968.2857085724268, 1139.139949338261, 1144.6566030190909, 1195.282830301812, 1204.9819252711216, 1209.5343292832322, 829.788403956987, 919.2186641354795, 924.2328867040341, 931.1200915135132, 932.6828878181451, 5814.622049566765, 5853.268341457318, 5882.794102206402, 6026.728797204137, 6174.475169610633, 425.5106627378539, 444.18387423733043, 447.2910436957459, 454.4818906446653, 455.7857806830784, 3973.443717879499, 4000.0399904022825, 4033.6168064034455, 4038.8384464621085, 4091.6112969267874, 10761.892381076246, 10943.616973405893, 11171.329720216812, 11280.492377843017, 11292.209545331913, 9685.564149613285, 11064.05955493776, 11094.611688591021, 11120.277181983145, 11130.276532025555, 8194.22154895284, 8462.449940753831, 8550.700725474579, 8559.358048146414, 8560.887084678952, 4898.804047838189, 5659.122835960433, 5776.162456443876, 5781.075027995501, 6266.373362663697, 10113.949430252802, 10246.897531024595, 10261.74345641365, 10312.517141816974, 10417.635382761568, 10274.589016439259, 10536.157107431234, 10567.52446139941, 10636.30863993838, 10711.25021248505, 7189.532680375759, 7497.0253866996945, 7773.41699372538, 7786.961065194638, 7939.444238903452, 8503.829923401621, 8581.184787445183, 8604.26863716566, 8626.39615226928, 8630.611622477129, 7693.422993275639, 7780.49426787257, 7801.3368863644955, 7910.52536847791, 7952.403569732409, 7560.092788865371, 7649.694012239448, 7665.42509311815, 7684.923150768421, 7711.0746710395115, 6918.723251070102, 7064.258252883579, 7069.858602827811, 7102.5028248022145, 7115.75094871677, 4502.752348620857, 4945.184044632595, 4970.105381031449, 5190.8183213587345, 5191.143461328838, 5006.374203224597, 5039.521245481674, 5138.511841375063, 5167.483251674803, 5183.144781111226], "value": 4555.741178763368, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.8956670382014, 294.5508100147274, 301.80835169667256, 308.36784591587246, 315.80262336039976, 4709.2936059591075, 5014.016660087252, 5269.76286067127, 5472.972635136824, 5474.808381706636, 4289.528151903288, 5259.684418934867, 5266.552343050836, 5279.934450473133, 5340.305760251172, 4108.603074954515, 4137.648299894513, 4163.68772342074, 4173.749575025493, 4206.516250631178, 3906.863259785908, 3997.0, 4113.835446582133, 4126.133511962492, 4129.359949207863, 3136.952945705816, 3195.904122876306, 3737.8131093445354, 3912.0219945013746, 4126.360414135814, 3067.8619462124257, 3301.7783420134706, 4086.38587757834, 4127.690423218256, 4149.564295748964, 2961.6446026476747, 3563.2873425314783, 3574.4995700601935, 3577.5528058992627, 3591.281743651254, 5163.690178589259, 5192.844214673528, 5203.661761985497, 5272.235525848769, 5318.601104917147, 4028.798560071985, 4079.77561234132, 4316.179925814116, 4653.813847446098, 4671.532846715335, 4748.667593268473, 5295.629305948585, 5630.718464076821, 5679.318481782213, 5687.26065611472, 3775.8861135964958, 3855.6529912307747, 3876.6898648108368, 3905.4141878718137, 3906.921861562781, 4147.585241475828, 5338.439463856317, 5919.0, 5939.46544810969, 5962.612430192024, 3224.339010502841, 3263.379957808009, 3881.825317860703, 3894.065424298148, 3905.535424215919, 3506.7019303359502, 3968.2460332536725, 3968.353133449644, 3980.3631418972827, 3987.5613682494904, 4326.329418940069, 4456.866294011184, 4631.0, 4639.396878405786, 4657.0, 4329.069250111178, 5450.672959622435, 5662.546996240291, 5679.375268720438, 5695.686737229409, 1278.8465384153776, 1335.893128549733, 1351.7499262636443, 1356.8100465934776, 1362.7206422683525, 722.3751454991394, 851.3572252949108, 867.4751775176054, 894.4365050018447, 927.9421459536135, 4627.981843994316, 5149.845504634867, 5293.841184764463, 5295.669905241682, 5296.841094767163, 5637.633553818989, 5800.419958004166, 5807.186993820868, 5817.360090390053, 5840.328362238397, 4969.478204788517, 5233.371995360505, 5270.130428479335, 5311.575073994071, 5317.404778566492, 3023.5313526403443, 3033.317503561725, 3042.543618457249, 3055.984720076385, 3065.892693755708, 5714.942850571441, 5738.794853080816, 5930.436608522184, 5948.2862056553495, 5975.312839023481, 5650.7739690412745, 6084.8174554762545, 6085.939140608537, 6087.726052327655, 6124.540659450559, 6110.175126357974, 6125.1012186222415, 6140.600860944024, 6145.8156255312415, 6170.352113028157, 5039.697618142924, 5272.99813035522, 5909.6407826201075, 5924.919042098171, 5936.308152176609, 4837.89551545079, 5824.417558244142, 5825.446582574648, 5831.7375718091935, 5834.533237341087, 4873.975630121827, 5690.345610254708, 6088.817335479943, 6129.84675383119, 6162.661053642093, 3333.4833100869405, 3905.9218815624095, 3950.6049395060263, 3973.2450834341385, 3984.422258772404, 4858.392700912386, 5401.3248343957, 5677.977963966526, 5913.881722365614, 5967.731452084579, 5278.736063196901, 5532.585056120726, 5696.262639894706, 5792.9710351447975, 5853.678047707417, 4704.717716936994, 4977.850664480072, 5706.714664266687, 5735.0214176109175, 5748.9425105748405, 4386.4736231652405, 5394.946050539601, 5557.722113894209, 5569.805056822992, 5614.606977511535, 5007.624428167975, 5620.26936498269, 5692.743826527899, 5712.457316554921, 5823.4476969048, 4775.498572649961, 5501.862453438696, 5619.662820230799, 5668.801591944262, 5672.716364181857], "value": 4109.577161331068, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.6748305837501, 722.8337482379053, 749.7900587835408, 809.8704207326825, 819.229923871561, 16070.437534686289, 16823.49529514115, 16824.0, 16828.0, 16839.98960062394, 15244.923775381136, 15353.769693454607, 15412.229388530557, 15423.997440166382, 15424.228788560584, 723.5839392349394, 741.3179874515432, 862.1464749897603, 882.9470231786081, 887.6138879587401, 901.5987885391004, 907.727681695492, 909.8908131024286, 909.9408538445012, 912.6075787411411, 966.6085235479642, 966.7679756858373, 966.7728083900278, 967.8548217767321, 968.3221744778648, 962.9951850240774, 963.5760265483165, 966.0822218892046, 966.1497881863914, 967.1199208720101, 708.7731925783751, 709.8118998465411, 712.184548691745, 716.0, 716.0691101567941, 15384.461543846024, 15739.685206295924, 15762.448314309058, 15769.526914192593, 15777.921110394489, 13953.3720982555, 14074.92962535191, 14130.50543230982, 14213.076150050318, 14452.205128717917, 13113.934430327787, 13518.256495892721, 13688.52090176849, 13804.93097534506, 13965.650858728512, 3985.3822657488136, 4060.3909413587903, 4228.217779710763, 4761.095391875532, 4796.208625576775, 121052.0, 123001.0, 123309.38345308306, 124894.75105249013, 129750.0, 10664.520096595517, 10992.505337259843, 11099.056580190612, 11166.776664466664, 11201.0, 21303.68044479334, 21364.679529807065, 21406.0, 21464.78535214628, 21490.247841325792, 7720.343770779435, 7898.644560994769, 8079.0, 8221.712240071569, 8567.271781898484, 4421.845235416745, 4443.314844439095, 4588.678792484494, 4613.792379342937, 4732.313814496879, 3690.6493883081066, 3822.0444888777806, 3833.0800607853917, 3842.077901303667, 3842.5965273646425, 675.9019942108366, 683.7095729306882, 687.0552989639247, 692.650211643117, 707.8725829350664, 487.5270987142466, 656.937590928861, 682.9078074459984, 706.7914965085312, 717.3006318839194, 8592.785180370542, 9747.56135973883, 9843.360181588174, 9882.308238423242, 10157.796844063225, 675.7668604331498, 692.2973182220051, 699.1226011355716, 705.4074577355046, 721.9566825990457, 4585.564371384713, 4833.178359678863, 4846.709197448094, 4846.8788280292565, 4877.878053048702, 138161.0, 143096.0, 144023.0, 160352.59471107944, 160963.39036609483, 144695.0, 148405.25797370943, 148743.51256487513, 150835.0, 152788.0, 103890.48054759677, 106702.46648766861, 121041.0, 122428.0, 128377.0, 10087.646932357333, 10271.178305735373, 10279.743006424898, 10285.53715082808, 10348.896511035095, 46084.847878803295, 48040.0, 65076.34923650703, 65578.67210663916, 68417.31582684109, 92595.0, 97082.0, 98346.52480212659, 99115.5132673025, 100191.0, 12730.809037864254, 12793.87206127964, 13280.335983200608, 13553.79669304981, 14121.2939353034, 14601.780973285197, 15465.690686185988, 15776.13231272291, 16307.429239976544, 16312.429064982669, 12255.632331030083, 13176.736465270833, 13919.443222270997, 14050.016498844983, 14073.648158796112, 13944.559702052304, 14372.568822935329, 14471.27643617794, 14561.762250208427, 14618.269086545417, 13078.476860925457, 13730.794038089636, 14226.626970647558, 14280.214588197749, 14309.928450357682, 10044.196464282693, 10681.359118452918, 11409.714757131138, 11561.768764624829, 12176.147669663038, 10091.495425228562, 11537.942310288396, 11787.0, 11973.221740586834, 12040.518379264731], "value": 8214.694212869575, "unit": "score"}], "name": "dromaeo_css", "value": 7478.620145244342, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 111.0, 111.0, 112.0, 111.0, 111.0, 112.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 107.0, 107.0, 138.0, 104.0, 114.0, 107.0, 106.0, 136.0, 105.0], "value": 116.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 181.0, 181.0, 182.0, 183.0, 181.0, 182.0, 189.0, 183.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 60.0, 88.0, 59.0, 58.0, 58.0, 63.0, 81.0, 58.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 93.0, 69.0, 69.0, 91.0, 129.0, 97.0, 69.0, 89.0], "value": 86.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 89.0, 85.0, 91.0, 87.0, 89.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 93.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 91.0, 86.0, 69.0, 124.0, 133.0, 116.0, 85.0, 86.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 53.0, 54.0, 55.0, 56.0, 55.0, 54.0, 52.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 68.0, 70.0, 73.0, 69.0, 66.0, 64.0, 61.0, 68.0, 75.0], "value": 67.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 80.0, 82.0, 81.0, 80.0, 80.0, 84.0, 88.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 147.0, 132.0, 133.0, 134.0, 143.0, 144.0, 122.0, 192.0, 144.0], "value": 142.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 191.0, 160.0, 161.0, 161.0, 159.0, 159.0, 160.0, 161.0, 162.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 66.0, 61.0, 82.0, 79.0, 79.0, 83.0, 84.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1428.3, "alertThreshold": 2.0}]} 07:10:07 INFO - Return code: 0 07:10:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:10:08 INFO - # TBPL SUCCESS # 07:10:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:10:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:10:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:10:08 INFO - 2016-11-24 07:10:08.016 screenresolution[1658:10385] starting screenresolution argv=screenresolution get 07:10:08 INFO - 2016-11-24 07:10:08.019 screenresolution[1658:10385] Display 0: 1600x1200x32@60 07:10:08 INFO - 2016-11-24 07:10:08.025 screenresolution[1659:10388] starting screenresolution argv=screenresolution list 07:10:08 INFO - Available Modes on Display 0 07:10:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:10:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:10:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:10:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:10:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:10:08 INFO - Intel Iris: 07:10:08 INFO - Chipset Model: Intel Iris 07:10:08 INFO - Type: GPU 07:10:08 INFO - Bus: Built-In 07:10:08 INFO - VRAM (Dynamic, Max): 1536 MB 07:10:08 INFO - Vendor: Intel (0x8086) 07:10:08 INFO - Device ID: 0x0a2e 07:10:08 INFO - Revision ID: 0x0009 07:10:08 INFO - Displays: 07:10:08 INFO - Display: 07:10:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:10:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:10:08 INFO - Display Serial Number: 1600x1200 60 07:10:08 INFO - Main Display: Yes 07:10:08 INFO - Mirror: Off 07:10:08 INFO - Online: Yes 07:10:08 INFO - Rotation: Supported 07:10:08 INFO - Return code: 0 07:10:08 INFO - Running post-action listener: _resource_record_post_action 07:10:08 INFO - [mozharness: 2016-11-24 15:10:08.262038Z] Finished run-tests step (success) 07:10:08 INFO - Running post-run listener: _resource_record_post_run 07:10:08 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 32332800; Write bytes: 495654400; Read time: 200; Write time: 1556 07:10:08 INFO - TinderboxPrint: CPU usage
53.1% 07:10:08 INFO - TinderboxPrint: I/O read bytes / time
32,332,800 / 200 07:10:08 INFO - TinderboxPrint: I/O write bytes / time
495,654,400 / 1,556 07:10:08 INFO - TinderboxPrint: CPU idle
2,241.4 (46.9%) 07:10:08 INFO - TinderboxPrint: CPU system
951.4 (19.9%) 07:10:08 INFO - TinderboxPrint: CPU user
1,588.8 (33.2%) 07:10:08 INFO - TinderboxPrint: Swap in / out
223,948,800 / 0 07:10:08 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194482688; Write bytes: 186896384; Read time: 17845; Write time: 404 07:10:08 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 29260800; Write bytes: 296132096; Read time: 177; Write time: 1118 07:10:08 INFO - Running post-run listener: _upload_blobber_files 07:10:08 INFO - Blob upload gear active. 07:10:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:10:08 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 07:10:08 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'] 07:10:08 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 07:10:09 INFO - (blobuploader) - INFO - Open directory for files ... 07:10:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:10:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:10:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:10 INFO - (blobuploader) - INFO - Done attempting. 07:10:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:10:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:10:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:11 INFO - (blobuploader) - INFO - Done attempting. 07:10:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:10:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:10:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:14 INFO - (blobuploader) - INFO - Done attempting. 07:10:14 INFO - (blobuploader) - INFO - Iteration through files over. 07:10:14 INFO - Return code: 0 07:10:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:10:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:10:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec6962593d7bda4ad960c5d1f0fda44b01eb3f21effed7742774498765ebccd684ad4c44d6f95c13995e85fe173f122237fa7bf5570e7a7f1574d97bfdd45cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/933ed0f4ec10dd7a04ad1029b0f46ed0be6b1593abc0053e1e0553069e983b416120efd1699ee41fe5637f5f4b063676db21f3dcbbd108333ca039e5624e53a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4267c14eea9cde846895a70fb2aa0f161745da3453b0f2ab8c8ae5385f615b0270e422be529e8bb2a4997250769c031a155a9c855ea7fcbeec5fc7a864c807b3"} 07:10:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:10:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:10:14 INFO - Contents: 07:10:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec6962593d7bda4ad960c5d1f0fda44b01eb3f21effed7742774498765ebccd684ad4c44d6f95c13995e85fe173f122237fa7bf5570e7a7f1574d97bfdd45cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/933ed0f4ec10dd7a04ad1029b0f46ed0be6b1593abc0053e1e0553069e983b416120efd1699ee41fe5637f5f4b063676db21f3dcbbd108333ca039e5624e53a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4267c14eea9cde846895a70fb2aa0f161745da3453b0f2ab8c8ae5385f615b0270e422be529e8bb2a4997250769c031a155a9c855ea7fcbeec5fc7a864c807b3"} 07:10:14 INFO - Running post-run listener: copy_logs_to_upload_dir 07:10:14 INFO - Copying logs to upload dir... 07:10:14 INFO - mkdir: /builds/slave/test/build/upload/logs 07:10:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.841176 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-24 07:10:14.198641) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 07:10:14.202241) ========= 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.UgnwXselT7/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.ewQFZGsgZX/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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/ec6962593d7bda4ad960c5d1f0fda44b01eb3f21effed7742774498765ebccd684ad4c44d6f95c13995e85fe173f122237fa7bf5570e7a7f1574d97bfdd45cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/933ed0f4ec10dd7a04ad1029b0f46ed0be6b1593abc0053e1e0553069e983b416120efd1699ee41fe5637f5f4b063676db21f3dcbbd108333ca039e5624e53a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4267c14eea9cde846895a70fb2aa0f161745da3453b0f2ab8c8ae5385f615b0270e422be529e8bb2a4997250769c031a155a9c855ea7fcbeec5fc7a864c807b3"} build_url:https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/KWjCQpvoT8KgbTk6v_IcoQ/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/ec6962593d7bda4ad960c5d1f0fda44b01eb3f21effed7742774498765ebccd684ad4c44d6f95c13995e85fe173f122237fa7bf5570e7a7f1574d97bfdd45cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/933ed0f4ec10dd7a04ad1029b0f46ed0be6b1593abc0053e1e0553069e983b416120efd1699ee41fe5637f5f4b063676db21f3dcbbd108333ca039e5624e53a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4267c14eea9cde846895a70fb2aa0f161745da3453b0f2ab8c8ae5385f615b0270e422be529e8bb2a4997250769c031a155a9c855ea7fcbeec5fc7a864c807b3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 07:10:14.242803) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:10:14.243247) ========= 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.UgnwXselT7/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.ewQFZGsgZX/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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.005165 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:10:14.292336) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 07:10:14.292679) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 07:10:14.293044) ========= ========= Total master_lag: 0.20 =========