builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0210 starttime: 1475843786.28 results: success (0) buildid: 20161007033200 builduid: 45f4789a976f4f7fa37e2db98682c814 revision: f161a85e85e45fd2dcc56abbcd4e43c70d177bb5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:26.278610) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:26.279058) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:26.279335) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:26.302025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:26.302372) ========= 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.TBSE22MleI/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.VcnN8TkNMQ/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-07 05:36:26-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.40M=0.001s 2016-10-07 05:36:26 (8.40 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095920 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:26.419687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:26.420025) ========= 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.TBSE22MleI/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.VcnN8TkNMQ/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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.020856 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:26.468722) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-07 05:36:26.469085) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f161a85e85e45fd2dcc56abbcd4e43c70d177bb5 --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 f161a85e85e45fd2dcc56abbcd4e43c70d177bb5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TBSE22MleI/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.VcnN8TkNMQ/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-07 05:36:26,545 truncating revision to first 12 chars 2016-10-07 05:36:26,545 Setting DEBUG logging. 2016-10-07 05:36:26,545 attempt 1/10 2016-10-07 05:36:26,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f161a85e85e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 05:36:28,535 unpacking tar archive at: mozilla-aurora-f161a85e85e4/testing/mozharness/ program finished with exit code 0 elapsedTime=2.276269 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-07 05:36:28.766866) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:28.767321) ========= script_repo_revision: f161a85e85e45fd2dcc56abbcd4e43c70d177bb5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:28.767738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:28.768025) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 05:36:28.785921) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-07 05:36:28.786312) ========= /tools/buildbot/bin/python 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', '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.TBSE22MleI/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.VcnN8TkNMQ/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 05:36:28 INFO - MultiFileLogger online at 20161007 05:36:28 in /builds/slave/test 05:36:28 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 05:36:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:36:28 INFO - {'append_to_log': False, 05:36:28 INFO - 'base_work_dir': '/builds/slave/test', 05:36:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:36:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:36:28 INFO - 'branch': 'Mozilla-Aurora', 05:36:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:36:28 INFO - 'config_files': ('talos/mac_config.py',), 05:36:28 INFO - 'default_actions': ('clobber', 05:36:28 INFO - 'read-buildbot-config', 05:36:28 INFO - 'download-and-extract', 05:36:28 INFO - 'populate-webroot', 05:36:28 INFO - 'create-virtualenv', 05:36:28 INFO - 'install', 05:36:28 INFO - 'run-tests'), 05:36:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:36:28 INFO - 'download_minidump_stackwalk': True, 05:36:28 INFO - 'download_symbols': 'ondemand', 05:36:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:36:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:36:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:36:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:36:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:36:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:36:28 INFO - 'installer_path': 'installer.exe', 05:36:28 INFO - 'log_level': 'info', 05:36:28 INFO - 'log_name': 'talos', 05:36:28 INFO - 'log_to_console': True, 05:36:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:36:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:36:28 INFO - 'opt_config_files': (), 05:36:28 INFO - 'pip_index': False, 05:36:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:36:28 INFO - 'cmd': ('bash', 05:36:28 INFO - '-c', 05:36:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:36:28 INFO - 'enabled': True, 05:36:28 INFO - 'halt_on_failure': False, 05:36:28 INFO - 'name': 'check_screen_resolution'},), 05:36:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:36:28 INFO - 'cmd': ('bash', 05:36:28 INFO - '-c', 05:36:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:36:28 INFO - 'enabled': True, 05:36:28 INFO - 'halt_on_failure': False, 05:36:28 INFO - 'name': 'check_screen_resolution'},), 05:36:28 INFO - 'run_cmd_checks_enabled': True, 05:36:28 INFO - 'sps_profile': False, 05:36:28 INFO - 'sps_profile_interval': 0, 05:36:28 INFO - 'suite': 'dromaeojs', 05:36:28 INFO - 'system_bits': '32', 05:36:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:36:28 INFO - 'title': 't-yosemite-r7-0210', 05:36:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:36:28 INFO - 'use_talos_json': True, 05:36:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:36:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:36:28 INFO - 'work_dir': 'build'} 05:36:28 INFO - [mozharness: 2016-10-07 12:36:28.975129Z] Running clobber step. 05:36:28 INFO - Running pre-action listener: _resource_record_pre_action 05:36:28 INFO - Running main action method: clobber 05:36:28 INFO - rmtree: /builds/slave/test/build 05:36:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:36:30 INFO - Running post-action listener: _resource_record_post_action 05:36:30 INFO - [mozharness: 2016-10-07 12:36:30.576666Z] Finished clobber step (success) 05:36:30 INFO - [mozharness: 2016-10-07 12:36:30.576803Z] Running read-buildbot-config step. 05:36:30 INFO - Running pre-action listener: _resource_record_pre_action 05:36:30 INFO - Running main action method: read_buildbot_config 05:36:30 INFO - Using buildbot properties: 05:36:30 INFO - { 05:36:30 INFO - "project": "", 05:36:30 INFO - "product": "firefox", 05:36:30 INFO - "script_repo_revision": "production", 05:36:30 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:36:30 INFO - "repository": "", 05:36:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:36:30 INFO - "buildid": "20161007033200", 05:36:30 INFO - "pgo_build": "False", 05:36:30 INFO - "basedir": "/builds/slave/test", 05:36:30 INFO - "buildnumber": 40, 05:36:30 INFO - "slavename": "t-yosemite-r7-0210", 05:36:30 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:36:30 INFO - "platform": "yosemite_r7", 05:36:30 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:36:30 INFO - "branch": "mozilla-aurora", 05:36:30 INFO - "repo_path": "releases/mozilla-aurora", 05:36:30 INFO - "revision": "f161a85e85e45fd2dcc56abbcd4e43c70d177bb5", 05:36:30 INFO - "stage_platform": "macosx64", 05:36:30 INFO - "builduid": "45f4789a976f4f7fa37e2db98682c814", 05:36:30 INFO - "slavebuilddir": "test" 05:36:30 INFO - } 05:36:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 05:36:30 INFO - Running post-action listener: _resource_record_post_action 05:36:30 INFO - [mozharness: 2016-10-07 12:36:30.579987Z] Finished read-buildbot-config step (success) 05:36:30 INFO - [mozharness: 2016-10-07 12:36:30.580124Z] Running download-and-extract step. 05:36:30 INFO - Running pre-action listener: _resource_record_pre_action 05:36:30 INFO - Running main action method: download_and_extract 05:36:30 INFO - mkdir: /builds/slave/test/build/tests 05:36: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')]} 05:36:30 INFO - trying https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 05:36:30 INFO - Downloading https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 05:36:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 05:36:31 INFO - Downloaded 1199 bytes. 05:36:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 05:36:31 INFO - Using the following test package requirements: 05:36:31 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:36:31 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:31 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 05:36:31 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:31 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 05:36:31 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:31 INFO - u'jsshell-mac.zip'], 05:36:31 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:31 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 05:36:31 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:36:31 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:31 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 05:36:31 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:31 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 05:36:31 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:31 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 05:36:31 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:36:31 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 05:36:31 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:36:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:36:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:36:31 INFO - Fetch https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:36:32 INFO - Expected file size: 16434722 05:36:38 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:36:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:36:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:36:38 INFO - Fetch https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:36:39 INFO - Expected file size: 16434722 05:36:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 05:36:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:36:46 INFO - Fetch https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 05:36:46 INFO - Expected file size: 14414059 05:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:47 INFO - trying https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:36:47 INFO - Downloading https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 05:36:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 05:36:50 INFO - Downloaded 115310260 bytes. 05:36:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:36:50 INFO - mkdir: /builds/slave/test/properties 05:36:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:36:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:36:50 INFO - Contents: 05:36:50 INFO - build_url:https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:36:50 INFO - Running post-action listener: _resource_record_post_action 05:36:50 INFO - Running post-action listener: set_extra_try_arguments 05:36:50 INFO - [mozharness: 2016-10-07 12:36:50.756628Z] Finished download-and-extract step (success) 05:36:50 INFO - [mozharness: 2016-10-07 12:36:50.756772Z] Running populate-webroot step. 05:36:50 INFO - Running pre-action listener: _resource_record_pre_action 05:36:50 INFO - Running main action method: populate_webroot 05:36:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:36:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:36:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:36:50 INFO - '--tppagecycles', 05:36:50 INFO - '7'], 05:36:50 INFO - 'tests': ['tsvgm']}}, 05:36:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:36:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:36:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:36:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:36:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:36:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:36:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:50 INFO - 'talos_options': ['--disable-e10s'], 05:36:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:50 INFO - 'talos_options': ['--disable-e10s'], 05:36:50 INFO - 'tests': ['damp', 'tps']}, 05:36:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:50 INFO - 'tests': ['damp', 'tps']}, 05:36:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:36:50 INFO - 'tests': ['dromaeo_dom']}, 05:36:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:36:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:36:50 INFO - 'tests': ['basic_compositor_video']}, 05:36:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:36:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:36:50 INFO - 'tests': ['a11yr', 05:36:50 INFO - 'ts_paint', 05:36:50 INFO - 'tpaint', 05:36:50 INFO - 'sessionrestore', 05:36:50 INFO - 'sessionrestore_no_auto_restore', 05:36:50 INFO - 'tabpaint']}, 05:36:50 INFO - 'other-e10s': {'tests': ['a11yr', 05:36:50 INFO - 'ts_paint', 05:36:50 INFO - 'tpaint', 05:36:50 INFO - 'sessionrestore', 05:36:50 INFO - 'sessionrestore_no_auto_restore', 05:36:50 INFO - 'tabpaint']}, 05:36:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:36:50 INFO - 'ts_paint', 05:36:50 INFO - 'tpaint', 05:36:50 INFO - 'sessionrestore', 05:36:50 INFO - 'sessionrestore_no_auto_restore', 05:36:50 INFO - 'tabpaint']}, 05:36:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:36:50 INFO - 'ts_paint', 05:36:50 INFO - 'tpaint', 05:36:50 INFO - 'sessionrestore', 05:36:50 INFO - 'sessionrestore_no_auto_restore', 05:36:50 INFO - 'tabpaint']}, 05:36:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:36:50 INFO - 'tests': ['a11yr', 05:36:50 INFO - 'ts_paint', 05:36:50 INFO - 'tpaint', 05:36:50 INFO - 'sessionrestore', 05:36:50 INFO - 'sessionrestore_no_auto_restore', 05:36:50 INFO - 'tabpaint']}, 05:36:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:36:50 INFO - 'tests': ['a11yr', 05:36:50 INFO - 'ts_paint', 05:36:50 INFO - 'tpaint', 05:36:50 INFO - 'sessionrestore', 05:36:50 INFO - 'sessionrestore_no_auto_restore', 05:36:50 INFO - 'tabpaint']}, 05:36:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:36:50 INFO - 'tests': ['tsvgx', 05:36:50 INFO - 'tsvgr_opacity', 05:36:50 INFO - 'tart', 05:36:50 INFO - 'tscrollx', 05:36:50 INFO - 'cart']}, 05:36:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:36:50 INFO - 'tsvgr_opacity', 05:36:50 INFO - 'tart', 05:36:50 INFO - 'tscrollx', 05:36:50 INFO - 'cart']}, 05:36:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:50 INFO - 'talos_options': ['--disable-e10s'], 05:36:50 INFO - 'tests': ['tp5o']}, 05:36:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:50 INFO - 'tests': ['tp5o']}, 05:36:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:50 INFO - 'talos_options': ['--disable-e10s', 05:36:50 INFO - '--xperf_path', 05:36:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:50 INFO - 'tests': ['tp5n']}, 05:36:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:50 INFO - 'talos_options': ['--xperf_path', 05:36:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:50 INFO - 'tests': ['tp5n']}}, 05:36:50 INFO - 'talos.zip': {'path': '', 05:36:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:36:50 INFO - Running post-action listener: _resource_record_post_action 05:36:50 INFO - [mozharness: 2016-10-07 12:36:50.775544Z] Finished populate-webroot step (success) 05:36:50 INFO - [mozharness: 2016-10-07 12:36:50.775675Z] Running create-virtualenv step. 05:36:50 INFO - Running pre-action listener: _resource_record_pre_action 05:36:50 INFO - Running main action method: create_virtualenv 05:36:50 INFO - Creating virtualenv /builds/slave/test/build/venv 05:36:50 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 05:36:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:36:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:36:50 INFO - Using real prefix '/tools/python27' 05:36:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:36:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:36:54 INFO - Installing pip.................done. 05:36:54 INFO - Return code: 0 05:36:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:36:54 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')]} 05:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:54 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')]} 05:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:54 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 0x106525490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb20477c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106339d30>, '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 0x10619fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106331b20>, '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.TBSE22MleI/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.VcnN8TkNMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 05:36:54 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 05:36:54 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 05:36:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TBSE22MleI/Render', 05:36:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:54 INFO - 'HOME': '/Users/cltbld', 05:36:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:54 INFO - 'LOGNAME': 'cltbld', 05:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:54 INFO - 'MOZ_NO_REMOTE': '1', 05:36:54 INFO - 'NO_EM_RESTART': '1', 05:36:54 INFO - 'PAGER': '/bin/cat', 05:36:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:54 INFO - 'PWD': '/builds/slave/test', 05:36:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:54 INFO - 'SHELL': '/bin/bash', 05:36:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcnN8TkNMQ/Listeners', 05:36:54 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:36:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:54 INFO - 'USER': 'cltbld', 05:36:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:54 INFO - 'XPC_FLAGS': '0x0', 05:36:54 INFO - 'XPC_SERVICE_NAME': '0', 05:36:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:54 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 05:36:54 INFO - Cleaning up... 05:36:54 INFO - Return code: 0 05:36:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:36:54 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')]} 05:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:54 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')]} 05:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:54 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 0x106525490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb20477c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106339d30>, '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 0x10619fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106331b20>, '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.TBSE22MleI/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.VcnN8TkNMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 05:36:54 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 05:36:54 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 05:36:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TBSE22MleI/Render', 05:36:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:54 INFO - 'HOME': '/Users/cltbld', 05:36:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:54 INFO - 'LOGNAME': 'cltbld', 05:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:54 INFO - 'MOZ_NO_REMOTE': '1', 05:36:54 INFO - 'NO_EM_RESTART': '1', 05:36:54 INFO - 'PAGER': '/bin/cat', 05:36:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:54 INFO - 'PWD': '/builds/slave/test', 05:36:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:54 INFO - 'SHELL': '/bin/bash', 05:36:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcnN8TkNMQ/Listeners', 05:36:54 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:36:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:54 INFO - 'USER': 'cltbld', 05:36:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:54 INFO - 'XPC_FLAGS': '0x0', 05:36:54 INFO - 'XPC_SERVICE_NAME': '0', 05:36:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:54 INFO - Downloading/unpacking psutil>=3.1.1 05:36:54 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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:36:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:58 INFO - Installing collected packages: psutil 05:36:58 INFO - Running setup.py install for psutil 05:36:58 INFO - building 'psutil._psutil_osx' extension 05:36:58 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 05:36:58 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 05:36:58 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 05:36:58 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 05:36:58 INFO - building 'psutil._psutil_posix' extension 05:36:58 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 05:36:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:36:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:36:58 INFO - ^ 05:36:58 INFO - 1 warning generated. 05:36:58 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 05:36:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:58 INFO - Successfully installed psutil 05:36:58 INFO - Cleaning up... 05:36:59 INFO - Return code: 0 05:36:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:36: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')]} 05:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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')]} 05:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106525490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb20477c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106339d30>, '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 0x10619fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106331b20>, '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.TBSE22MleI/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.VcnN8TkNMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 05:36: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:36: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 mozsystemmonitor==0.3 05:36:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TBSE22MleI/Render', 05:36:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:59 INFO - 'HOME': '/Users/cltbld', 05:36:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:59 INFO - 'LOGNAME': 'cltbld', 05:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:59 INFO - 'MOZ_NO_REMOTE': '1', 05:36:59 INFO - 'NO_EM_RESTART': '1', 05:36:59 INFO - 'PAGER': '/bin/cat', 05:36:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:59 INFO - 'PWD': '/builds/slave/test', 05:36:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:59 INFO - 'SHELL': '/bin/bash', 05:36:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcnN8TkNMQ/Listeners', 05:36:59 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:36:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:59 INFO - 'USER': 'cltbld', 05:36:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:59 INFO - 'XPC_FLAGS': '0x0', 05:36:59 INFO - 'XPC_SERVICE_NAME': '0', 05:36:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:37:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:37:01 INFO - Installing collected packages: mozsystemmonitor 05:37:01 INFO - Running setup.py install for mozsystemmonitor 05:37:01 INFO - Successfully installed mozsystemmonitor 05:37:01 INFO - Cleaning up... 05:37:02 INFO - Return code: 0 05:37:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:37:02 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')]} 05:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:02 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')]} 05:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:02 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 0x106525490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb20477c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106339d30>, '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 0x10619fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106331b20>, '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.TBSE22MleI/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.VcnN8TkNMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 05:37:02 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 05:37:02 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 05:37:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TBSE22MleI/Render', 05:37:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:02 INFO - 'HOME': '/Users/cltbld', 05:37:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:02 INFO - 'LOGNAME': 'cltbld', 05:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:02 INFO - 'MOZ_NO_REMOTE': '1', 05:37:02 INFO - 'NO_EM_RESTART': '1', 05:37:02 INFO - 'PAGER': '/bin/cat', 05:37:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:02 INFO - 'PWD': '/builds/slave/test', 05:37:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:02 INFO - 'SHELL': '/bin/bash', 05:37:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcnN8TkNMQ/Listeners', 05:37:02 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:37:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:02 INFO - 'USER': 'cltbld', 05:37:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:02 INFO - 'XPC_FLAGS': '0x0', 05:37:02 INFO - 'XPC_SERVICE_NAME': '0', 05:37:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:02 INFO - Downloading/unpacking jsonschema==2.5.1 05:37:02 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 05:37:02 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 05:37:02 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 05:37:02 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 05:37:02 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 05:37:02 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 05:37:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:37:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:05 INFO - Downloading functools32-3.2.3-2.tar.gz 05:37:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:37:05 INFO - warning: no files found matching '*.txt' 05:37:05 INFO - no previously-included directories found matching 'build' 05:37:05 INFO - no previously-included directories found matching 'dist' 05:37:05 INFO - no previously-included directories found matching '.git*' 05:37:05 INFO - Installing collected packages: jsonschema, functools32 05:37:05 INFO - Running setup.py install for functools32 05:37:05 INFO - warning: no files found matching '*.txt' 05:37:05 INFO - no previously-included directories found matching 'build' 05:37:05 INFO - no previously-included directories found matching 'dist' 05:37:05 INFO - no previously-included directories found matching '.git*' 05:37:05 INFO - Successfully installed jsonschema functools32 05:37:05 INFO - Cleaning up... 05:37:05 INFO - Return code: 0 05:37:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:37:05 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')]} 05:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:05 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')]} 05:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:05 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 0x106525490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb20477c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106339d30>, '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 0x10619fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106331b20>, '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.TBSE22MleI/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.VcnN8TkNMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 05:37:05 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 05:37:05 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 05:37:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TBSE22MleI/Render', 05:37:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:05 INFO - 'HOME': '/Users/cltbld', 05:37:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:05 INFO - 'LOGNAME': 'cltbld', 05:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:05 INFO - 'MOZ_NO_REMOTE': '1', 05:37:05 INFO - 'NO_EM_RESTART': '1', 05:37:05 INFO - 'PAGER': '/bin/cat', 05:37:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:05 INFO - 'PWD': '/builds/slave/test', 05:37:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:05 INFO - 'SHELL': '/bin/bash', 05:37:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcnN8TkNMQ/Listeners', 05:37:05 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:37:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:05 INFO - 'USER': 'cltbld', 05:37:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:05 INFO - 'XPC_FLAGS': '0x0', 05:37:05 INFO - 'XPC_SERVICE_NAME': '0', 05:37:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:37:05 INFO - Cleaning up... 05:37:05 INFO - Return code: 0 05:37:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:37:05 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')]} 05:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:05 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')]} 05:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:05 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 0x106525490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb20477c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106339d30>, '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 0x10619fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106331b20>, '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.TBSE22MleI/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.VcnN8TkNMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 05:37:05 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 05:37:05 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 05:37:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TBSE22MleI/Render', 05:37:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:05 INFO - 'HOME': '/Users/cltbld', 05:37:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:05 INFO - 'LOGNAME': 'cltbld', 05:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:05 INFO - 'MOZ_NO_REMOTE': '1', 05:37:05 INFO - 'NO_EM_RESTART': '1', 05:37:05 INFO - 'PAGER': '/bin/cat', 05:37:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:05 INFO - 'PWD': '/builds/slave/test', 05:37:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:05 INFO - 'SHELL': '/bin/bash', 05:37:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcnN8TkNMQ/Listeners', 05:37:05 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:37:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:05 INFO - 'USER': 'cltbld', 05:37:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:05 INFO - 'XPC_FLAGS': '0x0', 05:37:05 INFO - 'XPC_SERVICE_NAME': '0', 05:37:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:06 INFO - Downloading/unpacking blobuploader==1.2.4 05:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:37:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:37:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:37:09 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 05:37:09 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 05:37:09 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 05:37:09 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 05:37:09 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 05:37:09 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 05:37:09 INFO - Downloading docopt-0.6.1.tar.gz 05:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:37:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:37:09 INFO - Running setup.py install for blobuploader 05:37:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:37:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:37:09 INFO - Running setup.py install for requests 05:37:10 INFO - Running setup.py install for docopt 05:37:10 INFO - Successfully installed blobuploader requests docopt 05:37:10 INFO - Cleaning up... 05:37:10 INFO - Return code: 0 05:37:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:10 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')]} 05:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:10 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')]} 05:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:10 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 0x106525490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb20477c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106339d30>, '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 0x10619fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106331b20>, '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.TBSE22MleI/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.VcnN8TkNMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 05:37:10 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 05:37:10 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 05:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TBSE22MleI/Render', 05:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:10 INFO - 'HOME': '/Users/cltbld', 05:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:10 INFO - 'LOGNAME': 'cltbld', 05:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:10 INFO - 'MOZ_NO_REMOTE': '1', 05:37:10 INFO - 'NO_EM_RESTART': '1', 05:37:10 INFO - 'PAGER': '/bin/cat', 05:37:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:10 INFO - 'PWD': '/builds/slave/test', 05:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:10 INFO - 'SHELL': '/bin/bash', 05:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcnN8TkNMQ/Listeners', 05:37:10 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:10 INFO - 'USER': 'cltbld', 05:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:10 INFO - 'XPC_FLAGS': '0x0', 05:37:10 INFO - 'XPC_SERVICE_NAME': '0', 05:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:10 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-92H8EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:11 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-eCz33A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:11 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-9ZD8Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:37:11 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-mdmDE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:37:11 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-vWnEQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:37:11 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-_vexSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:37:11 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-27T_TJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:37:11 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-0vtB2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:37:11 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-soIMsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:37:11 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-G7Ecfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:37:11 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-Iq6XFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:37:12 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-cYp3JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:37:12 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-LlyrO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:37:12 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-JsFo9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:12 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-uSb0nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:37:12 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-mVYzhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:37:12 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-23wZfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:37:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:37:12 INFO - Running setup.py install for manifestparser 05:37:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Running setup.py install for mozcrash 05:37:13 INFO - Running setup.py install for mozdebug 05:37:13 INFO - Running setup.py install for mozdevice 05:37:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:37:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:37:13 INFO - Running setup.py install for mozfile 05:37:13 INFO - Running setup.py install for mozhttpd 05:37:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:37:13 INFO - Running setup.py install for mozinfo 05:37:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:37:13 INFO - Running setup.py install for mozInstall 05:37:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:37:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:37:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:37:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:37:13 INFO - Running setup.py install for mozleak 05:37:14 INFO - Running setup.py install for mozlog 05:37:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:37:14 INFO - Running setup.py install for moznetwork 05:37:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:37:14 INFO - Running setup.py install for mozprocess 05:37:14 INFO - Running setup.py install for mozprofile 05:37:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:37:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:37:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:37:14 INFO - Running setup.py install for mozrunner 05:37:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:37:14 INFO - Running setup.py install for mozscreenshot 05:37:15 INFO - Running setup.py install for moztest 05:37:15 INFO - Running setup.py install for mozversion 05:37:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:37:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:37:15 INFO - Cleaning up... 05:37:15 INFO - Return code: 0 05:37:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:15 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 0x106525490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb20477c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106339d30>, '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 0x10619fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106331b20>, '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.TBSE22MleI/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.VcnN8TkNMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 05:37:15 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 05:37:15 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 05:37:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TBSE22MleI/Render', 05:37:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:15 INFO - 'HOME': '/Users/cltbld', 05:37:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:15 INFO - 'LOGNAME': 'cltbld', 05:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:15 INFO - 'MOZ_NO_REMOTE': '1', 05:37:15 INFO - 'NO_EM_RESTART': '1', 05:37:15 INFO - 'PAGER': '/bin/cat', 05:37:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:15 INFO - 'PWD': '/builds/slave/test', 05:37:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:15 INFO - 'SHELL': '/bin/bash', 05:37:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcnN8TkNMQ/Listeners', 05:37:15 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:37:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:15 INFO - 'USER': 'cltbld', 05:37:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:15 INFO - 'XPC_FLAGS': '0x0', 05:37:15 INFO - 'XPC_SERVICE_NAME': '0', 05:37:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:15 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-OgoGax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:15 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)) 05:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:15 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-horxpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:15 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-UVQImP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:15 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)) 05:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:37:15 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-dLHqDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:37:16 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-KpqbDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:37:16 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)) 05:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:37:16 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-CYc3Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:37:16 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)) 05:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:37:16 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-o6jEzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:37:16 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)) 05:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:37:16 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-AMtMp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:37:16 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)) 05:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:37:16 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-G3WApl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:37:16 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)) 05:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:37:16 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-U_5TGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:37:16 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)) 05:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:37:16 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-Sug1gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:37:16 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)) 05:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:37:16 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-BBrEWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:37:16 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-NOQquj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:37:16 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)) 05:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:37:16 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-zQp8F3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:17 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-ptUXIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:17 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)) 05:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:37:17 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-92zXvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:37:17 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-U16orD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:37:17 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)) 05:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:37:17 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)) 05:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:37:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:37:17 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 05:37:17 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 05:37:17 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 05:37:17 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 05:37:17 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 05:37:17 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 05:37:19 INFO - Downloading blessings-1.6.tar.gz 05:37:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:37:19 INFO - Installing collected packages: blessings 05:37:19 INFO - Running setup.py install for blessings 05:37:20 INFO - Successfully installed blessings 05:37:20 INFO - Cleaning up... 05:37:20 INFO - Return code: 0 05:37:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:37:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:37:20 INFO - Reading from file tmpfile_stdout 05:37:20 INFO - Current package versions: 05:37:20 INFO - blessings == 1.6 05:37:20 INFO - blobuploader == 1.2.4 05:37:20 INFO - docopt == 0.6.1 05:37:20 INFO - functools32 == 3.2.3-2 05:37:20 INFO - jsonschema == 2.5.1 05:37:20 INFO - manifestparser == 1.1 05:37:20 INFO - mozInstall == 1.12 05:37:20 INFO - mozcrash == 0.17 05:37:20 INFO - mozdebug == 0.1 05:37:20 INFO - mozdevice == 0.48 05:37:20 INFO - mozfile == 1.2 05:37:20 INFO - mozhttpd == 0.7 05:37:20 INFO - mozinfo == 0.9 05:37:20 INFO - mozleak == 0.1 05:37:20 INFO - mozlog == 3.4 05:37:20 INFO - moznetwork == 0.27 05:37:20 INFO - mozprocess == 0.23 05:37:20 INFO - mozprofile == 0.28 05:37:20 INFO - mozrunner == 6.12 05:37:20 INFO - mozscreenshot == 0.1 05:37:20 INFO - mozsystemmonitor == 0.3 05:37:20 INFO - moztest == 0.7 05:37:20 INFO - mozversion == 1.4 05:37:20 INFO - psutil == 3.1.1 05:37:20 INFO - requests == 1.2.3 05:37:20 INFO - wsgiref == 0.1.2 05:37:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37: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')]} 05:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:20 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 0x106525490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb20477c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106339d30>, '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 0x10619fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106331b20>, '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.TBSE22MleI/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.VcnN8TkNMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 05:37:20 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 05:37:20 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 05:37:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TBSE22MleI/Render', 05:37:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:20 INFO - 'HOME': '/Users/cltbld', 05:37:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:20 INFO - 'LOGNAME': 'cltbld', 05:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:20 INFO - 'MOZ_NO_REMOTE': '1', 05:37:20 INFO - 'NO_EM_RESTART': '1', 05:37:20 INFO - 'PAGER': '/bin/cat', 05:37:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:20 INFO - 'PWD': '/builds/slave/test', 05:37:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:20 INFO - 'SHELL': '/bin/bash', 05:37:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcnN8TkNMQ/Listeners', 05:37:20 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:37:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:20 INFO - 'USER': 'cltbld', 05:37:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:20 INFO - 'XPC_FLAGS': '0x0', 05:37:20 INFO - 'XPC_SERVICE_NAME': '0', 05:37:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:20 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)) 05:37:20 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)) 05:37:20 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)) 05:37:20 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)) 05:37:20 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)) 05:37:20 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)) 05:37:20 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)) 05:37:20 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)) 05:37:20 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)) 05:37:20 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)) 05:37:20 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)) 05:37:20 INFO - Cleaning up... 05:37:20 INFO - Return code: 0 05:37:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:37: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')]} 05:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37: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')]} 05:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:20 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 0x106525490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb20477c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106339d30>, '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 0x10619fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106331b20>, '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.TBSE22MleI/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.VcnN8TkNMQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 05:37:20 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 05:37:20 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 05:37:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TBSE22MleI/Render', 05:37:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:20 INFO - 'HOME': '/Users/cltbld', 05:37:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:20 INFO - 'LOGNAME': 'cltbld', 05:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:20 INFO - 'MOZ_NO_REMOTE': '1', 05:37:20 INFO - 'NO_EM_RESTART': '1', 05:37:20 INFO - 'PAGER': '/bin/cat', 05:37:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:20 INFO - 'PWD': '/builds/slave/test', 05:37:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:20 INFO - 'SHELL': '/bin/bash', 05:37:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcnN8TkNMQ/Listeners', 05:37:20 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:37:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:20 INFO - 'USER': 'cltbld', 05:37:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:20 INFO - 'XPC_FLAGS': '0x0', 05:37:20 INFO - 'XPC_SERVICE_NAME': '0', 05:37:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:37:21 INFO - Cleaning up... 05:37:21 INFO - Return code: 0 05:37:21 INFO - Running post-action listener: _resource_record_post_action 05:37:21 INFO - Running post-action listener: _start_resource_monitoring 05:37:21 INFO - Starting resource monitoring. 05:37:21 INFO - [mozharness: 2016-10-07 12:37:21.090612Z] Finished create-virtualenv step (success) 05:37:21 INFO - [mozharness: 2016-10-07 12:37:21.091606Z] Running install step. 05:37:21 INFO - Running pre-action listener: _resource_record_pre_action 05:37:21 INFO - Running main action method: install 05:37:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:37:21 INFO - Reading from file tmpfile_stdout 05:37:21 INFO - Detecting whether we're running mozinstall >=1.0... 05:37:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:37:21 INFO - Reading from file tmpfile_stdout 05:37:21 INFO - Output received: 05:37:21 INFO - Usage: mozinstall [options] installer 05:37:21 INFO - Options: 05:37:21 INFO - -h, --help show this help message and exit 05:37:21 INFO - -d DEST, --destination=DEST 05:37:21 INFO - Directory to install application into. [default: 05:37:21 INFO - "/builds/slave/test"] 05:37:21 INFO - --app=APP Application being installed. [default: firefox] 05:37:21 INFO - mkdir: /builds/slave/test/build/application 05:37:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:37:54 INFO - Reading from file tmpfile_stdout 05:37:54 INFO - Output received: 05:37:54 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:37:54 INFO - Running post-action listener: _resource_record_post_action 05:37:54 INFO - [mozharness: 2016-10-07 12:37:54.089285Z] Finished install step (success) 05:37:54 INFO - [mozharness: 2016-10-07 12:37:54.089407Z] Running run-tests step. 05:37:54 INFO - Running pre-action listener: _resource_record_pre_action 05:37:54 INFO - Running main action method: run_tests 05:37:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:37:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:37:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:37:54 INFO - 2016-10-07 05:37:54.104 screenresolution[1940:17273] starting screenresolution argv=screenresolution get 05:37:54 INFO - 2016-10-07 05:37:54.106 screenresolution[1940:17273] Display 0: 1600x1200x32@60 05:37:54 INFO - 2016-10-07 05:37:54.112 screenresolution[1941:17276] starting screenresolution argv=screenresolution list 05:37:54 INFO - Available Modes on Display 0 05:37:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:37:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:37:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:37:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:37:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:37:54 INFO - Intel Iris: 05:37:54 INFO - Chipset Model: Intel Iris 05:37:54 INFO - Type: GPU 05:37:54 INFO - Bus: Built-In 05:37:54 INFO - VRAM (Dynamic, Max): 1536 MB 05:37:54 INFO - Vendor: Intel (0x8086) 05:37:54 INFO - Device ID: 0x0a2e 05:37:54 INFO - Revision ID: 0x0009 05:37:54 INFO - Displays: 05:37:54 INFO - Display: 05:37:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:37:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:37:54 INFO - Display Serial Number: 1600x1200 60 05:37:54 INFO - Main Display: Yes 05:37:54 INFO - Mirror: Off 05:37:54 INFO - Online: Yes 05:37:54 INFO - Rotation: Supported 05:37:54 INFO - Return code: 0 05:37:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:37:54 INFO - Python 2.7.3 05:37:54 INFO - Return code: 0 05:37:54 INFO - grabbing minidump binary from tooltool 05:37:54 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')]} 05:37:54 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 0x106339d30>, '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 0x10619fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106331b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:37:54 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 05:37:54 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 05:37:54 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 05:37:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:37:54 INFO - Return code: 0 05:37:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:37:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:37:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:37:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:37:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:37:54 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/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0210', '--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 05:37:54 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/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0210 --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 05:37:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TBSE22MleI/Render', 05:37:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:54 INFO - 'HOME': '/Users/cltbld', 05:37:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:54 INFO - 'LOGNAME': 'cltbld', 05:37:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:37:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:54 INFO - 'MOZ_NO_REMOTE': '1', 05:37:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:37:54 INFO - 'NO_EM_RESTART': '1', 05:37:54 INFO - 'PAGER': '/bin/cat', 05:37:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:54 INFO - 'PWD': '/builds/slave/test', 05:37:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:37:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:54 INFO - 'SHELL': '/bin/bash', 05:37:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VcnN8TkNMQ/Listeners', 05:37:54 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:37:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:54 INFO - 'USER': 'cltbld', 05:37:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:54 INFO - 'XPC_FLAGS': '0x0', 05:37:54 INFO - 'XPC_SERVICE_NAME': '0', 05:37:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:54 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/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0210', '--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 05:37:54 INFO - mozversion application_buildid: 20161007033200 05:37:54 INFO - mozversion application_changeset: f161a85e85e45fd2dcc56abbcd4e43c70d177bb5 05:37:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:37:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:37:54 INFO - mozversion application_name: Firefox 05:37:54 INFO - mozversion application_remotingname: firefox-dev 05:37:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:37:54 INFO - mozversion application_vendor: Mozilla 05:37:54 INFO - mozversion application_version: 51.0a2 05:37:54 INFO - mozversion platform_buildid: 20161007033200 05:37:54 INFO - mozversion platform_changeset: f161a85e85e45fd2dcc56abbcd4e43c70d177bb5 05:37:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:37:54 INFO - mozversion platform_version: 51.0a2 05:37:54 INFO - using testdate: 1475843874 05:37:54 INFO - actual date: 1475843874 05:37:54 INFO - starting webserver on 'localhost:54412' 05:37:54 INFO - SUITE-START | Running 2 tests 05:37:54 INFO - TEST-START | dromaeo_css 05:37:54 INFO - operating with platform_type : mac_ 05:37:54 INFO - Initialising browser for dromaeo_css test... 05:37:54 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpQCi3AZ/profile http://localhost:54412/getInfo.html) 05:37:57 INFO - PROCESS | 1951 | __metrics Screen width/height:1600/1200 05:37:57 INFO - PROCESS | 1951 | colorDepth:24 05:37:57 INFO - PROCESS | 1951 | Browser inner width/height: 1024/689 05:37:57 INFO - PROCESS | 1951 | __metrics 05:37:57 INFO - PROCESS | 1951 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:37:57 INFO - PROCESS | 1951 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:37:58 INFO - TEST-INFO | 1951: exit 0 05:37:58 INFO - Browser initialized. 05:37:58 INFO - Running cycle 1/1 for dromaeo_css test... 05:37:58 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpQCi3AZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:10 INFO - PROCESS | 1953 | RSS: Main: 219267072 05:38:10 INFO - PROCESS | 1953 | 05:39:01 INFO - PROCESS | 1953 | 1475843941017 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:41:13 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54412/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54412/tests/dromaeo/cssquery-ext.html) 05:41:14 INFO - PROCESS | 1953 | RSS: Main: 353988608 05:41:14 INFO - PROCESS | 1953 | 05:44:17 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54412/tests/dromaeo/cssquery-ext.html (next: http://localhost:54412/tests/dromaeo/cssquery-jquery.html) 05:44:18 INFO - PROCESS | 1953 | RSS: Main: 350347264 05:44:18 INFO - PROCESS | 1953 | 05:47:20 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54412/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54412/tests/dromaeo/cssquery-mootools.html) 05:47:21 INFO - PROCESS | 1953 | RSS: Main: 331132928 05:47:21 INFO - PROCESS | 1953 | 05:50:23 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54412/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54412/tests/dromaeo/cssquery-prototype.html) 05:50:24 INFO - PROCESS | 1953 | RSS: Main: 339214336 05:50:24 INFO - PROCESS | 1953 | 05:53:27 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54412/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54412/tests/dromaeo/cssquery-yui.html) 05:53:28 INFO - PROCESS | 1953 | RSS: Main: 312664064 05:53:28 INFO - PROCESS | 1953 | 05:56:31 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54412/tests/dromaeo/cssquery-yui.html (next: http://localhost:54412/tests/dromaeo/cssquery-dojo.html) 05:56:31 INFO - PROCESS | 1953 | RSS: Main: 383119360 05:56:31 INFO - PROCESS | 1953 | 05:56:31 INFO - PROCESS | 1953 | __start_tp_report 05:56:31 INFO - PROCESS | 1953 | _x_x_mozilla_page_load 05:56:31 INFO - PROCESS | 1953 | _x_x_mozilla_page_load_details 05:56:31 INFO - PROCESS | 1953 | |i|pagename|runs| 05:56:31 INFO - PROCESS | 1953 | |0;dojo.html;3334.3831391192625;3341.3150304187643;3375.544301519296;3387.8814241501555;3412.146963259185;5695.202671625976;5705.229793977812;5781.884362312761;5791.8262452126455;5851.912221316678;5662.094064949609;5662.858428539278;5789.507891829189;5797.36229014808;5801.129830525423;4354.499232588261;5217.982493413767;5227.79088836446;5252.185911183773;5262.236975638531;5238.764255608507;5260.947390526084;5263.631545791777;5312.963972025456;5379.435159308275;5221.164613661815;5293.6294459387855;5302.734863256841;5334.439883812202;5359;5222.764975576109;5223.477652234784;5246.37043554772;5275.261463395128;5285.814996475144;5154.742262886878;5206.062908676437;5238.554722848562;5239.266502689627;5264.684118952875;5671.2060311556415;5680.346760122557;5731.083026715747;5738;5741.19623252745;5173.793048278064;5188.662736922088;6202.844928876769;6245.687715614201;6254.843628909268;5198.714070726109;6327.050942358637;6332.4934005279465;6342.587731797418;6365.077063825719;5752.993226185443;5773.566982476331;5795.304563452412;5817.301923769175;5823.272090988627;6269.404406581368;6308.653024083719;6349.619022858643;6360.9045864312075;6368.076628888878;6219.844503887439;6248.31268560458;6251.468625166821;6263.498920086382;6275.780347687901;6187.133801267826;6195.845103872349;6340.4293613575;6348.904766428507;6355.1738274025;6189.04069869171;6198.6280823150755;6236.968815155895;6329.778457753957;6348.777792777323;6288.717007734663;6304;6308.211473565804;6326.49388048955;6341.8097457076365;4883.926741098886;4917.901641967141;4964.652474326835;4989.351384320088;5009.899802004013;4444.31113177458;4447.999200179934;4475.776211189427;4494.842680506166;4521.773911304422;5943.613665111754;5945.643261404243;5957.940420595825;5973.074173503027;5993.0710739835395;6141.670122563582;6285;6316.494680425555;6319.33646967071;6325.968370158212;5753.194552762617;5767.711614419346;5823.30120385548;5823.88352232953;5824.3302020267365;5377.7311134443125;5415.945840541623;5428;5428.2671839301975;5440.129579267298;6300.054991751183;6322.778702745381;6378.202724659325;6404.935950640434;6491.675416229265;6283.748650053946;6302.936970630235;6311;6317.620942743266;6320.051992201206;6231;6472.805815825533;6490.870182596416;6494.220693516808;6496.415322620798;6174.629522228681;6178.567500274938;6226.688665566794;6229.906551401642;6270.49836013127;6331.240251169705;6344.714487847966;6348.714307856065;6353.5870168438905;6359.236891573041;6049.818505444844;6130.233720784902;6237.906431403623;6243.531735119794;6256.624602523863;6041.335453100068;6106.217989796568;6129.601575897553;6222.595531290452;6225;6048.90926636092;6075.3317135115985;6105.8168254952425;6155.72299246526;6164.044573091178;6144.938550614436;6208.441240288395;6270.184875966095;6291.276503202007;6298.08677741734;5828.70856457167;6024.186734790747;6103.115048318058;6105;6123.234595675541 05:56:31 INFO - PROCESS | 1953 | |1;ext.html;477.427087495006;488.6213184781794;496.1664403801612;514.6037551085662;532.835753877777;30563.083107506784;40656.39015414767;41727;41872;43970.78014609931;43091.56908430915;43477.34783978243;43511.564884351144;43565;43659.690209293774;8800.8679869802;9862.704118876445;10044.54799534019;10058.346207496526;10072.093511583957;8764.737057888273;9031.27749780016;9032.096790320948;9036.50299233542;12166.81749773754;12255.816162757566;12373.257604543756;12400;12408.82845502038;12456.501739930438;12327.691807704834;12359.62921112368;12394;12404.875951240552;12418.875811241953;12164.209326393757;12274.754504909852;12285.447154878051;12292.815607765891;12297.938510307391;41490.377644335356;41767.37348939768;41831;41940.1611967762;42016.369754453706;2733.330334068146;3093.566900633913;3334.3164651246434;3601.6038235794304;4043.9595604043875;21061.68407473874;26234.344141396617;26948.461030779472;27425;28042.719572804213;3165.838394993548;3181.650018497963;3246.6753324667343;3254;3321.485169798685;490167;490732;491881;492189;494324.0567594314;50384;61796.69101654463;62217;62462.375376246564;62489.062664060075;33839;35195.648043519235;35220.47169292463;36206.637933620856;36293.81853090718;17123.486295411156;17275.654486910193;17282;17294.65410691779;17295.221715022853;13148.671283217996;13256.204627722367;13277.402516886763;13279.26964016969;13296.468141274434;16416.425425110065;17024.57438564046;17272.877262977865;17337.959722416694;19266.123608100814;7361.742339018108;7507;7760.495567788075;7792.8051798704355;7902;769.9230076992256;885.703289398046;1035.8549803027581;1063.0910571461288;1100.7028102412464;29909.850450747606;29952.400951981275;30270.84864575663;30582.847085764875;30858;891.5675897189858;1028.9073983341386;1070.7055559721139;1074.0548317480723;1147.6040765935738;15439.30523126462;15975.520734377755;16028.599285017735;16112.436064737678;16415.91792041032;657684;659912;661477;662460;664298;59384;59824;59923.40076599266;59948.700256498436;60020.699896500235;1210.1710328425056;1258.993705031469;1262.5770366927;1339.397271227932;1348.6965432777547;30275.70625987175;32113.8394308027;32181.678183218806;32632.857849976088;32848.50727239141;49643.00713985772;50348.748256258485;50402;50508.49491505038;50534.49465505298;511602;513028;513427;514008;514176;26747.732522675302;26887.058952936553;27324.180274591796;27333.180004599893;28239.435211295247;40249.396259056724;47820.521794781605;48998.26502602535;49146.262806057224;49252;39046.219075618894;39323.803380982914;39851.80074099611;40016;41052.794736027325;40012.59987400089;40063.79968100141;40457.98855028648;40778.776636700946;41706.58293417027;38729.127087291046;38833;39458.21083578255;39590.40614390844;39803;33748.98753037413;35138.77014304589;35899.82050089733;35940.92177234687;36053.81973090118;25759.742402575735;26130.73869261359;26147.607785883607;26175.345616359744;26638 05:56:31 INFO - PROCESS | 1953 | |2;jquery.html;327.28324968319384;351.0171519744714;367.61951380321375;368.67556550235787;396.0731887383522;12742.872571274296;13844;15715.84284157158;20576;21355.466113347135;20151.49621259469;20661.483462913435;20678.48303792406;20682.48293792656;20950;5782.335031471382;6047.909281360783;6095.146679464879;6111.388861113897;6114.2357205349335;5347.59893008024;5605.523530499892;5949.851253718648;6034.728437220314;6087.026075827868;5690.317161940552;5692.5161361284345;5697.202391665171;5699.629524080921;5706.28671416073;5390.676559406448;5551.861203469905;5618.2415373924405;5684.118961560965;5696.601237913327;5453.836384908459;5455.618106732531;5457.045017121988;5458.263134476834;5461.2354270401775;12961.416736246798;13902.582922512342;21415.036323365486;25211.621825672628;25518.979240830344;2183.563287342522;2270.3189043286948;2369.3958040699513;2631.815772895898;2984.0301901881976;9654.372465789702;10090.142337901214;10126.392416454963;10144.442055686934;11793.882061179364;1867.3090956346239;1888.1503323504342;1932.4009557037223;1951.7950615185343;1962.6761584338567;112682.96329520803;116210;121799.3910030453;131325.6867431323;134072;8965.731028069169;9306.86039709405;11253.549858005588;11632.53469861196;11825.940870295593;14492.637684057772;14500.607399778919;14510.419583216764;14510.709785804225;14523.273836308143;8360.498370097814;8380.748577542561;8643.438176518506;8722.040575536686;8744.169303916118;8559.57202139903;8573.699920502753;8597.054324024351;8724.563771811385;8737.38838281327;4423.469183697976;4474.530174331649;4492.730436173774;4537.8411755588395;4545.136424079415;1509.6527798606382;1695.4571340080468;1834.4773837714665;1865.7406250780668;1921.4331772127257;812.8130529978138;913.2146354135439;922.3866129024124;929.3782349799508;963.1572374172599;20399.694004589943;20898.686519702216;20907.26824561133;20952.580948380946;21005;926.5228407370209;932.6222879733718;941.1999800169801;966.8791401074866;971.5190980464715;10643.52104155315;10901.563937442414;11089.500972456259;11122.944385278022;11186.664400068012;553506;556017;560891;574604;577267;100348.79317561175;101072.49463752781;113541;133301.0004849928;142122.28938855446;996.5415908681942;1016;1024.329064462793;1042.7393151712072;1042.8592140061146;17840.91079544594;18549.443516694522;18931;19143.617127657646;19228.71156932619;53626;54570.45429545813;55166.72416638052;55313.72343138258;58064.4193558059;74472.25527744653;77533;77984.61007694925;78532.82200766879;79700.20299796927;6780.38976492118;7871.724489642835;7878.606069696607;7883.172266911892;8173.141820109041;10211.438370889673;12461.501539938301;12545.31000794965;12685.23888566689;12865.935670321589;10820.89179108199;10866.728331791768;10979.121670266519;11190.608328708457;11331.320120792449;8901.643934242558;10812;10942;11161.609343672932;11337.603183888525;10767.946160269148;11102.833457497982;11136.944315278372;11289.71775705581;11420.657380278604;7770.728024519115;7922.683092676459;7935;8050.355971522147;8146.389020823581;8481.57592120404;10754;10761.192910531585;10784.838227426439;10994 05:56:31 INFO - PROCESS | 1953 | |3;mootools.html;1362.1963041805336;1528.5719998400446;1668.499450164951;1810.8008119106905;1852.9258829646806;8476.32189424846;8981.775455613613;9001.819963600725;9002.9646590642;9007.54962251888;7824.687012519506;8048.154943730911;8064.556449395281;8566.100559441247;8768.649254029848;2382.356763673811;2428.64784606232;2431.0640403444622;2432.9878350608224;2434.075051480435;2385.3321070100315;2411.517696460715;2421.4551725861716;2423.333583264599;2424.5514579802707;2392.28231530541;2398.8680622565753;2400.0279886645935;2428.878556072198;2429.744876787938;2386.3079706884982;2392.569337519246;2405.446747248125;2405.675233843435;2413.1071503543626;2392.0551382204108;2398.70016247969;2402.1232250228713;2405.9759402405925;2407.0973384980634;8627.223549880478;8962.68630597926;9029.367944243906;9046;9065;5195.844124676266;5375.381831089397;5379.300690910196;5383.596230282745;5389.622726409153;3501.422265326218;3629.6370362963494;3694.18727879866;3703.703703703697;3713.0531714412923;985.6451677396132;1036.4092467293647;1058.968230953065;1090.1551297744231;1102.9834552481718;11615;11753.118516111326;11768.940795328546;11771.470283837249;11775.940165385071;4568.269076947672;4648.209804333272;4842.982973575518;4843.0313937212695;4855.562999330077;10000.14998725102;10013.249006324555;10025.348352357074;10033.347832390871;10036.498175091216;5398.379186393537;5398.946010539844;5404.54061404785;5404.756785944642;5414.3232095988005;4419.823207071681;4604.401427814362;4769.66612337133;4905.533974272438;4945.629077819178;3921.5490218624655;3970.4441378207075;4022.0950286185957;4061.7969101544804;4126.339785634284;1294.5727909789746;1304.9151805132635;1305.8432988041495;1314.80277958307;1317.947282108724;767.8310771630232;805.6696754330696;880.9163129502815;913.48388160689;924.075924075924;5541.390447050821;5806.970965145232;5830.7084645767545;5981.252343457068;6087.908681369783;897.1925267259388;911.2573252798948;937.301710225886;945.8297506448905;965.1265604627823;3779.7165212608616;3805.9429108563395;3915.804209789499;3923.136909879822;3956.8363285911587;10634.787304254027;10763.246572739834;10768.569257229623;10992.725181870357;11007.394593297446;10827.133829293638;10932.398718070583;10944.39805810688;10944.39805810688;10964.616238431616;6448.806535804028;8132.75601731949;8293.129221431784;8298.792530186794;8309.169083091763;5377.435369286169;5555.861103472445;5907.852303692442;6053.4551890330085;6132;8778.780530486789;9756.26827987918;9765.730455040799;9835.950820245853;9863.45750983674;10004.899951000396;10163.949180254347;10339.793204135725;10373.585056597953;10378.740531486774;6971.58170509771;7213.819654508679;7238.348548630648;7523.849523009619;7664.655090520829;7823.452358334862;8150.470219435718;8450;8465.873011904703;8584.399092063495;7050.717971281091;7108.684893294757;7488.925110748823;7597.2022937592965;7756.612169391621;7353.558786472829;7364.263573642593;7460.29127232912;7470.925290747023;7500.324970752658;6943.132108486439;7083.1854336749875;7085.078939737801;7104.680289387094;7106.822329441805;4229.809658565434;4967.3045773591;5006.224035274538;5022.899542009066;5048.444671086104;4962.33008543842;5004.599632029356;5051.848444546669;5115.4884511550035;5151.2273159026445 05:56:31 INFO - PROCESS | 1953 | |4;prototype.html;292.3334796663607;301.28144375664033;314.9008062460326;319.2752451934111;319.73142560249386;4426.734395936242;5297.735113244332;5336.893262134759;5351.224072509483;5398.757055932488;4311.361682560622;4795.1129041127415;5260.552853007499;5288.682679039261;5303.628745987782;3700.1674623209833;4102.179564087194;4115.54728979812;4116.115035267417;4136.5242997055275;3413.351463221992;3604.4773507841346;3928.8232029558594;4098.282800509914;4134.173165366924;3651;3804.2962052020325;4002.359622460407;4074.8777536673947;4087.6510751452097;3340.3486320167576;3437.9312413751586;4040.919181616351;4058.472398588194;4072.8778136655947;3519.5072689823446;3522.4716292556063;3530.2057037166687;3531.876384326536;3535.5757309122814;5014.2979982802435;5124.538791508782;5163.509466600667;5192.376914770214;5217.2695822584865;4238.3430568261965;4572.657050721209;4598.655100867449;4617.468991066037;4629.282461218517;5376.946230537684;5529.240116720628;5579.13523403873;5579.581531385163;5585.301837270341;3749.906252343686;3867.7292589518743;3882.301185786557;3906.4140378943102;3917.6669983051474;4939.3578834751615;5462.562994960394;5793.768249270024;5867.151847168128;5890.293164820207;3631.1285291529844;3743.1390780120723;3779.1874746929543;3839.4816699745734;3932.5477570079233;3453.2575496268423;3550.680438760524;4040.575739547364;4047.2680940365135;4056.965473804161;3677.687396571268;3943.290207762573;4410.095930334273;4626.814927402934;4660.813567457264;4795.688280261772;4997.125503036954;5440.878057557556;5576.693281869455;5605.579581531401;1264.8166015927638;1341.7920222365549;1360.1773623344766;1368.438940034581;1377.9793303100462;750.8535835512132;786.614558866163;841.3185319890908;860.9612567434356;865.2947847504264;3859.826307816099;4195.804195804181;4297.076128632297;4371.213181627338;4415.6909016368545;4102.400063975052;4262.531121576624;4284.4430224070675;4413.6248418884115;4783.736894470768;3642.5993140754495;3792.440102930566;3926.2343842950922;3994.820233089518;4361.753696846126;2201.2075652764993;2246.2699622622713;2294.6558016297354;2470.555300046009;2533.6959564852336;4582.097156043002;4977.809763703959;4979.751012449436;4988.052270068675;5023.949760502422;4024.2756303865585;4466.263066593976;4652.32541281519;4658.883527911829;4930.6795058321095;4156.607536475314;4324.983628847219;4447.221111555339;4749.905001899873;4787.640926930424;4429.712068715523;4739.194336962656;4770.689905156154;4782.991143719577;4791.227245919033;4138.110306284163;4708.293755936637;4721.504242054535;4742.715437073786;4753.809847606195;4172.979135104427;4408.170609197276;4633.710065853282;4768.809247630056;4961.5534601886;3395.5076513905838;3427.4919035624243;3429.8971030869116;3449.724022078278;3481.6344283850844;4819.421669399694;4834.492378300369;4840.975795121002;4852.975735121302;4860.538248866352;4081.8774237396983;4507.526709695566;4679.660169915042;4693.0992947856175;4908.7545622719435;4903.583195428429;5531.834044978657;5659.434056594308;5673.106715575169;5728.455796699307;4909.4845041270155;5518.475744804237;5564.944350556442;5566.135344659584;5575.944240557705;4916.680415772963;5326.9733651333045;5578.927383010344;5651.095824668033;5664.745086471036;5513.807016754395;5515.834524964257;5519.806806761905;5533.2253484513;5564.888702225851 05:56:31 INFO - PROCESS | 1953 | |5;yui.html;739.5119221313932;752.1012390193717;773.5977291808256;775.6238224461135;810.0684213154875;17341.30634774609;17673.204705788237;17676.292948282084;17720.468385948425;18102.5474363141;16562.751558726628;16742;16762.497125086265;16769.91615041926;16772.748408773878;687.3470203306854;714.3820595185153;760.8554374668795;845.26461978079;866.3935245328264;711.921688614252;848.1984524624232;860.0582362313288;880.5773228850156;884.3146561414891;907.4056492997097;908.7818923458356;912.1198043887647;912.3567884641345;913.1097180249237;711.3633298198084;899.8425275576781;900.5587262241454;901.441106513959;901.6799036342103;552.2103392149226;664.833791552112;683.0880774166494;685.7017197519045;692.3388164303078;15497.992630479095;15583.45457908979;15596.532104036896;15602.687946241012;15604.843951560453;11821.586244481401;13391.531296404579;13677;13749.175049497062;13761.31193440324;11307.208495405324;11757.118216133824;11820.349880756556;12677.74644507114;12814.29521376324;3805.2960202362374;3814.0464883779055;3857.6528112470014;3897.66869816066;3946.9013274668077;110317;115372.42313788462;116066.83933160645;117480;117992;10714.196435267386;10940.890591093987;10992.131337672616;11010.50452729629;11530.76938461226;20620.793792062188;21221;21835.563288734138;21852.781472185394;21859.234926777488;8064.274215320649;8107.067687215927;8171.673133074611;8176.059753128467;8176.550289734003;4400.867973960786;4450.332450132506;4566.26939689648;4707.105649926503;4719.457262414798;3586.65500437336;3689.409694448929;3695.630436956337;3734.0104872208885;3734.3278209922473;655.6295692933477;658.1411258307954;658.8221180281297;666.2271764752863;678.1963373402534;551.6827824001215;557.3729554251468;580.882682621841;605.6214865708932;639.2424976402978;9137.445482866044;9630.614775409045;9653.131218190396;9712.969117816168;9946.850797238047;581.8167277307634;622.2129006806393;671.9395254427125;676.2763842688277;679.8198477403492;4462.776861156929;4698.781981694884;4712;4747.018756366933;4806.255030470213;94724.0527594729;138930;150575;168839;168887;142730;142855;143331;148708;149165;119796.8020319803;125080.37459812642;125206.37396812957;126391.3680431592;128746;8995.505247211466;9168.633254669738;9179.403338782959;9194.31042671789;9351.672691455766;67367.98948015686;69565;69575.65212173907;70891.29108708847;70962;76043.61978190074;101976.45058873587;102273.48863255636;107690.46154769175;109751.45124274647;10975.231733778559;11203;11521.308721476738;11755.706107347043;12054.819177712518;12844.35778211067;13244.139130956457;13441.059125861097;13459.461621535029;13874.791878121634;11647.11296284388;12362.567310144103;12366.567170149001;12771.425285862344;12809.231446113263;11794.46924888365;11861.288322700666;11926.463309151282;12648.367581621067;12693.048021398248;11591.826122608336;11730.882691173321;11862.762744745229;12112.636620901387;12718.809217861555;8751.606177721891;8798.604062817316;9099.909000910171;9221.400608960395;9279.48962807025;9281.118293762082;9282.907170928474;9329.346945713734;9330.626774929198;9342.766430839283 05:56:31 INFO - PROCESS | 1953 | __end_tp_report 05:56:31 INFO - PROCESS | 1953 | __start_cc_report 05:56:31 INFO - PROCESS | 1953 | _x_x_mozilla_cycle_collect,1393 05:56:31 INFO - PROCESS | 1953 | __end_cc_report 05:56:31 INFO - PROCESS | 1953 | __startTimestamp1475844991723__endTimestamp 05:56:31 INFO - PROCESS | 1953 | 05:56:31 INFO - PROCESS | 1953 | ------- Summary: start ------- 05:56:31 INFO - PROCESS | 1953 | Number of tests: 6 05:56:31 INFO - PROCESS | 1953 | 05:56:31 INFO - PROCESS | 1953 | [#0] dojo.html Cycles:165 Average:5793.10 Median:6049.82 stddev:665.77 (11.0%) stddev-sans-first:639.26 05:56:31 INFO - PROCESS | 1953 | Values: 3334.4 3341.3 3375.5 3387.9 3412.1 5695.2 5705.2 5781.9 5791.8 5851.9 5662.1 5662.9 5789.5 5797.4 5801.1 4354.5 5218.0 5227.8 5252.2 5262.2 5238.8 5260.9 5263.6 5313.0 5379.4 5221.2 5293.6 5302.7 5334.4 5359.0 5222.8 5223.5 5246.4 5275.3 5285.8 5154.7 5206.1 5238.6 5239.3 5264.7 5671.2 5680.3 5731.1 5738.0 5741.2 5173.8 5188.7 6202.8 6245.7 6254.8 5198.7 6327.1 6332.5 6342.6 6365.1 5753.0 5773.6 5795.3 5817.3 5823.3 6269.4 6308.7 6349.6 6360.9 6368.1 6219.8 6248.3 6251.5 6263.5 6275.8 6187.1 6195.8 6340.4 6348.9 6355.2 6189.0 6198.6 6237.0 6329.8 6348.8 6288.7 6304.0 6308.2 6326.5 6341.8 4883.9 4917.9 4964.7 4989.4 5009.9 4444.3 4448.0 4475.8 4494.8 4521.8 5943.6 5945.6 5957.9 5973.1 5993.1 6141.7 6285.0 6316.5 6319.3 6326.0 5753.2 5767.7 5823.3 5823.9 5824.3 5377.7 5415.9 5428.0 5428.3 5440.1 6300.1 6322.8 6378.2 6404.9 6491.7 6283.7 6302.9 6311.0 6317.6 6320.1 6231.0 6472.8 6490.9 6494.2 6496.4 6174.6 6178.6 6226.7 6229.9 6270.5 6331.2 6344.7 6348.7 6353.6 6359.2 6049.8 6130.2 6237.9 6243.5 6256.6 6041.3 6106.2 6129.6 6222.6 6225.0 6048.9 6075.3 6105.8 6155.7 6164.0 6144.9 6208.4 6270.2 6291.3 6298.1 5828.7 6024.2 6103.1 6105.0 6123.2 05:56:31 INFO - PROCESS | 1953 | 05:56:31 INFO - PROCESS | 1953 | [#1] ext.html Cycles:180 Average:68860.80 Median:35920.37 stddev:149681.25 (416.7%) stddev-sans-first:150013.08 05:56:31 INFO - PROCESS | 1953 | Values: 477.4 488.6 496.2 514.6 532.8 30563.1 40656.4 41727.0 41872.0 43970.8 43091.6 43477.3 43511.6 43565.0 43659.7 8800.9 9862.7 10044.5 10058.3 10072.1 8764.7 9031.3 9032.1 9036.5 12166.8 12255.8 12373.3 12400.0 12408.8 12456.5 12327.7 12359.6 12394.0 12404.9 12418.9 12164.2 12274.8 12285.4 12292.8 12297.9 41490.4 41767.4 41831.0 41940.2 42016.4 2733.3 3093.6 3334.3 3601.6 4044.0 21061.7 26234.3 26948.5 27425.0 28042.7 3165.8 3181.7 3246.7 3254.0 3321.5 490167.0 490732.0 491881.0 492189.0 494324.1 50384.0 61796.7 62217.0 62462.4 62489.1 33839.0 35195.6 35220.5 36206.6 36293.8 17123.5 17275.7 17282.0 17294.7 17295.2 13148.7 13256.2 13277.4 13279.3 13296.5 16416.4 17024.6 17272.9 17338.0 19266.1 7361.7 7507.0 7760.5 7792.8 7902.0 769.9 885.7 1035.9 1063.1 1100.7 29909.9 29952.4 30270.8 30582.8 30858.0 891.6 1028.9 1070.7 1074.1 1147.6 15439.3 15975.5 16028.6 16112.4 16415.9 657684.0 659912.0 661477.0 662460.0 664298.0 59384.0 59824.0 59923.4 59948.7 60020.7 1210.2 1259.0 1262.6 1339.4 1348.7 30275.7 32113.8 32181.7 32632.9 32848.5 49643.0 50348.7 50402.0 50508.5 50534.5 511602.0 513028.0 513427.0 514008.0 514176.0 26747.7 26887.1 27324.2 27333.2 28239.4 40249.4 47820.5 48998.3 49146.3 49252.0 39046.2 39323.8 39851.8 40016.0 41052.8 40012.6 40063.8 40458.0 40778.8 41706.6 38729.1 38833.0 39458.2 39590.4 39803.0 33749.0 35138.8 35899.8 35940.9 36053.8 25759.7 26130.7 26147.6 26175.3 26638.0 05:56:31 INFO - PROCESS | 1953 | 05:56:31 INFO - PROCESS | 1953 | [#2] jquery.html Cycles:180 Average:33687.40 Median:25365.30 stddev:94543.74 (372.7%) stddev-sans-first:94775.77 05:56:31 INFO - PROCESS | 1953 | Values: 327.3 351.0 367.6 368.7 396.1 12742.9 13844.0 15715.8 20576.0 21355.5 20151.5 20661.5 20678.5 20682.5 20950.0 5782.3 6047.9 6095.1 6111.4 6114.2 5347.6 5605.5 5949.9 6034.7 6087.0 5690.3 5692.5 5697.2 5699.6 5706.3 5390.7 5551.9 5618.2 5684.1 5696.6 5453.8 5455.6 5457.0 5458.3 5461.2 12961.4 13902.6 21415.0 25211.6 25519.0 2183.6 2270.3 2369.4 2631.8 2984.0 9654.4 10090.1 10126.4 10144.4 11793.9 1867.3 1888.2 1932.4 1951.8 1962.7 112683.0 116210.0 121799.4 131325.7 134072.0 8965.7 9306.9 11253.5 11632.5 11825.9 14492.6 14500.6 14510.4 14510.7 14523.3 8360.5 8380.7 8643.4 8722.0 8744.2 8559.6 8573.7 8597.1 8724.6 8737.4 4423.5 4474.5 4492.7 4537.8 4545.1 1509.7 1695.5 1834.5 1865.7 1921.4 812.8 913.2 922.4 929.4 963.2 20399.7 20898.7 20907.3 20952.6 21005.0 926.5 932.6 941.2 966.9 971.5 10643.5 10901.6 11089.5 11122.9 11186.7 553506.0 556017.0 560891.0 574604.0 577267.0 100348.8 101072.5 113541.0 133301.0 142122.3 996.5 1016.0 1024.3 1042.7 1042.9 17840.9 18549.4 18931.0 19143.6 19228.7 53626.0 54570.5 55166.7 55313.7 58064.4 74472.3 77533.0 77984.6 78532.8 79700.2 6780.4 7871.7 7878.6 7883.2 8173.1 10211.4 12461.5 12545.3 12685.2 12865.9 10820.9 10866.7 10979.1 11190.6 11331.3 8901.6 10812.0 10942.0 11161.6 11337.6 10767.9 11102.8 11136.9 11289.7 11420.7 7770.7 7922.7 7935.0 8050.4 8146.4 8481.6 10754.0 10761.2 10784.8 10994.0 05:56:31 INFO - PROCESS | 1953 | 05:56:31 INFO - PROCESS | 1953 | [#3] mootools.html Cycles:180 Average:5723.76 Median:4964.82 stddev:3199.91 (64.5%) stddev-sans-first:3192.10 05:56:31 INFO - PROCESS | 1953 | Values: 1362.2 1528.6 1668.5 1810.8 1852.9 8476.3 8981.8 9001.8 9003.0 9007.5 7824.7 8048.2 8064.6 8566.1 8768.6 2382.4 2428.6 2431.1 2433.0 2434.1 2385.3 2411.5 2421.5 2423.3 2424.6 2392.3 2398.9 2400.0 2428.9 2429.7 2386.3 2392.6 2405.4 2405.7 2413.1 2392.1 2398.7 2402.1 2406.0 2407.1 8627.2 8962.7 9029.4 9046.0 9065.0 5195.8 5375.4 5379.3 5383.6 5389.6 3501.4 3629.6 3694.2 3703.7 3713.1 985.6 1036.4 1059.0 1090.2 1103.0 11615.0 11753.1 11768.9 11771.5 11775.9 4568.3 4648.2 4843.0 4843.0 4855.6 10000.1 10013.2 10025.3 10033.3 10036.5 5398.4 5398.9 5404.5 5404.8 5414.3 4419.8 4604.4 4769.7 4905.5 4945.6 3921.5 3970.4 4022.1 4061.8 4126.3 1294.6 1304.9 1305.8 1314.8 1317.9 767.8 805.7 880.9 913.5 924.1 5541.4 5807.0 5830.7 5981.3 6087.9 897.2 911.3 937.3 945.8 965.1 3779.7 3805.9 3915.8 3923.1 3956.8 10634.8 10763.2 10768.6 10992.7 11007.4 10827.1 10932.4 10944.4 10944.4 10964.6 6448.8 8132.8 8293.1 8298.8 8309.2 5377.4 5555.9 5907.9 6053.5 6132.0 8778.8 9756.3 9765.7 9836.0 9863.5 10004.9 10163.9 10339.8 10373.6 10378.7 6971.6 7213.8 7238.3 7523.8 7664.7 7823.5 8150.5 8450.0 8465.9 8584.4 7050.7 7108.7 7488.9 7597.2 7756.6 7353.6 7364.3 7460.3 7470.9 7500.3 6943.1 7083.2 7085.1 7104.7 7106.8 4229.8 4967.3 5006.2 5022.9 5048.4 4962.3 5004.6 5051.8 5115.5 5151.2 05:56:31 INFO - PROCESS | 1953 | 05:56:31 INFO - PROCESS | 1953 | [#4] prototype.html Cycles:180 Average:4195.59 Median:4540.09 stddev:1269.45 (28.0%) stddev-sans-first:1238.75 05:56:31 INFO - PROCESS | 1953 | Values: 292.3 301.3 314.9 319.3 319.7 4426.7 5297.7 5336.9 5351.2 5398.8 4311.4 4795.1 5260.6 5288.7 5303.6 3700.2 4102.2 4115.5 4116.1 4136.5 3413.4 3604.5 3928.8 4098.3 4134.2 3651.0 3804.3 4002.4 4074.9 4087.7 3340.3 3437.9 4040.9 4058.5 4072.9 3519.5 3522.5 3530.2 3531.9 3535.6 5014.3 5124.5 5163.5 5192.4 5217.3 4238.3 4572.7 4598.7 4617.5 4629.3 5376.9 5529.2 5579.1 5579.6 5585.3 3749.9 3867.7 3882.3 3906.4 3917.7 4939.4 5462.6 5793.8 5867.2 5890.3 3631.1 3743.1 3779.2 3839.5 3932.5 3453.3 3550.7 4040.6 4047.3 4057.0 3677.7 3943.3 4410.1 4626.8 4660.8 4795.7 4997.1 5440.9 5576.7 5605.6 1264.8 1341.8 1360.2 1368.4 1378.0 750.9 786.6 841.3 861.0 865.3 3859.8 4195.8 4297.1 4371.2 4415.7 4102.4 4262.5 4284.4 4413.6 4783.7 3642.6 3792.4 3926.2 3994.8 4361.8 2201.2 2246.3 2294.7 2470.6 2533.7 4582.1 4977.8 4979.8 4988.1 5023.9 4024.3 4466.3 4652.3 4658.9 4930.7 4156.6 4325.0 4447.2 4749.9 4787.6 4429.7 4739.2 4770.7 4783.0 4791.2 4138.1 4708.3 4721.5 4742.7 4753.8 4173.0 4408.2 4633.7 4768.8 4961.6 3395.5 3427.5 3429.9 3449.7 3481.6 4819.4 4834.5 4841.0 4853.0 4860.5 4081.9 4507.5 4679.7 4693.1 4908.8 4903.6 5531.8 5659.4 5673.1 5728.5 4909.5 5518.5 5564.9 5566.1 5575.9 4916.7 5327.0 5578.9 5651.1 5664.7 5513.8 5515.8 5519.8 5533.2 5564.9 05:56:31 INFO - PROCESS | 1953 | 05:56:31 INFO - PROCESS | 1953 | [#5] yui.html Cycles:180 Average:26043.80 Median:3877.66 stddev:42674.37 (1100.5%) stddev-sans-first:42751.78 05:56:31 INFO - PROCESS | 1953 | Values: 739.5 752.1 773.6 775.6 810.1 17341.3 17673.2 17676.3 17720.5 18102.5 16562.8 16742.0 16762.5 16769.9 16772.7 687.3 714.4 760.9 845.3 866.4 711.9 848.2 860.1 880.6 884.3 907.4 908.8 912.1 912.4 913.1 711.4 899.8 900.6 901.4 901.7 552.2 664.8 683.1 685.7 692.3 15498.0 15583.5 15596.5 15602.7 15604.8 11821.6 13391.5 13677.0 13749.2 13761.3 11307.2 11757.1 11820.3 12677.7 12814.3 3805.3 3814.0 3857.7 3897.7 3946.9 110317.0 115372.4 116066.8 117480.0 117992.0 10714.2 10940.9 10992.1 11010.5 11530.8 20620.8 21221.0 21835.6 21852.8 21859.2 8064.3 8107.1 8171.7 8176.1 8176.6 4400.9 4450.3 4566.3 4707.1 4719.5 3586.7 3689.4 3695.6 3734.0 3734.3 655.6 658.1 658.8 666.2 678.2 551.7 557.4 580.9 605.6 639.2 9137.4 9630.6 9653.1 9713.0 9946.9 581.8 622.2 671.9 676.3 679.8 4462.8 4698.8 4712.0 4747.0 4806.3 94724.1 138930.0 150575.0 168839.0 168887.0 142730.0 142855.0 143331.0 148708.0 149165.0 119796.8 125080.4 125206.4 126391.4 128746.0 8995.5 9168.6 9179.4 9194.3 9351.7 67368.0 69565.0 69575.7 70891.3 70962.0 76043.6 101976.5 102273.5 107690.5 109751.5 10975.2 11203.0 11521.3 11755.7 12054.8 12844.4 13244.1 13441.1 13459.5 13874.8 11647.1 12362.6 12366.6 12771.4 12809.2 11794.5 11861.3 11926.5 12648.4 12693.0 11591.8 11730.9 11862.8 12112.6 12718.8 8751.6 8798.6 9099.9 9221.4 9279.5 9281.1 9282.9 9329.3 9330.6 9342.8 05:56:31 INFO - PROCESS | 1953 | -------- Summary: end -------- 05:56:31 INFO - PROCESS | 1953 | 05:56:32 INFO - TEST-INFO | 1953: exit 0 05:56:32 INFO - TEST-OK | dromaeo_css | took 1117731ms 05:56:32 INFO - TEST-START | kraken 05:56:32 INFO - operating with platform_type : mac_ 05:56:32 INFO - Initialising browser for kraken test... 05:56:32 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpj0VrIB/profile http://localhost:54412/getInfo.html) 05:56:34 INFO - PROCESS | 1959 | __metrics Screen width/height:1600/1200 05:56:34 INFO - PROCESS | 1959 | colorDepth:24 05:56:34 INFO - PROCESS | 1959 | Browser inner width/height: 1024/689 05:56:34 INFO - PROCESS | 1959 | __metrics 05:56:34 INFO - PROCESS | 1959 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:56:34 INFO - PROCESS | 1959 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:56:35 INFO - TEST-INFO | 1959: exit 0 05:56:35 INFO - Browser initialized. 05:56:35 INFO - Running cycle 1/1 for kraken test... 05:56:35 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpj0VrIB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:56:47 INFO - PROCESS | 1960 | RSS: Main: 219705344 05:56:47 INFO - PROCESS | 1960 | 05:56:50 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54412/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54412/tests/kraken/driver.html?testName=audio-beat-detection) 05:56:51 INFO - PROCESS | 1960 | RSS: Main: 269422592 05:56:51 INFO - PROCESS | 1960 | 05:56:53 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54412/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54412/tests/kraken/driver.html?testName=audio-dft) 05:56:54 INFO - PROCESS | 1960 | RSS: Main: 280031232 05:56:54 INFO - PROCESS | 1960 | 05:56:57 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54412/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54412/tests/kraken/driver.html?testName=audio-fft) 05:56:58 INFO - PROCESS | 1960 | RSS: Main: 378548224 05:56:58 INFO - PROCESS | 1960 | 05:57:00 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54412/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54412/tests/kraken/driver.html?testName=audio-oscillator) 05:57:01 INFO - PROCESS | 1960 | RSS: Main: 279494656 05:57:01 INFO - PROCESS | 1960 | 05:57:03 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54412/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54412/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:57:03 INFO - PROCESS | 1960 | RSS: Main: 280182784 05:57:03 INFO - PROCESS | 1960 | 05:57:06 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54412/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54412/tests/kraken/driver.html?testName=imaging-darkroom) 05:57:06 INFO - PROCESS | 1960 | RSS: Main: 318218240 05:57:06 INFO - PROCESS | 1960 | 05:57:09 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54412/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54412/tests/kraken/driver.html?testName=imaging-desaturate) 05:57:10 INFO - PROCESS | 1960 | RSS: Main: 319463424 05:57:10 INFO - PROCESS | 1960 | 05:57:13 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54412/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54412/tests/kraken/driver.html?testName=json-parse-financial) 05:57:13 INFO - PROCESS | 1960 | RSS: Main: 317853696 05:57:13 INFO - PROCESS | 1960 | 05:57:15 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54412/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54412/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:57:15 INFO - PROCESS | 1960 | RSS: Main: 288931840 05:57:15 INFO - PROCESS | 1960 | 05:57:17 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54412/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54412/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:57:18 INFO - PROCESS | 1960 | RSS: Main: 294940672 05:57:18 INFO - PROCESS | 1960 | 05:57:20 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54412/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54412/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:57:21 INFO - PROCESS | 1960 | RSS: Main: 297701376 05:57:21 INFO - PROCESS | 1960 | 05:57:24 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54412/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:57:24 INFO - PROCESS | 1960 | RSS: Main: 306593792 05:57:24 INFO - PROCESS | 1960 | 05:57:27 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:57:28 INFO - PROCESS | 1960 | RSS: Main: 306909184 05:57:28 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54412/tests/kraken/driver.html?testName=ai-astar) 05:57:30 INFO - PROCESS | 1960 | RSS: Main: 350085120 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | __start_tp_report 05:57:30 INFO - PROCESS | 1960 | _x_x_mozilla_page_load 05:57:30 INFO - PROCESS | 1960 | _x_x_mozilla_page_load_details 05:57:30 INFO - PROCESS | 1960 | |i|pagename|runs| 05:57:30 INFO - PROCESS | 1960 | |0;ai-astar;115;112;115;115;115;116;114;114;114;113 05:57:30 INFO - PROCESS | 1960 | |1;audio-beat-detection;144;111;110;141;111;110;108;109;144;107 05:57:30 INFO - PROCESS | 1960 | |2;audio-dft;185;198;265;201;188;185;184;184;184;183 05:57:30 INFO - PROCESS | 1960 | |3;audio-fft;83;60;58;89;60;58;59;59;83;57 05:57:30 INFO - PROCESS | 1960 | |4;audio-oscillator;86;70;96;71;68;69;91;68;68;89 05:57:30 INFO - PROCESS | 1960 | |5;imaging-gaussian-blur;87;83;87;84;85;82;87;84;87;83 05:57:30 INFO - PROCESS | 1960 | |6;imaging-darkroom;92;94;93;93;93;92;92;92;93;92 05:57:30 INFO - PROCESS | 1960 | |7;imaging-desaturate;85;85;84;86;84;82;85;84;83;85 05:57:30 INFO - PROCESS | 1960 | |8;json-parse-financial;56;49;49;51;54;58;56;56;55;55 05:57:30 INFO - PROCESS | 1960 | |9;json-stringify-tinderbox;67;81;71;72;70;67;69;68;74;69 05:57:30 INFO - PROCESS | 1960 | |10;stanford-crypto-aes;82;80;82;82;85;82;85;82;81;85 05:57:30 INFO - PROCESS | 1960 | |11;stanford-crypto-ccm;139;140;139;130;131;141;140;141;171;135 05:57:30 INFO - PROCESS | 1960 | |12;stanford-crypto-pbkdf2;177;228;187;162;163;164;161;163;160;162 05:57:30 INFO - PROCESS | 1960 | |13;stanford-crypto-sha256-iterative;64;64;67;67;66;67;67;67;66;67 05:57:30 INFO - PROCESS | 1960 | __end_tp_report 05:57:30 INFO - PROCESS | 1960 | __start_cc_report 05:57:30 INFO - PROCESS | 1960 | _x_x_mozilla_cycle_collect,1920 05:57:30 INFO - PROCESS | 1960 | __end_cc_report 05:57:30 INFO - PROCESS | 1960 | __startTimestamp1475845050305__endTimestamp 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | ------- Summary: start ------- 05:57:30 INFO - PROCESS | 1960 | Number of tests: 14 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:1.16 (1.0%) stddev-sans-first:1.20 05:57:30 INFO - PROCESS | 1960 | Values: 115.0 112.0 115.0 115.0 115.0 116.0 114.0 114.0 114.0 113.0 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | [#1] audio-beat-detection Cycles:10 Average:119.50 Median:111.00 stddev:16.28 (14.7%) stddev-sans-first:14.66 05:57:30 INFO - PROCESS | 1960 | Values: 144.0 111.0 110.0 141.0 111.0 110.0 108.0 109.0 144.0 107.0 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | [#2] audio-dft Cycles:10 Average:195.70 Median:186.50 stddev:25.16 (13.5%) stddev-sans-first:26.38 05:57:30 INFO - PROCESS | 1960 | Values: 185.0 198.0 265.0 201.0 188.0 185.0 184.0 184.0 184.0 183.0 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | [#3] audio-fft Cycles:10 Average:66.60 Median:60.00 stddev:12.83 (21.4%) stddev-sans-first:12.16 05:57:30 INFO - PROCESS | 1960 | Values: 83.0 60.0 58.0 89.0 60.0 58.0 59.0 59.0 83.0 57.0 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.50 stddev:11.40 (14.5%) stddev-sans-first:11.68 05:57:30 INFO - PROCESS | 1960 | Values: 86.0 70.0 96.0 71.0 68.0 69.0 91.0 68.0 68.0 89.0 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:86.00 stddev:1.97 (2.3%) stddev-sans-first:1.94 05:57:30 INFO - PROCESS | 1960 | Values: 87.0 83.0 87.0 84.0 85.0 82.0 87.0 84.0 87.0 83.0 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 05:57:30 INFO - PROCESS | 1960 | Values: 92.0 94.0 93.0 93.0 93.0 92.0 92.0 92.0 93.0 92.0 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:85.00 stddev:1.16 (1.4%) stddev-sans-first:1.20 05:57:30 INFO - PROCESS | 1960 | Values: 85.0 85.0 84.0 86.0 84.0 82.0 85.0 84.0 83.0 85.0 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:55.50 stddev:3.14 (5.7%) stddev-sans-first:3.24 05:57:30 INFO - PROCESS | 1960 | Values: 56.0 49.0 49.0 51.0 54.0 58.0 56.0 56.0 55.0 55.0 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:70.50 stddev:4.21 (6.0%) stddev-sans-first:4.24 05:57:30 INFO - PROCESS | 1960 | Values: 67.0 81.0 71.0 72.0 70.0 67.0 69.0 68.0 74.0 69.0 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:1.78 (2.2%) stddev-sans-first:1.87 05:57:30 INFO - PROCESS | 1960 | Values: 82.0 80.0 82.0 82.0 85.0 82.0 85.0 82.0 81.0 85.0 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:140.00 stddev:11.38 (8.1%) stddev-sans-first:12.06 05:57:30 INFO - PROCESS | 1960 | Values: 139.0 140.0 139.0 130.0 131.0 141.0 140.0 141.0 171.0 135.0 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:163.50 stddev:21.27 (13.0%) stddev-sans-first:22.50 05:57:30 INFO - PROCESS | 1960 | Values: 177.0 228.0 187.0 162.0 163.0 164.0 161.0 163.0 160.0 162.0 05:57:30 INFO - PROCESS | 1960 | 05:57:30 INFO - PROCESS | 1960 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.01 05:57:30 INFO - PROCESS | 1960 | Values: 64.0 64.0 67.0 67.0 66.0 67.0 67.0 67.0 66.0 67.0 05:57:30 INFO - PROCESS | 1960 | -------- Summary: end -------- 05:57:30 INFO - PROCESS | 1960 | 05:57:31 INFO - TEST-INFO | 1960: exit 0 05:57:31 INFO - TEST-OK | kraken | took 58708ms 05:57:31 INFO - SUITE-END | took 1176s 05:57:31 INFO - Completed test suite (00:19:36) 05:57:31 INFO - javascript benchmark 05:57:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3334.3831391192625, 3341.3150304187643, 3375.544301519296, 3387.8814241501555, 3412.146963259185, 5695.202671625976, 5705.229793977812, 5781.884362312761, 5791.8262452126455, 5851.912221316678, 5662.094064949609, 5662.858428539278, 5789.507891829189, 5797.36229014808, 5801.129830525423, 4354.499232588261, 5217.982493413767, 5227.79088836446, 5252.185911183773, 5262.236975638531, 5238.764255608507, 5260.947390526084, 5263.631545791777, 5312.963972025456, 5379.435159308275, 5221.164613661815, 5293.6294459387855, 5302.734863256841, 5334.439883812202, 5359.0, 5222.764975576109, 5223.477652234784, 5246.37043554772, 5275.261463395128, 5285.814996475144, 5154.742262886878, 5206.062908676437, 5238.554722848562, 5239.266502689627, 5264.684118952875, 5671.2060311556415, 5680.346760122557, 5731.083026715747, 5738.0, 5741.19623252745, 5173.793048278064, 5188.662736922088, 6202.844928876769, 6245.687715614201, 6254.843628909268, 5198.714070726109, 6327.050942358637, 6332.4934005279465, 6342.587731797418, 6365.077063825719, 5752.993226185443, 5773.566982476331, 5795.304563452412, 5817.301923769175, 5823.272090988627, 6269.404406581368, 6308.653024083719, 6349.619022858643, 6360.9045864312075, 6368.076628888878, 6219.844503887439, 6248.31268560458, 6251.468625166821, 6263.498920086382, 6275.780347687901, 6187.133801267826, 6195.845103872349, 6340.4293613575, 6348.904766428507, 6355.1738274025, 6189.04069869171, 6198.6280823150755, 6236.968815155895, 6329.778457753957, 6348.777792777323, 6288.717007734663, 6304.0, 6308.211473565804, 6326.49388048955, 6341.8097457076365, 4883.926741098886, 4917.901641967141, 4964.652474326835, 4989.351384320088, 5009.899802004013, 4444.31113177458, 4447.999200179934, 4475.776211189427, 4494.842680506166, 4521.773911304422, 5943.613665111754, 5945.643261404243, 5957.940420595825, 5973.074173503027, 5993.0710739835395, 6141.670122563582, 6285.0, 6316.494680425555, 6319.33646967071, 6325.968370158212, 5753.194552762617, 5767.711614419346, 5823.30120385548, 5823.88352232953, 5824.3302020267365, 5377.7311134443125, 5415.945840541623, 5428.0, 5428.2671839301975, 5440.129579267298, 6300.054991751183, 6322.778702745381, 6378.202724659325, 6404.935950640434, 6491.675416229265, 6283.748650053946, 6302.936970630235, 6311.0, 6317.620942743266, 6320.051992201206, 6231.0, 6472.805815825533, 6490.870182596416, 6494.220693516808, 6496.415322620798, 6174.629522228681, 6178.567500274938, 6226.688665566794, 6229.906551401642, 6270.49836013127, 6331.240251169705, 6344.714487847966, 6348.714307856065, 6353.5870168438905, 6359.236891573041, 6049.818505444844, 6130.233720784902, 6237.906431403623, 6243.531735119794, 6256.624602523863, 6041.335453100068, 6106.217989796568, 6129.601575897553, 6222.595531290452, 6225.0, 6048.90926636092, 6075.3317135115985, 6105.8168254952425, 6155.72299246526, 6164.044573091178, 6144.938550614436, 6208.441240288395, 6270.184875966095, 6291.276503202007, 6298.08677741734, 5828.70856457167, 6024.186734790747, 6103.115048318058, 6105.0, 6123.234595675541], "value": 5749.87612421611, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.427087495006, 488.6213184781794, 496.1664403801612, 514.6037551085662, 532.835753877777, 30563.083107506784, 40656.39015414767, 41727.0, 41872.0, 43970.78014609931, 43091.56908430915, 43477.34783978243, 43511.564884351144, 43565.0, 43659.690209293774, 8800.8679869802, 9862.704118876445, 10044.54799534019, 10058.346207496526, 10072.093511583957, 8764.737057888273, 9031.27749780016, 9032.096790320948, 9036.50299233542, 12166.81749773754, 12255.816162757566, 12373.257604543756, 12400.0, 12408.82845502038, 12456.501739930438, 12327.691807704834, 12359.62921112368, 12394.0, 12404.875951240552, 12418.875811241953, 12164.209326393757, 12274.754504909852, 12285.447154878051, 12292.815607765891, 12297.938510307391, 41490.377644335356, 41767.37348939768, 41831.0, 41940.1611967762, 42016.369754453706, 2733.330334068146, 3093.566900633913, 3334.3164651246434, 3601.6038235794304, 4043.9595604043875, 21061.68407473874, 26234.344141396617, 26948.461030779472, 27425.0, 28042.719572804213, 3165.838394993548, 3181.650018497963, 3246.6753324667343, 3254.0, 3321.485169798685, 490167.0, 490732.0, 491881.0, 492189.0, 494324.0567594314, 50384.0, 61796.69101654463, 62217.0, 62462.375376246564, 62489.062664060075, 33839.0, 35195.648043519235, 35220.47169292463, 36206.637933620856, 36293.81853090718, 17123.486295411156, 17275.654486910193, 17282.0, 17294.65410691779, 17295.221715022853, 13148.671283217996, 13256.204627722367, 13277.402516886763, 13279.26964016969, 13296.468141274434, 16416.425425110065, 17024.57438564046, 17272.877262977865, 17337.959722416694, 19266.123608100814, 7361.742339018108, 7507.0, 7760.495567788075, 7792.8051798704355, 7902.0, 769.9230076992256, 885.703289398046, 1035.8549803027581, 1063.0910571461288, 1100.7028102412464, 29909.850450747606, 29952.400951981275, 30270.84864575663, 30582.847085764875, 30858.0, 891.5675897189858, 1028.9073983341386, 1070.7055559721139, 1074.0548317480723, 1147.6040765935738, 15439.30523126462, 15975.520734377755, 16028.599285017735, 16112.436064737678, 16415.91792041032, 657684.0, 659912.0, 661477.0, 662460.0, 664298.0, 59384.0, 59824.0, 59923.40076599266, 59948.700256498436, 60020.699896500235, 1210.1710328425056, 1258.993705031469, 1262.5770366927, 1339.397271227932, 1348.6965432777547, 30275.70625987175, 32113.8394308027, 32181.678183218806, 32632.857849976088, 32848.50727239141, 49643.00713985772, 50348.748256258485, 50402.0, 50508.49491505038, 50534.49465505298, 511602.0, 513028.0, 513427.0, 514008.0, 514176.0, 26747.732522675302, 26887.058952936553, 27324.180274591796, 27333.180004599893, 28239.435211295247, 40249.396259056724, 47820.521794781605, 48998.26502602535, 49146.262806057224, 49252.0, 39046.219075618894, 39323.803380982914, 39851.80074099611, 40016.0, 41052.794736027325, 40012.59987400089, 40063.79968100141, 40457.98855028648, 40778.776636700946, 41706.58293417027, 38729.127087291046, 38833.0, 39458.21083578255, 39590.40614390844, 39803.0, 33748.98753037413, 35138.77014304589, 35899.82050089733, 35940.92177234687, 36053.81973090118, 25759.742402575735, 26130.73869261359, 26147.607785883607, 26175.345616359744, 26638.0], "value": 20150.112712247344, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.28324968319384, 351.0171519744714, 367.61951380321375, 368.67556550235787, 396.0731887383522, 12742.872571274296, 13844.0, 15715.84284157158, 20576.0, 21355.466113347135, 20151.49621259469, 20661.483462913435, 20678.48303792406, 20682.48293792656, 20950.0, 5782.335031471382, 6047.909281360783, 6095.146679464879, 6111.388861113897, 6114.2357205349335, 5347.59893008024, 5605.523530499892, 5949.851253718648, 6034.728437220314, 6087.026075827868, 5690.317161940552, 5692.5161361284345, 5697.202391665171, 5699.629524080921, 5706.28671416073, 5390.676559406448, 5551.861203469905, 5618.2415373924405, 5684.118961560965, 5696.601237913327, 5453.836384908459, 5455.618106732531, 5457.045017121988, 5458.263134476834, 5461.2354270401775, 12961.416736246798, 13902.582922512342, 21415.036323365486, 25211.621825672628, 25518.979240830344, 2183.563287342522, 2270.3189043286948, 2369.3958040699513, 2631.815772895898, 2984.0301901881976, 9654.372465789702, 10090.142337901214, 10126.392416454963, 10144.442055686934, 11793.882061179364, 1867.3090956346239, 1888.1503323504342, 1932.4009557037223, 1951.7950615185343, 1962.6761584338567, 112682.96329520803, 116210.0, 121799.3910030453, 131325.6867431323, 134072.0, 8965.731028069169, 9306.86039709405, 11253.549858005588, 11632.53469861196, 11825.940870295593, 14492.637684057772, 14500.607399778919, 14510.419583216764, 14510.709785804225, 14523.273836308143, 8360.498370097814, 8380.748577542561, 8643.438176518506, 8722.040575536686, 8744.169303916118, 8559.57202139903, 8573.699920502753, 8597.054324024351, 8724.563771811385, 8737.38838281327, 4423.469183697976, 4474.530174331649, 4492.730436173774, 4537.8411755588395, 4545.136424079415, 1509.6527798606382, 1695.4571340080468, 1834.4773837714665, 1865.7406250780668, 1921.4331772127257, 812.8130529978138, 913.2146354135439, 922.3866129024124, 929.3782349799508, 963.1572374172599, 20399.694004589943, 20898.686519702216, 20907.26824561133, 20952.580948380946, 21005.0, 926.5228407370209, 932.6222879733718, 941.1999800169801, 966.8791401074866, 971.5190980464715, 10643.52104155315, 10901.563937442414, 11089.500972456259, 11122.944385278022, 11186.664400068012, 553506.0, 556017.0, 560891.0, 574604.0, 577267.0, 100348.79317561175, 101072.49463752781, 113541.0, 133301.0004849928, 142122.28938855446, 996.5415908681942, 1016.0, 1024.329064462793, 1042.7393151712072, 1042.8592140061146, 17840.91079544594, 18549.443516694522, 18931.0, 19143.617127657646, 19228.71156932619, 53626.0, 54570.45429545813, 55166.72416638052, 55313.72343138258, 58064.4193558059, 74472.25527744653, 77533.0, 77984.61007694925, 78532.82200766879, 79700.20299796927, 6780.38976492118, 7871.724489642835, 7878.606069696607, 7883.172266911892, 8173.141820109041, 10211.438370889673, 12461.501539938301, 12545.31000794965, 12685.23888566689, 12865.935670321589, 10820.89179108199, 10866.728331791768, 10979.121670266519, 11190.608328708457, 11331.320120792449, 8901.643934242558, 10812.0, 10942.0, 11161.609343672932, 11337.603183888525, 10767.946160269148, 11102.833457497982, 11136.944315278372, 11289.71775705581, 11420.657380278604, 7770.728024519115, 7922.683092676459, 7935.0, 8050.355971522147, 8146.389020823581, 8481.57592120404, 10754.0, 10761.192910531585, 10784.838227426439, 10994.0], "value": 9358.927580346583, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.1963041805336, 1528.5719998400446, 1668.499450164951, 1810.8008119106905, 1852.9258829646806, 8476.32189424846, 8981.775455613613, 9001.819963600725, 9002.9646590642, 9007.54962251888, 7824.687012519506, 8048.154943730911, 8064.556449395281, 8566.100559441247, 8768.649254029848, 2382.356763673811, 2428.64784606232, 2431.0640403444622, 2432.9878350608224, 2434.075051480435, 2385.3321070100315, 2411.517696460715, 2421.4551725861716, 2423.333583264599, 2424.5514579802707, 2392.28231530541, 2398.8680622565753, 2400.0279886645935, 2428.878556072198, 2429.744876787938, 2386.3079706884982, 2392.569337519246, 2405.446747248125, 2405.675233843435, 2413.1071503543626, 2392.0551382204108, 2398.70016247969, 2402.1232250228713, 2405.9759402405925, 2407.0973384980634, 8627.223549880478, 8962.68630597926, 9029.367944243906, 9046.0, 9065.0, 5195.844124676266, 5375.381831089397, 5379.300690910196, 5383.596230282745, 5389.622726409153, 3501.422265326218, 3629.6370362963494, 3694.18727879866, 3703.703703703697, 3713.0531714412923, 985.6451677396132, 1036.4092467293647, 1058.968230953065, 1090.1551297744231, 1102.9834552481718, 11615.0, 11753.118516111326, 11768.940795328546, 11771.470283837249, 11775.940165385071, 4568.269076947672, 4648.209804333272, 4842.982973575518, 4843.0313937212695, 4855.562999330077, 10000.14998725102, 10013.249006324555, 10025.348352357074, 10033.347832390871, 10036.498175091216, 5398.379186393537, 5398.946010539844, 5404.54061404785, 5404.756785944642, 5414.3232095988005, 4419.823207071681, 4604.401427814362, 4769.66612337133, 4905.533974272438, 4945.629077819178, 3921.5490218624655, 3970.4441378207075, 4022.0950286185957, 4061.7969101544804, 4126.339785634284, 1294.5727909789746, 1304.9151805132635, 1305.8432988041495, 1314.80277958307, 1317.947282108724, 767.8310771630232, 805.6696754330696, 880.9163129502815, 913.48388160689, 924.075924075924, 5541.390447050821, 5806.970965145232, 5830.7084645767545, 5981.252343457068, 6087.908681369783, 897.1925267259388, 911.2573252798948, 937.301710225886, 945.8297506448905, 965.1265604627823, 3779.7165212608616, 3805.9429108563395, 3915.804209789499, 3923.136909879822, 3956.8363285911587, 10634.787304254027, 10763.246572739834, 10768.569257229623, 10992.725181870357, 11007.394593297446, 10827.133829293638, 10932.398718070583, 10944.39805810688, 10944.39805810688, 10964.616238431616, 6448.806535804028, 8132.75601731949, 8293.129221431784, 8298.792530186794, 8309.169083091763, 5377.435369286169, 5555.861103472445, 5907.852303692442, 6053.4551890330085, 6132.0, 8778.780530486789, 9756.26827987918, 9765.730455040799, 9835.950820245853, 9863.45750983674, 10004.899951000396, 10163.949180254347, 10339.793204135725, 10373.585056597953, 10378.740531486774, 6971.58170509771, 7213.819654508679, 7238.348548630648, 7523.849523009619, 7664.655090520829, 7823.452358334862, 8150.470219435718, 8450.0, 8465.873011904703, 8584.399092063495, 7050.717971281091, 7108.684893294757, 7488.925110748823, 7597.2022937592965, 7756.612169391621, 7353.558786472829, 7364.263573642593, 7460.29127232912, 7470.925290747023, 7500.324970752658, 6943.132108486439, 7083.1854336749875, 7085.078939737801, 7104.680289387094, 7106.822329441805, 4229.809658565434, 4967.3045773591, 5006.224035274538, 5022.899542009066, 5048.444671086104, 4962.33008543842, 5004.599632029356, 5051.848444546669, 5115.4884511550035, 5151.2273159026445], "value": 4606.595371702124, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.3334796663607, 301.28144375664033, 314.9008062460326, 319.2752451934111, 319.73142560249386, 4426.734395936242, 5297.735113244332, 5336.893262134759, 5351.224072509483, 5398.757055932488, 4311.361682560622, 4795.1129041127415, 5260.552853007499, 5288.682679039261, 5303.628745987782, 3700.1674623209833, 4102.179564087194, 4115.54728979812, 4116.115035267417, 4136.5242997055275, 3413.351463221992, 3604.4773507841346, 3928.8232029558594, 4098.282800509914, 4134.173165366924, 3651.0, 3804.2962052020325, 4002.359622460407, 4074.8777536673947, 4087.6510751452097, 3340.3486320167576, 3437.9312413751586, 4040.919181616351, 4058.472398588194, 4072.8778136655947, 3519.5072689823446, 3522.4716292556063, 3530.2057037166687, 3531.876384326536, 3535.5757309122814, 5014.2979982802435, 5124.538791508782, 5163.509466600667, 5192.376914770214, 5217.2695822584865, 4238.3430568261965, 4572.657050721209, 4598.655100867449, 4617.468991066037, 4629.282461218517, 5376.946230537684, 5529.240116720628, 5579.13523403873, 5579.581531385163, 5585.301837270341, 3749.906252343686, 3867.7292589518743, 3882.301185786557, 3906.4140378943102, 3917.6669983051474, 4939.3578834751615, 5462.562994960394, 5793.768249270024, 5867.151847168128, 5890.293164820207, 3631.1285291529844, 3743.1390780120723, 3779.1874746929543, 3839.4816699745734, 3932.5477570079233, 3453.2575496268423, 3550.680438760524, 4040.575739547364, 4047.2680940365135, 4056.965473804161, 3677.687396571268, 3943.290207762573, 4410.095930334273, 4626.814927402934, 4660.813567457264, 4795.688280261772, 4997.125503036954, 5440.878057557556, 5576.693281869455, 5605.579581531401, 1264.8166015927638, 1341.7920222365549, 1360.1773623344766, 1368.438940034581, 1377.9793303100462, 750.8535835512132, 786.614558866163, 841.3185319890908, 860.9612567434356, 865.2947847504264, 3859.826307816099, 4195.804195804181, 4297.076128632297, 4371.213181627338, 4415.6909016368545, 4102.400063975052, 4262.531121576624, 4284.4430224070675, 4413.6248418884115, 4783.736894470768, 3642.5993140754495, 3792.440102930566, 3926.2343842950922, 3994.820233089518, 4361.753696846126, 2201.2075652764993, 2246.2699622622713, 2294.6558016297354, 2470.555300046009, 2533.6959564852336, 4582.097156043002, 4977.809763703959, 4979.751012449436, 4988.052270068675, 5023.949760502422, 4024.2756303865585, 4466.263066593976, 4652.32541281519, 4658.883527911829, 4930.6795058321095, 4156.607536475314, 4324.983628847219, 4447.221111555339, 4749.905001899873, 4787.640926930424, 4429.712068715523, 4739.194336962656, 4770.689905156154, 4782.991143719577, 4791.227245919033, 4138.110306284163, 4708.293755936637, 4721.504242054535, 4742.715437073786, 4753.809847606195, 4172.979135104427, 4408.170609197276, 4633.710065853282, 4768.809247630056, 4961.5534601886, 3395.5076513905838, 3427.4919035624243, 3429.8971030869116, 3449.724022078278, 3481.6344283850844, 4819.421669399694, 4834.492378300369, 4840.975795121002, 4852.975735121302, 4860.538248866352, 4081.8774237396983, 4507.526709695566, 4679.660169915042, 4693.0992947856175, 4908.7545622719435, 4903.583195428429, 5531.834044978657, 5659.434056594308, 5673.106715575169, 5728.455796699307, 4909.4845041270155, 5518.475744804237, 5564.944350556442, 5566.135344659584, 5575.944240557705, 4916.680415772963, 5326.9733651333045, 5578.927383010344, 5651.095824668033, 5664.745086471036, 5513.807016754395, 5515.834524964257, 5519.806806761905, 5533.2253484513, 5564.888702225851], "value": 3801.9080611435443, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.5119221313932, 752.1012390193717, 773.5977291808256, 775.6238224461135, 810.0684213154875, 17341.30634774609, 17673.204705788237, 17676.292948282084, 17720.468385948425, 18102.5474363141, 16562.751558726628, 16742.0, 16762.497125086265, 16769.91615041926, 16772.748408773878, 687.3470203306854, 714.3820595185153, 760.8554374668795, 845.26461978079, 866.3935245328264, 711.921688614252, 848.1984524624232, 860.0582362313288, 880.5773228850156, 884.3146561414891, 907.4056492997097, 908.7818923458356, 912.1198043887647, 912.3567884641345, 913.1097180249237, 711.3633298198084, 899.8425275576781, 900.5587262241454, 901.441106513959, 901.6799036342103, 552.2103392149226, 664.833791552112, 683.0880774166494, 685.7017197519045, 692.3388164303078, 15497.992630479095, 15583.45457908979, 15596.532104036896, 15602.687946241012, 15604.843951560453, 11821.586244481401, 13391.531296404579, 13677.0, 13749.175049497062, 13761.31193440324, 11307.208495405324, 11757.118216133824, 11820.349880756556, 12677.74644507114, 12814.29521376324, 3805.2960202362374, 3814.0464883779055, 3857.6528112470014, 3897.66869816066, 3946.9013274668077, 110317.0, 115372.42313788462, 116066.83933160645, 117480.0, 117992.0, 10714.196435267386, 10940.890591093987, 10992.131337672616, 11010.50452729629, 11530.76938461226, 20620.793792062188, 21221.0, 21835.563288734138, 21852.781472185394, 21859.234926777488, 8064.274215320649, 8107.067687215927, 8171.673133074611, 8176.059753128467, 8176.550289734003, 4400.867973960786, 4450.332450132506, 4566.26939689648, 4707.105649926503, 4719.457262414798, 3586.65500437336, 3689.409694448929, 3695.630436956337, 3734.0104872208885, 3734.3278209922473, 655.6295692933477, 658.1411258307954, 658.8221180281297, 666.2271764752863, 678.1963373402534, 551.6827824001215, 557.3729554251468, 580.882682621841, 605.6214865708932, 639.2424976402978, 9137.445482866044, 9630.614775409045, 9653.131218190396, 9712.969117816168, 9946.850797238047, 581.8167277307634, 622.2129006806393, 671.9395254427125, 676.2763842688277, 679.8198477403492, 4462.776861156929, 4698.781981694884, 4712.0, 4747.018756366933, 4806.255030470213, 94724.0527594729, 138930.0, 150575.0, 168839.0, 168887.0, 142730.0, 142855.0, 143331.0, 148708.0, 149165.0, 119796.8020319803, 125080.37459812642, 125206.37396812957, 126391.3680431592, 128746.0, 8995.505247211466, 9168.633254669738, 9179.403338782959, 9194.31042671789, 9351.672691455766, 67367.98948015686, 69565.0, 69575.65212173907, 70891.29108708847, 70962.0, 76043.61978190074, 101976.45058873587, 102273.48863255636, 107690.46154769175, 109751.45124274647, 10975.231733778559, 11203.0, 11521.308721476738, 11755.706107347043, 12054.819177712518, 12844.35778211067, 13244.139130956457, 13441.059125861097, 13459.461621535029, 13874.791878121634, 11647.11296284388, 12362.567310144103, 12366.567170149001, 12771.425285862344, 12809.231446113263, 11794.46924888365, 11861.288322700666, 11926.463309151282, 12648.367581621067, 12693.048021398248, 11591.826122608336, 11730.882691173321, 11862.762744745229, 12112.636620901387, 12718.809217861555, 8751.606177721891, 8798.604062817316, 9099.909000910171, 9221.400608960395, 9279.48962807025, 9281.118293762082, 9282.907170928474, 9329.346945713734, 9330.626774929198, 9342.766430839283], "value": 7788.818556047625, "unit": "score"}], "name": "dromaeo_css", "value": 7272.394980468398, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 115.0, 115.0, 115.0, 116.0, 114.0, 114.0, 114.0, 113.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 110.0, 141.0, 111.0, 110.0, 108.0, 109.0, 144.0, 107.0], "value": 119.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 198.0, 265.0, 201.0, 188.0, 185.0, 184.0, 184.0, 184.0, 183.0], "value": 195.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 58.0, 89.0, 60.0, 58.0, 59.0, 59.0, 83.0, 57.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 96.0, 71.0, 68.0, 69.0, 91.0, 68.0, 68.0, 89.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 87.0, 84.0, 85.0, 82.0, 87.0, 84.0, 87.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 93.0, 93.0, 93.0, 92.0, 92.0, 92.0, 93.0, 92.0], "value": 92.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 86.0, 84.0, 82.0, 85.0, 84.0, 83.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 49.0, 49.0, 51.0, 54.0, 58.0, 56.0, 56.0, 55.0, 55.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 81.0, 71.0, 72.0, 70.0, 67.0, 69.0, 68.0, 74.0, 69.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 82.0, 82.0, 85.0, 82.0, 85.0, 82.0, 81.0, 85.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 139.0, 130.0, 131.0, 141.0, 140.0, 141.0, 171.0, 135.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 228.0, 187.0, 162.0, 163.0, 164.0, 161.0, 163.0, 160.0, 162.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1422.4, "alertThreshold": 2.0}]} 05:57:31 INFO - Return code: 0 05:57:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:57:31 INFO - # TBPL SUCCESS # 05:57:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:57:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:57:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:57:31 INFO - 2016-10-07 05:57:31.624 screenresolution[1964:19656] starting screenresolution argv=screenresolution get 05:57:31 INFO - 2016-10-07 05:57:31.627 screenresolution[1964:19656] Display 0: 1600x1200x32@60 05:57:31 INFO - 2016-10-07 05:57:31.633 screenresolution[1965:19659] starting screenresolution argv=screenresolution list 05:57:31 INFO - Available Modes on Display 0 05:57:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:57:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:57:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:57:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:57:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:57:31 INFO - Intel Iris: 05:57:31 INFO - Chipset Model: Intel Iris 05:57:31 INFO - Type: GPU 05:57:31 INFO - Bus: Built-In 05:57:31 INFO - VRAM (Dynamic, Max): 1536 MB 05:57:31 INFO - Vendor: Intel (0x8086) 05:57:31 INFO - Device ID: 0x0a2e 05:57:31 INFO - Revision ID: 0x0009 05:57:31 INFO - Displays: 05:57:31 INFO - Display: 05:57:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:57:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:57:31 INFO - Display Serial Number: 1600x1200 60 05:57:31 INFO - Main Display: Yes 05:57:31 INFO - Mirror: Off 05:57:31 INFO - Online: Yes 05:57:31 INFO - Rotation: Supported 05:57:31 INFO - Return code: 0 05:57:31 INFO - Running post-action listener: _resource_record_post_action 05:57:31 INFO - [mozharness: 2016-10-07 12:57:31.867674Z] Finished run-tests step (success) 05:57:31 INFO - Running post-run listener: _resource_record_post_run 05:57:31 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 1609728; Write bytes: 662737408; Read time: 12; Write time: 1891 05:57:31 INFO - TinderboxPrint: CPU usage
53.6% 05:57:31 INFO - TinderboxPrint: I/O read bytes / time
1,609,728 / 12 05:57:31 INFO - TinderboxPrint: I/O write bytes / time
662,737,408 / 1,891 05:57:31 INFO - TinderboxPrint: CPU idle
2,246.4 (46.4%) 05:57:31 INFO - TinderboxPrint: CPU system
969.0 (20.0%) 05:57:31 INFO - TinderboxPrint: CPU user
1,626.4 (33.6%) 05:57:31 INFO - TinderboxPrint: Swap in / out
364,982,272 / 0 05:57:31 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 351222272; Write bytes: 345225216; Read time: 27929; Write time: 719 05:57:31 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 1609728; Write bytes: 295384064; Read time: 12; Write time: 1105 05:57:32 INFO - Running post-run listener: _upload_blobber_files 05:57:32 INFO - Blob upload gear active. 05:57:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:57:32 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 05:57:32 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'] 05:57:32 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 05:57:32 INFO - (blobuploader) - INFO - Open directory for files ... 05:57:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:57:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:57:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:33 INFO - (blobuploader) - INFO - Done attempting. 05:57:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:57:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:57:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:34 INFO - (blobuploader) - INFO - Done attempting. 05:57:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:57:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:57:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:37 INFO - (blobuploader) - INFO - Done attempting. 05:57:37 INFO - (blobuploader) - INFO - Iteration through files over. 05:57:37 INFO - Return code: 0 05:57:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:57:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:57:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e6bd001b3e8fcd0bc0a028911e6ce63adacb3edbb2a68923346480e6d5c7b9f1055c48822e746fb24a61b1f3ca27d14dcbd54098a70fe35bc6676389e60f74e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bfb0ab3283ec55e08994d1c93b546730666ac9a53fc81b17c18627f299b56e529cd3ba5921065760eb34834a483153fc49e53b336643399b0490904aca681b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7deaa149cd79476272238931fba50bd1f3373b1cea5547c1964f0a0645502cf315a234df5a8b62772d27129e09c77ca69e89f6a566cc60874b91132d8f488c0a"} 05:57:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:57:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:57:37 INFO - Contents: 05:57:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e6bd001b3e8fcd0bc0a028911e6ce63adacb3edbb2a68923346480e6d5c7b9f1055c48822e746fb24a61b1f3ca27d14dcbd54098a70fe35bc6676389e60f74e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bfb0ab3283ec55e08994d1c93b546730666ac9a53fc81b17c18627f299b56e529cd3ba5921065760eb34834a483153fc49e53b336643399b0490904aca681b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7deaa149cd79476272238931fba50bd1f3373b1cea5547c1964f0a0645502cf315a234df5a8b62772d27129e09c77ca69e89f6a566cc60874b91132d8f488c0a"} 05:57:37 INFO - Running post-run listener: copy_logs_to_upload_dir 05:57:37 INFO - Copying logs to upload dir... 05:57:37 INFO - mkdir: /builds/slave/test/build/upload/logs 05:57:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.759021 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-07 05:57:37.580800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:37.584321) ========= 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.TBSE22MleI/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.VcnN8TkNMQ/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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/6e6bd001b3e8fcd0bc0a028911e6ce63adacb3edbb2a68923346480e6d5c7b9f1055c48822e746fb24a61b1f3ca27d14dcbd54098a70fe35bc6676389e60f74e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bfb0ab3283ec55e08994d1c93b546730666ac9a53fc81b17c18627f299b56e529cd3ba5921065760eb34834a483153fc49e53b336643399b0490904aca681b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7deaa149cd79476272238931fba50bd1f3373b1cea5547c1964f0a0645502cf315a234df5a8b62772d27129e09c77ca69e89f6a566cc60874b91132d8f488c0a"} build_url:https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/PMdNmQeWS2mZCgbn4crncQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e6bd001b3e8fcd0bc0a028911e6ce63adacb3edbb2a68923346480e6d5c7b9f1055c48822e746fb24a61b1f3ca27d14dcbd54098a70fe35bc6676389e60f74e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bfb0ab3283ec55e08994d1c93b546730666ac9a53fc81b17c18627f299b56e529cd3ba5921065760eb34834a483153fc49e53b336643399b0490904aca681b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7deaa149cd79476272238931fba50bd1f3373b1cea5547c1964f0a0645502cf315a234df5a8b62772d27129e09c77ca69e89f6a566cc60874b91132d8f488c0a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:37.617731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:37.618077) ========= 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.TBSE22MleI/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.VcnN8TkNMQ/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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.005241 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:37.666702) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 05:57:37.667026) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 05:57:37.667384) ========= ========= Total master_lag: 0.17 =========