builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0322 starttime: 1487259149.03 results: success (0) buildid: 20170216043618 builduid: 32bf7002178d4777ab1775442a32dc7f revision: d273229cde3cccea129e2450ec1234e9ac51efc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 07:32:29.029141) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 07:32:29.029564) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 07:32:29.029851) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 07:32:29.054634) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 07:32:29.054952) ========= 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.RZn1c9N604/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.IMoWvarFUC/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-16 07:32:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.81M=0.001s 2017-02-16 07:32:29 (9.81 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124870 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 07:32:29.202938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 07:32:29.203244) ========= 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.RZn1c9N604/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.IMoWvarFUC/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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.019949 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 07:32:29.251317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 07:32:29.251682) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d273229cde3cccea129e2450ec1234e9ac51efc4 --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 d273229cde3cccea129e2450ec1234e9ac51efc4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RZn1c9N604/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.IMoWvarFUC/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-16 07:32:29,342 truncating revision to first 12 chars 2017-02-16 07:32:29,342 Setting DEBUG logging. 2017-02-16 07:32:29,342 attempt 1/10 2017-02-16 07:32:29,342 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d273229cde3c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-16 07:32:29,792 unpacking tar archive at: mozilla-beta-d273229cde3c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703780 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 07:32:29.978871) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 07:32:29.979169) ========= script_repo_revision: d273229cde3cccea129e2450ec1234e9ac51efc4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 07:32:29.979537) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 07:32:29.979809) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 07:32:29.999452) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-16 07:32:29.999801) ========= /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.RZn1c9N604/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.IMoWvarFUC/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 07:32:30 INFO - MultiFileLogger online at 20170216 07:32:30 in /builds/slave/test 07:32:30 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 07:32:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:32:30 INFO - {'append_to_log': False, 07:32:30 INFO - 'base_work_dir': '/builds/slave/test', 07:32:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:32:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:32:30 INFO - 'branch': 'Mozilla-Beta', 07:32:30 INFO - 'buildbot_json_path': 'buildprops.json', 07:32:30 INFO - 'config_files': ('talos/mac_config.py',), 07:32:30 INFO - 'default_actions': ('clobber', 07:32:30 INFO - 'read-buildbot-config', 07:32:30 INFO - 'download-and-extract', 07:32:30 INFO - 'populate-webroot', 07:32:30 INFO - 'create-virtualenv', 07:32:30 INFO - 'install', 07:32:30 INFO - 'run-tests'), 07:32:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:32:30 INFO - 'download_minidump_stackwalk': True, 07:32:30 INFO - 'download_symbols': 'ondemand', 07:32:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:32:30 INFO - 'tooltool.py': '/tools/tooltool.py', 07:32:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:32:30 INFO - '/tools/misc-python/virtualenv.py')}, 07:32:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:32:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:32:30 INFO - 'installer_path': 'installer.exe', 07:32:30 INFO - 'log_level': 'info', 07:32:30 INFO - 'log_name': 'talos', 07:32:30 INFO - 'log_to_console': True, 07:32:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:32:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:32:30 INFO - 'opt_config_files': (), 07:32:30 INFO - 'pip_index': False, 07:32:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:32:30 INFO - 'cmd': ('bash', 07:32:30 INFO - '-c', 07:32:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:32:30 INFO - 'enabled': True, 07:32:30 INFO - 'halt_on_failure': False, 07:32:30 INFO - 'name': 'check_screen_resolution'},), 07:32:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:32:30 INFO - 'cmd': ('bash', 07:32:30 INFO - '-c', 07:32:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:32:30 INFO - 'enabled': True, 07:32:30 INFO - 'halt_on_failure': False, 07:32:30 INFO - 'name': 'check_screen_resolution'},), 07:32:30 INFO - 'run_cmd_checks_enabled': True, 07:32:30 INFO - 'sps_profile': False, 07:32:30 INFO - 'sps_profile_interval': 0, 07:32:30 INFO - 'suite': 'dromaeojs', 07:32:30 INFO - 'system_bits': '32', 07:32:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:32:30 INFO - 'title': 't-yosemite-r7-0322', 07:32:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:32:30 INFO - 'use_talos_json': True, 07:32:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:32:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:32:30 INFO - 'work_dir': 'build'} 07:32:30 INFO - [mozharness: 2017-02-16 15:32:30.208476Z] Running clobber step. 07:32:30 INFO - Running pre-action listener: _resource_record_pre_action 07:32:30 INFO - Running main action method: clobber 07:32:30 INFO - rmtree: /builds/slave/test/build 07:32:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:32:31 INFO - Running post-action listener: _resource_record_post_action 07:32:31 INFO - [mozharness: 2017-02-16 15:32:31.878554Z] Finished clobber step (success) 07:32:31 INFO - [mozharness: 2017-02-16 15:32:31.878784Z] Running read-buildbot-config step. 07:32:31 INFO - Running pre-action listener: _resource_record_pre_action 07:32:31 INFO - Running main action method: read_buildbot_config 07:32:31 INFO - Using buildbot properties: 07:32:31 INFO - { 07:32:31 INFO - "project": "", 07:32:31 INFO - "product": "firefox", 07:32:31 INFO - "script_repo_revision": "production", 07:32:31 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:32:31 INFO - "repository": "", 07:32:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:32:31 INFO - "buildid": "20170216043618", 07:32:31 INFO - "pgo_build": "False", 07:32:31 INFO - "basedir": "/builds/slave/test", 07:32:31 INFO - "buildnumber": 10, 07:32:31 INFO - "slavename": "t-yosemite-r7-0322", 07:32:31 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:32:31 INFO - "platform": "yosemite_r7", 07:32:31 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:32:31 INFO - "branch": "mozilla-beta", 07:32:31 INFO - "repo_path": "releases/mozilla-beta", 07:32:31 INFO - "revision": "d273229cde3cccea129e2450ec1234e9ac51efc4", 07:32:31 INFO - "stage_platform": "macosx64", 07:32:31 INFO - "builduid": "32bf7002178d4777ab1775442a32dc7f", 07:32:31 INFO - "slavebuilddir": "test" 07:32:31 INFO - } 07:32:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 07:32:31 INFO - Running post-action listener: _resource_record_post_action 07:32:31 INFO - [mozharness: 2017-02-16 15:32:31.883260Z] Finished read-buildbot-config step (success) 07:32:31 INFO - [mozharness: 2017-02-16 15:32:31.883375Z] Running download-and-extract step. 07:32:31 INFO - Running pre-action listener: _resource_record_pre_action 07:32:31 INFO - Running main action method: download_and_extract 07:32:31 INFO - mkdir: /builds/slave/test/build/tests 07:32:31 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')]} 07:32:31 INFO - trying https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 07:32:31 INFO - Downloading https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 07:32:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 07:32:33 INFO - Downloaded 1165 bytes. 07:32:33 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 07:32:33 INFO - Using the following test package requirements: 07:32:33 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 07:32:33 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:32:33 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 07:32:33 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:32:33 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 07:32:33 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:32:33 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:32:33 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 07:32:33 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 07:32:33 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:32:33 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 07:32:33 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:32:33 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 07:32:33 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:32:33 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 07:32:33 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:32:33 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 07:32:33 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 07:32:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 07:32:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 07:32:33 INFO - Fetch https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 07:32:33 INFO - Http code: 200 07:32:33 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 07:32:33 INFO - x-amz-cf-id: Xvf-vz4b7YMR8pf9Z56AWMCqpVCjgaYssY2-ooibIaSX6vZb5O_VLw== 07:32:33 INFO - x-amz-version-id: ooLmpISPh6FAdbNGXD9yf_H4m8cHsRtU 07:32:34 INFO - Expected file size: 16094097 07:32:34 INFO - Obtained file size: 16094097 07:32:40 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:32:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 07:32:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 07:32:40 INFO - Fetch https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 07:32:41 INFO - Http code: 200 07:32:41 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 07:32:41 INFO - x-amz-cf-id: u2nCdORhXjBKnLv8APP6oyCsjHeAYafsgDXLrKKzEesVOqpWFqGUOA== 07:32:41 INFO - x-amz-version-id: ooLmpISPh6FAdbNGXD9yf_H4m8cHsRtU 07:32:41 INFO - Expected file size: 16094097 07:32:41 INFO - Obtained file size: 16094097 07:32:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 07:32:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 07:32:47 INFO - Fetch https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 07:32:48 INFO - Http code: 200 07:32:48 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 07:32:48 INFO - x-amz-cf-id: vyHUZhEvI5pvhCyto9yRNlUajNl21o1_lIHWU27tBIasJA9RSc5s3g== 07:32:48 INFO - x-amz-version-id: .QJM1Qn0QQGavYfj6yRLVuJi9RwSVp.L 07:32:48 INFO - Expected file size: 14403005 07:32:48 INFO - Obtained file size: 14403005 07:32: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')]} 07:32:49 INFO - trying https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 07:32:49 INFO - Downloading https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 07:32:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 07:32:51 INFO - Downloaded 82114135 bytes. 07:32:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 07:32:51 INFO - mkdir: /builds/slave/test/properties 07:32:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:32:51 INFO - Writing to file /builds/slave/test/properties/build_url 07:32:51 INFO - Contents: 07:32:51 INFO - build_url:https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 07:32:51 INFO - Running post-action listener: _resource_record_post_action 07:32:51 INFO - Running post-action listener: set_extra_try_arguments 07:32:51 INFO - [mozharness: 2017-02-16 15:32:51.976183Z] Finished download-and-extract step (success) 07:32:51 INFO - [mozharness: 2017-02-16 15:32:51.976330Z] Running populate-webroot step. 07:32:51 INFO - Running pre-action listener: _resource_record_pre_action 07:32:51 INFO - Running main action method: populate_webroot 07:32:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:32:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:32:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:32:51 INFO - '--tppagecycles', 07:32:51 INFO - '7'], 07:32:51 INFO - 'tests': ['tsvgm']}}, 07:32:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:32:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:32:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:32:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:32:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:32:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:32:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:51 INFO - 'talos_options': ['--disable-e10s'], 07:32:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:51 INFO - 'talos_options': ['--disable-e10s'], 07:32:51 INFO - 'tests': ['damp', 'tps']}, 07:32:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:51 INFO - 'tests': ['damp', 'tps']}, 07:32:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:32:51 INFO - 'tests': ['dromaeo_dom']}, 07:32:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:32:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:32:51 INFO - 'tests': ['basic_compositor_video']}, 07:32:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:32:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:32:51 INFO - 'tests': ['a11yr', 07:32:51 INFO - 'ts_paint', 07:32:51 INFO - 'tpaint', 07:32:51 INFO - 'sessionrestore', 07:32:51 INFO - 'sessionrestore_no_auto_restore', 07:32:51 INFO - 'tabpaint']}, 07:32:51 INFO - 'other-e10s': {'tests': ['a11yr', 07:32:51 INFO - 'ts_paint', 07:32:51 INFO - 'tpaint', 07:32:51 INFO - 'sessionrestore', 07:32:51 INFO - 'sessionrestore_no_auto_restore', 07:32:51 INFO - 'tabpaint']}, 07:32:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:32:51 INFO - 'ts_paint', 07:32:51 INFO - 'tpaint', 07:32:51 INFO - 'sessionrestore', 07:32:51 INFO - 'sessionrestore_no_auto_restore', 07:32:51 INFO - 'tabpaint']}, 07:32:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:32:51 INFO - 'ts_paint', 07:32:51 INFO - 'tpaint', 07:32:51 INFO - 'sessionrestore', 07:32:51 INFO - 'sessionrestore_no_auto_restore', 07:32:51 INFO - 'tabpaint']}, 07:32:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:32:51 INFO - 'tests': ['a11yr', 07:32:51 INFO - 'ts_paint', 07:32:51 INFO - 'tpaint', 07:32:51 INFO - 'sessionrestore', 07:32:51 INFO - 'sessionrestore_no_auto_restore', 07:32:51 INFO - 'tabpaint']}, 07:32:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:32:51 INFO - 'tests': ['a11yr', 07:32:51 INFO - 'ts_paint', 07:32:51 INFO - 'tpaint', 07:32:51 INFO - 'sessionrestore', 07:32:51 INFO - 'sessionrestore_no_auto_restore', 07:32:51 INFO - 'tabpaint']}, 07:32:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:32:51 INFO - 'tests': ['tsvgx', 07:32:51 INFO - 'tsvgr_opacity', 07:32:51 INFO - 'tart', 07:32:51 INFO - 'tscrollx', 07:32:51 INFO - 'cart']}, 07:32:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:32:51 INFO - 'tsvgr_opacity', 07:32:51 INFO - 'tart', 07:32:51 INFO - 'tscrollx', 07:32:51 INFO - 'cart']}, 07:32:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:51 INFO - 'talos_options': ['--disable-e10s'], 07:32:51 INFO - 'tests': ['tp5o']}, 07:32:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:51 INFO - 'tests': ['tp5o']}, 07:32:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:51 INFO - 'talos_options': ['--disable-e10s', 07:32:51 INFO - '--xperf_path', 07:32:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:51 INFO - 'tests': ['tp5n']}, 07:32:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:51 INFO - 'talos_options': ['--xperf_path', 07:32:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:51 INFO - 'tests': ['tp5n']}}, 07:32:51 INFO - 'talos.zip': {'path': '', 07:32:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:32:51 INFO - Running post-action listener: _resource_record_post_action 07:32:51 INFO - [mozharness: 2017-02-16 15:32:51.994951Z] Finished populate-webroot step (success) 07:32:51 INFO - [mozharness: 2017-02-16 15:32:51.995061Z] Running create-virtualenv step. 07:32:51 INFO - Running pre-action listener: _resource_record_pre_action 07:32:51 INFO - Running main action method: create_virtualenv 07:32:51 INFO - Creating virtualenv /builds/slave/test/build/venv 07:32:51 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 07:32:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:32:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:32:52 INFO - Using real prefix '/tools/python27' 07:32:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:32:52 INFO - Installing distribute.............................................................................................................................................................................................done. 07:32:55 INFO - Installing pip.................done. 07:32:55 INFO - Return code: 0 07:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:32:55 INFO - Reading from file tmpfile_stdout 07:32:55 INFO - Output received: 07:32:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:32:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:32:55 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')]} 07:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:55 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')]} 07:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:55 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 0x105312490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105288570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe293cd31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105126d30>, '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 0x104f8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511eb20>, '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.RZn1c9N604/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.IMoWvarFUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 07:32:55 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 07:32:55 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 07:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZn1c9N604/Render', 07:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:55 INFO - 'HOME': '/Users/cltbld', 07:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:55 INFO - 'LOGNAME': 'cltbld', 07:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:55 INFO - 'MOZ_NO_REMOTE': '1', 07:32:55 INFO - 'NO_EM_RESTART': '1', 07:32:55 INFO - 'PAGER': '/bin/cat', 07:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:55 INFO - 'PWD': '/builds/slave/test', 07:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:55 INFO - 'SHELL': '/bin/bash', 07:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IMoWvarFUC/Listeners', 07:32:55 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 07:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:55 INFO - 'USER': 'cltbld', 07:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:55 INFO - 'XPC_FLAGS': '0x0', 07:32:55 INFO - 'XPC_SERVICE_NAME': '0', 07:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:56 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 07:32:56 INFO - Cleaning up... 07:32:56 INFO - Return code: 0 07:32:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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', '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 0x105312490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105288570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe293cd31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105126d30>, '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 0x104f8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511eb20>, '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.RZn1c9N604/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.IMoWvarFUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 07:32: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:32: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 psutil>=3.1.1 07:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZn1c9N604/Render', 07:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:56 INFO - 'HOME': '/Users/cltbld', 07:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:56 INFO - 'LOGNAME': 'cltbld', 07:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:56 INFO - 'MOZ_NO_REMOTE': '1', 07:32:56 INFO - 'NO_EM_RESTART': '1', 07:32:56 INFO - 'PAGER': '/bin/cat', 07:32:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:56 INFO - 'PWD': '/builds/slave/test', 07:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:56 INFO - 'SHELL': '/bin/bash', 07:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IMoWvarFUC/Listeners', 07:32:56 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 07:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:56 INFO - 'USER': 'cltbld', 07:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:56 INFO - 'XPC_FLAGS': '0x0', 07:32:56 INFO - 'XPC_SERVICE_NAME': '0', 07:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:56 INFO - Downloading/unpacking psutil>=3.1.1 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:32:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:59 INFO - Installing collected packages: psutil 07:32:59 INFO - Running setup.py install for psutil 07:32:59 INFO - building 'psutil._psutil_osx' extension 07:32:59 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 07:33:00 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 07:33:00 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 07:33:00 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 07:33:00 INFO - building 'psutil._psutil_posix' extension 07:33:00 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 07:33:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:33:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:33:00 INFO - ^ 07:33:00 INFO - 1 warning generated. 07:33:00 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 07:33:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:33:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:33:00 INFO - Successfully installed psutil 07:33:00 INFO - Cleaning up... 07:33:00 INFO - Return code: 0 07:33:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:00 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 0x105312490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105288570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe293cd31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105126d30>, '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 0x104f8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511eb20>, '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.RZn1c9N604/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.IMoWvarFUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 07:33:00 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 07:33:00 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 07:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZn1c9N604/Render', 07:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:00 INFO - 'HOME': '/Users/cltbld', 07:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:00 INFO - 'LOGNAME': 'cltbld', 07:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:00 INFO - 'MOZ_NO_REMOTE': '1', 07:33:00 INFO - 'NO_EM_RESTART': '1', 07:33:00 INFO - 'PAGER': '/bin/cat', 07:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:00 INFO - 'PWD': '/builds/slave/test', 07:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:00 INFO - 'SHELL': '/bin/bash', 07:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IMoWvarFUC/Listeners', 07:33:00 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 07:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:00 INFO - 'USER': 'cltbld', 07:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:00 INFO - 'XPC_FLAGS': '0x0', 07:33:00 INFO - 'XPC_SERVICE_NAME': '0', 07:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:33:01 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 07:33:01 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 07:33:01 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 07:33:01 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 07:33:01 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 07:33:01 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 07:33:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:33:03 INFO - Installing collected packages: mozsystemmonitor 07:33:03 INFO - Running setup.py install for mozsystemmonitor 07:33:03 INFO - Successfully installed mozsystemmonitor 07:33:03 INFO - Cleaning up... 07:33:04 INFO - Return code: 0 07:33:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:33:04 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')]} 07:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:04 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')]} 07:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:04 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 0x105312490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105288570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe293cd31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105126d30>, '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 0x104f8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511eb20>, '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.RZn1c9N604/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.IMoWvarFUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 07:33:04 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 07:33:04 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 07:33:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZn1c9N604/Render', 07:33:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:04 INFO - 'HOME': '/Users/cltbld', 07:33:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:04 INFO - 'LOGNAME': 'cltbld', 07:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:04 INFO - 'MOZ_NO_REMOTE': '1', 07:33:04 INFO - 'NO_EM_RESTART': '1', 07:33:04 INFO - 'PAGER': '/bin/cat', 07:33:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:04 INFO - 'PWD': '/builds/slave/test', 07:33:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:04 INFO - 'SHELL': '/bin/bash', 07:33:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IMoWvarFUC/Listeners', 07:33:04 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 07:33:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:04 INFO - 'USER': 'cltbld', 07:33:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:04 INFO - 'XPC_FLAGS': '0x0', 07:33:04 INFO - 'XPC_SERVICE_NAME': '0', 07:33:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:04 INFO - Downloading/unpacking jsonschema==2.5.1 07:33:04 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 07:33:04 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 07:33:04 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 07:33:04 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 07:33:04 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 07:33:04 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 07:33:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:33:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:07 INFO - Downloading functools32-3.2.3-2.tar.gz 07:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:33:07 INFO - warning: no files found matching '*.txt' 07:33:07 INFO - no previously-included directories found matching 'build' 07:33:07 INFO - no previously-included directories found matching 'dist' 07:33:07 INFO - no previously-included directories found matching '.git*' 07:33:07 INFO - Installing collected packages: jsonschema, functools32 07:33:07 INFO - Running setup.py install for functools32 07:33:07 INFO - warning: no files found matching '*.txt' 07:33:07 INFO - no previously-included directories found matching 'build' 07:33:07 INFO - no previously-included directories found matching 'dist' 07:33:07 INFO - no previously-included directories found matching '.git*' 07:33:07 INFO - Successfully installed jsonschema functools32 07:33:07 INFO - Cleaning up... 07:33:07 INFO - Return code: 0 07:33:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105312490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105288570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe293cd31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105126d30>, '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 0x104f8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511eb20>, '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.RZn1c9N604/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.IMoWvarFUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 07:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:33:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZn1c9N604/Render', 07:33:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:07 INFO - 'HOME': '/Users/cltbld', 07:33:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:07 INFO - 'LOGNAME': 'cltbld', 07:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:07 INFO - 'MOZ_NO_REMOTE': '1', 07:33:07 INFO - 'NO_EM_RESTART': '1', 07:33:07 INFO - 'PAGER': '/bin/cat', 07:33:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:07 INFO - 'PWD': '/builds/slave/test', 07:33:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:07 INFO - 'SHELL': '/bin/bash', 07:33:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IMoWvarFUC/Listeners', 07:33:07 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 07:33:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:07 INFO - 'USER': 'cltbld', 07:33:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:07 INFO - 'XPC_FLAGS': '0x0', 07:33:07 INFO - 'XPC_SERVICE_NAME': '0', 07:33:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:33:07 INFO - Cleaning up... 07:33:07 INFO - Return code: 0 07:33:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105312490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105288570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe293cd31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105126d30>, '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 0x104f8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511eb20>, '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.RZn1c9N604/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.IMoWvarFUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 07:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:33:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZn1c9N604/Render', 07:33:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:07 INFO - 'HOME': '/Users/cltbld', 07:33:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:07 INFO - 'LOGNAME': 'cltbld', 07:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:07 INFO - 'MOZ_NO_REMOTE': '1', 07:33:07 INFO - 'NO_EM_RESTART': '1', 07:33:07 INFO - 'PAGER': '/bin/cat', 07:33:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:07 INFO - 'PWD': '/builds/slave/test', 07:33:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:07 INFO - 'SHELL': '/bin/bash', 07:33:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IMoWvarFUC/Listeners', 07:33:07 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 07:33:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:07 INFO - 'USER': 'cltbld', 07:33:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:07 INFO - 'XPC_FLAGS': '0x0', 07:33:07 INFO - 'XPC_SERVICE_NAME': '0', 07:33:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:08 INFO - Downloading/unpacking blobuploader==1.2.4 07:33: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 07:33: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 07:33: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 07:33: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 07:33: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 07:33: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 07:33:10 INFO - Downloading blobuploader-1.2.4.tar.gz 07:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:33:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:33:10 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 07:33:10 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 07:33:10 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 07:33:10 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 07:33:10 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 07:33:10 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 07:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:33:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:12 INFO - Downloading docopt-0.6.1.tar.gz 07:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:33:12 INFO - Installing collected packages: blobuploader, requests, docopt 07:33:12 INFO - Running setup.py install for blobuploader 07:33:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:33:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:33:12 INFO - Running setup.py install for requests 07:33:12 INFO - Running setup.py install for docopt 07:33:12 INFO - Successfully installed blobuploader requests docopt 07:33:12 INFO - Cleaning up... 07:33:13 INFO - Return code: 0 07:33:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:13 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 0x105312490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105288570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe293cd31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105126d30>, '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 0x104f8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511eb20>, '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.RZn1c9N604/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.IMoWvarFUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 07:33:13 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 07:33:13 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 07:33:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZn1c9N604/Render', 07:33:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:13 INFO - 'HOME': '/Users/cltbld', 07:33:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:13 INFO - 'LOGNAME': 'cltbld', 07:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:13 INFO - 'MOZ_NO_REMOTE': '1', 07:33:13 INFO - 'NO_EM_RESTART': '1', 07:33:13 INFO - 'PAGER': '/bin/cat', 07:33:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:13 INFO - 'PWD': '/builds/slave/test', 07:33:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:13 INFO - 'SHELL': '/bin/bash', 07:33:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IMoWvarFUC/Listeners', 07:33:13 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 07:33:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:13 INFO - 'USER': 'cltbld', 07:33:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:13 INFO - 'XPC_FLAGS': '0x0', 07:33:13 INFO - 'XPC_SERVICE_NAME': '0', 07:33:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:33:13 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-Yoqz0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:33:13 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-lzPj1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:33:13 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-vMlNrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:33:13 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-jllhlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:33:13 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-qNp6WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:33:13 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-7O28_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:33:13 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-ioU8h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:33:14 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-XZ1SqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:33:14 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-fQgMt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:33:14 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-A2BugK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:33:14 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-xiOV1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:33:14 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-qqD_aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:33:14 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-4gOMkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:33:14 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-1Yvw_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:14 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-RA7Gkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:33:14 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-tVj5uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:33:14 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-jkUBLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:33:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:33:15 INFO - Running setup.py install for manifestparser 07:33:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:33:15 INFO - Running setup.py install for mozcrash 07:33:15 INFO - Running setup.py install for mozdebug 07:33:15 INFO - Running setup.py install for mozdevice 07:33:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:33:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:33:15 INFO - Running setup.py install for mozfile 07:33:15 INFO - Running setup.py install for mozhttpd 07:33:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:33:15 INFO - Running setup.py install for mozinfo 07:33:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:33:16 INFO - Running setup.py install for mozInstall 07:33:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:33:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:33:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:33:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:33:16 INFO - Running setup.py install for mozleak 07:33:16 INFO - Running setup.py install for mozlog 07:33:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:33:16 INFO - Running setup.py install for moznetwork 07:33:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:33:16 INFO - Running setup.py install for mozprocess 07:33:16 INFO - Running setup.py install for mozprofile 07:33:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:33:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:33:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:33:17 INFO - Running setup.py install for mozrunner 07:33:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:33:17 INFO - Running setup.py install for mozscreenshot 07:33:17 INFO - Running setup.py install for moztest 07:33:17 INFO - Running setup.py install for mozversion 07:33:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:33:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:33:17 INFO - Cleaning up... 07:33:17 INFO - Return code: 0 07:33:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:17 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 0x105312490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105288570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe293cd31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105126d30>, '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 0x104f8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511eb20>, '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.RZn1c9N604/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.IMoWvarFUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 07:33:17 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 07:33:17 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 07:33:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZn1c9N604/Render', 07:33:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:17 INFO - 'HOME': '/Users/cltbld', 07:33:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:17 INFO - 'LOGNAME': 'cltbld', 07:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:17 INFO - 'MOZ_NO_REMOTE': '1', 07:33:17 INFO - 'NO_EM_RESTART': '1', 07:33:17 INFO - 'PAGER': '/bin/cat', 07:33:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:17 INFO - 'PWD': '/builds/slave/test', 07:33:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:17 INFO - 'SHELL': '/bin/bash', 07:33:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IMoWvarFUC/Listeners', 07:33:17 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 07:33:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:17 INFO - 'USER': 'cltbld', 07:33:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:17 INFO - 'XPC_FLAGS': '0x0', 07:33:17 INFO - 'XPC_SERVICE_NAME': '0', 07:33:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:33:17 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-GudJG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:33:18 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)) 07:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:33:18 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-b3mBsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:33:18 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-gk6yYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:33:18 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)) 07:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:33:18 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-XJbyFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:33:18 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)) 07:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:33:18 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-1yOMt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:33:18 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)) 07:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:33:18 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-ic84cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:33:18 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)) 07:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:33:18 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-qaCOIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:33:18 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)) 07:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:33:18 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-y6wDsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:33:18 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)) 07:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:33:18 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-3zjCVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:33:18 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)) 07:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:33:18 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-KchSHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:33:19 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)) 07:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:33:19 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-WPNEgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:33:19 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)) 07:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:33:19 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-ekUOcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:33:19 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)) 07:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:33:19 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-AAW3FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:33:19 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)) 07:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:33:19 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-eS54dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:19 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-5hXGAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:19 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)) 07:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:33:19 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-DKN5_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:33:19 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-OPbh2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:33:19 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)) 07:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:33:19 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)) 07:33:19 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)) 07:33:19 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)) 07:33:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:22 INFO - Downloading blessings-1.6.tar.gz 07:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:33:22 INFO - Installing collected packages: blessings 07:33:22 INFO - Running setup.py install for blessings 07:33:22 INFO - Successfully installed blessings 07:33:22 INFO - Cleaning up... 07:33:22 INFO - Return code: 0 07:33:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:33:22 INFO - Reading from file tmpfile_stdout 07:33:22 INFO - Current package versions: 07:33:22 INFO - blessings == 1.6 07:33:22 INFO - blobuploader == 1.2.4 07:33:22 INFO - docopt == 0.6.1 07:33:22 INFO - functools32 == 3.2.3-2 07:33:22 INFO - jsonschema == 2.5.1 07:33:22 INFO - manifestparser == 1.1 07:33:22 INFO - mozInstall == 1.12 07:33:22 INFO - mozcrash == 1.0 07:33:22 INFO - mozdebug == 0.1 07:33:22 INFO - mozdevice == 0.48 07:33:22 INFO - mozfile == 1.2 07:33:22 INFO - mozhttpd == 0.7 07:33:22 INFO - mozinfo == 0.9 07:33:22 INFO - mozleak == 0.1 07:33:22 INFO - mozlog == 3.4 07:33:22 INFO - moznetwork == 0.27 07:33:22 INFO - mozprocess == 0.23 07:33:22 INFO - mozprofile == 0.28 07:33:22 INFO - mozrunner == 6.13 07:33:22 INFO - mozscreenshot == 0.1 07:33:22 INFO - mozsystemmonitor == 0.3 07:33:22 INFO - moztest == 0.8 07:33:22 INFO - mozversion == 1.4 07:33:22 INFO - psutil == 3.1.1 07:33:22 INFO - requests == 1.2.3 07:33:22 INFO - wsgiref == 0.1.2 07:33:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:33:22 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')]} 07:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:22 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')]} 07:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:22 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 0x105312490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105288570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe293cd31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105126d30>, '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 0x104f8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511eb20>, '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.RZn1c9N604/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.IMoWvarFUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 07:33:22 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 07:33:22 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 07:33:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZn1c9N604/Render', 07:33:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:22 INFO - 'HOME': '/Users/cltbld', 07:33:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:22 INFO - 'LOGNAME': 'cltbld', 07:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:22 INFO - 'MOZ_NO_REMOTE': '1', 07:33:22 INFO - 'NO_EM_RESTART': '1', 07:33:22 INFO - 'PAGER': '/bin/cat', 07:33:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:22 INFO - 'PWD': '/builds/slave/test', 07:33:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:22 INFO - 'SHELL': '/bin/bash', 07:33:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IMoWvarFUC/Listeners', 07:33:22 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 07:33:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:22 INFO - 'USER': 'cltbld', 07:33:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:22 INFO - 'XPC_FLAGS': '0x0', 07:33:22 INFO - 'XPC_SERVICE_NAME': '0', 07:33:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:23 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)) 07:33:23 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)) 07:33:23 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)) 07:33:23 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)) 07:33:23 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)) 07:33:23 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)) 07:33:23 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)) 07:33:23 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)) 07:33:23 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)) 07:33:23 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)) 07:33:23 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)) 07:33:23 INFO - Cleaning up... 07:33:23 INFO - Return code: 0 07:33:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105312490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105288570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe293cd31f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105126d30>, '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 0x104f8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511eb20>, '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.RZn1c9N604/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.IMoWvarFUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 07:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:33:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZn1c9N604/Render', 07:33:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:23 INFO - 'HOME': '/Users/cltbld', 07:33:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:23 INFO - 'LOGNAME': 'cltbld', 07:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:23 INFO - 'MOZ_NO_REMOTE': '1', 07:33:23 INFO - 'NO_EM_RESTART': '1', 07:33:23 INFO - 'PAGER': '/bin/cat', 07:33:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:23 INFO - 'PWD': '/builds/slave/test', 07:33:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:23 INFO - 'SHELL': '/bin/bash', 07:33:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IMoWvarFUC/Listeners', 07:33:23 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 07:33:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:23 INFO - 'USER': 'cltbld', 07:33:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:23 INFO - 'XPC_FLAGS': '0x0', 07:33:23 INFO - 'XPC_SERVICE_NAME': '0', 07:33:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:33:23 INFO - Cleaning up... 07:33:23 INFO - Return code: 0 07:33:23 INFO - Running post-action listener: _resource_record_post_action 07:33:23 INFO - Running post-action listener: _start_resource_monitoring 07:33:23 INFO - Starting resource monitoring. 07:33:23 INFO - [mozharness: 2017-02-16 15:33:23.555194Z] Finished create-virtualenv step (success) 07:33:23 INFO - [mozharness: 2017-02-16 15:33:23.556205Z] Running install step. 07:33:23 INFO - Running pre-action listener: _resource_record_pre_action 07:33:23 INFO - Running main action method: install 07:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:33:23 INFO - Reading from file tmpfile_stdout 07:33:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:33:23 INFO - Reading from file tmpfile_stdout 07:33:23 INFO - Output received: 07:33:23 INFO - Usage: mozinstall [options] installer 07:33:23 INFO - Options: 07:33:23 INFO - -h, --help show this help message and exit 07:33:23 INFO - -d DEST, --destination=DEST 07:33:23 INFO - Directory to install application into. [default: 07:33:23 INFO - "/builds/slave/test"] 07:33:23 INFO - --app=APP Application being installed. [default: firefox] 07:33:23 INFO - mkdir: /builds/slave/test/build/application 07:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:33:45 INFO - Reading from file tmpfile_stdout 07:33:45 INFO - Output received: 07:33:45 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:33:45 INFO - Running post-action listener: _resource_record_post_action 07:33:45 INFO - [mozharness: 2017-02-16 15:33:45.275462Z] Finished install step (success) 07:33:45 INFO - [mozharness: 2017-02-16 15:33:45.275612Z] Running run-tests step. 07:33:45 INFO - Running pre-action listener: _resource_record_pre_action 07:33:45 INFO - Running main action method: run_tests 07:33:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:33:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:33:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:33:45 INFO - 2017-02-16 07:33:45.289 screenresolution[1891:14168] starting screenresolution argv=screenresolution get 07:33:45 INFO - 2017-02-16 07:33:45.292 screenresolution[1891:14168] Display 0: 1600x1200x32@60 07:33:45 INFO - 2017-02-16 07:33:45.297 screenresolution[1892:14171] starting screenresolution argv=screenresolution list 07:33:45 INFO - Available Modes on Display 0 07:33:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:33:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:33:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:33:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:33:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:33:45 INFO - Intel Iris: 07:33:45 INFO - Chipset Model: Intel Iris 07:33:45 INFO - Type: GPU 07:33:45 INFO - Bus: Built-In 07:33:45 INFO - VRAM (Dynamic, Max): 1536 MB 07:33:45 INFO - Vendor: Intel (0x8086) 07:33:45 INFO - Device ID: 0x0a2e 07:33:45 INFO - Revision ID: 0x0009 07:33:45 INFO - Displays: 07:33:45 INFO - Display: 07:33:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:33:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:33:45 INFO - Display Serial Number: 1600x1200 60 07:33:45 INFO - Main Display: Yes 07:33:45 INFO - Mirror: Off 07:33:45 INFO - Online: Yes 07:33:45 INFO - Rotation: Supported 07:33:45 INFO - Return code: 0 07:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:33:45 INFO - Python 2.7.3 07:33:45 INFO - Return code: 0 07:33:45 INFO - grabbing minidump binary from tooltool 07:33:45 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')]} 07:33:45 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 0x105126d30>, '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 0x104f8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:33:45 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 07:33:45 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 07:33:45 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 07:33:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:33:45 INFO - Return code: 0 07:33:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:33:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:33:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:33:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:33:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:33:45 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/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0322', '--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 07:33:45 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/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0322 --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 07:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZn1c9N604/Render', 07:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:45 INFO - 'HOME': '/Users/cltbld', 07:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:45 INFO - 'LOGNAME': 'cltbld', 07:33:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:33:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:45 INFO - 'MOZ_NO_REMOTE': '1', 07:33:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:33:45 INFO - 'NO_EM_RESTART': '1', 07:33:45 INFO - 'PAGER': '/bin/cat', 07:33:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:45 INFO - 'PWD': '/builds/slave/test', 07:33:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:45 INFO - 'SHELL': '/bin/bash', 07:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IMoWvarFUC/Listeners', 07:33:45 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 07:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:45 INFO - 'USER': 'cltbld', 07:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:45 INFO - 'XPC_FLAGS': '0x0', 07:33:45 INFO - 'XPC_SERVICE_NAME': '0', 07:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:45 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/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0322', '--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 07:33:45 INFO - mozversion application_buildid: 20170216043618 07:33:45 INFO - mozversion application_changeset: d273229cde3cccea129e2450ec1234e9ac51efc4 07:33:45 INFO - mozversion application_display_name: Firefox 07:33:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:33:45 INFO - mozversion application_name: Firefox 07:33:45 INFO - mozversion application_remotingname: firefox 07:33:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:33:45 INFO - mozversion application_vendor: Mozilla 07:33:45 INFO - mozversion application_version: 52.0 07:33:45 INFO - mozversion platform_buildid: 20170216043618 07:33:45 INFO - mozversion platform_changeset: d273229cde3cccea129e2450ec1234e9ac51efc4 07:33:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:33:45 INFO - mozversion platform_version: 52.0 07:33:45 INFO - using testdate: 1487259225 07:33:45 INFO - actual date: 1487259225 07:33:45 INFO - starting webserver on 'localhost:51830' 07:33:45 INFO - SUITE-START | Running 2 tests 07:33:45 INFO - TEST-START | dromaeo_css 07:33:45 INFO - operating with platform_type : mac_ 07:33:45 INFO - Initialising browser for dromaeo_css test... 07:33:45 INFO - TEST-INFO | started process 1902 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpZwEw36/profile http://localhost:51830/getInfo.html) 07:33:48 INFO - PROCESS | 1902 | __metrics Screen width/height:1600/1200 07:33:48 INFO - PROCESS | 1902 | colorDepth:24 07:33:48 INFO - PROCESS | 1902 | Browser inner width/height: 1024/689 07:33:48 INFO - PROCESS | 1902 | __metrics 07:33:48 INFO - PROCESS | 1902 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:33:48 INFO - PROCESS | 1902 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:33:49 INFO - TEST-INFO | 1902: exit 0 07:33:49 INFO - Browser initialized. 07:33:49 INFO - Running cycle 1/1 for dromaeo_css test... 07:33:49 INFO - TEST-INFO | started process 1905 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpZwEw36/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:34:01 INFO - PROCESS | 1905 | RSS: Main: 167911424 07:34:01 INFO - PROCESS | 1905 | 07:37:03 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51830/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51830/tests/dromaeo/cssquery-ext.html) 07:37:05 INFO - PROCESS | 1905 | RSS: Main: 268337152 07:37:05 INFO - PROCESS | 1905 | 07:40:08 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51830/tests/dromaeo/cssquery-ext.html (next: http://localhost:51830/tests/dromaeo/cssquery-jquery.html) 07:40:09 INFO - PROCESS | 1905 | RSS: Main: 327446528 07:40:09 INFO - PROCESS | 1905 | 07:43:11 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51830/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51830/tests/dromaeo/cssquery-mootools.html) 07:43:12 INFO - PROCESS | 1905 | RSS: Main: 282386432 07:43:12 INFO - PROCESS | 1905 | 07:46:14 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51830/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51830/tests/dromaeo/cssquery-prototype.html) 07:46:14 INFO - PROCESS | 1905 | RSS: Main: 268075008 07:46:14 INFO - PROCESS | 1905 | 07:49:18 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51830/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51830/tests/dromaeo/cssquery-yui.html) 07:49:18 INFO - PROCESS | 1905 | RSS: Main: 258756608 07:49:18 INFO - PROCESS | 1905 | 07:52:21 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51830/tests/dromaeo/cssquery-yui.html (next: http://localhost:51830/tests/dromaeo/cssquery-dojo.html) 07:52:22 INFO - PROCESS | 1905 | RSS: Main: 410660864 07:52:22 INFO - PROCESS | 1905 | 07:52:22 INFO - PROCESS | 1905 | __start_tp_report 07:52:22 INFO - PROCESS | 1905 | _x_x_mozilla_page_load 07:52:22 INFO - PROCESS | 1905 | _x_x_mozilla_page_load_details 07:52:22 INFO - PROCESS | 1905 | |i|pagename|runs| 07:52:22 INFO - PROCESS | 1905 | |0;dojo.html;3360.5631267935164;3422.3155368926205;3429.537012503312;3448.5172075909363;3496.8251587420623;5724.141378793183;5738.254026976498;5755.971220143893;5776.740046697898;5780.4219578042175;5672.971635141829;5785.450382213693;5789.710514474281;5791.507721843648;5806.012977793775;5219.399769026553;5232.372115346145;5236.607254455912;5252.080885844981;5261.710605916673;5120.820771273006;5153.716545589991;5167.638265321429;5281.339832520935;5287.735613219324;5191.558717508998;5217.765200565965;5223.608229382811;5236.005159019793;5293.52358287754;5208.7395630218525;5240.554552863011;5244.842654720364;5290.709011004393;5313.57491400687;5173.896522069537;5229.686218826882;5243.79024839006;5249.737513124367;5315.973420132875;5631.8592035199035;5637.548996080303;5661.405552417019;5661.60368774186;5786.479216870502;6192.349803270637;6275.592086514362;6291.7797877074545;6293.590916590407;6300.369963003709;6262;6266.780662676784;6268.467180289681;6273.62358258506;6307.905381419282;5575.414581468887;5636.210930469738;5774.39368866263;5844.853878653025;5849.502792262705;6250.4374606285655;6279.152314437584;6282.968585157045;6290.591111577733;6297.338779428185;6189.133521307021;6204.038374052029;6219.968900155471;6227.408396202353;6231.2522497300615;6133.46907813317;6136.417040381246;6151.96924015377;6238.313785483593;6293.402126797947;6108.725107370179;6193.907091393633;6196.1635179251125;6271;6277.686115694289;6279;6283.434490895841;6289.559730818799;6295.685215739195;6310.305866354697;4867.659263851497;4869.074875773592;4987.850364489072;4999.850004499871;5029.220470827027;3478.4434490481403;3592.4072528033103;4135;4451.5103338632725;4504.414426124583;5870.677112758839;5889.882202355929;5894.17481552583;5904.468597826216;5910.172575839386;6152.753889844445;6190.2571691397325;6264.874702505925;6271.498280137578;6278.874422511524;5726.885462290731;5740.54075673945;5747.971260143672;5776.191333213354;5788.0739081746715;5485.917711234335;5486.231927530149;5486.533644640171;5500.862478438071;5504.422035686275;6321.367863213642;6321.936780632135;6332.905006425;6334.524910631629;6345.619262844244;6021.849453763691;6125.174407016003;6131.0096813291075;6219.782307619212;6259.217597800275;6243.37566243372;6293.496520278275;6303.716332764945;6308.495320374267;6310.053491976057;6196.721147548461;6197;6199.473044791243;6200.100985357008;6216.502679785697;6102.993006153935;6153.2000839890525;6154.876902462015;6222.968885155546;6268.310485846644;5931.13998470228;6101.054336577838;6113.385090542009;6191.473724733268;6212.596181248205;6115.899138155175;6116.510679145568;6125.387461253839;6162.661053642093;6174;5836.678982655994;5975.43233392827;6036.301397126237;6037.849053773515;6045.335013148462;6046.758129674764;6091.634501929721;6118.162361256354;6123.252118380239;6134.846828498841;6040.818775436744;6046.9697651513225;6049.697515124314;6072.757089716361;6085.939140608714 07:52:22 INFO - PROCESS | 1905 | |1;ext.html;463.90721855628874;480.2987638048449;536.0993530868143;562.4488001758277;563.7153237615004;30039.84980075099;32046.35907281853;32080.83959580199;32093;32108.03675889721;32605.347893042126;33240.33519329612;33368.66631333686;33386.49920251198;33565.82519611808;8453.408261421719;9684.418934863896;9704.70885873425;9722.076402741764;9738.756531086745;9491.003444638318;9591.520423978807;9608.08723171301;9612.279079069063;9620.134187923086;9560.474173920431;9613.99053099425;9618.519074046304;9619;9622.518874056304;9560.61757529698;9604.567794449267;9613.66352177674;9631.133198012143;9642.951785241028;9412.905870941271;9475.620975160986;9498.667546635903;9506.524673766284;9527.52362381885;38539.42190867139;38963.61036389628;38995.805020975;39007.41488877669;39065.218695626216;3234.6118465784257;3406.1690277874513;3720.7581507201944;3904.6876249899938;3937.271604753101;27984.580231296546;29080.418391632047;29273.853630731923;30123.548146777815;31178.22054448657;2615.0585789115903;2737.630419893309;2780.5551111822215;2800.663920329553;2859.642544681915;479204.6039769779;479223;480722;481026;482289;55606.72196638991;55904.44095559074;55933;55947;55973.44026559682;58951.705241473515;59004.11493827596;59028.933987310236;59054;59269.70365148147;15951.20243987796;16149.434769783002;16183.514494565183;16192.919035404748;16225.918870405572;12609.558665446848;12674.366281686063;12680.80978785319;12682.556110536087;12690.55583054607;11806.350650714294;14562.781558276634;14596.416143354147;14606.63483412902;14770.778438323434;5402.135658294733;5695.316562012585;5922.289325280994;6079.331273559905;6090.33006369299;696.905917701114;862.719616124762;915.9771005724776;918.0589895357313;934.6962237272913;26084.60873086905;28146.2963425916;28455.71544284572;28580;28630.71369286322;1053;1069.417167643636;1081.7403823082561;1097.078454098561;1156.3582211872324;13914.443422263199;14611.050281731654;14785.89105817068;15016.948813583163;15250.923745381424;689238;702600;705314.4734276398;904125;908569;48069;54762;55352.16971745427;55448;55510.444895551336;1248.8563815161372;1274.7450509897872;1275.5854347336967;1372.9656758580916;1407.331517529186;20556.28053018137;24693.753062469146;26601.866990664923;30419.2395190122;31210.21974450657;51362.22956655578;52319.47680523298;52340.691482713235;52349.47650523446;52450.737746311024;594802;599869;601561;602196;602754;22526.91052554699;22639.320820375415;23985.760142398354;25101;25595.488090238465;37324.62675373212;37330.813345934184;37694;41794.79102604589;44197;35042.29069604683;35186.12034699153;36522.66835533203;37035;37230.8138459306;35497.64502355047;35653;35820.64179358173;36981.445278321386;37082.443763343035;30275.545866812456;31115.688843112184;31661;31741.365172695954;36271.818640906626;25234.495310094062;31808;32339.029829105166;32373.838130809196;32753;24121.638175427033;24306.39234019093;24336.391590210387;24723.134690285755;24810 07:52:22 INFO - PROCESS | 1905 | |2;jquery.html;381.9713521485889;383.64896120050173;389.60065932419286;397.0906623831427;417.599104859335;19525.707114393277;20064.899675501638;20848.687269690967;20865.26971555996;20909.790902090994;17415.651686966285;20216.69674954877;20364.69452958203;20707.06818193185;21090.89454552725;5241;5733.197352370671;5871.794487192949;6110.694465276741;6232.906506402408;6148.877022459548;6189.442950134487;6192.876142477147;6193.504519638441;6252.249730032402;6703.296153903843;6772.322767723237;6783.45732341414;6794.490413219004;6797.898031529531;6119.785807496739;6144.2319710036245;6233.033879748601;6784;6798.04827324175;6092.147099406086;6094.0249560070615;6096.0551114576865;6104.389561043905;6105.267367915879;13157.210567365988;13235.735285294337;13418;13568.660783480393;13617.523386681418;2287.931362059141;2606.3353844769463;2641.828281161738;2817.6055352250496;2957.0833041757123;10118.291719579633;10203.183745300432;10256.230782691327;16603.07147370044;17579.29682812686;1965.5577495063496;1986.414007867668;2006.8595198336122;2006.9498262543407;2140.347194105797;136930;138802.99999999898;145912.27043864818;146089;146552.26723866313;17221.56946076333;21426.785732142478;21475.248366307416;21644.134234630437;22160.88919555392;36365.27269454596;36610.8169459151;36812.63187368146;36878.078048048475;36881.89354319375;10677.092447141924;10696.625618103484;10760.246782725135;10867.239293249397;11106;8916.242119419792;8950.462972221687;8960.507172105597;9112.448514415973;9141.08589141094;9465.621375145054;9748.9025109748;9913.157381622643;9937.850932236022;9945.950270248748;3496.650334966483;3759.3609086455367;3776.8866933992026;3782.7730336179916;3795.1840354323954;699.776071657075;871.4379225399582;907.2152588011322;928.9767755806159;1036.7342869959687;20209.797902020793;21497.247596334055;21561;21605;21610.675839862415;941.1435593609782;951.362587066667;953.2356167115282;972.2027937091517;995.5520015992832;10823.080038196684;11203.271787333797;11206.831897521544;11259.605913793142;11376.829347559793;570237;576586.117069412;576882;577226.4554708882;581418;86991;94134.11731765326;126205;132906;136622.63377366296;963.3978763272954;978.8972157923458;1000.6847842929454;1003.4180175498193;1025.1952217509368;19094.522636934187;19399.127039282983;19855.503612409804;19890.50273743168;19939.601207976048;50570.74714626403;58127.418725812204;58495.12257316229;59123.704381477815;59517.80964380775;82603.7609435847;85580;85837;87013;89499.55250223707;5393.352797664148;7500.174980752004;7772.378209743094;8041.959790201012;8360.163983601591;6956.234814170539;8687.565621718762;10975.725606859893;12704.936475317565;13479.797803033158;10533.57865685364;10988.285761425483;11034.944825275823;11538.365389903636;11570;10270;11133.94022105913;11170.218084733991;11557.133215009077;11681.941590291994;11088.33469991803;11266.83099753488;11428.542858285575;11584.768304634028;11650.53397864076;8046.758597242092;8221.506709597443;8366.623501942306;8506.276966457921;8604.741857744277;9472.95263523678;11062.778744424906;11408.486618102372;11460.312381257152;11525.942370288094 07:52:22 INFO - PROCESS | 1905 | |3;mootools.html;1355.5526676196844;1504.5561559339994;1529.7399442094843;1710.324421853368;1871.5976065145999;7538.359239464645;7951.681932722691;8142.226488483592;8337.041240257373;8341.998960124794;8181.140980197083;8285.337173026159;8285.54429506377;8290.461120027208;8299.004119505653;2343.8828058597046;2389.2712722619594;2392.3301475586863;2393.760623937601;2394.365493144318;2376.3821406434363;2402.5675378431874;2434.8417352872093;2437.366284765965;2438.329459398662;2359.1153317505937;2360.9291721248305;2390.6533552634855;2393.150431596784;2393.270052633946;2339.6022676144926;2349.3304408243653;2370.4073981504625;2378.857268563892;2390.988045059781;2322.7328857181474;2347.518758654489;2391.964120538193;2392.1986134644917;2394.2697477269426;7014.438844892396;7300.342969132804;8274.793130171734;8388.580570971428;8389;5077.796888124471;5271.472852714736;5271.762770675329;5271.947280527184;5271.971965466735;3089.459344614706;3429.329478967635;3513.841877115536;3516.82415879205;3593.6406359364114;1080.751427171747;1088.8366744988316;1107.6123356825128;1108.3959242213014;1130.248384824091;10757.193210509244;10796.298240614335;10882.61910833117;10883.23817332787;10916.727081822939;4271.957280427156;4406.383106365111;4487.596116349544;4497.415336006298;4516.209663308908;8574.27118694918;8625.353098517637;8631.223189912938;8631.438956467935;8632.438891472035;5096.694198348111;5105.183170692671;5109.054824857413;5110.744462776846;5117.488251174853;4299.935500967488;4466.553344665507;4676.579107880307;4749.121412538691;4771.427428708577;3616.4575313703153;3671.871484498083;3727.0682329417646;3771.4908487353855;3771.5097037384962;1159;1162.9127815413879;1171.297221666993;1179.9764004719857;1184.1474138620179;845.4166625028711;848.2154007543121;899.7480705402497;904.6607522179182;906.9591868365808;5233.502817232356;5389.299391079213;5529.778808847682;5624.0439125348785;5723.627964182315;840.3823189955378;982.6413359123868;989.9158571521501;1043.7912417516527;1055.4247934875511;3583.086312990171;3612.7471077024356;3635.909102272464;3787.110029143149;3795.1840354323954;9824.361416507903;10009.049140331657;10104.545295461721;10117.59529618807;10121.392716437038;9535.332526723063;9949.154321882721;9995.950020249853;10001;10050.246231532665;7652.73215437457;7868.606569671608;7882.408819338572;7896.7236146734585;7903.486273392326;5332.33345831771;5393.110136827379;5589.301337332833;5688.232088668143;5779.508741756998;9063.637454501746;9345.345825792128;9347.252219822534;9479.620815167316;9513.33406661527;9144.359894807565;9464.290178236797;9485.288603354915;9597.424154550748;9641.325107242426;5820.214271073351;7066.328698773608;7110.0401445804155;7204.675789589586;7207.783766487014;7974;8049.154838741848;8058.831469436782;8061.435699500978;8084;6959.332824291072;7101.39638130744;7139.178994415501;7176.892346614701;7220.530665506725;7002.7899163025195;7067.6819543119655;7086.220515743367;7118.572885626879;7166.390856777232;6630.436412904957;6633.436157926631;6695.765648202289;6698.899516507159;6706.966465167839;4697.8355757548325;4700.55344742249;4751.548602882721;4789.928151077806;4792.2332426811545;4556.498785133699;4744.572988431058;4751.144793936986;4892.0705066037335;5038.017586570583 07:52:22 INFO - PROCESS | 1905 | |4;prototype.html;311.25454536385354;311.50781764811586;319.70587059904886;323.4985772053317;325.5978866100367;4560.863174104774;4863.732494712794;5167.741612919358;5212.76542555585;5266.657667251626;4188.895277618061;4877.804887804493;5008.549230569248;5032.899342013157;5189.299444574981;3673.7876500754687;3816.9618303817024;3921.5294164700276;3983.661388781957;3991.582988039248;3600.207954250061;3883.3204189266908;3975.9006024849464;4016.3373043447796;4028.3554631259003;3347.2134048498583;3851.4415409765566;3916.70624703147;3986.940195897064;3986.940195897064;3700.85196592136;3974.304496713078;3981.303271927401;3998.8000599969887;4010.6991975601945;3086.2284428892776;3355.4128027595075;3475.2180759329203;3498.2828520153307;3525.2068284636007;3896.47397601323;4958.305837182797;4992.251162325644;5050.646454748169;5070.619703522214;4225.852095176654;4465.196264672358;4519.457665080178;4558.883073646978;4572.725636461823;4539.886502837422;4749.928751068702;5393.352797664266;5452.536534394581;5495.2856128703415;2967.234495475189;3832.4670131947164;3835.884923452301;3846.59610740871;3850.4801851749935;5346.8395948121615;5486.451354864522;5706.6629361685;5721.856953576153;5735.254416925814;3349.296647703961;3753.1930634913624;3782.962170378261;3794.924101517954;3819.052283335519;2980.5857255623014;3398.2693720850134;3447.517347571342;3886.6502014818802;3892.82482288292;4069.369247766601;4338.069559046194;4493.865184044484;4520.276755719069;4526.958799476073;4158.397032430281;4755.763501489569;5041.344625198701;5132.409772876093;5252.369715634149;1130.547780887635;1245.3524167432884;1249.3815561297035;1251.5932321995388;1256.4974010395915;737.8266107464741;769.9076110866732;816.4529765057425;842.7990114087401;855.2730179347504;4419.845305414359;4451.577100175478;4897.706137631753;4948.70307781527;4986.601071914238;4477.574630410106;4787;4985.875353116128;5172.896542069213;5441.211024401518;4591.14058806184;4696.473646065043;4758.976205118952;4869.488703686133;4888.5111488850835;2256.7023961222035;2757.26932362924;2764.7926405519665;2785.3175971886612;2802.313433208877;4894.26586012094;5362.624616276823;5367.007103685831;5414.756335964812;5534.584906132056;4914.311996320518;5228.8757917048015;5353.437889021675;5447.455254474521;5456.863578410572;4363.3018717005125;4594.931076033862;5259.289995850511;5389.9191512127345;5448.318960129984;4513.074819661896;5036.647434679538;5244.134717771525;5329.653572517774;5364.436734143015;4003.6396724293786;4862.367892173995;5265.629527492249;5267.631265811357;5270.472952704698;4535.319702044588;5010.649254552146;5544.584156188383;5549.667019978814;5565.220869078251;3174.730147937451;3552.6802587767224;3557.7153827693205;3572.1783989682;3597.892063238107;4143.81352839117;4631.073785243032;4740.952590474051;5191.480851914778;5195.506426889439;4184.81168347419;4692.48382677912;4912.778924948315;5112.693238405707;5159.303494028408;4857.441394239708;4973.5523802857915;5017.394433781155;5088.745562721923;5133.486651334986;3916.8433262669173;4746.928796067993;4852.878678033077;4901.9019619608125;4934.654574179916;4309.892252693708;5218.921716174336;5273.284258606897;5330.413654498079;5340.679559226303;4250.597302889977;4621.498013145809;4825.758712064313;5241.764120614658;5285.788568457218 07:52:22 INFO - PROCESS | 1905 | |5;yui.html;684.47979535553;767.6967597798873;769.6438160014317;788.7081779741495;803.6945960534997;12508.874911250885;14362.353694083766;15217.4673886414;15306.234688265598;15335.84664153358;13532.323383830819;13794.2413167276;13827.101238419496;13833.17000979942;13973.580792576238;827.5944787054331;827.7806381308958;830.0620299062051;833.708202129253;836.8577341851884;859.7248880358288;863.1109956744532;864.723288547665;865.4288169807928;865.8614621660536;728.4754976416971;753.0774800868919;879.2965627497977;909.6543313540878;911.8632205169245;866.0257210638032;866.2939704141105;866.8526350520426;867.4014929698551;869.9826003479926;643.3662842100528;643.3952085040047;644.0661041489858;645.7610684046932;647.3429469088878;13949.232792196424;14161;14207.076540024866;14208.502702405367;14220;10664.520096595672;13195.20828750278;13435.798463023062;13458.730825383438;13475.932620336933;11013.504392302366;11146.832797508045;11273.43632818364;11566.826497602542;11574;4361.236783562864;4381.627561657263;4498.8425405110665;4527.388802511652;4532.342810292489;80877.59561202215;85766.71349929756;86164.27671446536;86539.70190447148;86841.52633894637;10397.688069357931;10441.425721585234;10475.669764898883;10605.363678179334;10853.077488413574;20209.797902021084;20334.593308133753;20390;20394.592108157754;20399.388018359474;7491;7545.471816972869;7623;7627.084749830056;7867.527948323119;4276.87169384919;4281.100968796588;4331.177076355545;4414.09511050234;4511.278195488771;3281.6718328166994;3388.525606415104;3388.6950174484414;3394.304167645676;3395.7622966392114;619.1734035063241;630.3444417805523;653.1665674012347;654.0548906829681;659.5712786688595;496.9826056088092;608.1728848765675;629.0972454527767;637.5591163969463;637.7895294552786;8485.703000394957;8963.417377870417;9005.909940900638;9098.363114582047;9117;536.2787051415839;579.2816907035246;591.7100620695828;603.2459425717852;635.0664523150961;3949.8420063197723;4317.525072242051;4329.653627709776;4368.039031413084;4427.800748966304;114312.42843785894;117274.41362793131;119844;120519.39740301242;122109;88402.55798720966;101097;102022.91908323733;105784;106219.46890265499;90645;91572;92197.5390123045;93313;94480;8448.40861139739;8491.532965686947;8541.701040463555;8664.335247481402;8715.782105447415;53778.462215377345;56709.149362760414;58816.411835881096;59871.30579123863;60623.69688151531;63009.36990630035;78369.60815195888;82048.58975705084;83563.5821820887;85742;10705.090067344363;10781.838272426077;10948.95984881435;10965.56137754481;11170.4090895488;12237.69405764863;13113.344332783514;13706.93146534261;14059.086159399607;14457.27713614294;12900.571927007504;13058.934705326412;13245.867541324464;13259.602211933658;13259.602211933658;12317.75459769536;12731.299778512272;12929.418176182282;13257.337133143112;14151.716965660424;12951.481940722266;13489.730205396034;13703;13922.582322530341;13984.510542130976;10711.94644026775;11049;11064.114870810155;11309.208355415041;11375.43122843838;10686.73283167927;11201.38392388394;11237.71905702364;11436.94281528587;11679.708007299885 07:52:22 INFO - PROCESS | 1905 | __end_tp_report 07:52:22 INFO - PROCESS | 1905 | __start_cc_report 07:52:22 INFO - PROCESS | 1905 | _x_x_mozilla_cycle_collect,1748 07:52:22 INFO - PROCESS | 1905 | __end_cc_report 07:52:22 INFO - PROCESS | 1905 | __startTimestamp1487260342214__endTimestamp 07:52:22 INFO - PROCESS | 1905 | 07:52:22 INFO - PROCESS | 1905 | ------- Summary: start ------- 07:52:22 INFO - PROCESS | 1905 | Number of tests: 6 07:52:22 INFO - PROCESS | 1905 | 07:52:22 INFO - PROCESS | 1905 | [#0] dojo.html Cycles:165 Average:5763.32 Median:6045.34 stddev:661.44 (10.9%) stddev-sans-first:636.04 07:52:22 INFO - PROCESS | 1905 | Values: 3360.6 3422.3 3429.5 3448.5 3496.8 5724.1 5738.3 5756.0 5776.7 5780.4 5673.0 5785.5 5789.7 5791.5 5806.0 5219.4 5232.4 5236.6 5252.1 5261.7 5120.8 5153.7 5167.6 5281.3 5287.7 5191.6 5217.8 5223.6 5236.0 5293.5 5208.7 5240.6 5244.8 5290.7 5313.6 5173.9 5229.7 5243.8 5249.7 5316.0 5631.9 5637.5 5661.4 5661.6 5786.5 6192.3 6275.6 6291.8 6293.6 6300.4 6262.0 6266.8 6268.5 6273.6 6307.9 5575.4 5636.2 5774.4 5844.9 5849.5 6250.4 6279.2 6283.0 6290.6 6297.3 6189.1 6204.0 6220.0 6227.4 6231.3 6133.5 6136.4 6152.0 6238.3 6293.4 6108.7 6193.9 6196.2 6271.0 6277.7 6279.0 6283.4 6289.6 6295.7 6310.3 4867.7 4869.1 4987.9 4999.9 5029.2 3478.4 3592.4 4135.0 4451.5 4504.4 5870.7 5889.9 5894.2 5904.5 5910.2 6152.8 6190.3 6264.9 6271.5 6278.9 5726.9 5740.5 5748.0 5776.2 5788.1 5485.9 5486.2 5486.5 5500.9 5504.4 6321.4 6321.9 6332.9 6334.5 6345.6 6021.8 6125.2 6131.0 6219.8 6259.2 6243.4 6293.5 6303.7 6308.5 6310.1 6196.7 6197.0 6199.5 6200.1 6216.5 6103.0 6153.2 6154.9 6223.0 6268.3 5931.1 6101.1 6113.4 6191.5 6212.6 6115.9 6116.5 6125.4 6162.7 6174.0 5836.7 5975.4 6036.3 6037.8 6045.3 6046.8 6091.6 6118.2 6123.3 6134.8 6040.8 6047.0 6049.7 6072.8 6085.9 07:52:22 INFO - PROCESS | 1905 | 07:52:22 INFO - PROCESS | 1905 | [#1] ext.html Cycles:180 Average:72684.59 Median:20401.60 stddev:171240.87 (839.4%) stddev-sans-first:171635.39 07:52:22 INFO - PROCESS | 1905 | Values: 463.9 480.3 536.1 562.4 563.7 30039.8 32046.4 32080.8 32093.0 32108.0 32605.3 33240.3 33368.7 33386.5 33565.8 8453.4 9684.4 9704.7 9722.1 9738.8 9491.0 9591.5 9608.1 9612.3 9620.1 9560.5 9614.0 9618.5 9619.0 9622.5 9560.6 9604.6 9613.7 9631.1 9643.0 9412.9 9475.6 9498.7 9506.5 9527.5 38539.4 38963.6 38995.8 39007.4 39065.2 3234.6 3406.2 3720.8 3904.7 3937.3 27984.6 29080.4 29273.9 30123.5 31178.2 2615.1 2737.6 2780.6 2800.7 2859.6 479204.6 479223.0 480722.0 481026.0 482289.0 55606.7 55904.4 55933.0 55947.0 55973.4 58951.7 59004.1 59028.9 59054.0 59269.7 15951.2 16149.4 16183.5 16192.9 16225.9 12609.6 12674.4 12680.8 12682.6 12690.6 11806.4 14562.8 14596.4 14606.6 14770.8 5402.1 5695.3 5922.3 6079.3 6090.3 696.9 862.7 916.0 918.1 934.7 26084.6 28146.3 28455.7 28580.0 28630.7 1053.0 1069.4 1081.7 1097.1 1156.4 13914.4 14611.1 14785.9 15016.9 15250.9 689238.0 702600.0 705314.5 904125.0 908569.0 48069.0 54762.0 55352.2 55448.0 55510.4 1248.9 1274.7 1275.6 1373.0 1407.3 20556.3 24693.8 26601.9 30419.2 31210.2 51362.2 52319.5 52340.7 52349.5 52450.7 594802.0 599869.0 601561.0 602196.0 602754.0 22526.9 22639.3 23985.8 25101.0 25595.5 37324.6 37330.8 37694.0 41794.8 44197.0 35042.3 35186.1 36522.7 37035.0 37230.8 35497.6 35653.0 35820.6 36981.4 37082.4 30275.5 31115.7 31661.0 31741.4 36271.8 25234.5 31808.0 32339.0 32373.8 32753.0 24121.6 24306.4 24336.4 24723.1 24810.0 07:52:22 INFO - PROCESS | 1905 | 07:52:22 INFO - PROCESS | 1905 | [#2] jquery.html Cycles:180 Average:36053.89 Median:36488.04 stddev:96818.53 (265.3%) stddev-sans-first:97053.08 07:52:22 INFO - PROCESS | 1905 | Values: 382.0 383.6 389.6 397.1 417.6 19525.7 20064.9 20848.7 20865.3 20909.8 17415.7 20216.7 20364.7 20707.1 21090.9 5241.0 5733.2 5871.8 6110.7 6232.9 6148.9 6189.4 6192.9 6193.5 6252.2 6703.3 6772.3 6783.5 6794.5 6797.9 6119.8 6144.2 6233.0 6784.0 6798.0 6092.1 6094.0 6096.1 6104.4 6105.3 13157.2 13235.7 13418.0 13568.7 13617.5 2287.9 2606.3 2641.8 2817.6 2957.1 10118.3 10203.2 10256.2 16603.1 17579.3 1965.6 1986.4 2006.9 2006.9 2140.3 136930.0 138803.0 145912.3 146089.0 146552.3 17221.6 21426.8 21475.2 21644.1 22160.9 36365.3 36610.8 36812.6 36878.1 36881.9 10677.1 10696.6 10760.2 10867.2 11106.0 8916.2 8950.5 8960.5 9112.4 9141.1 9465.6 9748.9 9913.2 9937.9 9946.0 3496.7 3759.4 3776.9 3782.8 3795.2 699.8 871.4 907.2 929.0 1036.7 20209.8 21497.2 21561.0 21605.0 21610.7 941.1 951.4 953.2 972.2 995.6 10823.1 11203.3 11206.8 11259.6 11376.8 570237.0 576586.1 576882.0 577226.5 581418.0 86991.0 94134.1 126205.0 132906.0 136622.6 963.4 978.9 1000.7 1003.4 1025.2 19094.5 19399.1 19855.5 19890.5 19939.6 50570.7 58127.4 58495.1 59123.7 59517.8 82603.8 85580.0 85837.0 87013.0 89499.6 5393.4 7500.2 7772.4 8042.0 8360.2 6956.2 8687.6 10975.7 12704.9 13479.8 10533.6 10988.3 11034.9 11538.4 11570.0 10270.0 11133.9 11170.2 11557.1 11681.9 11088.3 11266.8 11428.5 11584.8 11650.5 8046.8 8221.5 8366.6 8506.3 8604.7 9473.0 11062.8 11408.5 11460.3 11525.9 07:52:22 INFO - PROCESS | 1905 | 07:52:22 INFO - PROCESS | 1905 | [#3] mootools.html Cycles:180 Average:5403.26 Median:5107.12 stddev:2930.92 (57.4%) stddev-sans-first:2923.35 07:52:22 INFO - PROCESS | 1905 | Values: 1355.6 1504.6 1529.7 1710.3 1871.6 7538.4 7951.7 8142.2 8337.0 8342.0 8181.1 8285.3 8285.5 8290.5 8299.0 2343.9 2389.3 2392.3 2393.8 2394.4 2376.4 2402.6 2434.8 2437.4 2438.3 2359.1 2360.9 2390.7 2393.2 2393.3 2339.6 2349.3 2370.4 2378.9 2391.0 2322.7 2347.5 2392.0 2392.2 2394.3 7014.4 7300.3 8274.8 8388.6 8389.0 5077.8 5271.5 5271.8 5271.9 5272.0 3089.5 3429.3 3513.8 3516.8 3593.6 1080.8 1088.8 1107.6 1108.4 1130.2 10757.2 10796.3 10882.6 10883.2 10916.7 4272.0 4406.4 4487.6 4497.4 4516.2 8574.3 8625.4 8631.2 8631.4 8632.4 5096.7 5105.2 5109.1 5110.7 5117.5 4299.9 4466.6 4676.6 4749.1 4771.4 3616.5 3671.9 3727.1 3771.5 3771.5 1159.0 1162.9 1171.3 1180.0 1184.1 845.4 848.2 899.7 904.7 907.0 5233.5 5389.3 5529.8 5624.0 5723.6 840.4 982.6 989.9 1043.8 1055.4 3583.1 3612.7 3635.9 3787.1 3795.2 9824.4 10009.0 10104.5 10117.6 10121.4 9535.3 9949.2 9996.0 10001.0 10050.2 7652.7 7868.6 7882.4 7896.7 7903.5 5332.3 5393.1 5589.3 5688.2 5779.5 9063.6 9345.3 9347.3 9479.6 9513.3 9144.4 9464.3 9485.3 9597.4 9641.3 5820.2 7066.3 7110.0 7204.7 7207.8 7974.0 8049.2 8058.8 8061.4 8084.0 6959.3 7101.4 7139.2 7176.9 7220.5 7002.8 7067.7 7086.2 7118.6 7166.4 6630.4 6633.4 6695.8 6698.9 6707.0 4697.8 4700.6 4751.5 4789.9 4792.2 4556.5 4744.6 4751.1 4892.1 5038.0 07:52:22 INFO - PROCESS | 1905 | 07:52:22 INFO - PROCESS | 1905 | [#4] prototype.html Cycles:180 Average:4222.47 Median:4661.78 stddev:1268.80 (27.2%) stddev-sans-first:1237.93 07:52:22 INFO - PROCESS | 1905 | Values: 311.3 311.5 319.7 323.5 325.6 4560.9 4863.7 5167.7 5212.8 5266.7 4188.9 4877.8 5008.5 5032.9 5189.3 3673.8 3817.0 3921.5 3983.7 3991.6 3600.2 3883.3 3975.9 4016.3 4028.4 3347.2 3851.4 3916.7 3986.9 3986.9 3700.9 3974.3 3981.3 3998.8 4010.7 3086.2 3355.4 3475.2 3498.3 3525.2 3896.5 4958.3 4992.3 5050.6 5070.6 4225.9 4465.2 4519.5 4558.9 4572.7 4539.9 4749.9 5393.4 5452.5 5495.3 2967.2 3832.5 3835.9 3846.6 3850.5 5346.8 5486.5 5706.7 5721.9 5735.3 3349.3 3753.2 3783.0 3794.9 3819.1 2980.6 3398.3 3447.5 3886.7 3892.8 4069.4 4338.1 4493.9 4520.3 4527.0 4158.4 4755.8 5041.3 5132.4 5252.4 1130.5 1245.4 1249.4 1251.6 1256.5 737.8 769.9 816.5 842.8 855.3 4419.8 4451.6 4897.7 4948.7 4986.6 4477.6 4787.0 4985.9 5172.9 5441.2 4591.1 4696.5 4759.0 4869.5 4888.5 2256.7 2757.3 2764.8 2785.3 2802.3 4894.3 5362.6 5367.0 5414.8 5534.6 4914.3 5228.9 5353.4 5447.5 5456.9 4363.3 4594.9 5259.3 5389.9 5448.3 4513.1 5036.6 5244.1 5329.7 5364.4 4003.6 4862.4 5265.6 5267.6 5270.5 4535.3 5010.6 5544.6 5549.7 5565.2 3174.7 3552.7 3557.7 3572.2 3597.9 4143.8 4631.1 4741.0 5191.5 5195.5 4184.8 4692.5 4912.8 5112.7 5159.3 4857.4 4973.6 5017.4 5088.7 5133.5 3916.8 4746.9 4852.9 4901.9 4934.7 4309.9 5218.9 5273.3 5330.4 5340.7 4250.6 4621.5 4825.8 5241.8 5285.8 07:52:22 INFO - PROCESS | 1905 | 07:52:22 INFO - PROCESS | 1905 | [#5] yui.html Cycles:180 Average:21280.93 Median:4364.64 stddev:31804.41 (728.7%) stddev-sans-first:31856.03 07:52:22 INFO - PROCESS | 1905 | Values: 684.5 767.7 769.6 788.7 803.7 12508.9 14362.4 15217.5 15306.2 15335.8 13532.3 13794.2 13827.1 13833.2 13973.6 827.6 827.8 830.1 833.7 836.9 859.7 863.1 864.7 865.4 865.9 728.5 753.1 879.3 909.7 911.9 866.0 866.3 866.9 867.4 870.0 643.4 643.4 644.1 645.8 647.3 13949.2 14161.0 14207.1 14208.5 14220.0 10664.5 13195.2 13435.8 13458.7 13475.9 11013.5 11146.8 11273.4 11566.8 11574.0 4361.2 4381.6 4498.8 4527.4 4532.3 80877.6 85766.7 86164.3 86539.7 86841.5 10397.7 10441.4 10475.7 10605.4 10853.1 20209.8 20334.6 20390.0 20394.6 20399.4 7491.0 7545.5 7623.0 7627.1 7867.5 4276.9 4281.1 4331.2 4414.1 4511.3 3281.7 3388.5 3388.7 3394.3 3395.8 619.2 630.3 653.2 654.1 659.6 497.0 608.2 629.1 637.6 637.8 8485.7 8963.4 9005.9 9098.4 9117.0 536.3 579.3 591.7 603.2 635.1 3949.8 4317.5 4329.7 4368.0 4427.8 114312.4 117274.4 119844.0 120519.4 122109.0 88402.6 101097.0 102022.9 105784.0 106219.5 90645.0 91572.0 92197.5 93313.0 94480.0 8448.4 8491.5 8541.7 8664.3 8715.8 53778.5 56709.1 58816.4 59871.3 60623.7 63009.4 78369.6 82048.6 83563.6 85742.0 10705.1 10781.8 10949.0 10965.6 11170.4 12237.7 13113.3 13706.9 14059.1 14457.3 12900.6 13058.9 13245.9 13259.6 13259.6 12317.8 12731.3 12929.4 13257.3 14151.7 12951.5 13489.7 13703.0 13922.6 13984.5 10711.9 11049.0 11064.1 11309.2 11375.4 10686.7 11201.4 11237.7 11436.9 11679.7 07:52:22 INFO - PROCESS | 1905 | -------- Summary: end -------- 07:52:22 INFO - PROCESS | 1905 | 07:52:22 INFO - TEST-INFO | 1905: exit 0 07:52:22 INFO - TEST-OK | dromaeo_css | took 1116975ms 07:52:22 INFO - TEST-START | kraken 07:52:22 INFO - operating with platform_type : mac_ 07:52:22 INFO - Initialising browser for kraken test... 07:52:22 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpXLfrGG/profile http://localhost:51830/getInfo.html) 07:52:25 INFO - PROCESS | 1910 | __metrics Screen width/height:1600/1200 07:52:25 INFO - PROCESS | 1910 | colorDepth:24 07:52:25 INFO - PROCESS | 1910 | Browser inner width/height: 1024/689 07:52:25 INFO - PROCESS | 1910 | __metrics 07:52:25 INFO - PROCESS | 1910 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:52:25 INFO - PROCESS | 1910 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:52:26 INFO - TEST-INFO | 1910: exit 0 07:52:26 INFO - Browser initialized. 07:52:26 INFO - Running cycle 1/1 for kraken test... 07:52:26 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpXLfrGG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:38 INFO - PROCESS | 1912 | RSS: Main: 167788544 07:52:38 INFO - PROCESS | 1912 | 07:52:40 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:51830/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51830/tests/kraken/driver.html?testName=audio-beat-detection) 07:52:41 INFO - PROCESS | 1912 | RSS: Main: 218218496 07:52:41 INFO - PROCESS | 1912 | 07:52:44 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:51830/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51830/tests/kraken/driver.html?testName=audio-dft) 07:52:45 INFO - PROCESS | 1912 | RSS: Main: 232009728 07:52:45 INFO - PROCESS | 1912 | 07:52:48 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:51830/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51830/tests/kraken/driver.html?testName=audio-fft) 07:52:48 INFO - PROCESS | 1912 | RSS: Main: 329330688 07:52:48 INFO - PROCESS | 1912 | 07:52:50 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:51830/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51830/tests/kraken/driver.html?testName=audio-oscillator) 07:52:51 INFO - PROCESS | 1912 | RSS: Main: 233267200 07:52:51 INFO - PROCESS | 1912 | 07:52:53 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:51830/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51830/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:52:54 INFO - PROCESS | 1912 | RSS: Main: 234668032 07:52:54 INFO - PROCESS | 1912 | 07:52:56 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:51830/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51830/tests/kraken/driver.html?testName=imaging-darkroom) 07:52:57 INFO - PROCESS | 1912 | RSS: Main: 274317312 07:52:57 INFO - PROCESS | 1912 | 07:53:00 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:51830/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51830/tests/kraken/driver.html?testName=imaging-desaturate) 07:53:00 INFO - PROCESS | 1912 | RSS: Main: 274214912 07:53:00 INFO - PROCESS | 1912 | 07:53:03 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:51830/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51830/tests/kraken/driver.html?testName=json-parse-financial) 07:53:04 INFO - PROCESS | 1912 | RSS: Main: 270356480 07:53:04 INFO - PROCESS | 1912 | 07:53:05 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:51830/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51830/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:53:06 INFO - PROCESS | 1912 | RSS: Main: 248025088 07:53:06 INFO - PROCESS | 1912 | 07:53:08 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:51830/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51830/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:53:08 INFO - PROCESS | 1912 | RSS: Main: 249753600 07:53:08 INFO - PROCESS | 1912 | 07:53:10 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:51830/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51830/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:53:11 INFO - PROCESS | 1912 | RSS: Main: 251453440 07:53:11 INFO - PROCESS | 1912 | 07:53:14 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:51830/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51830/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:53:15 INFO - PROCESS | 1912 | RSS: Main: 268652544 07:53:15 INFO - PROCESS | 1912 | 07:53:17 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:51830/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51830/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:53:18 INFO - PROCESS | 1912 | RSS: Main: 262053888 07:53:18 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:51830/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51830/tests/kraken/driver.html?testName=ai-astar) 07:53:20 INFO - PROCESS | 1912 | RSS: Main: 306364416 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | __start_tp_report 07:53:20 INFO - PROCESS | 1912 | _x_x_mozilla_page_load 07:53:20 INFO - PROCESS | 1912 | _x_x_mozilla_page_load_details 07:53:20 INFO - PROCESS | 1912 | |i|pagename|runs| 07:53:20 INFO - PROCESS | 1912 | |0;ai-astar;103;114;114;113;114;113;113;112;112;115 07:53:20 INFO - PROCESS | 1912 | |1;audio-beat-detection;149;140;142;143;109;107;107;108;139;109 07:53:20 INFO - PROCESS | 1912 | |2;audio-dft;187;182;185;184;182;184;181;184;184;183 07:53:20 INFO - PROCESS | 1912 | |3;audio-fft;81;79;81;115;66;60;59;58;82;57 07:53:20 INFO - PROCESS | 1912 | |4;audio-oscillator;89;70;93;70;68;67;72;75;90;119 07:53:20 INFO - PROCESS | 1912 | |5;imaging-gaussian-blur;88;84;87;85;88;131;92;84;87;84 07:53:20 INFO - PROCESS | 1912 | |6;imaging-darkroom;93;101;149;138;93;94;93;93;95;94 07:53:20 INFO - PROCESS | 1912 | |7;imaging-desaturate;80;81;82;79;81;83;85;84;82;82 07:53:20 INFO - PROCESS | 1912 | |8;json-parse-financial;55;53;52;54;58;58;58;56;55;57 07:53:20 INFO - PROCESS | 1912 | |9;json-stringify-tinderbox;64;72;80;70;72;66;68;68;68;67 07:53:20 INFO - PROCESS | 1912 | |10;stanford-crypto-aes;83;82;83;81;81;75;81;82;81;80 07:53:20 INFO - PROCESS | 1912 | |11;stanford-crypto-ccm;143;151;145;136;138;141;138;137;183;146 07:53:20 INFO - PROCESS | 1912 | |12;stanford-crypto-pbkdf2;163;162;160;160;161;161;160;162;160;160 07:53:20 INFO - PROCESS | 1912 | |13;stanford-crypto-sha256-iterative;67;65;65;64;64;67;65;67;64;65 07:53:20 INFO - PROCESS | 1912 | __end_tp_report 07:53:20 INFO - PROCESS | 1912 | __start_cc_report 07:53:20 INFO - PROCESS | 1912 | _x_x_mozilla_cycle_collect,1906 07:53:20 INFO - PROCESS | 1912 | __end_cc_report 07:53:20 INFO - PROCESS | 1912 | __startTimestamp1487260400441__endTimestamp 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | ------- Summary: start ------- 07:53:20 INFO - PROCESS | 1912 | Number of tests: 14 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.50 stddev:3.40 (3.0%) stddev-sans-first:1.00 07:53:20 INFO - PROCESS | 1912 | Values: 103.0 114.0 114.0 113.0 114.0 113.0 113.0 112.0 112.0 115.0 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | [#1] audio-beat-detection Cycles:10 Average:125.30 Median:139.50 stddev:18.43 (13.2%) stddev-sans-first:17.44 07:53:20 INFO - PROCESS | 1912 | Values: 149.0 140.0 142.0 143.0 109.0 107.0 107.0 108.0 139.0 109.0 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.71 (0.9%) stddev-sans-first:1.30 07:53:20 INFO - PROCESS | 1912 | Values: 187.0 182.0 185.0 184.0 182.0 184.0 181.0 184.0 184.0 183.0 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | [#3] audio-fft Cycles:10 Average:73.80 Median:72.50 stddev:17.94 (24.7%) stddev-sans-first:18.84 07:53:20 INFO - PROCESS | 1912 | Values: 81.0 79.0 81.0 115.0 66.0 60.0 59.0 58.0 82.0 57.0 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:73.50 stddev:16.52 (22.5%) stddev-sans-first:17.29 07:53:20 INFO - PROCESS | 1912 | Values: 89.0 70.0 93.0 70.0 68.0 67.0 72.0 75.0 90.0 119.0 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:87.00 stddev:14.28 (16.4%) stddev-sans-first:15.10 07:53:20 INFO - PROCESS | 1912 | Values: 88.0 84.0 87.0 85.0 88.0 131.0 92.0 84.0 87.0 84.0 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | [#6] imaging-darkroom Cycles:10 Average:104.30 Median:93.00 stddev:20.96 (22.5%) stddev-sans-first:21.83 07:53:20 INFO - PROCESS | 1912 | Values: 93.0 101.0 149.0 138.0 93.0 94.0 93.0 93.0 95.0 94.0 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | [#7] imaging-desaturate Cycles:10 Average:81.90 Median:82.00 stddev:1.79 (2.2%) stddev-sans-first:1.76 07:53:20 INFO - PROCESS | 1912 | Values: 80.0 81.0 82.0 79.0 81.0 83.0 85.0 84.0 82.0 82.0 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.50 stddev:2.17 (3.8%) stddev-sans-first:2.29 07:53:20 INFO - PROCESS | 1912 | Values: 55.0 53.0 52.0 54.0 58.0 58.0 58.0 56.0 55.0 57.0 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.00 stddev:4.45 (6.5%) stddev-sans-first:4.26 07:53:20 INFO - PROCESS | 1912 | Values: 64.0 72.0 80.0 70.0 72.0 66.0 68.0 68.0 68.0 67.0 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.50 stddev:2.28 (2.8%) stddev-sans-first:2.29 07:53:20 INFO - PROCESS | 1912 | Values: 83.0 82.0 83.0 81.0 81.0 75.0 81.0 82.0 81.0 80.0 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:144.00 stddev:13.89 (9.6%) stddev-sans-first:14.70 07:53:20 INFO - PROCESS | 1912 | Values: 143.0 151.0 145.0 136.0 138.0 141.0 138.0 137.0 183.0 146.0 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:0.87 07:53:20 INFO - PROCESS | 1912 | Values: 163.0 162.0 160.0 160.0 161.0 161.0 160.0 162.0 160.0 160.0 07:53:20 INFO - PROCESS | 1912 | 07:53:20 INFO - PROCESS | 1912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:1.25 (1.9%) stddev-sans-first:1.17 07:53:20 INFO - PROCESS | 1912 | Values: 67.0 65.0 65.0 64.0 64.0 67.0 65.0 67.0 64.0 65.0 07:53:20 INFO - PROCESS | 1912 | -------- Summary: end -------- 07:53:20 INFO - PROCESS | 1912 | 07:53:21 INFO - TEST-INFO | 1912: exit 0 07:53:21 INFO - TEST-OK | kraken | took 58723ms 07:53:21 INFO - SUITE-END | took 1175s 07:53:21 INFO - Completed test suite (00:19:35) 07:53:21 INFO - javascript benchmark 07:53:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.5631267935164, 3422.3155368926205, 3429.537012503312, 3448.5172075909363, 3496.8251587420623, 5724.141378793183, 5738.254026976498, 5755.971220143893, 5776.740046697898, 5780.4219578042175, 5672.971635141829, 5785.450382213693, 5789.710514474281, 5791.507721843648, 5806.012977793775, 5219.399769026553, 5232.372115346145, 5236.607254455912, 5252.080885844981, 5261.710605916673, 5120.820771273006, 5153.716545589991, 5167.638265321429, 5281.339832520935, 5287.735613219324, 5191.558717508998, 5217.765200565965, 5223.608229382811, 5236.005159019793, 5293.52358287754, 5208.7395630218525, 5240.554552863011, 5244.842654720364, 5290.709011004393, 5313.57491400687, 5173.896522069537, 5229.686218826882, 5243.79024839006, 5249.737513124367, 5315.973420132875, 5631.8592035199035, 5637.548996080303, 5661.405552417019, 5661.60368774186, 5786.479216870502, 6192.349803270637, 6275.592086514362, 6291.7797877074545, 6293.590916590407, 6300.369963003709, 6262.0, 6266.780662676784, 6268.467180289681, 6273.62358258506, 6307.905381419282, 5575.414581468887, 5636.210930469738, 5774.39368866263, 5844.853878653025, 5849.502792262705, 6250.4374606285655, 6279.152314437584, 6282.968585157045, 6290.591111577733, 6297.338779428185, 6189.133521307021, 6204.038374052029, 6219.968900155471, 6227.408396202353, 6231.2522497300615, 6133.46907813317, 6136.417040381246, 6151.96924015377, 6238.313785483593, 6293.402126797947, 6108.725107370179, 6193.907091393633, 6196.1635179251125, 6271.0, 6277.686115694289, 6279.0, 6283.434490895841, 6289.559730818799, 6295.685215739195, 6310.305866354697, 4867.659263851497, 4869.074875773592, 4987.850364489072, 4999.850004499871, 5029.220470827027, 3478.4434490481403, 3592.4072528033103, 4135.0, 4451.5103338632725, 4504.414426124583, 5870.677112758839, 5889.882202355929, 5894.17481552583, 5904.468597826216, 5910.172575839386, 6152.753889844445, 6190.2571691397325, 6264.874702505925, 6271.498280137578, 6278.874422511524, 5726.885462290731, 5740.54075673945, 5747.971260143672, 5776.191333213354, 5788.0739081746715, 5485.917711234335, 5486.231927530149, 5486.533644640171, 5500.862478438071, 5504.422035686275, 6321.367863213642, 6321.936780632135, 6332.905006425, 6334.524910631629, 6345.619262844244, 6021.849453763691, 6125.174407016003, 6131.0096813291075, 6219.782307619212, 6259.217597800275, 6243.37566243372, 6293.496520278275, 6303.716332764945, 6308.495320374267, 6310.053491976057, 6196.721147548461, 6197.0, 6199.473044791243, 6200.100985357008, 6216.502679785697, 6102.993006153935, 6153.2000839890525, 6154.876902462015, 6222.968885155546, 6268.310485846644, 5931.13998470228, 6101.054336577838, 6113.385090542009, 6191.473724733268, 6212.596181248205, 6115.899138155175, 6116.510679145568, 6125.387461253839, 6162.661053642093, 6174.0, 5836.678982655994, 5975.43233392827, 6036.301397126237, 6037.849053773515, 6045.335013148462, 6046.758129674764, 6091.634501929721, 6118.162361256354, 6123.252118380239, 6134.846828498841, 6040.818775436744, 6046.9697651513225, 6049.697515124314, 6072.757089716361, 6085.939140608714], "value": 5718.84505325065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.90721855628874, 480.2987638048449, 536.0993530868143, 562.4488001758277, 563.7153237615004, 30039.84980075099, 32046.35907281853, 32080.83959580199, 32093.0, 32108.03675889721, 32605.347893042126, 33240.33519329612, 33368.66631333686, 33386.49920251198, 33565.82519611808, 8453.408261421719, 9684.418934863896, 9704.70885873425, 9722.076402741764, 9738.756531086745, 9491.003444638318, 9591.520423978807, 9608.08723171301, 9612.279079069063, 9620.134187923086, 9560.474173920431, 9613.99053099425, 9618.519074046304, 9619.0, 9622.518874056304, 9560.61757529698, 9604.567794449267, 9613.66352177674, 9631.133198012143, 9642.951785241028, 9412.905870941271, 9475.620975160986, 9498.667546635903, 9506.524673766284, 9527.52362381885, 38539.42190867139, 38963.61036389628, 38995.805020975, 39007.41488877669, 39065.218695626216, 3234.6118465784257, 3406.1690277874513, 3720.7581507201944, 3904.6876249899938, 3937.271604753101, 27984.580231296546, 29080.418391632047, 29273.853630731923, 30123.548146777815, 31178.22054448657, 2615.0585789115903, 2737.630419893309, 2780.5551111822215, 2800.663920329553, 2859.642544681915, 479204.6039769779, 479223.0, 480722.0, 481026.0, 482289.0, 55606.72196638991, 55904.44095559074, 55933.0, 55947.0, 55973.44026559682, 58951.705241473515, 59004.11493827596, 59028.933987310236, 59054.0, 59269.70365148147, 15951.20243987796, 16149.434769783002, 16183.514494565183, 16192.919035404748, 16225.918870405572, 12609.558665446848, 12674.366281686063, 12680.80978785319, 12682.556110536087, 12690.55583054607, 11806.350650714294, 14562.781558276634, 14596.416143354147, 14606.63483412902, 14770.778438323434, 5402.135658294733, 5695.316562012585, 5922.289325280994, 6079.331273559905, 6090.33006369299, 696.905917701114, 862.719616124762, 915.9771005724776, 918.0589895357313, 934.6962237272913, 26084.60873086905, 28146.2963425916, 28455.71544284572, 28580.0, 28630.71369286322, 1053.0, 1069.417167643636, 1081.7403823082561, 1097.078454098561, 1156.3582211872324, 13914.443422263199, 14611.050281731654, 14785.89105817068, 15016.948813583163, 15250.923745381424, 689238.0, 702600.0, 705314.4734276398, 904125.0, 908569.0, 48069.0, 54762.0, 55352.16971745427, 55448.0, 55510.444895551336, 1248.8563815161372, 1274.7450509897872, 1275.5854347336967, 1372.9656758580916, 1407.331517529186, 20556.28053018137, 24693.753062469146, 26601.866990664923, 30419.2395190122, 31210.21974450657, 51362.22956655578, 52319.47680523298, 52340.691482713235, 52349.47650523446, 52450.737746311024, 594802.0, 599869.0, 601561.0, 602196.0, 602754.0, 22526.91052554699, 22639.320820375415, 23985.760142398354, 25101.0, 25595.488090238465, 37324.62675373212, 37330.813345934184, 37694.0, 41794.79102604589, 44197.0, 35042.29069604683, 35186.12034699153, 36522.66835533203, 37035.0, 37230.8138459306, 35497.64502355047, 35653.0, 35820.64179358173, 36981.445278321386, 37082.443763343035, 30275.545866812456, 31115.688843112184, 31661.0, 31741.365172695954, 36271.818640906626, 25234.495310094062, 31808.0, 32339.029829105166, 32373.838130809196, 32753.0, 24121.638175427033, 24306.39234019093, 24336.391590210387, 24723.134690285755, 24810.0], "value": 18796.258905294813, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.9713521485889, 383.64896120050173, 389.60065932419286, 397.0906623831427, 417.599104859335, 19525.707114393277, 20064.899675501638, 20848.687269690967, 20865.26971555996, 20909.790902090994, 17415.651686966285, 20216.69674954877, 20364.69452958203, 20707.06818193185, 21090.89454552725, 5241.0, 5733.197352370671, 5871.794487192949, 6110.694465276741, 6232.906506402408, 6148.877022459548, 6189.442950134487, 6192.876142477147, 6193.504519638441, 6252.249730032402, 6703.296153903843, 6772.322767723237, 6783.45732341414, 6794.490413219004, 6797.898031529531, 6119.785807496739, 6144.2319710036245, 6233.033879748601, 6784.0, 6798.04827324175, 6092.147099406086, 6094.0249560070615, 6096.0551114576865, 6104.389561043905, 6105.267367915879, 13157.210567365988, 13235.735285294337, 13418.0, 13568.660783480393, 13617.523386681418, 2287.931362059141, 2606.3353844769463, 2641.828281161738, 2817.6055352250496, 2957.0833041757123, 10118.291719579633, 10203.183745300432, 10256.230782691327, 16603.07147370044, 17579.29682812686, 1965.5577495063496, 1986.414007867668, 2006.8595198336122, 2006.9498262543407, 2140.347194105797, 136930.0, 138802.99999999898, 145912.27043864818, 146089.0, 146552.26723866313, 17221.56946076333, 21426.785732142478, 21475.248366307416, 21644.134234630437, 22160.88919555392, 36365.27269454596, 36610.8169459151, 36812.63187368146, 36878.078048048475, 36881.89354319375, 10677.092447141924, 10696.625618103484, 10760.246782725135, 10867.239293249397, 11106.0, 8916.242119419792, 8950.462972221687, 8960.507172105597, 9112.448514415973, 9141.08589141094, 9465.621375145054, 9748.9025109748, 9913.157381622643, 9937.850932236022, 9945.950270248748, 3496.650334966483, 3759.3609086455367, 3776.8866933992026, 3782.7730336179916, 3795.1840354323954, 699.776071657075, 871.4379225399582, 907.2152588011322, 928.9767755806159, 1036.7342869959687, 20209.797902020793, 21497.247596334055, 21561.0, 21605.0, 21610.675839862415, 941.1435593609782, 951.362587066667, 953.2356167115282, 972.2027937091517, 995.5520015992832, 10823.080038196684, 11203.271787333797, 11206.831897521544, 11259.605913793142, 11376.829347559793, 570237.0, 576586.117069412, 576882.0, 577226.4554708882, 581418.0, 86991.0, 94134.11731765326, 126205.0, 132906.0, 136622.63377366296, 963.3978763272954, 978.8972157923458, 1000.6847842929454, 1003.4180175498193, 1025.1952217509368, 19094.522636934187, 19399.127039282983, 19855.503612409804, 19890.50273743168, 19939.601207976048, 50570.74714626403, 58127.418725812204, 58495.12257316229, 59123.704381477815, 59517.80964380775, 82603.7609435847, 85580.0, 85837.0, 87013.0, 89499.55250223707, 5393.352797664148, 7500.174980752004, 7772.378209743094, 8041.959790201012, 8360.163983601591, 6956.234814170539, 8687.565621718762, 10975.725606859893, 12704.936475317565, 13479.797803033158, 10533.57865685364, 10988.285761425483, 11034.944825275823, 11538.365389903636, 11570.0, 10270.0, 11133.94022105913, 11170.218084733991, 11557.133215009077, 11681.941590291994, 11088.33469991803, 11266.83099753488, 11428.542858285575, 11584.768304634028, 11650.53397864076, 8046.758597242092, 8221.506709597443, 8366.623501942306, 8506.276966457921, 8604.741857744277, 9472.95263523678, 11062.778744424906, 11408.486618102372, 11460.312381257152, 11525.942370288094], "value": 10573.137066273364, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.5526676196844, 1504.5561559339994, 1529.7399442094843, 1710.324421853368, 1871.5976065145999, 7538.359239464645, 7951.681932722691, 8142.226488483592, 8337.041240257373, 8341.998960124794, 8181.140980197083, 8285.337173026159, 8285.54429506377, 8290.461120027208, 8299.004119505653, 2343.8828058597046, 2389.2712722619594, 2392.3301475586863, 2393.760623937601, 2394.365493144318, 2376.3821406434363, 2402.5675378431874, 2434.8417352872093, 2437.366284765965, 2438.329459398662, 2359.1153317505937, 2360.9291721248305, 2390.6533552634855, 2393.150431596784, 2393.270052633946, 2339.6022676144926, 2349.3304408243653, 2370.4073981504625, 2378.857268563892, 2390.988045059781, 2322.7328857181474, 2347.518758654489, 2391.964120538193, 2392.1986134644917, 2394.2697477269426, 7014.438844892396, 7300.342969132804, 8274.793130171734, 8388.580570971428, 8389.0, 5077.796888124471, 5271.472852714736, 5271.762770675329, 5271.947280527184, 5271.971965466735, 3089.459344614706, 3429.329478967635, 3513.841877115536, 3516.82415879205, 3593.6406359364114, 1080.751427171747, 1088.8366744988316, 1107.6123356825128, 1108.3959242213014, 1130.248384824091, 10757.193210509244, 10796.298240614335, 10882.61910833117, 10883.23817332787, 10916.727081822939, 4271.957280427156, 4406.383106365111, 4487.596116349544, 4497.415336006298, 4516.209663308908, 8574.27118694918, 8625.353098517637, 8631.223189912938, 8631.438956467935, 8632.438891472035, 5096.694198348111, 5105.183170692671, 5109.054824857413, 5110.744462776846, 5117.488251174853, 4299.935500967488, 4466.553344665507, 4676.579107880307, 4749.121412538691, 4771.427428708577, 3616.4575313703153, 3671.871484498083, 3727.0682329417646, 3771.4908487353855, 3771.5097037384962, 1159.0, 1162.9127815413879, 1171.297221666993, 1179.9764004719857, 1184.1474138620179, 845.4166625028711, 848.2154007543121, 899.7480705402497, 904.6607522179182, 906.9591868365808, 5233.502817232356, 5389.299391079213, 5529.778808847682, 5624.0439125348785, 5723.627964182315, 840.3823189955378, 982.6413359123868, 989.9158571521501, 1043.7912417516527, 1055.4247934875511, 3583.086312990171, 3612.7471077024356, 3635.909102272464, 3787.110029143149, 3795.1840354323954, 9824.361416507903, 10009.049140331657, 10104.545295461721, 10117.59529618807, 10121.392716437038, 9535.332526723063, 9949.154321882721, 9995.950020249853, 10001.0, 10050.246231532665, 7652.73215437457, 7868.606569671608, 7882.408819338572, 7896.7236146734585, 7903.486273392326, 5332.33345831771, 5393.110136827379, 5589.301337332833, 5688.232088668143, 5779.508741756998, 9063.637454501746, 9345.345825792128, 9347.252219822534, 9479.620815167316, 9513.33406661527, 9144.359894807565, 9464.290178236797, 9485.288603354915, 9597.424154550748, 9641.325107242426, 5820.214271073351, 7066.328698773608, 7110.0401445804155, 7204.675789589586, 7207.783766487014, 7974.0, 8049.154838741848, 8058.831469436782, 8061.435699500978, 8084.0, 6959.332824291072, 7101.39638130744, 7139.178994415501, 7176.892346614701, 7220.530665506725, 7002.7899163025195, 7067.6819543119655, 7086.220515743367, 7118.572885626879, 7166.390856777232, 6630.436412904957, 6633.436157926631, 6695.765648202289, 6698.899516507159, 6706.966465167839, 4697.8355757548325, 4700.55344742249, 4751.548602882721, 4789.928151077806, 4792.2332426811545, 4556.498785133699, 4744.572988431058, 4751.144793936986, 4892.0705066037335, 5038.017586570583], "value": 4406.574048454884, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.25454536385354, 311.50781764811586, 319.70587059904886, 323.4985772053317, 325.5978866100367, 4560.863174104774, 4863.732494712794, 5167.741612919358, 5212.76542555585, 5266.657667251626, 4188.895277618061, 4877.804887804493, 5008.549230569248, 5032.899342013157, 5189.299444574981, 3673.7876500754687, 3816.9618303817024, 3921.5294164700276, 3983.661388781957, 3991.582988039248, 3600.207954250061, 3883.3204189266908, 3975.9006024849464, 4016.3373043447796, 4028.3554631259003, 3347.2134048498583, 3851.4415409765566, 3916.70624703147, 3986.940195897064, 3986.940195897064, 3700.85196592136, 3974.304496713078, 3981.303271927401, 3998.8000599969887, 4010.6991975601945, 3086.2284428892776, 3355.4128027595075, 3475.2180759329203, 3498.2828520153307, 3525.2068284636007, 3896.47397601323, 4958.305837182797, 4992.251162325644, 5050.646454748169, 5070.619703522214, 4225.852095176654, 4465.196264672358, 4519.457665080178, 4558.883073646978, 4572.725636461823, 4539.886502837422, 4749.928751068702, 5393.352797664266, 5452.536534394581, 5495.2856128703415, 2967.234495475189, 3832.4670131947164, 3835.884923452301, 3846.59610740871, 3850.4801851749935, 5346.8395948121615, 5486.451354864522, 5706.6629361685, 5721.856953576153, 5735.254416925814, 3349.296647703961, 3753.1930634913624, 3782.962170378261, 3794.924101517954, 3819.052283335519, 2980.5857255623014, 3398.2693720850134, 3447.517347571342, 3886.6502014818802, 3892.82482288292, 4069.369247766601, 4338.069559046194, 4493.865184044484, 4520.276755719069, 4526.958799476073, 4158.397032430281, 4755.763501489569, 5041.344625198701, 5132.409772876093, 5252.369715634149, 1130.547780887635, 1245.3524167432884, 1249.3815561297035, 1251.5932321995388, 1256.4974010395915, 737.8266107464741, 769.9076110866732, 816.4529765057425, 842.7990114087401, 855.2730179347504, 4419.845305414359, 4451.577100175478, 4897.706137631753, 4948.70307781527, 4986.601071914238, 4477.574630410106, 4787.0, 4985.875353116128, 5172.896542069213, 5441.211024401518, 4591.14058806184, 4696.473646065043, 4758.976205118952, 4869.488703686133, 4888.5111488850835, 2256.7023961222035, 2757.26932362924, 2764.7926405519665, 2785.3175971886612, 2802.313433208877, 4894.26586012094, 5362.624616276823, 5367.007103685831, 5414.756335964812, 5534.584906132056, 4914.311996320518, 5228.8757917048015, 5353.437889021675, 5447.455254474521, 5456.863578410572, 4363.3018717005125, 4594.931076033862, 5259.289995850511, 5389.9191512127345, 5448.318960129984, 4513.074819661896, 5036.647434679538, 5244.134717771525, 5329.653572517774, 5364.436734143015, 4003.6396724293786, 4862.367892173995, 5265.629527492249, 5267.631265811357, 5270.472952704698, 4535.319702044588, 5010.649254552146, 5544.584156188383, 5549.667019978814, 5565.220869078251, 3174.730147937451, 3552.6802587767224, 3557.7153827693205, 3572.1783989682, 3597.892063238107, 4143.81352839117, 4631.073785243032, 4740.952590474051, 5191.480851914778, 5195.506426889439, 4184.81168347419, 4692.48382677912, 4912.778924948315, 5112.693238405707, 5159.303494028408, 4857.441394239708, 4973.5523802857915, 5017.394433781155, 5088.745562721923, 5133.486651334986, 3916.8433262669173, 4746.928796067993, 4852.878678033077, 4901.9019619608125, 4934.654574179916, 4309.892252693708, 5218.921716174336, 5273.284258606897, 5330.413654498079, 5340.679559226303, 4250.597302889977, 4621.498013145809, 4825.758712064313, 5241.764120614658, 5285.788568457218], "value": 3826.593679041018, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.47979535553, 767.6967597798873, 769.6438160014317, 788.7081779741495, 803.6945960534997, 12508.874911250885, 14362.353694083766, 15217.4673886414, 15306.234688265598, 15335.84664153358, 13532.323383830819, 13794.2413167276, 13827.101238419496, 13833.17000979942, 13973.580792576238, 827.5944787054331, 827.7806381308958, 830.0620299062051, 833.708202129253, 836.8577341851884, 859.7248880358288, 863.1109956744532, 864.723288547665, 865.4288169807928, 865.8614621660536, 728.4754976416971, 753.0774800868919, 879.2965627497977, 909.6543313540878, 911.8632205169245, 866.0257210638032, 866.2939704141105, 866.8526350520426, 867.4014929698551, 869.9826003479926, 643.3662842100528, 643.3952085040047, 644.0661041489858, 645.7610684046932, 647.3429469088878, 13949.232792196424, 14161.0, 14207.076540024866, 14208.502702405367, 14220.0, 10664.520096595672, 13195.20828750278, 13435.798463023062, 13458.730825383438, 13475.932620336933, 11013.504392302366, 11146.832797508045, 11273.43632818364, 11566.826497602542, 11574.0, 4361.236783562864, 4381.627561657263, 4498.8425405110665, 4527.388802511652, 4532.342810292489, 80877.59561202215, 85766.71349929756, 86164.27671446536, 86539.70190447148, 86841.52633894637, 10397.688069357931, 10441.425721585234, 10475.669764898883, 10605.363678179334, 10853.077488413574, 20209.797902021084, 20334.593308133753, 20390.0, 20394.592108157754, 20399.388018359474, 7491.0, 7545.471816972869, 7623.0, 7627.084749830056, 7867.527948323119, 4276.87169384919, 4281.100968796588, 4331.177076355545, 4414.09511050234, 4511.278195488771, 3281.6718328166994, 3388.525606415104, 3388.6950174484414, 3394.304167645676, 3395.7622966392114, 619.1734035063241, 630.3444417805523, 653.1665674012347, 654.0548906829681, 659.5712786688595, 496.9826056088092, 608.1728848765675, 629.0972454527767, 637.5591163969463, 637.7895294552786, 8485.703000394957, 8963.417377870417, 9005.909940900638, 9098.363114582047, 9117.0, 536.2787051415839, 579.2816907035246, 591.7100620695828, 603.2459425717852, 635.0664523150961, 3949.8420063197723, 4317.525072242051, 4329.653627709776, 4368.039031413084, 4427.800748966304, 114312.42843785894, 117274.41362793131, 119844.0, 120519.39740301242, 122109.0, 88402.55798720966, 101097.0, 102022.91908323733, 105784.0, 106219.46890265499, 90645.0, 91572.0, 92197.5390123045, 93313.0, 94480.0, 8448.40861139739, 8491.532965686947, 8541.701040463555, 8664.335247481402, 8715.782105447415, 53778.462215377345, 56709.149362760414, 58816.411835881096, 59871.30579123863, 60623.69688151531, 63009.36990630035, 78369.60815195888, 82048.58975705084, 83563.5821820887, 85742.0, 10705.090067344363, 10781.838272426077, 10948.95984881435, 10965.56137754481, 11170.4090895488, 12237.69405764863, 13113.344332783514, 13706.93146534261, 14059.086159399607, 14457.27713614294, 12900.571927007504, 13058.934705326412, 13245.867541324464, 13259.602211933658, 13259.602211933658, 12317.75459769536, 12731.299778512272, 12929.418176182282, 13257.337133143112, 14151.716965660424, 12951.481940722266, 13489.730205396034, 13703.0, 13922.582322530341, 13984.510542130976, 10711.94644026775, 11049.0, 11064.114870810155, 11309.208355415041, 11375.43122843838, 10686.73283167927, 11201.38392388394, 11237.71905702364, 11436.94281528587, 11679.708007299885], "value": 7356.619518828579, "unit": "score"}], "name": "dromaeo_css", "value": 7214.466518189124, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 113.0, 114.0, 113.0, 113.0, 112.0, 112.0, 115.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 140.0, 142.0, 143.0, 109.0, 107.0, 107.0, 108.0, 139.0, 109.0], "value": 125.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 182.0, 185.0, 184.0, 182.0, 184.0, 181.0, 184.0, 184.0, 183.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 81.0, 115.0, 66.0, 60.0, 59.0, 58.0, 82.0, 57.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 93.0, 70.0, 68.0, 67.0, 72.0, 75.0, 90.0, 119.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 85.0, 88.0, 131.0, 92.0, 84.0, 87.0, 84.0], "value": 91.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 101.0, 149.0, 138.0, 93.0, 94.0, 93.0, 93.0, 95.0, 94.0], "value": 104.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 82.0, 79.0, 81.0, 83.0, 85.0, 84.0, 82.0, 82.0], "value": 81.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 54.0, 58.0, 58.0, 58.0, 56.0, 55.0, 57.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 80.0, 70.0, 72.0, 66.0, 68.0, 68.0, 68.0, 67.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 81.0, 81.0, 75.0, 81.0, 82.0, 81.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 151.0, 145.0, 136.0, 138.0, 141.0, 138.0, 137.0, 183.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 160.0, 161.0, 161.0, 160.0, 162.0, 160.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 64.0, 64.0, 67.0, 65.0, 67.0, 64.0, 65.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1431.5, "alertThreshold": 2.0}]} 07:53:21 INFO - Return code: 0 07:53:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:53:21 INFO - # TBPL SUCCESS # 07:53:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:53:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:53:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:53:21 INFO - 2017-02-16 07:53:21.779 screenresolution[1916:16410] starting screenresolution argv=screenresolution get 07:53:21 INFO - 2017-02-16 07:53:21.782 screenresolution[1916:16410] Display 0: 1600x1200x32@60 07:53:21 INFO - 2017-02-16 07:53:21.789 screenresolution[1917:16413] starting screenresolution argv=screenresolution list 07:53:21 INFO - Available Modes on Display 0 07:53:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:53:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:53:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:53:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:53:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:53:22 INFO - Intel Iris: 07:53:22 INFO - Chipset Model: Intel Iris 07:53:22 INFO - Type: GPU 07:53:22 INFO - Bus: Built-In 07:53:22 INFO - VRAM (Dynamic, Max): 1536 MB 07:53:22 INFO - Vendor: Intel (0x8086) 07:53:22 INFO - Device ID: 0x0a2e 07:53:22 INFO - Revision ID: 0x0009 07:53:22 INFO - Displays: 07:53:22 INFO - Display: 07:53:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:53:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:53:22 INFO - Display Serial Number: 1600x1200 60 07:53:22 INFO - Main Display: Yes 07:53:22 INFO - Mirror: Off 07:53:22 INFO - Online: Yes 07:53:22 INFO - Rotation: Supported 07:53:22 INFO - Return code: 0 07:53:22 INFO - Running post-action listener: _resource_record_post_action 07:53:22 INFO - [mozharness: 2017-02-16 15:53:22.038096Z] Finished run-tests step (success) 07:53:22 INFO - Running post-run listener: _resource_record_post_run 07:53:22 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 909312; Write bytes: 500515840; Read time: 13; Write time: 1624 07:53:22 INFO - TinderboxPrint: CPU usage
53.6% 07:53:22 INFO - TinderboxPrint: I/O read bytes / time
909,312 / 13 07:53:22 INFO - TinderboxPrint: I/O write bytes / time
500,515,840 / 1,624 07:53:22 INFO - TinderboxPrint: CPU idle
2,223.2 (46.4%) 07:53:22 INFO - TinderboxPrint: CPU system
961.1 (20.1%) 07:53:22 INFO - TinderboxPrint: CPU user
1,609.4 (33.6%) 07:53:22 INFO - TinderboxPrint: Swap in / out
192,921,600 / 0 07:53:22 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183392768; Write bytes: 176017408; Read time: 16943; Write time: 395 07:53:22 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 909312; Write bytes: 307811328; Read time: 13; Write time: 1181 07:53:22 INFO - Running post-run listener: _upload_blobber_files 07:53:22 INFO - Blob upload gear active. 07:53:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:53:22 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:53:22 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:53:22 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:53:22 INFO - (blobuploader) - INFO - Open directory for files ... 07:53:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:53:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:53:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:23 INFO - (blobuploader) - INFO - Done attempting. 07:53:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:53:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:53:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:24 INFO - (blobuploader) - INFO - Done attempting. 07:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:53:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:27 INFO - (blobuploader) - INFO - Done attempting. 07:53:27 INFO - (blobuploader) - INFO - Iteration through files over. 07:53:27 INFO - Return code: 0 07:53:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:53:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:53:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e8ea6bae8e03f9cab132546447cacac466c95b68d33bef9ff5c000fd6dedb3aca0081910f75d2916bc33f775ba90b87f8d1c8599c2c09578c88887aa8ddb3a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c84fc99781615237a20ca0e01cd821e32c71e8b15e9b9aaa780245a526d49c6adc7cf2d708e20e1cdbe1612ce187a35ae46a97ac3eaea752a486a81f7f556a31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/505970310af933305f408ccbe784866ffcbeb788d6d1df9864f1b682da08b1b7c543fba33190cf363027ae1628eddffdc763151c8f86ee9e248aef430a4d974e"} 07:53:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:53:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:53:27 INFO - Contents: 07:53:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e8ea6bae8e03f9cab132546447cacac466c95b68d33bef9ff5c000fd6dedb3aca0081910f75d2916bc33f775ba90b87f8d1c8599c2c09578c88887aa8ddb3a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c84fc99781615237a20ca0e01cd821e32c71e8b15e9b9aaa780245a526d49c6adc7cf2d708e20e1cdbe1612ce187a35ae46a97ac3eaea752a486a81f7f556a31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/505970310af933305f408ccbe784866ffcbeb788d6d1df9864f1b682da08b1b7c543fba33190cf363027ae1628eddffdc763151c8f86ee9e248aef430a4d974e"} 07:53:27 INFO - Running post-run listener: copy_logs_to_upload_dir 07:53:27 INFO - Copying logs to upload dir... 07:53:27 INFO - mkdir: /builds/slave/test/build/upload/logs 07:53:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.408782 ========= master_lag: 2.59 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-16 07:53:30.001858) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 07:53:30.005027) ========= 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.RZn1c9N604/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.IMoWvarFUC/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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/0e8ea6bae8e03f9cab132546447cacac466c95b68d33bef9ff5c000fd6dedb3aca0081910f75d2916bc33f775ba90b87f8d1c8599c2c09578c88887aa8ddb3a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c84fc99781615237a20ca0e01cd821e32c71e8b15e9b9aaa780245a526d49c6adc7cf2d708e20e1cdbe1612ce187a35ae46a97ac3eaea752a486a81f7f556a31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/505970310af933305f408ccbe784866ffcbeb788d6d1df9864f1b682da08b1b7c543fba33190cf363027ae1628eddffdc763151c8f86ee9e248aef430a4d974e"} build_url:https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011119 build_url: 'https://queue.taskcluster.net/v1/task/ONT1kt7MQXOL7aZRZycmYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e8ea6bae8e03f9cab132546447cacac466c95b68d33bef9ff5c000fd6dedb3aca0081910f75d2916bc33f775ba90b87f8d1c8599c2c09578c88887aa8ddb3a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c84fc99781615237a20ca0e01cd821e32c71e8b15e9b9aaa780245a526d49c6adc7cf2d708e20e1cdbe1612ce187a35ae46a97ac3eaea752a486a81f7f556a31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/505970310af933305f408ccbe784866ffcbeb788d6d1df9864f1b682da08b1b7c543fba33190cf363027ae1628eddffdc763151c8f86ee9e248aef430a4d974e"}' ========= master_lag: 0.35 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 07:53:30.367000) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 07:53:30.367330) ========= 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.RZn1c9N604/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.IMoWvarFUC/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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.005132 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 07:53:30.394992) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 07:53:30.395304) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 07:53:30.395605) ========= ========= Total master_lag: 3.04 =========