builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0077 starttime: 1488293337.22 results: success (0) buildid: 20170228061236 builduid: 697241816f794aa5a9418abf7f651629 revision: c269adcb4e01ae92e215efe6232a5ab28a9c3949 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-28 06:48:57.219427) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-28 06:48:57.219887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-28 06:48:57.220299) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-28 06:48:57.249192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 06:48:57.249574) ========= 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.lOW9AmBeCt/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.gsq08cu7mD/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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-28 06:48:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2017-02-28 06:48:57 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.238950 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 06:48:57.513003) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 06:48:57.513358) ========= 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.lOW9AmBeCt/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.gsq08cu7mD/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.033279 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 06:48:57.570011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-28 06:48:57.570417) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c269adcb4e01ae92e215efe6232a5ab28a9c3949 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c269adcb4e01ae92e215efe6232a5ab28a9c3949 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lOW9AmBeCt/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.gsq08cu7mD/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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-28 06:48:57,675 truncating revision to first 12 chars 2017-02-28 06:48:57,675 Setting DEBUG logging. 2017-02-28 06:48:57,675 attempt 1/10 2017-02-28 06:48:57,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c269adcb4e01?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-28 06:48:58,556 unpacking tar archive at: mozilla-aurora-c269adcb4e01/testing/mozharness/ program finished with exit code 0 elapsedTime=1.154407 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-28 06:48:58.751042) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-28 06:48:58.751574) ========= script_repo_revision: c269adcb4e01ae92e215efe6232a5ab28a9c3949 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-28 06:48:58.752231) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-28 06:48:58.752692) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-28 06:48:58.782275) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-28 06:48:58.782874) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lOW9AmBeCt/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.gsq08cu7mD/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:48:58 INFO - MultiFileLogger online at 20170228 06:48:58 in /builds/slave/test 06:48:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:48:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:48:58 INFO - {'append_to_log': False, 06:48:58 INFO - 'base_work_dir': '/builds/slave/test', 06:48:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:48:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:48:58 INFO - 'branch': 'Mozilla-Aurora', 06:48:58 INFO - 'buildbot_json_path': 'buildprops.json', 06:48:58 INFO - 'config_files': ('talos/mac_config.py',), 06:48:58 INFO - 'default_actions': ('clobber', 06:48:58 INFO - 'read-buildbot-config', 06:48:58 INFO - 'download-and-extract', 06:48:59 INFO - 'populate-webroot', 06:48:59 INFO - 'create-virtualenv', 06:48:59 INFO - 'install', 06:48:59 INFO - 'run-tests'), 06:48:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:48:59 INFO - 'download_minidump_stackwalk': True, 06:48:59 INFO - 'download_symbols': 'ondemand', 06:48:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:48:59 INFO - 'tooltool.py': '/tools/tooltool.py', 06:48:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:48:59 INFO - '/tools/misc-python/virtualenv.py')}, 06:48:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:48:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:48:59 INFO - 'installer_path': 'installer.exe', 06:48:59 INFO - 'log_level': 'info', 06:48:59 INFO - 'log_name': 'talos', 06:48:59 INFO - 'log_to_console': True, 06:48:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:48:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:48:59 INFO - 'opt_config_files': (), 06:48:59 INFO - 'pip_index': False, 06:48:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:48:59 INFO - 'cmd': ('bash', 06:48:59 INFO - '-c', 06:48:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:48:59 INFO - 'enabled': True, 06:48:59 INFO - 'halt_on_failure': False, 06:48:59 INFO - 'name': 'check_screen_resolution'},), 06:48:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:48:59 INFO - 'cmd': ('bash', 06:48:59 INFO - '-c', 06:48:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:48:59 INFO - 'enabled': True, 06:48:59 INFO - 'halt_on_failure': False, 06:48:59 INFO - 'name': 'check_screen_resolution'},), 06:48:59 INFO - 'run_cmd_checks_enabled': True, 06:48:59 INFO - 'sps_profile': False, 06:48:59 INFO - 'sps_profile_interval': 0, 06:48:59 INFO - 'suite': 'dromaeojs', 06:48:59 INFO - 'system_bits': '32', 06:48:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:48:59 INFO - 'title': 't-yosemite-r7-0077', 06:48:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:48:59 INFO - 'use_talos_json': True, 06:48:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:48:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:48:59 INFO - 'work_dir': 'build'} 06:48:59 INFO - [mozharness: 2017-02-28 14:48:59.005097Z] Running clobber step. 06:48:59 INFO - Running pre-action listener: _resource_record_pre_action 06:48:59 INFO - Running main action method: clobber 06:48:59 INFO - rmtree: /builds/slave/test/build 06:48:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:49:01 INFO - Running post-action listener: _resource_record_post_action 06:49:01 INFO - [mozharness: 2017-02-28 14:49:01.536774Z] Finished clobber step (success) 06:49:01 INFO - [mozharness: 2017-02-28 14:49:01.537049Z] Running read-buildbot-config step. 06:49:01 INFO - Running pre-action listener: _resource_record_pre_action 06:49:01 INFO - Running main action method: read_buildbot_config 06:49:01 INFO - Using buildbot properties: 06:49:01 INFO - { 06:49:01 INFO - "project": "", 06:49:01 INFO - "product": "firefox", 06:49:01 INFO - "script_repo_revision": "production", 06:49:01 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 06:49:01 INFO - "repository": "", 06:49:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 06:49:01 INFO - "buildid": "20170228061236", 06:49:01 INFO - "pgo_build": "False", 06:49:01 INFO - "basedir": "/builds/slave/test", 06:49:01 INFO - "buildnumber": 57, 06:49:01 INFO - "slavename": "t-yosemite-r7-0077", 06:49:01 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 06:49:01 INFO - "platform": "yosemite_r7", 06:49:01 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:49:01 INFO - "branch": "mozilla-aurora", 06:49:01 INFO - "repo_path": "releases/mozilla-aurora", 06:49:01 INFO - "revision": "c269adcb4e01ae92e215efe6232a5ab28a9c3949", 06:49:01 INFO - "stage_platform": "macosx64", 06:49:01 INFO - "builduid": "697241816f794aa5a9418abf7f651629", 06:49:01 INFO - "slavebuilddir": "test" 06:49:01 INFO - } 06:49:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 06:49:01 INFO - Running post-action listener: _resource_record_post_action 06:49:01 INFO - [mozharness: 2017-02-28 14:49:01.542757Z] Finished read-buildbot-config step (success) 06:49:01 INFO - [mozharness: 2017-02-28 14:49:01.542982Z] Running download-and-extract step. 06:49:01 INFO - Running pre-action listener: _resource_record_pre_action 06:49:01 INFO - Running main action method: download_and_extract 06:49:01 INFO - mkdir: /builds/slave/test/build/tests 06:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:01 INFO - trying https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 06:49:01 INFO - Downloading https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 06:49:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 06:49:02 INFO - Downloaded 1199 bytes. 06:49:02 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 06:49:02 INFO - Using the following test package requirements: 06:49:02 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 06:49:02 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:49:02 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 06:49:02 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:49:02 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 06:49:02 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:49:02 INFO - u'jsshell-mac.zip'], 06:49:02 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:49:02 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 06:49:02 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 06:49:02 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:49:02 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 06:49:02 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:49:02 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 06:49:02 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:49:02 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 06:49:02 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:49:02 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 06:49:02 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:49:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 06:49:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:49:02 INFO - Fetch https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 06:49:03 INFO - Expected file size: 16357693 06:49:03 INFO - Obtained file size: 16357693 06:49:11 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 06:49:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 06:49:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:49:11 INFO - Fetch https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 06:49:12 INFO - Expected file size: 16357693 06:49:12 INFO - Obtained file size: 16357693 06:49:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 06:49:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:49:18 INFO - Fetch https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 06:49:21 INFO - Expected file size: 14403472 06:49:21 INFO - Obtained file size: 14403472 06:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:21 INFO - trying https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:49:21 INFO - Downloading https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 06:49:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 06:49:25 INFO - Downloaded 73920819 bytes. 06:49:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:49:25 INFO - mkdir: /builds/slave/test/properties 06:49:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:49:25 INFO - Writing to file /builds/slave/test/properties/build_url 06:49:25 INFO - Contents: 06:49:25 INFO - build_url:https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:49:26 INFO - Running post-action listener: _resource_record_post_action 06:49:26 INFO - Running post-action listener: set_extra_try_arguments 06:49:26 INFO - [mozharness: 2017-02-28 14:49:26.843034Z] Finished download-and-extract step (success) 06:49:26 INFO - [mozharness: 2017-02-28 14:49:26.843173Z] Running populate-webroot step. 06:49:26 INFO - Running pre-action listener: _resource_record_pre_action 06:49:26 INFO - Running main action method: populate_webroot 06:49:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:49:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:49:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:49:26 INFO - '--tppagecycles', 06:49:26 INFO - '7'], 06:49:26 INFO - 'tests': ['tsvgm']}}, 06:49:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:49:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:49:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:49:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:49:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:49:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:49:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:49:26 INFO - 'talos_options': ['--disable-e10s'], 06:49:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:49:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:49:26 INFO - 'talos_options': ['--disable-e10s'], 06:49:26 INFO - 'tests': ['damp', 'tps']}, 06:49:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:49:26 INFO - 'tests': ['damp', 'tps']}, 06:49:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:49:26 INFO - 'tests': ['dromaeo_dom']}, 06:49:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:49:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:49:26 INFO - 'tests': ['basic_compositor_video']}, 06:49:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:49:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:49:26 INFO - 'tests': ['a11yr', 06:49:26 INFO - 'ts_paint', 06:49:26 INFO - 'tpaint', 06:49:26 INFO - 'sessionrestore', 06:49:26 INFO - 'sessionrestore_no_auto_restore', 06:49:26 INFO - 'tabpaint']}, 06:49:26 INFO - 'other-e10s': {'tests': ['a11yr', 06:49:26 INFO - 'ts_paint', 06:49:26 INFO - 'tpaint', 06:49:26 INFO - 'sessionrestore', 06:49:26 INFO - 'sessionrestore_no_auto_restore', 06:49:26 INFO - 'tabpaint']}, 06:49:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:49:26 INFO - 'ts_paint', 06:49:26 INFO - 'tpaint', 06:49:26 INFO - 'sessionrestore', 06:49:26 INFO - 'sessionrestore_no_auto_restore', 06:49:26 INFO - 'tabpaint']}, 06:49:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:49:26 INFO - 'ts_paint', 06:49:26 INFO - 'tpaint', 06:49:26 INFO - 'sessionrestore', 06:49:26 INFO - 'sessionrestore_no_auto_restore', 06:49:26 INFO - 'tabpaint']}, 06:49:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:49:26 INFO - 'tests': ['a11yr', 06:49:26 INFO - 'ts_paint', 06:49:26 INFO - 'tpaint', 06:49:26 INFO - 'sessionrestore', 06:49:26 INFO - 'sessionrestore_no_auto_restore', 06:49:26 INFO - 'tabpaint']}, 06:49:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:49:26 INFO - 'tests': ['a11yr', 06:49:26 INFO - 'ts_paint', 06:49:26 INFO - 'tpaint', 06:49:26 INFO - 'sessionrestore', 06:49:26 INFO - 'sessionrestore_no_auto_restore', 06:49:26 INFO - 'tabpaint']}, 06:49:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:49:26 INFO - 'tests': ['tsvgx', 06:49:26 INFO - 'tsvgr_opacity', 06:49:26 INFO - 'tart', 06:49:26 INFO - 'tscrollx', 06:49:26 INFO - 'cart', 06:49:26 INFO - 'tsvg_static']}, 06:49:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:49:26 INFO - 'tsvgr_opacity', 06:49:26 INFO - 'tart', 06:49:26 INFO - 'tscrollx', 06:49:26 INFO - 'cart', 06:49:26 INFO - 'tsvg_static']}, 06:49:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:49:26 INFO - 'talos_options': ['--disable-e10s'], 06:49:26 INFO - 'tests': ['tp5o']}, 06:49:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:49:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:49:26 INFO - 'talos_options': ['--disable-e10s', 06:49:26 INFO - '--xperf_path', 06:49:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:26 INFO - 'tests': ['tp5n']}, 06:49:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:49:26 INFO - 'talos_options': ['--xperf_path', 06:49:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:26 INFO - 'tests': ['tp5n']}}, 06:49:26 INFO - 'talos.zip': {'path': '', 06:49:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:49:26 INFO - Running post-action listener: _resource_record_post_action 06:49:26 INFO - [mozharness: 2017-02-28 14:49:26.861620Z] Finished populate-webroot step (success) 06:49:26 INFO - [mozharness: 2017-02-28 14:49:26.861735Z] Running create-virtualenv step. 06:49:26 INFO - Running pre-action listener: _resource_record_pre_action 06:49:26 INFO - Running main action method: create_virtualenv 06:49:26 INFO - Creating virtualenv /builds/slave/test/build/venv 06:49:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:49:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:49:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:49:26 INFO - Using real prefix '/tools/python27' 06:49:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:49:27 INFO - Installing distribute.............................................................................................................................................................................................done. 06:49:30 INFO - Installing pip.................done. 06:49:30 INFO - Return code: 0 06:49:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:49:30 INFO - Reading from file tmpfile_stdout 06:49:30 INFO - Output received: 06:49:30 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) 06:49:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102d10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf294bbc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aeed30>, '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 0x102a15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3be8>, '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.lOW9AmBeCt/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.gsq08cu7mD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:49:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:49:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lOW9AmBeCt/Render', 06:49:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:30 INFO - 'HOME': '/Users/cltbld', 06:49:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:30 INFO - 'LOGNAME': 'cltbld', 06:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:30 INFO - 'MOZ_NO_REMOTE': '1', 06:49:30 INFO - 'NO_EM_RESTART': '1', 06:49:30 INFO - 'PAGER': '/bin/cat', 06:49:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:30 INFO - 'PWD': '/builds/slave/test', 06:49:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:30 INFO - 'SHELL': '/bin/bash', 06:49:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsq08cu7mD/Listeners', 06:49:30 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:49:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:30 INFO - 'USER': 'cltbld', 06:49:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:30 INFO - 'XPC_FLAGS': '0x0', 06:49:30 INFO - 'XPC_SERVICE_NAME': '0', 06:49:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:49:31 INFO - Cleaning up... 06:49:31 INFO - Return code: 0 06:49:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:49: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')]} 06:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49: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')]} 06:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:31 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 0x102d10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf294bbc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aeed30>, '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 0x102a15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3be8>, '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.lOW9AmBeCt/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.gsq08cu7mD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:49:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:49:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lOW9AmBeCt/Render', 06:49:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:31 INFO - 'HOME': '/Users/cltbld', 06:49:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:31 INFO - 'LOGNAME': 'cltbld', 06:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:31 INFO - 'MOZ_NO_REMOTE': '1', 06:49:31 INFO - 'NO_EM_RESTART': '1', 06:49:31 INFO - 'PAGER': '/bin/cat', 06:49:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:31 INFO - 'PWD': '/builds/slave/test', 06:49:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:31 INFO - 'SHELL': '/bin/bash', 06:49:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsq08cu7mD/Listeners', 06:49:31 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:49:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:31 INFO - 'USER': 'cltbld', 06:49:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:31 INFO - 'XPC_FLAGS': '0x0', 06:49:31 INFO - 'XPC_SERVICE_NAME': '0', 06:49:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:31 INFO - Downloading/unpacking psutil>=3.1.1 06:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:49:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:35 INFO - Installing collected packages: psutil 06:49:35 INFO - Running setup.py install for psutil 06:49:35 INFO - building 'psutil._psutil_osx' extension 06:49:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:49:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:49:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:49:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:49:36 INFO - building 'psutil._psutil_posix' extension 06:49:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:49:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:49:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:49:36 INFO - ^ 06:49:36 INFO - 1 warning generated. 06:49:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:49:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:36 INFO - Successfully installed psutil 06:49:36 INFO - Cleaning up... 06:49:36 INFO - Return code: 0 06:49:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:36 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 0x102d10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf294bbc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aeed30>, '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 0x102a15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3be8>, '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.lOW9AmBeCt/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.gsq08cu7mD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:49:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lOW9AmBeCt/Render', 06:49:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:36 INFO - 'HOME': '/Users/cltbld', 06:49:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:36 INFO - 'LOGNAME': 'cltbld', 06:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:36 INFO - 'MOZ_NO_REMOTE': '1', 06:49:36 INFO - 'NO_EM_RESTART': '1', 06:49:36 INFO - 'PAGER': '/bin/cat', 06:49:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:36 INFO - 'PWD': '/builds/slave/test', 06:49:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:36 INFO - 'SHELL': '/bin/bash', 06:49:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsq08cu7mD/Listeners', 06:49:36 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:49:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:36 INFO - 'USER': 'cltbld', 06:49:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:36 INFO - 'XPC_FLAGS': '0x0', 06:49:36 INFO - 'XPC_SERVICE_NAME': '0', 06:49:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:49:39 INFO - Installing collected packages: mozsystemmonitor 06:49:39 INFO - Running setup.py install for mozsystemmonitor 06:49:39 INFO - Successfully installed mozsystemmonitor 06:49:39 INFO - Cleaning up... 06:49:39 INFO - Return code: 0 06:49:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:39 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 0x102d10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf294bbc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aeed30>, '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 0x102a15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3be8>, '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.lOW9AmBeCt/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.gsq08cu7mD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:49:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:49:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lOW9AmBeCt/Render', 06:49:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:39 INFO - 'HOME': '/Users/cltbld', 06:49:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:39 INFO - 'LOGNAME': 'cltbld', 06:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:39 INFO - 'MOZ_NO_REMOTE': '1', 06:49:39 INFO - 'NO_EM_RESTART': '1', 06:49:39 INFO - 'PAGER': '/bin/cat', 06:49:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:39 INFO - 'PWD': '/builds/slave/test', 06:49:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:39 INFO - 'SHELL': '/bin/bash', 06:49:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsq08cu7mD/Listeners', 06:49:39 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:49:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:39 INFO - 'USER': 'cltbld', 06:49:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:39 INFO - 'XPC_FLAGS': '0x0', 06:49:39 INFO - 'XPC_SERVICE_NAME': '0', 06:49:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:40 INFO - Downloading/unpacking jsonschema==2.5.1 06:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:49:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:43 INFO - Downloading functools32-3.2.3-2.tar.gz 06:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:49:43 INFO - warning: no files found matching '*.txt' 06:49:43 INFO - no previously-included directories found matching 'build' 06:49:43 INFO - no previously-included directories found matching 'dist' 06:49:43 INFO - no previously-included directories found matching '.git*' 06:49:43 INFO - Installing collected packages: jsonschema, functools32 06:49:43 INFO - Running setup.py install for functools32 06:49:43 INFO - warning: no files found matching '*.txt' 06:49:43 INFO - no previously-included directories found matching 'build' 06:49:43 INFO - no previously-included directories found matching 'dist' 06:49:43 INFO - no previously-included directories found matching '.git*' 06:49:43 INFO - Successfully installed jsonschema functools32 06:49:43 INFO - Cleaning up... 06:49:43 INFO - Return code: 0 06:49:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:43 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 0x102d10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf294bbc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aeed30>, '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 0x102a15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3be8>, '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.lOW9AmBeCt/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.gsq08cu7mD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:49:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:49:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lOW9AmBeCt/Render', 06:49:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:43 INFO - 'HOME': '/Users/cltbld', 06:49:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:43 INFO - 'LOGNAME': 'cltbld', 06:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:43 INFO - 'MOZ_NO_REMOTE': '1', 06:49:43 INFO - 'NO_EM_RESTART': '1', 06:49:43 INFO - 'PAGER': '/bin/cat', 06:49:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:43 INFO - 'PWD': '/builds/slave/test', 06:49:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:43 INFO - 'SHELL': '/bin/bash', 06:49:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsq08cu7mD/Listeners', 06:49:43 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:49:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:43 INFO - 'USER': 'cltbld', 06:49:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:43 INFO - 'XPC_FLAGS': '0x0', 06:49:43 INFO - 'XPC_SERVICE_NAME': '0', 06:49:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:49:43 INFO - Cleaning up... 06:49:43 INFO - Return code: 0 06:49:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:43 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 0x102d10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf294bbc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aeed30>, '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 0x102a15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3be8>, '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.lOW9AmBeCt/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.gsq08cu7mD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:49:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:49:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lOW9AmBeCt/Render', 06:49:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:43 INFO - 'HOME': '/Users/cltbld', 06:49:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:43 INFO - 'LOGNAME': 'cltbld', 06:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:43 INFO - 'MOZ_NO_REMOTE': '1', 06:49:43 INFO - 'NO_EM_RESTART': '1', 06:49:43 INFO - 'PAGER': '/bin/cat', 06:49:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:43 INFO - 'PWD': '/builds/slave/test', 06:49:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:43 INFO - 'SHELL': '/bin/bash', 06:49:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsq08cu7mD/Listeners', 06:49:43 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:49:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:43 INFO - 'USER': 'cltbld', 06:49:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:43 INFO - 'XPC_FLAGS': '0x0', 06:49:43 INFO - 'XPC_SERVICE_NAME': '0', 06:49:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:44 INFO - Downloading/unpacking blobuploader==1.2.4 06:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:46 INFO - Downloading blobuploader-1.2.4.tar.gz 06:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:49:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:49:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:47 INFO - Downloading docopt-0.6.1.tar.gz 06:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:49:48 INFO - Installing collected packages: blobuploader, requests, docopt 06:49:48 INFO - Running setup.py install for blobuploader 06:49:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:49:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:49:48 INFO - Running setup.py install for requests 06:49:48 INFO - Running setup.py install for docopt 06:49:48 INFO - Successfully installed blobuploader requests docopt 06:49:48 INFO - Cleaning up... 06:49:48 INFO - Return code: 0 06:49:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:48 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 0x102d10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf294bbc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aeed30>, '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 0x102a15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3be8>, '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.lOW9AmBeCt/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.gsq08cu7mD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:49:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:49:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lOW9AmBeCt/Render', 06:49:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:48 INFO - 'HOME': '/Users/cltbld', 06:49:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:48 INFO - 'LOGNAME': 'cltbld', 06:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:48 INFO - 'MOZ_NO_REMOTE': '1', 06:49:48 INFO - 'NO_EM_RESTART': '1', 06:49:48 INFO - 'PAGER': '/bin/cat', 06:49:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:48 INFO - 'PWD': '/builds/slave/test', 06:49:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:48 INFO - 'SHELL': '/bin/bash', 06:49:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsq08cu7mD/Listeners', 06:49:48 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:49:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:48 INFO - 'USER': 'cltbld', 06:49:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:48 INFO - 'XPC_FLAGS': '0x0', 06:49:48 INFO - 'XPC_SERVICE_NAME': '0', 06:49:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:49:49 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-aJBO0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:49:49 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-SdxvFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:49:49 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-qZNfvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:49:49 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-MD77ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:49:49 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Qmk5WD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:49:49 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-6W2YnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:49:49 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-NiHAPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:49:49 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-pI6YzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:49:50 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-ciLwQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:49:50 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-7tyWNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:49:50 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-KiUfaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:49:50 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-6rOSnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:49:50 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-yKGlHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:49:50 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-cL9qOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:50 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-uaP5KV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:49:50 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-fK8im4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:49:50 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-tHwR4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:49:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:49:50 INFO - Running setup.py install for manifestparser 06:49:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:49:51 INFO - Running setup.py install for mozcrash 06:49:51 INFO - Running setup.py install for mozdebug 06:49:51 INFO - Running setup.py install for mozdevice 06:49:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:49:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:49:51 INFO - Running setup.py install for mozfile 06:49:51 INFO - Running setup.py install for mozhttpd 06:49:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:49:51 INFO - Running setup.py install for mozinfo 06:49:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:49:51 INFO - Running setup.py install for mozInstall 06:49:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:49:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:49:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:49:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:49:52 INFO - Running setup.py install for mozleak 06:49:52 INFO - Running setup.py install for mozlog 06:49:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:49:52 INFO - Running setup.py install for moznetwork 06:49:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:49:52 INFO - Running setup.py install for mozprocess 06:49:52 INFO - Running setup.py install for mozprofile 06:49:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:49:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:49:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:49:52 INFO - Running setup.py install for mozrunner 06:49:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:49:53 INFO - Running setup.py install for mozscreenshot 06:49:53 INFO - Running setup.py install for moztest 06:49:53 INFO - Running setup.py install for mozversion 06:49:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:49:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:49:53 INFO - Cleaning up... 06:49:53 INFO - Return code: 0 06:49:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:53 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 0x102d10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf294bbc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aeed30>, '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 0x102a15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3be8>, '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.lOW9AmBeCt/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.gsq08cu7mD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:49:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:49:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lOW9AmBeCt/Render', 06:49:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:53 INFO - 'HOME': '/Users/cltbld', 06:49:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:53 INFO - 'LOGNAME': 'cltbld', 06:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:53 INFO - 'MOZ_NO_REMOTE': '1', 06:49:53 INFO - 'NO_EM_RESTART': '1', 06:49:53 INFO - 'PAGER': '/bin/cat', 06:49:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:53 INFO - 'PWD': '/builds/slave/test', 06:49:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:53 INFO - 'SHELL': '/bin/bash', 06:49:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsq08cu7mD/Listeners', 06:49:53 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:49:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:53 INFO - 'USER': 'cltbld', 06:49:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:53 INFO - 'XPC_FLAGS': '0x0', 06:49:53 INFO - 'XPC_SERVICE_NAME': '0', 06:49:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:49:53 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-kW1LfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:49:53 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-qeWN_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:49:54 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)) 06:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:49:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-U5htuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:49:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-HdNteB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:49:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-n3xeNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:49:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-DHLoOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:49:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-tviK2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:49:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-RgN9Qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:49:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-1AuBLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:49:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-_cMWg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:49:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-HfMBzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:49:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Y5v0wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:49:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-aBzCrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:49:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-hPQ3b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:49:55 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)) 06:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-NWp15z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:49:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-nT3UqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:49:55 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)) 06:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:49:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Kn0oK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:49:55 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)) 06:49:55 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)) 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:49:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:58 INFO - Downloading blessings-1.6.tar.gz 06:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:49:58 INFO - Installing collected packages: blessings 06:49:58 INFO - Running setup.py install for blessings 06:49:58 INFO - Successfully installed blessings 06:49:58 INFO - Cleaning up... 06:49:58 INFO - Return code: 0 06:49:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:49:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:49:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:49:58 INFO - Reading from file tmpfile_stdout 06:49:58 INFO - Current package versions: 06:49:58 INFO - blessings == 1.6 06:49:58 INFO - blobuploader == 1.2.4 06:49:58 INFO - docopt == 0.6.1 06:49:58 INFO - functools32 == 3.2.3-2 06:49:58 INFO - jsonschema == 2.5.1 06:49:58 INFO - manifestparser == 1.1 06:49:58 INFO - mozInstall == 1.12 06:49:58 INFO - mozcrash == 1.0 06:49:58 INFO - mozdebug == 0.1 06:49:58 INFO - mozdevice == 0.49 06:49:58 INFO - mozfile == 1.2 06:49:58 INFO - mozhttpd == 0.7 06:49:58 INFO - mozinfo == 0.9 06:49:58 INFO - mozleak == 0.1 06:49:58 INFO - mozlog == 3.4 06:49:58 INFO - moznetwork == 0.27 06:49:58 INFO - mozprocess == 0.24 06:49:58 INFO - mozprofile == 0.28 06:49:58 INFO - mozrunner == 6.13 06:49:58 INFO - mozscreenshot == 0.1 06:49:58 INFO - mozsystemmonitor == 0.3 06:49:58 INFO - moztest == 0.8 06:49:58 INFO - mozversion == 1.4 06:49:58 INFO - psutil == 3.1.1 06:49:58 INFO - requests == 1.2.3 06:49:58 INFO - wsgiref == 0.1.2 06:49:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:58 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 0x102d10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf294bbc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aeed30>, '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 0x102a15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3be8>, '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.lOW9AmBeCt/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.gsq08cu7mD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:49:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:49:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:49:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lOW9AmBeCt/Render', 06:49:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:58 INFO - 'HOME': '/Users/cltbld', 06:49:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:58 INFO - 'LOGNAME': 'cltbld', 06:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:58 INFO - 'MOZ_NO_REMOTE': '1', 06:49:58 INFO - 'NO_EM_RESTART': '1', 06:49:58 INFO - 'PAGER': '/bin/cat', 06:49:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:58 INFO - 'PWD': '/builds/slave/test', 06:49:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:58 INFO - 'SHELL': '/bin/bash', 06:49:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsq08cu7mD/Listeners', 06:49:58 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:49:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:58 INFO - 'USER': 'cltbld', 06:49:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:58 INFO - 'XPC_FLAGS': '0x0', 06:49:58 INFO - 'XPC_SERVICE_NAME': '0', 06:49:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:49:59 INFO - Cleaning up... 06:49:59 INFO - Return code: 0 06:49:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:59 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 0x102d10b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d13768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf294bbc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aeed30>, '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 0x102a15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3be8>, '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.lOW9AmBeCt/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.gsq08cu7mD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:49:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:49:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lOW9AmBeCt/Render', 06:49:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:59 INFO - 'HOME': '/Users/cltbld', 06:49:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:59 INFO - 'LOGNAME': 'cltbld', 06:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:59 INFO - 'MOZ_NO_REMOTE': '1', 06:49:59 INFO - 'NO_EM_RESTART': '1', 06:49:59 INFO - 'PAGER': '/bin/cat', 06:49:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:59 INFO - 'PWD': '/builds/slave/test', 06:49:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:59 INFO - 'SHELL': '/bin/bash', 06:49:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsq08cu7mD/Listeners', 06:49:59 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:49:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:59 INFO - 'USER': 'cltbld', 06:49:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:59 INFO - 'XPC_FLAGS': '0x0', 06:49:59 INFO - 'XPC_SERVICE_NAME': '0', 06:49:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:49:59 INFO - Cleaning up... 06:49:59 INFO - Return code: 0 06:49:59 INFO - Running post-action listener: _resource_record_post_action 06:49:59 INFO - Running post-action listener: _start_resource_monitoring 06:49:59 INFO - Starting resource monitoring. 06:49:59 INFO - [mozharness: 2017-02-28 14:49:59.460459Z] Finished create-virtualenv step (success) 06:49:59 INFO - [mozharness: 2017-02-28 14:49:59.461507Z] Running install step. 06:49:59 INFO - Running pre-action listener: _resource_record_pre_action 06:49:59 INFO - Running main action method: install 06:49:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:49:59 INFO - Reading from file tmpfile_stdout 06:49:59 INFO - Detecting whether we're running mozinstall >=1.0... 06:49:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:49:59 INFO - Reading from file tmpfile_stdout 06:49:59 INFO - Output received: 06:49:59 INFO - Usage: mozinstall [options] installer 06:49:59 INFO - Options: 06:49:59 INFO - -h, --help show this help message and exit 06:49:59 INFO - -d DEST, --destination=DEST 06:49:59 INFO - Directory to install application into. [default: 06:49:59 INFO - "/builds/slave/test"] 06:49:59 INFO - --app=APP Application being installed. [default: firefox] 06:49:59 INFO - mkdir: /builds/slave/test/build/application 06:49:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 06:50:19 INFO - Reading from file tmpfile_stdout 06:50:19 INFO - Output received: 06:50:19 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:50:19 INFO - Running post-action listener: _resource_record_post_action 06:50:19 INFO - [mozharness: 2017-02-28 14:50:19.799442Z] Finished install step (success) 06:50:19 INFO - [mozharness: 2017-02-28 14:50:19.799554Z] Running run-tests step. 06:50:19 INFO - Running pre-action listener: _resource_record_pre_action 06:50:19 INFO - Running main action method: run_tests 06:50:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:50:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:50:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:50:19 INFO - 2017-02-28 06:50:19.814 screenresolution[1632:8262] starting screenresolution argv=screenresolution get 06:50:19 INFO - 2017-02-28 06:50:19.816 screenresolution[1632:8262] Display 0: 1600x1200x32@60 06:50:19 INFO - 2017-02-28 06:50:19.822 screenresolution[1633:8265] starting screenresolution argv=screenresolution list 06:50:19 INFO - Available Modes on Display 0 06:50:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:50:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:50:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:50:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:50:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:50:20 INFO - Intel Iris: 06:50:20 INFO - Chipset Model: Intel Iris 06:50:20 INFO - Type: GPU 06:50:20 INFO - Bus: Built-In 06:50:20 INFO - VRAM (Dynamic, Max): 1536 MB 06:50:20 INFO - Vendor: Intel (0x8086) 06:50:20 INFO - Device ID: 0x0a2e 06:50:20 INFO - Revision ID: 0x0009 06:50:20 INFO - Displays: 06:50:20 INFO - Display: 06:50:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:50:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:50:20 INFO - Display Serial Number: 1600x1200 60 06:50:20 INFO - Main Display: Yes 06:50:20 INFO - Mirror: Off 06:50:20 INFO - Online: Yes 06:50:20 INFO - Rotation: Supported 06:50:20 INFO - Return code: 0 06:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:50:20 INFO - Python 2.7.3 06:50:20 INFO - Return code: 0 06:50:20 INFO - grabbing minidump binary from tooltool 06:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:20 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 0x102aeed30>, '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 0x102a15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:50:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:50:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:50:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:50:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:50:20 INFO - Return code: 0 06:50:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:50:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:50:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:50:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:50:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0077 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:50:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lOW9AmBeCt/Render', 06:50:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:20 INFO - 'HOME': '/Users/cltbld', 06:50:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:20 INFO - 'LOGNAME': 'cltbld', 06:50:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:50:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:20 INFO - 'MOZ_NO_REMOTE': '1', 06:50:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:50:20 INFO - 'NO_EM_RESTART': '1', 06:50:20 INFO - 'PAGER': '/bin/cat', 06:50:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:20 INFO - 'PWD': '/builds/slave/test', 06:50:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:50:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:20 INFO - 'SHELL': '/bin/bash', 06:50:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gsq08cu7mD/Listeners', 06:50:20 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:50:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:20 INFO - 'USER': 'cltbld', 06:50:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:20 INFO - 'XPC_FLAGS': '0x0', 06:50:20 INFO - 'XPC_SERVICE_NAME': '0', 06:50:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:50:20 INFO - mozversion application_buildid: 20170228061236 06:50:20 INFO - mozversion application_changeset: c269adcb4e01ae92e215efe6232a5ab28a9c3949 06:50:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:50:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:50:20 INFO - mozversion application_name: Firefox 06:50:20 INFO - mozversion application_remotingname: firefox-dev 06:50:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:50:20 INFO - mozversion application_vendor: Mozilla 06:50:20 INFO - mozversion application_version: 53.0a2 06:50:20 INFO - mozversion platform_buildid: 20170228061236 06:50:20 INFO - mozversion platform_changeset: c269adcb4e01ae92e215efe6232a5ab28a9c3949 06:50:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:50:20 INFO - mozversion platform_version: 53.0a2 06:50:20 INFO - using testdate: 1488293420 06:50:20 INFO - actual date: 1488293420 06:50:20 INFO - starting webserver on 'localhost:49249' 06:50:20 INFO - SUITE-START | Running 2 tests 06:50:20 INFO - TEST-START | dromaeo_css 06:50:20 INFO - operating with platform_type : mac_ 06:50:20 INFO - Initialising browser for dromaeo_css test... 06:50:20 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpunEygt/profile http://localhost:49249/getInfo.html) 06:50:22 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 06:50:22 INFO - PROCESS | 1643 | colorDepth:24 06:50:22 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 06:50:22 INFO - PROCESS | 1643 | __metrics 06:50:22 INFO - PROCESS | 1643 | 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" 06:50:22 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:50:23 INFO - TEST-INFO | 1643: exit 0 06:50:23 INFO - Browser initialized. 06:50:23 INFO - Running cycle 1/1 for dromaeo_css test... 06:50:23 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpunEygt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:50:35 INFO - PROCESS | 1647 | RSS: Main: 212824064 06:50:35 INFO - PROCESS | 1647 | 06:53:38 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 06:53:40 INFO - PROCESS | 1647 | RSS: Main: 404684800 06:53:40 INFO - PROCESS | 1647 | 06:55:25 INFO - PROCESS | 1647 | ************************* 06:55:25 INFO - PROCESS | 1647 | A coding exception was thrown and uncaught in a Task. 06:55:25 INFO - PROCESS | 1647 | 06:55:25 ERROR - PROCESS | 1647 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:55:25 INFO - PROCESS | 1647 | Full stack: 06:55:25 INFO - PROCESS | 1647 | ************************* 06:56:43 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 06:56:44 INFO - PROCESS | 1647 | RSS: Main: 354521088 06:56:44 INFO - PROCESS | 1647 | 06:59:46 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 06:59:46 INFO - PROCESS | 1647 | RSS: Main: 319946752 06:59:46 INFO - PROCESS | 1647 | 07:02:49 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 07:02:50 INFO - PROCESS | 1647 | RSS: Main: 333471744 07:02:50 INFO - PROCESS | 1647 | 07:05:53 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 07:05:54 INFO - PROCESS | 1647 | RSS: Main: 307884032 07:05:54 INFO - PROCESS | 1647 | 07:08:57 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 07:08:57 INFO - PROCESS | 1647 | RSS: Main: 400236544 07:08:57 INFO - PROCESS | 1647 | 07:08:57 INFO - PROCESS | 1647 | __start_tp_report 07:08:57 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 07:08:57 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 07:08:57 INFO - PROCESS | 1647 | |i|pagename|runs| 07:08:57 INFO - PROCESS | 1647 | |0;dojo.html;2930.3992681500295;2974.925626859328;3342.4484959981596;3366.309906469174;3408;5694.715264236787;5717;5717.799877004306;5747.1379293106;5768.134779783035;5647.418722757634;5655.4910058094765;5766.509846663039;5788.42115788421;5791.565632577553;5226;5250.868728281795;5269.6311258211945;5273.209018647214;5333.546648534879;5190.92213616796;5197.376314842205;5214.843554693365;5221.2951251580935;5325.094733895227;5269.473052694738;5310.787568497275;5336.199570064483;5341.893162136755;5361.329833770778;5327.440618735016;5328.040952628526;5330.147176451768;5331.173668081454;5379.031774280628;3879.9612003879884;5043.319151914481;5165.535101840815;5228.529432351107;5232.241325007891;4685.601723853442;5690.857728556778;5783.5951483396175;5798.246227990334;5816.418358164192;6287.783563775628;6302.4958003359625;6330.68346582669;6333.271673757531;6335.68321583919;6248.531360147962;6347.238331400215;6348.873022539569;6366.204224471941;6388.840278993016;5714.771409143671;5726.770929162829;5780.393058728773;5813.7383817728305;5836.503897168704;6353.904691429632;6357.618542887441;6361.395667411589;6372.1716176897635;6373.362663733589;6233.1273621693;6246.000639897595;6252.624842509373;6256.092866534327;6256.124142620037;6155.230596175478;6231.3145553989025;6237.719302631393;6264.624122552661;6293.779717709858;6265.185525881606;6320.020396838498;6326.841828954221;6339.207599050119;6346.4605508532295;5307.575393968474;5364.506902126601;6151.569390142647;6326.082718005863;6337.017762246859;4857.392825896763;4954.851354459372;4961.975190124099;5000.1249781288125;5007.37407824022;4424.247877860771;4474.798634061475;4481.932771008437;4523.2988886722615;4529.411176547028;5783.103618938987;5826.82519524415;5832.154337621021;5832.62087964281;5870.941290587125;6199.907001394983;6228.875422491525;6256.906146407808;6273.059041143773;6340;5831.737571809279;5850.063989761703;5860.208871802252;5877.030290002187;5879.794207202813;5507.421720719267;5511.476409741068;5517.779288828402;5519.448055194529;5529.253550770675;6240.4071613196675;6382.393672601095;6405.103285540028;6417.486601071903;6428.517861160338;5299.6290259681455;6293.339199383999;6316.178896743394;6317.178766760292;6354.936450635434;6444.420002199825;6445.516586255956;6446.903296450463;6460.935390646034;6463.612183269019;6113.266408031065;6231.9688401557705;6268.2478102626155;6273.686315684106;6291.622502649856;6229.719662615284;6263.091851681572;6295.842603934938;6321.273053598895;6565;6219.533534984985;6230.657313847782;6230.875382492415;6234.625922444668;6235.532335074797;6151.108089326933;6189.535784816067;6201.914664933709;6203.069539569101;6211.689415529296;4351.846760608378;5479.726013699219;5666.631668941505;5725.971370143123;5728.627639203439;4864.92702609454;5921.4966727826895;5921.881562368642;6106.297775755845;6125.601746185282;5973.253343332083;5978.551608629457;5991.64050156992;5993.3706960768495;6015.819525414245 07:08:57 INFO - PROCESS | 1647 | |1;ext.html;450.72505771479405;451.72219085262554;504.21594420675837;529.2326127115681;532.651113520644;38245;39931.60068399315;40136.79931600338;40202.19595608086;42637.786811065904;41647;42024.739257822235;42146.94632634186;42165.7891710541;42387.364189537104;8181.3863960202925;9184.816303673939;9370.390924589914;9377.812443751121;9392.671256506024;8200.138985406536;11083.50124244411;11313.773724525505;11338.206325557214;11545;11274.830877536844;11343.489542970587;11366.829497557543;11387.658370248864;11418.885811141907;8146.592670366517;11248.38133902635;11303.604373846958;11325.943370283178;11357.920997505224;8240.340772738167;11011.28426652265;11244.831327530093;11256.38089905055;11450.713732156679;39870.80064599658;39959;40043.399349009786;40101.796946091665;40117;3896.201278737852;3934.3705007198996;3965.781881996489;3977.085270387827;3979.7612143271494;28912.277193070342;28917.56623650647;28936.27659308513;29881;30059.248518786986;3081.6147981502313;3228.499582564706;3239.7894136881264;3300.4389253826907;3337.916552086193;464586;465838.9999999966;466062;466107;466704;62778.233306001785;63194.684026579576;63277.36722632807;63323;63457.413564661256;65833;66079.33920660827;66273;66290;66297.66851165713;16290.837091628931;16527.669446611002;16529.256183471774;16538.669226615642;16554.83445165557;11373.94313028446;11700.06399488039;12695.174813637084;12779.424925878171;12790.488380464678;15261.771073433907;17729.748328300604;21291;21583.92080395974;21644.783552164277;7011.92988070123;7245.673944672502;8517.105703901125;8553.187447192508;8577.82844343122;868.1362044765373;873.8470767615769;881.9382643215042;900.9864852027225;919.2094798473307;29934.55098173529;30040.69959300423;30050.398992020037;30569;30571.694283056884;1019.9031092046243;1028.1466382902322;1034.6275340877428;1057.0856209378985;1064.1646307648614;13971.79042314366;14102;14350.641233969234;14374.640633984234;14375.856241437661;657219;660246;661714.6914265398;663760.6811965909;664698;50930.726731832;51679;51695.741521292905;51765.48234517607;51979.48020519822;1388.9861101388856;1410.22437659287;1431.0626539616567;1432.8925330600039;1436.2531483628663;26703.19890403291;26859.731402685724;26887;27360.042398515958;27410.258974103228;45640.31539526976;45996.310055349866;46001.30998034965;46060.76969615131;46294.76852615715;604549;606969;607201;608358;609044;25172.118975835758;25303;25850.35374115662;32332.736708430184;33101.84143554964;35359;35562;41457.79271103625;42701.78649106859;43340.78329608332;31391.7216556685;33669.66330336763;35315.470267945486;36699.44950825793;36724;35063.64936350604;35078.47382289216;35782.8210858944;36020.4596931041;36275.63724362723;34519.827400862836;34747.826260869544;34750.47874281938;35377.29245415026;35498.75754348585;29623.555646665747;31506.369872602878;31526.684733152375;31683.20791980219;31713.682863171074;22521.774782251967;23281.534369312856;23480;23805.404864878517;23849.52300954006 07:08:57 INFO - PROCESS | 1647 | |2;jquery.html;382.9540455145381;388.73371740357874;390.0794125862963;394.9229900169467;416.0576294692522;13097.73804523909;19879.204831806728;20624.587508249864;21102.15591376345;21128.366149015517;17236.224369903353;20937.267195648154;21006.89496552519;21108.0501377438;21213.893930530325;4852.927206091911;5086.059079070365;5154.587632989352;5188.9881473112755;5197.610179236553;5140.920406714576;5196.870078248036;5197.142471492218;5197.558207552343;5229.581633469314;5732.111522713986;5750.597458177929;5772.682502462363;5782.566307526931;5783.2481777368885;5146.408163061221;5240.213967904807;5753.252077229954;5764.596478246524;5772.942270577282;5110.386753589556;5110.412302585213;5111.948880511184;5113.437521872591;5113.539781419653;12677.556285530054;12832.422540985677;22210.444738881495;25662;26674.732647724966;2441.963370549443;2866.7276608722136;2913.0678182981455;2919.92700182495;2961.3781105967555;9387.389819661768;9819.705408837746;10159.746006349826;10202.846957295647;10227.130693891027;1681.495551334607;1765.5409593505653;1787.6960916644202;1819.3177558415593;1842.075145918025;125678;126642;127756;131982;132760;10276.537555810006;11633.825492617618;11726.237794543327;11760.294382337088;11779.175457717878;13846.861531384759;14332.49836255726;15324.846751532565;15335.846641533664;15767.842321576638;6789.422899053636;8441.07148213696;8610.354223433142;8852.778680533038;8974.19232269099;8119.350451963829;8282.088970213272;8586.356023298153;8618.353623478264;8745.300375969908;4309.1381723655395;4743.691660042086;4751.144793937125;4823.879403014953;4835.516448355207;2000.789917058688;2010.7788143304224;2024.4533975826444;2024.908879100444;2025.463252238158;359.5559484037212;363.2879556070079;366.84959166742044;844.5186243840951;890.5903284489208;11333.603323883624;11450;11538.711532211762;11818.290902545703;11958.103142264192;383.44783511743003;401.2636811450962;401.33378591537905;401.44800898764197;404.6277424769219;5759.1937128802;5766.94233057664;5815.621984570989;5940.227770389908;6002.789902353396;756530;759876;771342;779568;779657;157123;157831;161399;164519;169853.60292794075;418.4204876246421;425.9041715614024;427.0860358832102;427.09882148666907;427.2096621250723;8993.785838911663;9176.724698259062;10004.24968127408;10507.842382364117;10685.946570267099;57250.56873578194;58351;58983.70508147432;60150.699246503485;60918.69540652446;81494;84176.57911710402;84197;87696;88404;7923.524588524707;8087.555184464911;8104;8289.709860154866;8313.750587482386;10878.673639790819;11316.49075791575;12351.320677362832;13057.477700891857;13203.537876174289;9300.627974880928;9630.085141911508;10397.376157430579;11119.83320250213;11228.494717737558;9867.901320986986;11225.270357426742;11429;11476.483558240066;11892.940535297268;11582.6525204244;11782.882171178178;12030.338331391857;12079.094067944763;12081.395930203278;7248.673809678683;8179.263866252066;8297.419180657296;8374.790630234293;8601.967763868375;11127.499262533043;11290.137586084924;11685.532578697097;11700.47347869365;11744.060475162138 07:08:57 INFO - PROCESS | 1647 | |3;mootools.html;1405.2762827144022;1417.518043865086;1428.971420571588;1429.9928500357503;1433.5054406229854;8083.474574152676;8501.787455313612;8508.936382952132;8513.702020429286;8513.744587662364;7432.851342973137;7705.15243323234;7720.112187098485;7992.680292788296;8220.588970551464;2251.808596269319;2287.611106111965;2288.141946769961;2289.725232972046;2290.725112986444;2283.0981762204;2310.4570425949887;2314.4445333120016;2318.710161229846;2325.5581439526436;2005.2981456490259;2086.4158035750015;2208.282308249817;2249.0553967333676;2290.4273931517123;2116.640171170897;2125.4261349435565;2125.606762748881;2126.5321629241544;2133.7332833395826;2066.245820275604;2166.1118941234176;2270.1373478078226;2273.3861857298602;2291.598970180212;7157.320054594805;8476.872846907301;8478.279346255576;8482.66069357225;8496.78758031048;3917.843286268546;4986.803167239873;5013.623978201649;5072.112380333464;5171.276021356975;3284.458064419368;3412.095794614429;3417.5215469834243;3434.5019972104155;3445.3970555152746;1158.5887010111373;1223.7613665335264;1253.9776309453487;1259.8929091027182;1270.0821759143666;10931.813637272577;11039.724006899893;11055.11559075272;11093.83359249612;11098.611548595842;4444.422225110715;4515.548445155524;4625.283081122431;4635.605973492224;4681.765911704401;9579.185769209556;9582.425054496753;9584.568694408768;9599.280053995979;9625.903740962502;5233.816816411408;5234.712090835041;5235.214717792362;5238.397584277781;5240.240165176028;4207.537170911197;4332.978335108367;4400.889977750518;4668.136394766979;4711.882202944954;3840.8847734568008;3850.5186851643543;3963.1875465529497;3969.364901615728;4009.1179940413062;1271.7202215512573;1294.9482020719254;1296.7536168128026;1306.9542566010143;1308.5158491358259;759.4190444310108;777.766669998998;790.2650535002388;794.6781553470854;806.7176488229073;5473.644213126134;5490.533304669068;5653.378128405872;5690.77236910519;5715.971420142872;534.7807398966405;539.2854467830063;549.3023859698161;552.2903069555601;560.1094260126418;3680.9631903681156;3720.6093360197333;3760.6615404613167;3792.6776224020714;3796.867109651149;9285.07149285066;9970.900290997142;10025.598976040877;10099.798004040025;10107.343022703648;9953.950230248947;9958.751031224278;10049.397036177852;10058.849117263248;10092.44491552957;7725.575093369806;7872.33085187754;7887.645055972495;7887.9605601971625;7888.526688398714;5341.7062061586985;5418.295621569171;5463.125899856004;5502.449755024626;5560;9065.864012039956;9088.818223635622;9269.953650231706;9273;9378.343515954091;9200.35597508168;9313.906860931304;9319.254459643076;9328.39365441244;9437.81124377495;6590.340965903371;6777.525573209828;7164.104486939133;7256.129264488295;7268.345848873627;7714.537127772352;7882.881756773539;7953.0456345238945;8063.395245356739;8068.07217170033;7035.648217589202;7096.929030709627;7153.678084486315;7205.7838264852135;7264.309890560388;5977.372375900468;7028.964855175692;7075.257098004636;7089;7121.608311542915;6286.874262514815;6416.967915160394;6475.935240647722;6487.124238227779;6493.545451818327;4837.105135549935;4936.2102063669645;5002.724850133278;5007.5993920487;5057.241413787814;3948.0722030322277;4335.569262143422;4725.432948046119;4921.384826896638;5223.112070947872 07:08:57 INFO - PROCESS | 1647 | |4;prototype.html;312.28486765307434;327.14941153002184;328.371169210961;335.1520652748547;339.17749457565395;4716.834910778123;5325.20121981703;5381.865453363668;5386.5152136307825;5465.617406781527;4432.490263619685;5003.724795136266;5012.045302332084;5081.872953176173;5212.853172302097;3811.5997820228895;4115.855945041924;4118.094019315746;4131.876043718693;4150.792460376984;4109.157622687357;4117.258893399187;4148.481439820022;4157.08544120293;4184.895377615553;3558.3061303045915;3858.4405261237102;3975.82108805103;4093.9385909211387;4108.096218831853;4057.2494088593703;4058.9852536865783;4059.573744756802;4084.346504559286;4085.6527195188446;3018.109657650998;3565.447355659877;3576.2847430514003;3584.6594573515476;3619.49327094207;4986.800527978877;5081.949180508184;5088.465711100318;5096.541311282002;5203.661761985459;4685.367475390813;4727.22000869856;4749.501302363236;4749.715017098951;4766.952330476685;5380.569554435675;5510.669359838423;5588.066265210756;5648.6275764179145;5668.631538949996;3365.636917048599;3861.0540417597867;3891.073710487454;3977.642012218885;3991.5808840071663;5698.601097923189;5714.1428785682065;5774.7112644368035;5793.551612096976;5834.424705329538;3539.610642829287;4026.4564283821896;4039.6566291864933;4073.1853629274265;4081.5918408158946;3502.423909240852;3826.4642949987024;4099.959000409957;4135.338345864648;4151;3681.2453447043827;4089.754614723126;4181.825450765585;4454.37638730578;4517.706349087299;5306.363236411656;5608.439156084441;5631.352394474688;5683.829485115453;5696.3449203341315;1096.3915027160003;1223.3088305107585;1244.4337826289018;1252.931088790107;1254.85569159546;705.6648092156288;730.4915349802641;798.700487317256;806;807.8545861744942;4738.857834264978;4918.680285781485;4938.555530002317;5014.674046186986;5054.898902021939;4936.8645211600815;5067.113255180328;5339.599530035263;5488.313960754906;5513.283273174542;4127.5963515787125;4423.336499525032;4776.331313616097;4953.678010929278;5026.547610715053;2309.711286089239;2439.487707581428;2591.4298854252033;2659.260961209957;2698.865056747194;5216.365735303647;5582.553395728332;5662.37713851476;5707.401927460318;5773.249477567973;5230.764615592308;5274.868128296824;5518.696471694015;5612.35457922336;5680.289963754531;4503.369528266046;4988.700677959261;5617.297837770278;5714.65699063382;5737;4898.657094003385;5107.577922791813;5130.51260130287;5291.074062039204;5321.920171197513;5026.874328141826;5027.773750181177;5049.8737531562;5326.520613144836;5359.740460991586;5288.894222115459;5564.271937801602;5614.41048689898;5719.771209151588;5801.6519008859605;3480.8433620487644;3554.111472131967;3559.7864128152396;3561.7506774525536;3602.1715005548344;5665.3201615806365;5708.257926469532;5710.971445142914;5712.828615141552;5716.371199168005;5403.081476149143;5521.5306698931045;5522.889542209214;5536.91694624589;5546.417626149197;4612.654050946259;5252.737363131904;5579.330480342385;5587.413321601173;5613.158026295925;4840.636952228668;4854.95145048545;5444.972775136099;5500.58745594074;5515.420880807457;4777.0684716479955;5221.242919776687;5446.346438427414;5460.34475862899;5624.831255062355;5499.725013749377;5514.420985796594;5514.698535142596;5519.751611177587;5538.6399884007415 07:08:57 INFO - PROCESS | 1647 | |5;yui.html;695.3602685529313;712.9911175686401;768.1013214538989;804.7545498622922;819.6516480495787;14419.423223071077;15411.07533547988;15435.768463473043;15445.92277038616;15464.226788660564;14057.297135143228;14088.64778380541;14094.224817635026;14238.28808559573;14251.50119745809;661.2726001398447;688.7727050073489;842.4103127810527;861.8405594964952;868.1405408645427;685.4071228387459;686.289690170671;688.490517017406;689.2280645676849;805.6575955219038;902.7743064233941;903.530164314556;908.6501696846695;912.4297314178639;913.1005959130251;905.7011186308503;911.5761171055458;911.6307895302413;911.6307895302447;912.2747415804386;675.6621689155422;675.7364627795164;676.5027704637088;676.7496026470188;677.7255211639294;10623.521941512574;12256.571020014346;14441.422343106264;14911.850881491155;15177.937544371787;11452.71368215793;13908;14087.36606852694;14268.500602478967;14278.571642850628;10814.188935829845;11293.774124517546;11326.43367831605;11509.827352589718;11528.711782205512;3577.3560759063357;3628.51015112959;3723;3727.347714150013;3809.561900381464;94746.52626736891;101038;103266.48366758118;104447.95552044458;107166.46416767944;10423.635172768916;10811.35131892089;10815.675529733962;10843.295185812896;10862.239643224899;21911.12355505762;22330.553388932454;22367.66448503274;22404.99177536982;22412.103515859508;7288.217697674289;7454.552726836408;7517.361024312994;7529.284717951786;7729.265719756614;4089.9795501022304;4155.729877558009;4161.334186530141;4178.603032711888;4222.21888950539;3339.2653616204398;3411.9658803412144;3428.879989200366;3436.7078798302423;3449.3618680544178;629.2134831460675;633.6958260035209;637.2321352769901;640.4076229487705;642.6561789442626;627.7802769030802;634.4638780230698;641.5284765697209;661.5501459007825;669.6919417068203;8787.165219304155;9452.810943781085;9481.952590237004;9592.616295348247;9634;574.4772257245886;627.4056775234438;671.2347923367365;672.3411057163909;678.1049015299856;4000.739951903175;4800.975995120002;4887.511248875084;4952.108620448282;4964;79281.20718792854;80919.97700057545;101324.98675013303;103010;105140;73539.63230183815;75507;88676.11323886807;92047.53976230076;94838.10323793486;68319.65840170767;69432.95850562246;70849.58300834057;71840.92238616425;72349.2765072353;9450.291228157777;10519.631812886511;10652.73368165771;10739;10781.784364312827;45345.54654453413;45817.312740308254;46582.835429114544;48507.757461212466;50227.74886125546;59516.10725839029;61528.69235653793;62142.68928655328;66243.00635490374;66539.66730166318;12592.559260425842;12685.23888566689;13046.478140874258;13084.738305233652;13433.19400835953;14163.433462661378;14405.92797036008;14470.348834302693;14541.200233987232;14652.19412932299;11807.881921181022;13103.541376052173;13198.406071726988;13500.729985400434;13612.659683507596;12881.291528965998;13392.2634255113;13470.932645337103;13536.796948045983;13995.300234988414;12712.809307860205;12854.228746275254;13004.674883127618;13210.009249306147;13237.338133093499;10764.892351076702;11228.326300422;11286.153538484483;11447.828282575934;11662.53349865996;10000.499975001367;10947.124230061736;10991.61529346501;11327.546898123983;11361.829572556253 07:08:57 INFO - PROCESS | 1647 | __end_tp_report 07:08:57 INFO - PROCESS | 1647 | __start_cc_report 07:08:57 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2194 07:08:57 INFO - PROCESS | 1647 | __end_cc_report 07:08:57 INFO - PROCESS | 1647 | __startTimestamp1488294537669__endTimestamp 07:08:57 INFO - PROCESS | 1647 | 07:08:57 INFO - PROCESS | 1647 | ------- Summary: start ------- 07:08:57 INFO - PROCESS | 1647 | Number of tests: 6 07:08:57 INFO - PROCESS | 1647 | 07:08:57 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5751.63 Median:5877.03 stddev:701.83 (11.9%) stddev-sans-first:668.17 07:08:57 INFO - PROCESS | 1647 | Values: 2930.4 2974.9 3342.4 3366.3 3408.0 5694.7 5717.0 5717.8 5747.1 5768.1 5647.4 5655.5 5766.5 5788.4 5791.6 5226.0 5250.9 5269.6 5273.2 5333.5 5190.9 5197.4 5214.8 5221.3 5325.1 5269.5 5310.8 5336.2 5341.9 5361.3 5327.4 5328.0 5330.1 5331.2 5379.0 3880.0 5043.3 5165.5 5228.5 5232.2 4685.6 5690.9 5783.6 5798.2 5816.4 6287.8 6302.5 6330.7 6333.3 6335.7 6248.5 6347.2 6348.9 6366.2 6388.8 5714.8 5726.8 5780.4 5813.7 5836.5 6353.9 6357.6 6361.4 6372.2 6373.4 6233.1 6246.0 6252.6 6256.1 6256.1 6155.2 6231.3 6237.7 6264.6 6293.8 6265.2 6320.0 6326.8 6339.2 6346.5 5307.6 5364.5 6151.6 6326.1 6337.0 4857.4 4954.9 4962.0 5000.1 5007.4 4424.2 4474.8 4481.9 4523.3 4529.4 5783.1 5826.8 5832.2 5832.6 5870.9 6199.9 6228.9 6256.9 6273.1 6340.0 5831.7 5850.1 5860.2 5877.0 5879.8 5507.4 5511.5 5517.8 5519.4 5529.3 6240.4 6382.4 6405.1 6417.5 6428.5 5299.6 6293.3 6316.2 6317.2 6354.9 6444.4 6445.5 6446.9 6460.9 6463.6 6113.3 6232.0 6268.2 6273.7 6291.6 6229.7 6263.1 6295.8 6321.3 6565.0 6219.5 6230.7 6230.9 6234.6 6235.5 6151.1 6189.5 6201.9 6203.1 6211.7 4351.8 5479.7 5666.6 5726.0 5728.6 4864.9 5921.5 5921.9 6106.3 6125.6 5973.3 5978.6 5991.6 5993.4 6015.8 07:08:57 INFO - PROCESS | 1647 | 07:08:57 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:70347.77 Median:35368.15 stddev:156352.09 (442.1%) stddev-sans-first:156702.62 07:08:57 INFO - PROCESS | 1647 | Values: 450.7 451.7 504.2 529.2 532.7 38245.0 39931.6 40136.8 40202.2 42637.8 41647.0 42024.7 42146.9 42165.8 42387.4 8181.4 9184.8 9370.4 9377.8 9392.7 8200.1 11083.5 11313.8 11338.2 11545.0 11274.8 11343.5 11366.8 11387.7 11418.9 8146.6 11248.4 11303.6 11325.9 11357.9 8240.3 11011.3 11244.8 11256.4 11450.7 39870.8 39959.0 40043.4 40101.8 40117.0 3896.2 3934.4 3965.8 3977.1 3979.8 28912.3 28917.6 28936.3 29881.0 30059.2 3081.6 3228.5 3239.8 3300.4 3337.9 464586.0 465839.0 466062.0 466107.0 466704.0 62778.2 63194.7 63277.4 63323.0 63457.4 65833.0 66079.3 66273.0 66290.0 66297.7 16290.8 16527.7 16529.3 16538.7 16554.8 11373.9 11700.1 12695.2 12779.4 12790.5 15261.8 17729.7 21291.0 21583.9 21644.8 7011.9 7245.7 8517.1 8553.2 8577.8 868.1 873.8 881.9 901.0 919.2 29934.6 30040.7 30050.4 30569.0 30571.7 1019.9 1028.1 1034.6 1057.1 1064.2 13971.8 14102.0 14350.6 14374.6 14375.9 657219.0 660246.0 661714.7 663760.7 664698.0 50930.7 51679.0 51695.7 51765.5 51979.5 1389.0 1410.2 1431.1 1432.9 1436.3 26703.2 26859.7 26887.0 27360.0 27410.3 45640.3 45996.3 46001.3 46060.8 46294.8 604549.0 606969.0 607201.0 608358.0 609044.0 25172.1 25303.0 25850.4 32332.7 33101.8 35359.0 35562.0 41457.8 42701.8 43340.8 31391.7 33669.7 35315.5 36699.4 36724.0 35063.6 35078.5 35782.8 36020.5 36275.6 34519.8 34747.8 34750.5 35377.3 35498.8 29623.6 31506.4 31526.7 31683.2 31713.7 22521.8 23281.5 23480.0 23805.4 23849.5 07:08:57 INFO - PROCESS | 1647 | 07:08:57 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:40498.60 Median:398.09 stddev:128353.78 (32242.1%) stddev-sans-first:128678.50 07:08:57 INFO - PROCESS | 1647 | Values: 383.0 388.7 390.1 394.9 416.1 13097.7 19879.2 20624.6 21102.2 21128.4 17236.2 20937.3 21006.9 21108.1 21213.9 4852.9 5086.1 5154.6 5189.0 5197.6 5140.9 5196.9 5197.1 5197.6 5229.6 5732.1 5750.6 5772.7 5782.6 5783.2 5146.4 5240.2 5753.3 5764.6 5772.9 5110.4 5110.4 5111.9 5113.4 5113.5 12677.6 12832.4 22210.4 25662.0 26674.7 2442.0 2866.7 2913.1 2919.9 2961.4 9387.4 9819.7 10159.7 10202.8 10227.1 1681.5 1765.5 1787.7 1819.3 1842.1 125678.0 126642.0 127756.0 131982.0 132760.0 10276.5 11633.8 11726.2 11760.3 11779.2 13846.9 14332.5 15324.8 15335.8 15767.8 6789.4 8441.1 8610.4 8852.8 8974.2 8119.4 8282.1 8586.4 8618.4 8745.3 4309.1 4743.7 4751.1 4823.9 4835.5 2000.8 2010.8 2024.5 2024.9 2025.5 359.6 363.3 366.8 844.5 890.6 11333.6 11450.0 11538.7 11818.3 11958.1 383.4 401.3 401.3 401.4 404.6 5759.2 5766.9 5815.6 5940.2 6002.8 756530.0 759876.0 771342.0 779568.0 779657.0 157123.0 157831.0 161399.0 164519.0 169853.6 418.4 425.9 427.1 427.1 427.2 8993.8 9176.7 10004.2 10507.8 10685.9 57250.6 58351.0 58983.7 60150.7 60918.7 81494.0 84176.6 84197.0 87696.0 88404.0 7923.5 8087.6 8104.0 8289.7 8313.8 10878.7 11316.5 12351.3 13057.5 13203.5 9300.6 9630.1 10397.4 11119.8 11228.5 9867.9 11225.3 11429.0 11476.5 11892.9 11582.7 11782.9 12030.3 12079.1 12081.4 7248.7 8179.3 8297.4 8374.8 8602.0 11127.5 11290.1 11685.5 11700.5 11744.1 07:08:57 INFO - PROCESS | 1647 | 07:08:57 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5389.63 Median:5228.46 stddev:3006.41 (57.5%) stddev-sans-first:2999.93 07:08:57 INFO - PROCESS | 1647 | Values: 1405.3 1417.5 1429.0 1430.0 1433.5 8083.5 8501.8 8508.9 8513.7 8513.7 7432.9 7705.2 7720.1 7992.7 8220.6 2251.8 2287.6 2288.1 2289.7 2290.7 2283.1 2310.5 2314.4 2318.7 2325.6 2005.3 2086.4 2208.3 2249.1 2290.4 2116.6 2125.4 2125.6 2126.5 2133.7 2066.2 2166.1 2270.1 2273.4 2291.6 7157.3 8476.9 8478.3 8482.7 8496.8 3917.8 4986.8 5013.6 5072.1 5171.3 3284.5 3412.1 3417.5 3434.5 3445.4 1158.6 1223.8 1254.0 1259.9 1270.1 10931.8 11039.7 11055.1 11093.8 11098.6 4444.4 4515.5 4625.3 4635.6 4681.8 9579.2 9582.4 9584.6 9599.3 9625.9 5233.8 5234.7 5235.2 5238.4 5240.2 4207.5 4333.0 4400.9 4668.1 4711.9 3840.9 3850.5 3963.2 3969.4 4009.1 1271.7 1294.9 1296.8 1307.0 1308.5 759.4 777.8 790.3 794.7 806.7 5473.6 5490.5 5653.4 5690.8 5716.0 534.8 539.3 549.3 552.3 560.1 3681.0 3720.6 3760.7 3792.7 3796.9 9285.1 9970.9 10025.6 10099.8 10107.3 9954.0 9958.8 10049.4 10058.8 10092.4 7725.6 7872.3 7887.6 7888.0 7888.5 5341.7 5418.3 5463.1 5502.4 5560.0 9065.9 9088.8 9270.0 9273.0 9378.3 9200.4 9313.9 9319.3 9328.4 9437.8 6590.3 6777.5 7164.1 7256.1 7268.3 7714.5 7882.9 7953.0 8063.4 8068.1 7035.6 7096.9 7153.7 7205.8 7264.3 5977.4 7029.0 7075.3 7089.0 7121.6 6286.9 6417.0 6475.9 6487.1 6493.5 4837.1 4936.2 5002.7 5007.6 5057.2 3948.1 4335.6 4725.4 4921.4 5223.1 07:08:57 INFO - PROCESS | 1647 | 07:08:57 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4462.12 Median:5020.61 stddev:1372.32 (27.3%) stddev-sans-first:1340.36 07:08:57 INFO - PROCESS | 1647 | Values: 312.3 327.1 328.4 335.2 339.2 4716.8 5325.2 5381.9 5386.5 5465.6 4432.5 5003.7 5012.0 5081.9 5212.9 3811.6 4115.9 4118.1 4131.9 4150.8 4109.2 4117.3 4148.5 4157.1 4184.9 3558.3 3858.4 3975.8 4093.9 4108.1 4057.2 4059.0 4059.6 4084.3 4085.7 3018.1 3565.4 3576.3 3584.7 3619.5 4986.8 5081.9 5088.5 5096.5 5203.7 4685.4 4727.2 4749.5 4749.7 4767.0 5380.6 5510.7 5588.1 5648.6 5668.6 3365.6 3861.1 3891.1 3977.6 3991.6 5698.6 5714.1 5774.7 5793.6 5834.4 3539.6 4026.5 4039.7 4073.2 4081.6 3502.4 3826.5 4100.0 4135.3 4151.0 3681.2 4089.8 4181.8 4454.4 4517.7 5306.4 5608.4 5631.4 5683.8 5696.3 1096.4 1223.3 1244.4 1252.9 1254.9 705.7 730.5 798.7 806.0 807.9 4738.9 4918.7 4938.6 5014.7 5054.9 4936.9 5067.1 5339.6 5488.3 5513.3 4127.6 4423.3 4776.3 4953.7 5026.5 2309.7 2439.5 2591.4 2659.3 2698.9 5216.4 5582.6 5662.4 5707.4 5773.2 5230.8 5274.9 5518.7 5612.4 5680.3 4503.4 4988.7 5617.3 5714.7 5737.0 4898.7 5107.6 5130.5 5291.1 5321.9 5026.9 5027.8 5049.9 5326.5 5359.7 5288.9 5564.3 5614.4 5719.8 5801.7 3480.8 3554.1 3559.8 3561.8 3602.2 5665.3 5708.3 5711.0 5712.8 5716.4 5403.1 5521.5 5522.9 5536.9 5546.4 4612.7 5252.7 5579.3 5587.4 5613.2 4840.6 4855.0 5445.0 5500.6 5515.4 4777.1 5221.2 5446.3 5460.3 5624.8 5499.7 5514.4 5514.7 5519.8 5538.6 07:08:57 INFO - PROCESS | 1647 | 07:08:57 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:19498.48 Median:3905.15 stddev:27582.69 (706.3%) stddev-sans-first:27623.93 07:08:57 INFO - PROCESS | 1647 | Values: 695.4 713.0 768.1 804.8 819.7 14419.4 15411.1 15435.8 15445.9 15464.2 14057.3 14088.6 14094.2 14238.3 14251.5 661.3 688.8 842.4 861.8 868.1 685.4 686.3 688.5 689.2 805.7 902.8 903.5 908.7 912.4 913.1 905.7 911.6 911.6 911.6 912.3 675.7 675.7 676.5 676.7 677.7 10623.5 12256.6 14441.4 14911.9 15177.9 11452.7 13908.0 14087.4 14268.5 14278.6 10814.2 11293.8 11326.4 11509.8 11528.7 3577.4 3628.5 3723.0 3727.3 3809.6 94746.5 101038.0 103266.5 104448.0 107166.5 10423.6 10811.4 10815.7 10843.3 10862.2 21911.1 22330.6 22367.7 22405.0 22412.1 7288.2 7454.6 7517.4 7529.3 7729.3 4090.0 4155.7 4161.3 4178.6 4222.2 3339.3 3412.0 3428.9 3436.7 3449.4 629.2 633.7 637.2 640.4 642.7 627.8 634.5 641.5 661.6 669.7 8787.2 9452.8 9482.0 9592.6 9634.0 574.5 627.4 671.2 672.3 678.1 4000.7 4801.0 4887.5 4952.1 4964.0 79281.2 80920.0 101325.0 103010.0 105140.0 73539.6 75507.0 88676.1 92047.5 94838.1 68319.7 69433.0 70849.6 71840.9 72349.3 9450.3 10519.6 10652.7 10739.0 10781.8 45345.5 45817.3 46582.8 48507.8 50227.7 59516.1 61528.7 62142.7 66243.0 66539.7 12592.6 12685.2 13046.5 13084.7 13433.2 14163.4 14405.9 14470.3 14541.2 14652.2 11807.9 13103.5 13198.4 13500.7 13612.7 12881.3 13392.3 13470.9 13536.8 13995.3 12712.8 12854.2 13004.7 13210.0 13237.3 10764.9 11228.3 11286.2 11447.8 11662.5 10000.5 10947.1 10991.6 11327.5 11361.8 07:08:57 INFO - PROCESS | 1647 | -------- Summary: end -------- 07:08:57 INFO - PROCESS | 1647 | 07:08:58 INFO - TEST-INFO | 1647: exit 0 07:08:58 INFO - TEST-OK | dromaeo_css | took 1117899ms 07:08:58 INFO - TEST-START | kraken 07:08:58 INFO - operating with platform_type : mac_ 07:08:58 INFO - Initialising browser for kraken test... 07:08:58 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpQD7j5f/profile http://localhost:49249/getInfo.html) 07:09:00 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 07:09:00 INFO - PROCESS | 1653 | colorDepth:24 07:09:00 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 07:09:00 INFO - PROCESS | 1653 | __metrics 07:09:00 INFO - PROCESS | 1653 | 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:09:00 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:09:01 INFO - TEST-INFO | 1653: exit 0 07:09:01 INFO - Browser initialized. 07:09:01 INFO - Running cycle 1/1 for kraken test... 07:09:01 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpQD7j5f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:13 INFO - PROCESS | 1654 | RSS: Main: 212877312 07:09:13 INFO - PROCESS | 1654 | 07:09:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 07:09:17 INFO - PROCESS | 1654 | RSS: Main: 265879552 07:09:17 INFO - PROCESS | 1654 | 07:09:19 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 07:09:20 INFO - PROCESS | 1654 | RSS: Main: 274964480 07:09:20 INFO - PROCESS | 1654 | 07:09:23 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 07:09:24 INFO - PROCESS | 1654 | RSS: Main: 373395456 07:09:24 INFO - PROCESS | 1654 | 07:09:26 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 07:09:26 INFO - PROCESS | 1654 | RSS: Main: 276836352 07:09:26 INFO - PROCESS | 1654 | 07:09:28 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:09:29 INFO - PROCESS | 1654 | RSS: Main: 278478848 07:09:29 INFO - PROCESS | 1654 | 07:09:32 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 07:09:32 INFO - PROCESS | 1654 | RSS: Main: 317923328 07:09:32 INFO - PROCESS | 1654 | 07:09:35 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 07:09:36 INFO - PROCESS | 1654 | RSS: Main: 318734336 07:09:36 INFO - PROCESS | 1654 | 07:09:39 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 07:09:39 INFO - PROCESS | 1654 | RSS: Main: 317452288 07:09:39 INFO - PROCESS | 1654 | 07:09:41 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:09:42 INFO - PROCESS | 1654 | RSS: Main: 295321600 07:09:42 INFO - PROCESS | 1654 | 07:09:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:09:44 INFO - PROCESS | 1654 | RSS: Main: 298995712 07:09:44 INFO - PROCESS | 1654 | 07:09:46 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:09:47 INFO - PROCESS | 1654 | RSS: Main: 302051328 07:09:47 INFO - PROCESS | 1654 | 07:09:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:09:51 INFO - PROCESS | 1654 | RSS: Main: 320208896 07:09:51 INFO - PROCESS | 1654 | 07:09:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:09:54 INFO - PROCESS | 1654 | RSS: Main: 313266176 07:09:54 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 07:09:56 INFO - PROCESS | 1654 | RSS: Main: 357027840 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | __start_tp_report 07:09:56 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 07:09:56 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 07:09:56 INFO - PROCESS | 1654 | |i|pagename|runs| 07:09:56 INFO - PROCESS | 1654 | |0;ai-astar;117;115;114;118;168;170;162;113;114;114 07:09:56 INFO - PROCESS | 1654 | |1;audio-beat-detection;145;108;109;146;110;111;111;109;131;107 07:09:56 INFO - PROCESS | 1654 | |2;audio-dft;185;185;183;185;185;183;187;186;185;185 07:09:56 INFO - PROCESS | 1654 | |3;audio-fft;81;57;58;90;60;58;59;59;73;58 07:09:56 INFO - PROCESS | 1654 | |4;audio-oscillator;92;94;116;101;53;67;106;96;96;83 07:09:56 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;91;87;90;86;90;87;91;86;92;87 07:09:56 INFO - PROCESS | 1654 | |6;imaging-darkroom;99;99;99;99;98;101;115;96;99;98 07:09:56 INFO - PROCESS | 1654 | |7;imaging-desaturate;86;85;86;85;84;87;88;88;89;87 07:09:56 INFO - PROCESS | 1654 | |8;json-parse-financial;55;55;53;53;56;58;57;58;56;55 07:09:56 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;66;73;70;75;73;68;69;70;68;69 07:09:56 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;84;103;103;100;97;86;87;86;82;85 07:09:56 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;139;138;137;137;138;134;150;150;200;145 07:09:56 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;166;166;226;219;168;167;167;175;166;168 07:09:56 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;73;82;84;83;85;69;65;66;64;65 07:09:56 INFO - PROCESS | 1654 | __end_tp_report 07:09:56 INFO - PROCESS | 1654 | __start_cc_report 07:09:56 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2042 07:09:56 INFO - PROCESS | 1654 | __end_cc_report 07:09:56 INFO - PROCESS | 1654 | __startTimestamp1488294596907__endTimestamp 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | ------- Summary: start ------- 07:09:56 INFO - PROCESS | 1654 | Number of tests: 14 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:130.50 Median:117.50 stddev:25.08 (21.3%) stddev-sans-first:26.12 07:09:56 INFO - PROCESS | 1654 | Values: 117.0 115.0 114.0 118.0 168.0 170.0 162.0 113.0 114.0 114.0 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:111.00 stddev:15.71 (14.2%) stddev-sans-first:13.48 07:09:56 INFO - PROCESS | 1654 | Values: 145.0 108.0 109.0 146.0 110.0 111.0 111.0 109.0 131.0 107.0 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.00 stddev:1.20 (0.6%) stddev-sans-first:1.27 07:09:56 INFO - PROCESS | 1654 | Values: 185.0 185.0 183.0 185.0 185.0 183.0 187.0 186.0 185.0 185.0 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:65.30 Median:59.50 stddev:11.80 (19.8%) stddev-sans-first:11.06 07:09:56 INFO - PROCESS | 1654 | Values: 81.0 57.0 58.0 90.0 60.0 58.0 59.0 59.0 73.0 58.0 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:87.50 stddev:18.53 (21.2%) stddev-sans-first:19.65 07:09:56 INFO - PROCESS | 1654 | Values: 92.0 94.0 116.0 101.0 53.0 67.0 106.0 96.0 96.0 83.0 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:90.00 stddev:2.31 (2.6%) stddev-sans-first:2.30 07:09:56 INFO - PROCESS | 1654 | Values: 91.0 87.0 90.0 86.0 90.0 87.0 91.0 86.0 92.0 87.0 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:100.30 Median:99.00 stddev:5.31 (5.4%) stddev-sans-first:5.61 07:09:56 INFO - PROCESS | 1654 | Values: 99.0 99.0 99.0 99.0 98.0 101.0 115.0 96.0 99.0 98.0 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:87.00 stddev:1.58 (1.8%) stddev-sans-first:1.67 07:09:56 INFO - PROCESS | 1654 | Values: 86.0 85.0 86.0 85.0 84.0 87.0 88.0 88.0 89.0 87.0 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.78 (3.2%) stddev-sans-first:1.87 07:09:56 INFO - PROCESS | 1654 | Values: 55.0 55.0 53.0 53.0 56.0 58.0 57.0 58.0 56.0 55.0 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:2.77 (4.0%) stddev-sans-first:2.51 07:09:56 INFO - PROCESS | 1654 | Values: 66.0 73.0 70.0 75.0 73.0 68.0 69.0 70.0 68.0 69.0 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:85.50 stddev:8.41 (9.8%) stddev-sans-first:8.49 07:09:56 INFO - PROCESS | 1654 | Values: 84.0 103.0 103.0 100.0 97.0 86.0 87.0 86.0 82.0 85.0 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:142.00 stddev:19.51 (13.7%) stddev-sans-first:20.49 07:09:56 INFO - PROCESS | 1654 | Values: 139.0 138.0 137.0 137.0 138.0 134.0 150.0 150.0 200.0 145.0 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:168.00 stddev:23.24 (13.8%) stddev-sans-first:24.19 07:09:56 INFO - PROCESS | 1654 | Values: 166.0 166.0 226.0 219.0 168.0 167.0 167.0 175.0 166.0 168.0 07:09:56 INFO - PROCESS | 1654 | 07:09:56 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:77.50 stddev:8.92 (11.5%) stddev-sans-first:9.46 07:09:56 INFO - PROCESS | 1654 | Values: 73.0 82.0 84.0 83.0 85.0 69.0 65.0 66.0 64.0 65.0 07:09:56 INFO - PROCESS | 1654 | -------- Summary: end -------- 07:09:56 INFO - PROCESS | 1654 | 07:09:57 INFO - TEST-INFO | 1654: exit 0 07:09:57 INFO - TEST-OK | kraken | took 59591ms 07:09:57 INFO - SUITE-END | took 1177s 07:09:58 INFO - Completed test suite (00:19:37) 07:09:58 INFO - javascript benchmark 07:09:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2930.3992681500295, 2974.925626859328, 3342.4484959981596, 3366.309906469174, 3408.0, 5694.715264236787, 5717.0, 5717.799877004306, 5747.1379293106, 5768.134779783035, 5647.418722757634, 5655.4910058094765, 5766.509846663039, 5788.42115788421, 5791.565632577553, 5226.0, 5250.868728281795, 5269.6311258211945, 5273.209018647214, 5333.546648534879, 5190.92213616796, 5197.376314842205, 5214.843554693365, 5221.2951251580935, 5325.094733895227, 5269.473052694738, 5310.787568497275, 5336.199570064483, 5341.893162136755, 5361.329833770778, 5327.440618735016, 5328.040952628526, 5330.147176451768, 5331.173668081454, 5379.031774280628, 3879.9612003879884, 5043.319151914481, 5165.535101840815, 5228.529432351107, 5232.241325007891, 4685.601723853442, 5690.857728556778, 5783.5951483396175, 5798.246227990334, 5816.418358164192, 6287.783563775628, 6302.4958003359625, 6330.68346582669, 6333.271673757531, 6335.68321583919, 6248.531360147962, 6347.238331400215, 6348.873022539569, 6366.204224471941, 6388.840278993016, 5714.771409143671, 5726.770929162829, 5780.393058728773, 5813.7383817728305, 5836.503897168704, 6353.904691429632, 6357.618542887441, 6361.395667411589, 6372.1716176897635, 6373.362663733589, 6233.1273621693, 6246.000639897595, 6252.624842509373, 6256.092866534327, 6256.124142620037, 6155.230596175478, 6231.3145553989025, 6237.719302631393, 6264.624122552661, 6293.779717709858, 6265.185525881606, 6320.020396838498, 6326.841828954221, 6339.207599050119, 6346.4605508532295, 5307.575393968474, 5364.506902126601, 6151.569390142647, 6326.082718005863, 6337.017762246859, 4857.392825896763, 4954.851354459372, 4961.975190124099, 5000.1249781288125, 5007.37407824022, 4424.247877860771, 4474.798634061475, 4481.932771008437, 4523.2988886722615, 4529.411176547028, 5783.103618938987, 5826.82519524415, 5832.154337621021, 5832.62087964281, 5870.941290587125, 6199.907001394983, 6228.875422491525, 6256.906146407808, 6273.059041143773, 6340.0, 5831.737571809279, 5850.063989761703, 5860.208871802252, 5877.030290002187, 5879.794207202813, 5507.421720719267, 5511.476409741068, 5517.779288828402, 5519.448055194529, 5529.253550770675, 6240.4071613196675, 6382.393672601095, 6405.103285540028, 6417.486601071903, 6428.517861160338, 5299.6290259681455, 6293.339199383999, 6316.178896743394, 6317.178766760292, 6354.936450635434, 6444.420002199825, 6445.516586255956, 6446.903296450463, 6460.935390646034, 6463.612183269019, 6113.266408031065, 6231.9688401557705, 6268.2478102626155, 6273.686315684106, 6291.622502649856, 6229.719662615284, 6263.091851681572, 6295.842603934938, 6321.273053598895, 6565.0, 6219.533534984985, 6230.657313847782, 6230.875382492415, 6234.625922444668, 6235.532335074797, 6151.108089326933, 6189.535784816067, 6201.914664933709, 6203.069539569101, 6211.689415529296, 4351.846760608378, 5479.726013699219, 5666.631668941505, 5725.971370143123, 5728.627639203439, 4864.92702609454, 5921.4966727826895, 5921.881562368642, 6106.297775755845, 6125.601746185282, 5973.253343332083, 5978.551608629457, 5991.64050156992, 5993.3706960768495, 6015.819525414245], "value": 5704.765883911035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.72505771479405, 451.72219085262554, 504.21594420675837, 529.2326127115681, 532.651113520644, 38245.0, 39931.60068399315, 40136.79931600338, 40202.19595608086, 42637.786811065904, 41647.0, 42024.739257822235, 42146.94632634186, 42165.7891710541, 42387.364189537104, 8181.3863960202925, 9184.816303673939, 9370.390924589914, 9377.812443751121, 9392.671256506024, 8200.138985406536, 11083.50124244411, 11313.773724525505, 11338.206325557214, 11545.0, 11274.830877536844, 11343.489542970587, 11366.829497557543, 11387.658370248864, 11418.885811141907, 8146.592670366517, 11248.38133902635, 11303.604373846958, 11325.943370283178, 11357.920997505224, 8240.340772738167, 11011.28426652265, 11244.831327530093, 11256.38089905055, 11450.713732156679, 39870.80064599658, 39959.0, 40043.399349009786, 40101.796946091665, 40117.0, 3896.201278737852, 3934.3705007198996, 3965.781881996489, 3977.085270387827, 3979.7612143271494, 28912.277193070342, 28917.56623650647, 28936.27659308513, 29881.0, 30059.248518786986, 3081.6147981502313, 3228.499582564706, 3239.7894136881264, 3300.4389253826907, 3337.916552086193, 464586.0, 465838.9999999966, 466062.0, 466107.0, 466704.0, 62778.233306001785, 63194.684026579576, 63277.36722632807, 63323.0, 63457.413564661256, 65833.0, 66079.33920660827, 66273.0, 66290.0, 66297.66851165713, 16290.837091628931, 16527.669446611002, 16529.256183471774, 16538.669226615642, 16554.83445165557, 11373.94313028446, 11700.06399488039, 12695.174813637084, 12779.424925878171, 12790.488380464678, 15261.771073433907, 17729.748328300604, 21291.0, 21583.92080395974, 21644.783552164277, 7011.92988070123, 7245.673944672502, 8517.105703901125, 8553.187447192508, 8577.82844343122, 868.1362044765373, 873.8470767615769, 881.9382643215042, 900.9864852027225, 919.2094798473307, 29934.55098173529, 30040.69959300423, 30050.398992020037, 30569.0, 30571.694283056884, 1019.9031092046243, 1028.1466382902322, 1034.6275340877428, 1057.0856209378985, 1064.1646307648614, 13971.79042314366, 14102.0, 14350.641233969234, 14374.640633984234, 14375.856241437661, 657219.0, 660246.0, 661714.6914265398, 663760.6811965909, 664698.0, 50930.726731832, 51679.0, 51695.741521292905, 51765.48234517607, 51979.48020519822, 1388.9861101388856, 1410.22437659287, 1431.0626539616567, 1432.8925330600039, 1436.2531483628663, 26703.19890403291, 26859.731402685724, 26887.0, 27360.042398515958, 27410.258974103228, 45640.31539526976, 45996.310055349866, 46001.30998034965, 46060.76969615131, 46294.76852615715, 604549.0, 606969.0, 607201.0, 608358.0, 609044.0, 25172.118975835758, 25303.0, 25850.35374115662, 32332.736708430184, 33101.84143554964, 35359.0, 35562.0, 41457.79271103625, 42701.78649106859, 43340.78329608332, 31391.7216556685, 33669.66330336763, 35315.470267945486, 36699.44950825793, 36724.0, 35063.64936350604, 35078.47382289216, 35782.8210858944, 36020.4596931041, 36275.63724362723, 34519.827400862836, 34747.826260869544, 34750.47874281938, 35377.29245415026, 35498.75754348585, 29623.555646665747, 31506.369872602878, 31526.684733152375, 31683.20791980219, 31713.682863171074, 22521.774782251967, 23281.534369312856, 23480.0, 23805.404864878517, 23849.52300954006], "value": 19828.72811787095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.9540455145381, 388.73371740357874, 390.0794125862963, 394.9229900169467, 416.0576294692522, 13097.73804523909, 19879.204831806728, 20624.587508249864, 21102.15591376345, 21128.366149015517, 17236.224369903353, 20937.267195648154, 21006.89496552519, 21108.0501377438, 21213.893930530325, 4852.927206091911, 5086.059079070365, 5154.587632989352, 5188.9881473112755, 5197.610179236553, 5140.920406714576, 5196.870078248036, 5197.142471492218, 5197.558207552343, 5229.581633469314, 5732.111522713986, 5750.597458177929, 5772.682502462363, 5782.566307526931, 5783.2481777368885, 5146.408163061221, 5240.213967904807, 5753.252077229954, 5764.596478246524, 5772.942270577282, 5110.386753589556, 5110.412302585213, 5111.948880511184, 5113.437521872591, 5113.539781419653, 12677.556285530054, 12832.422540985677, 22210.444738881495, 25662.0, 26674.732647724966, 2441.963370549443, 2866.7276608722136, 2913.0678182981455, 2919.92700182495, 2961.3781105967555, 9387.389819661768, 9819.705408837746, 10159.746006349826, 10202.846957295647, 10227.130693891027, 1681.495551334607, 1765.5409593505653, 1787.6960916644202, 1819.3177558415593, 1842.075145918025, 125678.0, 126642.0, 127756.0, 131982.0, 132760.0, 10276.537555810006, 11633.825492617618, 11726.237794543327, 11760.294382337088, 11779.175457717878, 13846.861531384759, 14332.49836255726, 15324.846751532565, 15335.846641533664, 15767.842321576638, 6789.422899053636, 8441.07148213696, 8610.354223433142, 8852.778680533038, 8974.19232269099, 8119.350451963829, 8282.088970213272, 8586.356023298153, 8618.353623478264, 8745.300375969908, 4309.1381723655395, 4743.691660042086, 4751.144793937125, 4823.879403014953, 4835.516448355207, 2000.789917058688, 2010.7788143304224, 2024.4533975826444, 2024.908879100444, 2025.463252238158, 359.5559484037212, 363.2879556070079, 366.84959166742044, 844.5186243840951, 890.5903284489208, 11333.603323883624, 11450.0, 11538.711532211762, 11818.290902545703, 11958.103142264192, 383.44783511743003, 401.2636811450962, 401.33378591537905, 401.44800898764197, 404.6277424769219, 5759.1937128802, 5766.94233057664, 5815.621984570989, 5940.227770389908, 6002.789902353396, 756530.0, 759876.0, 771342.0, 779568.0, 779657.0, 157123.0, 157831.0, 161399.0, 164519.0, 169853.60292794075, 418.4204876246421, 425.9041715614024, 427.0860358832102, 427.09882148666907, 427.2096621250723, 8993.785838911663, 9176.724698259062, 10004.24968127408, 10507.842382364117, 10685.946570267099, 57250.56873578194, 58351.0, 58983.70508147432, 60150.699246503485, 60918.69540652446, 81494.0, 84176.57911710402, 84197.0, 87696.0, 88404.0, 7923.524588524707, 8087.555184464911, 8104.0, 8289.709860154866, 8313.750587482386, 10878.673639790819, 11316.49075791575, 12351.320677362832, 13057.477700891857, 13203.537876174289, 9300.627974880928, 9630.085141911508, 10397.376157430579, 11119.83320250213, 11228.494717737558, 9867.901320986986, 11225.270357426742, 11429.0, 11476.483558240066, 11892.940535297268, 11582.6525204244, 11782.882171178178, 12030.338331391857, 12079.094067944763, 12081.395930203278, 7248.673809678683, 8179.263866252066, 8297.419180657296, 8374.790630234293, 8601.967763868375, 11127.499262533043, 11290.137586084924, 11685.532578697097, 11700.47347869365, 11744.060475162138], "value": 8635.022306585257, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.2762827144022, 1417.518043865086, 1428.971420571588, 1429.9928500357503, 1433.5054406229854, 8083.474574152676, 8501.787455313612, 8508.936382952132, 8513.702020429286, 8513.744587662364, 7432.851342973137, 7705.15243323234, 7720.112187098485, 7992.680292788296, 8220.588970551464, 2251.808596269319, 2287.611106111965, 2288.141946769961, 2289.725232972046, 2290.725112986444, 2283.0981762204, 2310.4570425949887, 2314.4445333120016, 2318.710161229846, 2325.5581439526436, 2005.2981456490259, 2086.4158035750015, 2208.282308249817, 2249.0553967333676, 2290.4273931517123, 2116.640171170897, 2125.4261349435565, 2125.606762748881, 2126.5321629241544, 2133.7332833395826, 2066.245820275604, 2166.1118941234176, 2270.1373478078226, 2273.3861857298602, 2291.598970180212, 7157.320054594805, 8476.872846907301, 8478.279346255576, 8482.66069357225, 8496.78758031048, 3917.843286268546, 4986.803167239873, 5013.623978201649, 5072.112380333464, 5171.276021356975, 3284.458064419368, 3412.095794614429, 3417.5215469834243, 3434.5019972104155, 3445.3970555152746, 1158.5887010111373, 1223.7613665335264, 1253.9776309453487, 1259.8929091027182, 1270.0821759143666, 10931.813637272577, 11039.724006899893, 11055.11559075272, 11093.83359249612, 11098.611548595842, 4444.422225110715, 4515.548445155524, 4625.283081122431, 4635.605973492224, 4681.765911704401, 9579.185769209556, 9582.425054496753, 9584.568694408768, 9599.280053995979, 9625.903740962502, 5233.816816411408, 5234.712090835041, 5235.214717792362, 5238.397584277781, 5240.240165176028, 4207.537170911197, 4332.978335108367, 4400.889977750518, 4668.136394766979, 4711.882202944954, 3840.8847734568008, 3850.5186851643543, 3963.1875465529497, 3969.364901615728, 4009.1179940413062, 1271.7202215512573, 1294.9482020719254, 1296.7536168128026, 1306.9542566010143, 1308.5158491358259, 759.4190444310108, 777.766669998998, 790.2650535002388, 794.6781553470854, 806.7176488229073, 5473.644213126134, 5490.533304669068, 5653.378128405872, 5690.77236910519, 5715.971420142872, 534.7807398966405, 539.2854467830063, 549.3023859698161, 552.2903069555601, 560.1094260126418, 3680.9631903681156, 3720.6093360197333, 3760.6615404613167, 3792.6776224020714, 3796.867109651149, 9285.07149285066, 9970.900290997142, 10025.598976040877, 10099.798004040025, 10107.343022703648, 9953.950230248947, 9958.751031224278, 10049.397036177852, 10058.849117263248, 10092.44491552957, 7725.575093369806, 7872.33085187754, 7887.645055972495, 7887.9605601971625, 7888.526688398714, 5341.7062061586985, 5418.295621569171, 5463.125899856004, 5502.449755024626, 5560.0, 9065.864012039956, 9088.818223635622, 9269.953650231706, 9273.0, 9378.343515954091, 9200.35597508168, 9313.906860931304, 9319.254459643076, 9328.39365441244, 9437.81124377495, 6590.340965903371, 6777.525573209828, 7164.104486939133, 7256.129264488295, 7268.345848873627, 7714.537127772352, 7882.881756773539, 7953.0456345238945, 8063.395245356739, 8068.07217170033, 7035.648217589202, 7096.929030709627, 7153.678084486315, 7205.7838264852135, 7264.309890560388, 5977.372375900468, 7028.964855175692, 7075.257098004636, 7089.0, 7121.608311542915, 6286.874262514815, 6416.967915160394, 6475.935240647722, 6487.124238227779, 6493.545451818327, 4837.105135549935, 4936.2102063669645, 5002.724850133278, 5007.5993920487, 5057.241413787814, 3948.0722030322277, 4335.569262143422, 4725.432948046119, 4921.384826896638, 5223.112070947872], "value": 4301.712159957364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.28486765307434, 327.14941153002184, 328.371169210961, 335.1520652748547, 339.17749457565395, 4716.834910778123, 5325.20121981703, 5381.865453363668, 5386.5152136307825, 5465.617406781527, 4432.490263619685, 5003.724795136266, 5012.045302332084, 5081.872953176173, 5212.853172302097, 3811.5997820228895, 4115.855945041924, 4118.094019315746, 4131.876043718693, 4150.792460376984, 4109.157622687357, 4117.258893399187, 4148.481439820022, 4157.08544120293, 4184.895377615553, 3558.3061303045915, 3858.4405261237102, 3975.82108805103, 4093.9385909211387, 4108.096218831853, 4057.2494088593703, 4058.9852536865783, 4059.573744756802, 4084.346504559286, 4085.6527195188446, 3018.109657650998, 3565.447355659877, 3576.2847430514003, 3584.6594573515476, 3619.49327094207, 4986.800527978877, 5081.949180508184, 5088.465711100318, 5096.541311282002, 5203.661761985459, 4685.367475390813, 4727.22000869856, 4749.501302363236, 4749.715017098951, 4766.952330476685, 5380.569554435675, 5510.669359838423, 5588.066265210756, 5648.6275764179145, 5668.631538949996, 3365.636917048599, 3861.0540417597867, 3891.073710487454, 3977.642012218885, 3991.5808840071663, 5698.601097923189, 5714.1428785682065, 5774.7112644368035, 5793.551612096976, 5834.424705329538, 3539.610642829287, 4026.4564283821896, 4039.6566291864933, 4073.1853629274265, 4081.5918408158946, 3502.423909240852, 3826.4642949987024, 4099.959000409957, 4135.338345864648, 4151.0, 3681.2453447043827, 4089.754614723126, 4181.825450765585, 4454.37638730578, 4517.706349087299, 5306.363236411656, 5608.439156084441, 5631.352394474688, 5683.829485115453, 5696.3449203341315, 1096.3915027160003, 1223.3088305107585, 1244.4337826289018, 1252.931088790107, 1254.85569159546, 705.6648092156288, 730.4915349802641, 798.700487317256, 806.0, 807.8545861744942, 4738.857834264978, 4918.680285781485, 4938.555530002317, 5014.674046186986, 5054.898902021939, 4936.8645211600815, 5067.113255180328, 5339.599530035263, 5488.313960754906, 5513.283273174542, 4127.5963515787125, 4423.336499525032, 4776.331313616097, 4953.678010929278, 5026.547610715053, 2309.711286089239, 2439.487707581428, 2591.4298854252033, 2659.260961209957, 2698.865056747194, 5216.365735303647, 5582.553395728332, 5662.37713851476, 5707.401927460318, 5773.249477567973, 5230.764615592308, 5274.868128296824, 5518.696471694015, 5612.35457922336, 5680.289963754531, 4503.369528266046, 4988.700677959261, 5617.297837770278, 5714.65699063382, 5737.0, 4898.657094003385, 5107.577922791813, 5130.51260130287, 5291.074062039204, 5321.920171197513, 5026.874328141826, 5027.773750181177, 5049.8737531562, 5326.520613144836, 5359.740460991586, 5288.894222115459, 5564.271937801602, 5614.41048689898, 5719.771209151588, 5801.6519008859605, 3480.8433620487644, 3554.111472131967, 3559.7864128152396, 3561.7506774525536, 3602.1715005548344, 5665.3201615806365, 5708.257926469532, 5710.971445142914, 5712.828615141552, 5716.371199168005, 5403.081476149143, 5521.5306698931045, 5522.889542209214, 5536.91694624589, 5546.417626149197, 4612.654050946259, 5252.737363131904, 5579.330480342385, 5587.413321601173, 5613.158026295925, 4840.636952228668, 4854.95145048545, 5444.972775136099, 5500.58745594074, 5515.420880807457, 4777.0684716479955, 5221.242919776687, 5446.346438427414, 5460.34475862899, 5624.831255062355, 5499.725013749377, 5514.420985796594, 5514.698535142596, 5519.751611177587, 5538.6399884007415], "value": 4015.3924717426094, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.3602685529313, 712.9911175686401, 768.1013214538989, 804.7545498622922, 819.6516480495787, 14419.423223071077, 15411.07533547988, 15435.768463473043, 15445.92277038616, 15464.226788660564, 14057.297135143228, 14088.64778380541, 14094.224817635026, 14238.28808559573, 14251.50119745809, 661.2726001398447, 688.7727050073489, 842.4103127810527, 861.8405594964952, 868.1405408645427, 685.4071228387459, 686.289690170671, 688.490517017406, 689.2280645676849, 805.6575955219038, 902.7743064233941, 903.530164314556, 908.6501696846695, 912.4297314178639, 913.1005959130251, 905.7011186308503, 911.5761171055458, 911.6307895302413, 911.6307895302447, 912.2747415804386, 675.6621689155422, 675.7364627795164, 676.5027704637088, 676.7496026470188, 677.7255211639294, 10623.521941512574, 12256.571020014346, 14441.422343106264, 14911.850881491155, 15177.937544371787, 11452.71368215793, 13908.0, 14087.36606852694, 14268.500602478967, 14278.571642850628, 10814.188935829845, 11293.774124517546, 11326.43367831605, 11509.827352589718, 11528.711782205512, 3577.3560759063357, 3628.51015112959, 3723.0, 3727.347714150013, 3809.561900381464, 94746.52626736891, 101038.0, 103266.48366758118, 104447.95552044458, 107166.46416767944, 10423.635172768916, 10811.35131892089, 10815.675529733962, 10843.295185812896, 10862.239643224899, 21911.12355505762, 22330.553388932454, 22367.66448503274, 22404.99177536982, 22412.103515859508, 7288.217697674289, 7454.552726836408, 7517.361024312994, 7529.284717951786, 7729.265719756614, 4089.9795501022304, 4155.729877558009, 4161.334186530141, 4178.603032711888, 4222.21888950539, 3339.2653616204398, 3411.9658803412144, 3428.879989200366, 3436.7078798302423, 3449.3618680544178, 629.2134831460675, 633.6958260035209, 637.2321352769901, 640.4076229487705, 642.6561789442626, 627.7802769030802, 634.4638780230698, 641.5284765697209, 661.5501459007825, 669.6919417068203, 8787.165219304155, 9452.810943781085, 9481.952590237004, 9592.616295348247, 9634.0, 574.4772257245886, 627.4056775234438, 671.2347923367365, 672.3411057163909, 678.1049015299856, 4000.739951903175, 4800.975995120002, 4887.511248875084, 4952.108620448282, 4964.0, 79281.20718792854, 80919.97700057545, 101324.98675013303, 103010.0, 105140.0, 73539.63230183815, 75507.0, 88676.11323886807, 92047.53976230076, 94838.10323793486, 68319.65840170767, 69432.95850562246, 70849.58300834057, 71840.92238616425, 72349.2765072353, 9450.291228157777, 10519.631812886511, 10652.73368165771, 10739.0, 10781.784364312827, 45345.54654453413, 45817.312740308254, 46582.835429114544, 48507.757461212466, 50227.74886125546, 59516.10725839029, 61528.69235653793, 62142.68928655328, 66243.00635490374, 66539.66730166318, 12592.559260425842, 12685.23888566689, 13046.478140874258, 13084.738305233652, 13433.19400835953, 14163.433462661378, 14405.92797036008, 14470.348834302693, 14541.200233987232, 14652.19412932299, 11807.881921181022, 13103.541376052173, 13198.406071726988, 13500.729985400434, 13612.659683507596, 12881.291528965998, 13392.2634255113, 13470.932645337103, 13536.796948045983, 13995.300234988414, 12712.809307860205, 12854.228746275254, 13004.674883127618, 13210.009249306147, 13237.338133093499, 10764.892351076702, 11228.326300422, 11286.153538484483, 11447.828282575934, 11662.53349865996, 10000.499975001367, 10947.124230061736, 10991.61529346501, 11327.546898123983, 11361.829572556253], "value": 7285.926715665213, "unit": "score"}], "name": "dromaeo_css", "value": 7051.523639263819, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 114.0, 118.0, 168.0, 170.0, 162.0, 113.0, 114.0, 114.0], "value": 130.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 108.0, 109.0, 146.0, 110.0, 111.0, 111.0, 109.0, 131.0, 107.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 183.0, 185.0, 185.0, 183.0, 187.0, 186.0, 185.0, 185.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 58.0, 90.0, 60.0, 58.0, 59.0, 59.0, 73.0, 58.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 116.0, 101.0, 53.0, 67.0, 106.0, 96.0, 96.0, 83.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 90.0, 86.0, 90.0, 87.0, 91.0, 86.0, 92.0, 87.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 99.0, 99.0, 98.0, 101.0, 115.0, 96.0, 99.0, 98.0], "value": 100.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 85.0, 84.0, 87.0, 88.0, 88.0, 89.0, 87.0], "value": 86.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 53.0, 56.0, 58.0, 57.0, 58.0, 56.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 70.0, 75.0, 73.0, 68.0, 69.0, 70.0, 68.0, 69.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 103.0, 103.0, 100.0, 97.0, 86.0, 87.0, 86.0, 82.0, 85.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 137.0, 137.0, 138.0, 134.0, 150.0, 150.0, 200.0, 145.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 226.0, 219.0, 168.0, 167.0, 167.0, 175.0, 166.0, 168.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 82.0, 84.0, 83.0, 85.0, 69.0, 65.0, 66.0, 64.0, 65.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1481.5, "alertThreshold": 2.0}]} 07:09:58 INFO - Return code: 0 07:09:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:09:58 ERROR - # TBPL SUCCESS # 07:09:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:09:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:09:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:09:58 INFO - 2017-02-28 07:09:58.215 screenresolution[1658:10587] starting screenresolution argv=screenresolution get 07:09:58 INFO - 2017-02-28 07:09:58.218 screenresolution[1658:10587] Display 0: 1600x1200x32@60 07:09:58 INFO - 2017-02-28 07:09:58.224 screenresolution[1659:10590] starting screenresolution argv=screenresolution list 07:09:58 INFO - Available Modes on Display 0 07:09:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:09:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:09:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:09:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:09:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:09:58 INFO - Intel Iris: 07:09:58 INFO - Chipset Model: Intel Iris 07:09:58 INFO - Type: GPU 07:09:58 INFO - Bus: Built-In 07:09:58 INFO - VRAM (Dynamic, Max): 1536 MB 07:09:58 INFO - Vendor: Intel (0x8086) 07:09:58 INFO - Device ID: 0x0a2e 07:09:58 INFO - Revision ID: 0x0009 07:09:58 INFO - Displays: 07:09:58 INFO - Display: 07:09:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:09:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:09:58 INFO - Display Serial Number: 1600x1200 60 07:09:58 INFO - Main Display: Yes 07:09:58 INFO - Mirror: Off 07:09:58 INFO - Online: Yes 07:09:58 INFO - Rotation: Supported 07:09:58 INFO - Return code: 0 07:09:58 INFO - Running post-action listener: _resource_record_post_action 07:09:58 INFO - [mozharness: 2017-02-28 15:09:58.465723Z] Finished run-tests step (success) 07:09:58 INFO - Running post-run listener: _resource_record_post_run 07:09:58 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 33704960; Write bytes: 510792192; Read time: 311; Write time: 1772 07:09:58 INFO - TinderboxPrint: CPU usage
53.6% 07:09:58 INFO - TinderboxPrint: I/O read bytes / time
33,704,960 / 311 07:09:58 INFO - TinderboxPrint: I/O write bytes / time
510,792,192 / 1,772 07:09:58 INFO - TinderboxPrint: CPU idle
2,225.2 (46.4%) 07:09:58 INFO - TinderboxPrint: CPU system
956.4 (20.0%) 07:09:58 INFO - TinderboxPrint: CPU user
1,612.1 (33.6%) 07:09:58 INFO - TinderboxPrint: Swap in / out
237,965,312 / 0 07:09:58 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205654528; Write bytes: 202446848; Read time: 15749; Write time: 453 07:09:58 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 31587328; Write bytes: 297376256; Read time: 287; Write time: 1286 07:09:59 INFO - Running post-run listener: _upload_blobber_files 07:09:59 INFO - Blob upload gear active. 07:09:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:09:59 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:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:09:59 INFO - (blobuploader) - INFO - Open directory for files ... 07:09:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:09:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:09:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:10:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:00 INFO - (blobuploader) - INFO - Done attempting. 07:10:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:10:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:10:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:01 INFO - (blobuploader) - INFO - Done attempting. 07:10:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:10:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:10:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:02 INFO - (blobuploader) - INFO - Done attempting. 07:10:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:10:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:10:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:05 INFO - (blobuploader) - INFO - Done attempting. 07:10:05 INFO - (blobuploader) - INFO - Iteration through files over. 07:10:05 INFO - Return code: 0 07:10:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:10:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:10:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63dc64b1e78c5aca904d307b7fb46e72f2e5820309f2b89b94231864d2a557b56758349fa720bc5eef1b3978fd30fc5b9eb1669a444508bdbeb445ef19817d09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df8cc22e279f52657a4682e07777d230e9c9e75171827f4730dd025999dd911c3ec62e759941d8e042b0b5493eda53e389048e62dae6267bfd223e585997c3ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6cebf1c47949034568ce51453fa09def40fbff57325e88ea2ba41bbdaa9ca99ed6b7e3daecdfbe09e730300162404a79e7f6b2d31a85cf1af9d1805c3e8c4c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a21d5e2ccf12a66843dcaa7103c12e60a8b69d765cf2e4a794a4593bed2fc6956e7da0544ffe3817daecae8962ac545934ac60e5d84d94066797b8b1cafcd44"} 07:10:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:10:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:10:05 INFO - Contents: 07:10:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63dc64b1e78c5aca904d307b7fb46e72f2e5820309f2b89b94231864d2a557b56758349fa720bc5eef1b3978fd30fc5b9eb1669a444508bdbeb445ef19817d09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df8cc22e279f52657a4682e07777d230e9c9e75171827f4730dd025999dd911c3ec62e759941d8e042b0b5493eda53e389048e62dae6267bfd223e585997c3ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6cebf1c47949034568ce51453fa09def40fbff57325e88ea2ba41bbdaa9ca99ed6b7e3daecdfbe09e730300162404a79e7f6b2d31a85cf1af9d1805c3e8c4c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a21d5e2ccf12a66843dcaa7103c12e60a8b69d765cf2e4a794a4593bed2fc6956e7da0544ffe3817daecae8962ac545934ac60e5d84d94066797b8b1cafcd44"} 07:10:05 INFO - Running post-run listener: copy_logs_to_upload_dir 07:10:05 INFO - Copying logs to upload dir... 07:10:05 INFO - mkdir: /builds/slave/test/build/upload/logs 07:10:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.349338 ========= master_lag: 0.35 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-28 07:10:05.479016) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-28 07:10:05.483472) ========= 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.lOW9AmBeCt/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.gsq08cu7mD/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63dc64b1e78c5aca904d307b7fb46e72f2e5820309f2b89b94231864d2a557b56758349fa720bc5eef1b3978fd30fc5b9eb1669a444508bdbeb445ef19817d09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df8cc22e279f52657a4682e07777d230e9c9e75171827f4730dd025999dd911c3ec62e759941d8e042b0b5493eda53e389048e62dae6267bfd223e585997c3ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6cebf1c47949034568ce51453fa09def40fbff57325e88ea2ba41bbdaa9ca99ed6b7e3daecdfbe09e730300162404a79e7f6b2d31a85cf1af9d1805c3e8c4c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a21d5e2ccf12a66843dcaa7103c12e60a8b69d765cf2e4a794a4593bed2fc6956e7da0544ffe3817daecae8962ac545934ac60e5d84d94066797b8b1cafcd44"} build_url:https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011662 build_url: 'https://queue.taskcluster.net/v1/task/FwqyJ0o9SQGtZ_x-Azk5sg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63dc64b1e78c5aca904d307b7fb46e72f2e5820309f2b89b94231864d2a557b56758349fa720bc5eef1b3978fd30fc5b9eb1669a444508bdbeb445ef19817d09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df8cc22e279f52657a4682e07777d230e9c9e75171827f4730dd025999dd911c3ec62e759941d8e042b0b5493eda53e389048e62dae6267bfd223e585997c3ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6cebf1c47949034568ce51453fa09def40fbff57325e88ea2ba41bbdaa9ca99ed6b7e3daecdfbe09e730300162404a79e7f6b2d31a85cf1af9d1805c3e8c4c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a21d5e2ccf12a66843dcaa7103c12e60a8b69d765cf2e4a794a4593bed2fc6956e7da0544ffe3817daecae8962ac545934ac60e5d84d94066797b8b1cafcd44"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-28 07:10:05.526119) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 07:10:05.526523) ========= 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.lOW9AmBeCt/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.gsq08cu7mD/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.005001 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 07:10:05.574882) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-28 07:10:05.575212) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-28 07:10:05.575589) ========= ========= Total master_lag: 0.50 =========