builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0151 starttime: 1476461928.42 results: success (0) buildid: 20161014065436 builduid: b236737409124d0f9c3950b6593474a0 revision: 5fca1c8ef0b8198e902a3c1f640a49cd4d76905b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 09:18:48.421245) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 09:18:48.421707) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 09:18:48.421979) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 09:18:48.446470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:18:48.446766) ========= 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.NFcVh67gRM/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.e81TxuFC0s/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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-14 09:18:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.6M=0.001s 2016-10-14 09:18:48 (14.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160833 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:18:48.631036) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:18:48.631440) ========= 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.NFcVh67gRM/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.e81TxuFC0s/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.026257 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:18:48.680897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 09:18:48.681251) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5fca1c8ef0b8198e902a3c1f640a49cd4d76905b --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 5fca1c8ef0b8198e902a3c1f640a49cd4d76905b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NFcVh67gRM/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.e81TxuFC0s/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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-14 09:18:48,755 truncating revision to first 12 chars 2016-10-14 09:18:48,755 Setting DEBUG logging. 2016-10-14 09:18:48,755 attempt 1/10 2016-10-14 09:18:48,755 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5fca1c8ef0b8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 09:18:49,474 unpacking tar archive at: mozilla-aurora-5fca1c8ef0b8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.990499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 09:18:49.695583) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 09:18:49.696116) ========= script_repo_revision: 5fca1c8ef0b8198e902a3c1f640a49cd4d76905b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 09:18:49.696764) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 09:18:49.697243) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 09:18:49.716974) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-14 09:18:49.717596) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--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.NFcVh67gRM/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.e81TxuFC0s/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 09:18:49 INFO - MultiFileLogger online at 20161014 09:18:49 in /builds/slave/test 09:18:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:18:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:18:49 INFO - {'append_to_log': False, 09:18:49 INFO - 'base_work_dir': '/builds/slave/test', 09:18:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:18:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:18:49 INFO - 'branch': 'Mozilla-Aurora', 09:18:49 INFO - 'buildbot_json_path': 'buildprops.json', 09:18:49 INFO - 'config_files': ('talos/mac_config.py',), 09:18:49 INFO - 'default_actions': ('clobber', 09:18:49 INFO - 'read-buildbot-config', 09:18:49 INFO - 'download-and-extract', 09:18:49 INFO - 'populate-webroot', 09:18:49 INFO - 'create-virtualenv', 09:18:49 INFO - 'install', 09:18:49 INFO - 'run-tests'), 09:18:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:18:49 INFO - 'download_minidump_stackwalk': True, 09:18:49 INFO - 'download_symbols': 'ondemand', 09:18:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:18:49 INFO - 'tooltool.py': '/tools/tooltool.py', 09:18:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:18:49 INFO - '/tools/misc-python/virtualenv.py')}, 09:18:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:18:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:18:49 INFO - 'installer_path': 'installer.exe', 09:18:49 INFO - 'log_level': 'info', 09:18:49 INFO - 'log_name': 'talos', 09:18:49 INFO - 'log_to_console': True, 09:18:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:18:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:18:49 INFO - 'opt_config_files': (), 09:18:49 INFO - 'pip_index': False, 09:18:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:18:49 INFO - 'cmd': ('bash', 09:18:49 INFO - '-c', 09:18:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:18:49 INFO - 'enabled': True, 09:18:49 INFO - 'halt_on_failure': False, 09:18:49 INFO - 'name': 'check_screen_resolution'},), 09:18:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:18:49 INFO - 'cmd': ('bash', 09:18:49 INFO - '-c', 09:18:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:18:49 INFO - 'enabled': True, 09:18:49 INFO - 'halt_on_failure': False, 09:18:49 INFO - 'name': 'check_screen_resolution'},), 09:18:49 INFO - 'run_cmd_checks_enabled': True, 09:18:49 INFO - 'sps_profile': False, 09:18:49 INFO - 'sps_profile_interval': 0, 09:18:49 INFO - 'suite': 'dromaeojs-e10s', 09:18:49 INFO - 'system_bits': '32', 09:18:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:18:49 INFO - 'title': 't-yosemite-r7-0151', 09:18:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:18:49 INFO - 'use_talos_json': True, 09:18:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:18:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:18:49 INFO - 'work_dir': 'build'} 09:18:49 INFO - [mozharness: 2016-10-14 16:18:49.914584Z] Running clobber step. 09:18:49 INFO - Running pre-action listener: _resource_record_pre_action 09:18:49 INFO - Running main action method: clobber 09:18:49 INFO - rmtree: /builds/slave/test/build 09:18:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:18:51 INFO - Running post-action listener: _resource_record_post_action 09:18:51 INFO - [mozharness: 2016-10-14 16:18:51.993290Z] Finished clobber step (success) 09:18:51 INFO - [mozharness: 2016-10-14 16:18:51.993407Z] Running read-buildbot-config step. 09:18:51 INFO - Running pre-action listener: _resource_record_pre_action 09:18:51 INFO - Running main action method: read_buildbot_config 09:18:51 INFO - Using buildbot properties: 09:18:51 INFO - { 09:18:51 INFO - "project": "", 09:18:51 INFO - "product": "firefox", 09:18:51 INFO - "script_repo_revision": "production", 09:18:51 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 09:18:51 INFO - "repository": "", 09:18:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 09:18:51 INFO - "buildid": "20161014065436", 09:18:51 INFO - "pgo_build": "False", 09:18:51 INFO - "basedir": "/builds/slave/test", 09:18:51 INFO - "buildnumber": 4, 09:18:51 INFO - "slavename": "t-yosemite-r7-0151", 09:18:51 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:18:51 INFO - "platform": "yosemite_r7", 09:18:51 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:18:51 INFO - "branch": "mozilla-aurora", 09:18:51 INFO - "repo_path": "releases/mozilla-aurora", 09:18:51 INFO - "revision": "5fca1c8ef0b8198e902a3c1f640a49cd4d76905b", 09:18:51 INFO - "stage_platform": "macosx64", 09:18:51 INFO - "builduid": "b236737409124d0f9c3950b6593474a0", 09:18:51 INFO - "slavebuilddir": "test" 09:18:51 INFO - } 09:18:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 09:18:51 INFO - Running post-action listener: _resource_record_post_action 09:18:51 INFO - [mozharness: 2016-10-14 16:18:51.997962Z] Finished read-buildbot-config step (success) 09:18:51 INFO - [mozharness: 2016-10-14 16:18:51.998177Z] Running download-and-extract step. 09:18:51 INFO - Running pre-action listener: _resource_record_pre_action 09:18:51 INFO - Running main action method: download_and_extract 09:18:51 INFO - mkdir: /builds/slave/test/build/tests 09:18:51 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')]} 09:18:51 INFO - trying https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 09:18:52 INFO - Downloading https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/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 09:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/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 09:18:52 INFO - Downloaded 1199 bytes. 09:18:52 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 09:18:52 INFO - Using the following test package requirements: 09:18:52 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:18:52 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:52 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 09:18:52 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:52 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 09:18:52 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:52 INFO - u'jsshell-mac.zip'], 09:18:52 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:52 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 09:18:52 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:18:52 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:52 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 09:18:52 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:52 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 09:18:52 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:52 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 09:18:52 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:18:52 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 09:18:52 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:18:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:18:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:18:52 INFO - Fetch https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:18:53 INFO - Expected file size: 16435265 09:19:00 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 09:19:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:19:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:19:00 INFO - Fetch https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:19:01 INFO - Expected file size: 16435265 09:19:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 09:19:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:19:07 INFO - Fetch https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 09:19:08 INFO - Expected file size: 14414081 09:19:09 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')]} 09:19:09 INFO - trying https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:19:09 INFO - Downloading https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 09:19:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/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 09:19:12 INFO - Downloaded 115423006 bytes. 09:19:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:19:12 INFO - mkdir: /builds/slave/test/properties 09:19:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:12 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:12 INFO - Contents: 09:19:12 INFO - build_url:https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:19:13 INFO - Running post-action listener: _resource_record_post_action 09:19:13 INFO - Running post-action listener: set_extra_try_arguments 09:19:13 INFO - [mozharness: 2016-10-14 16:19:13.412646Z] Finished download-and-extract step (success) 09:19:13 INFO - [mozharness: 2016-10-14 16:19:13.412745Z] Running populate-webroot step. 09:19:13 INFO - Running pre-action listener: _resource_record_pre_action 09:19:13 INFO - Running main action method: populate_webroot 09:19:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:13 INFO - '--tppagecycles', 09:19:13 INFO - '7'], 09:19:13 INFO - 'tests': ['tsvgm']}}, 09:19:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:19:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:19:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:13 INFO - 'talos_options': ['--disable-e10s'], 09:19:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:13 INFO - 'talos_options': ['--disable-e10s'], 09:19:13 INFO - 'tests': ['damp', 'tps']}, 09:19:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:13 INFO - 'tests': ['damp', 'tps']}, 09:19:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:13 INFO - 'tests': ['dromaeo_dom']}, 09:19:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:13 INFO - 'tests': ['basic_compositor_video']}, 09:19:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:19:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:13 INFO - 'tests': ['a11yr', 09:19:13 INFO - 'ts_paint', 09:19:13 INFO - 'tpaint', 09:19:13 INFO - 'sessionrestore', 09:19:13 INFO - 'sessionrestore_no_auto_restore', 09:19:13 INFO - 'tabpaint']}, 09:19:13 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:13 INFO - 'ts_paint', 09:19:13 INFO - 'tpaint', 09:19:13 INFO - 'sessionrestore', 09:19:13 INFO - 'sessionrestore_no_auto_restore', 09:19:13 INFO - 'tabpaint']}, 09:19:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:13 INFO - 'ts_paint', 09:19:13 INFO - 'tpaint', 09:19:13 INFO - 'sessionrestore', 09:19:13 INFO - 'sessionrestore_no_auto_restore', 09:19:13 INFO - 'tabpaint']}, 09:19:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:13 INFO - 'ts_paint', 09:19:13 INFO - 'tpaint', 09:19:13 INFO - 'sessionrestore', 09:19:13 INFO - 'sessionrestore_no_auto_restore', 09:19:13 INFO - 'tabpaint']}, 09:19:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:13 INFO - 'tests': ['a11yr', 09:19:13 INFO - 'ts_paint', 09:19:13 INFO - 'tpaint', 09:19:13 INFO - 'sessionrestore', 09:19:13 INFO - 'sessionrestore_no_auto_restore', 09:19:13 INFO - 'tabpaint']}, 09:19:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:13 INFO - 'tests': ['a11yr', 09:19:13 INFO - 'ts_paint', 09:19:13 INFO - 'tpaint', 09:19:13 INFO - 'sessionrestore', 09:19:13 INFO - 'sessionrestore_no_auto_restore', 09:19:13 INFO - 'tabpaint']}, 09:19:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:13 INFO - 'tests': ['tsvgx', 09:19:13 INFO - 'tsvgr_opacity', 09:19:13 INFO - 'tart', 09:19:13 INFO - 'tscrollx', 09:19:13 INFO - 'cart']}, 09:19:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:13 INFO - 'tsvgr_opacity', 09:19:13 INFO - 'tart', 09:19:13 INFO - 'tscrollx', 09:19:13 INFO - 'cart']}, 09:19:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:13 INFO - 'talos_options': ['--disable-e10s'], 09:19:13 INFO - 'tests': ['tp5o']}, 09:19:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:13 INFO - 'tests': ['tp5o']}, 09:19:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:13 INFO - 'talos_options': ['--disable-e10s', 09:19:13 INFO - '--xperf_path', 09:19:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:13 INFO - 'tests': ['tp5n']}, 09:19:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:13 INFO - 'talos_options': ['--xperf_path', 09:19:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:13 INFO - 'tests': ['tp5n']}}, 09:19:13 INFO - 'talos.zip': {'path': '', 09:19:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:13 INFO - Running post-action listener: _resource_record_post_action 09:19:13 INFO - [mozharness: 2016-10-14 16:19:13.431891Z] Finished populate-webroot step (success) 09:19:13 INFO - [mozharness: 2016-10-14 16:19:13.432027Z] Running create-virtualenv step. 09:19:13 INFO - Running pre-action listener: _resource_record_pre_action 09:19:13 INFO - Running main action method: create_virtualenv 09:19:13 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:13 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 09:19:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:13 INFO - Using real prefix '/tools/python27' 09:19:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:14 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:17 INFO - Installing pip.................done. 09:19:17 INFO - Return code: 0 09:19:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:17 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 0x10ba08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81cd30>, '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 0x10b682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b814b20>, '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.NFcVh67gRM/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.e81TxuFC0s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 09:19:17 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 09:19:17 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 09:19:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NFcVh67gRM/Render', 09:19:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:17 INFO - 'HOME': '/Users/cltbld', 09:19:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:17 INFO - 'LOGNAME': 'cltbld', 09:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:17 INFO - 'MOZ_NO_REMOTE': '1', 09:19:17 INFO - 'NO_EM_RESTART': '1', 09:19:17 INFO - 'PAGER': '/bin/cat', 09:19:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:17 INFO - 'PWD': '/builds/slave/test', 09:19:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:17 INFO - 'SHELL': '/bin/bash', 09:19:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e81TxuFC0s/Listeners', 09:19:17 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 09:19:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:17 INFO - 'USER': 'cltbld', 09:19:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:17 INFO - 'XPC_FLAGS': '0x0', 09:19:17 INFO - 'XPC_SERVICE_NAME': '0', 09:19:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:17 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 09:19:17 INFO - Cleaning up... 09:19:17 INFO - Return code: 0 09:19:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:17 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 0x10ba08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81cd30>, '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 0x10b682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b814b20>, '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.NFcVh67gRM/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.e81TxuFC0s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 09:19:17 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 09:19:17 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 09:19:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NFcVh67gRM/Render', 09:19:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:17 INFO - 'HOME': '/Users/cltbld', 09:19:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:17 INFO - 'LOGNAME': 'cltbld', 09:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:17 INFO - 'MOZ_NO_REMOTE': '1', 09:19:17 INFO - 'NO_EM_RESTART': '1', 09:19:17 INFO - 'PAGER': '/bin/cat', 09:19:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:17 INFO - 'PWD': '/builds/slave/test', 09:19:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:17 INFO - 'SHELL': '/bin/bash', 09:19:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e81TxuFC0s/Listeners', 09:19:17 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 09:19:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:17 INFO - 'USER': 'cltbld', 09:19:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:17 INFO - 'XPC_FLAGS': '0x0', 09:19:17 INFO - 'XPC_SERVICE_NAME': '0', 09:19:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:17 INFO - Downloading/unpacking psutil>=3.1.1 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:20 INFO - Installing collected packages: psutil 09:19:20 INFO - Running setup.py install for psutil 09:19:20 INFO - building 'psutil._psutil_osx' extension 09:19:20 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 09:19:21 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 09:19:21 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 09:19:21 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 09:19:21 INFO - building 'psutil._psutil_posix' extension 09:19:21 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 09:19:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:19:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:19:21 INFO - ^ 09:19:21 INFO - 1 warning generated. 09:19:21 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 09:19:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:21 INFO - Successfully installed psutil 09:19:21 INFO - Cleaning up... 09:19:21 INFO - Return code: 0 09:19:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:21 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 0x10ba08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81cd30>, '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 0x10b682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b814b20>, '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.NFcVh67gRM/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.e81TxuFC0s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 09:19:21 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 09:19:21 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 09:19:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NFcVh67gRM/Render', 09:19:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:21 INFO - 'HOME': '/Users/cltbld', 09:19:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:21 INFO - 'LOGNAME': 'cltbld', 09:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:21 INFO - 'MOZ_NO_REMOTE': '1', 09:19:21 INFO - 'NO_EM_RESTART': '1', 09:19:21 INFO - 'PAGER': '/bin/cat', 09:19:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:21 INFO - 'PWD': '/builds/slave/test', 09:19:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:21 INFO - 'SHELL': '/bin/bash', 09:19:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e81TxuFC0s/Listeners', 09:19:21 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 09:19:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:21 INFO - 'USER': 'cltbld', 09:19:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:21 INFO - 'XPC_FLAGS': '0x0', 09:19:21 INFO - 'XPC_SERVICE_NAME': '0', 09:19:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:24 INFO - Installing collected packages: mozsystemmonitor 09:19:24 INFO - Running setup.py install for mozsystemmonitor 09:19:24 INFO - Successfully installed mozsystemmonitor 09:19:24 INFO - Cleaning up... 09:19:24 INFO - Return code: 0 09:19:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:24 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 0x10ba08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81cd30>, '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 0x10b682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b814b20>, '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.NFcVh67gRM/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.e81TxuFC0s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 09:19:24 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 09:19:24 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 09:19:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NFcVh67gRM/Render', 09:19:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:24 INFO - 'HOME': '/Users/cltbld', 09:19:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:24 INFO - 'LOGNAME': 'cltbld', 09:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:24 INFO - 'MOZ_NO_REMOTE': '1', 09:19:24 INFO - 'NO_EM_RESTART': '1', 09:19:24 INFO - 'PAGER': '/bin/cat', 09:19:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:24 INFO - 'PWD': '/builds/slave/test', 09:19:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:24 INFO - 'SHELL': '/bin/bash', 09:19:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e81TxuFC0s/Listeners', 09:19:24 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 09:19:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:24 INFO - 'USER': 'cltbld', 09:19:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:24 INFO - 'XPC_FLAGS': '0x0', 09:19:24 INFO - 'XPC_SERVICE_NAME': '0', 09:19:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:25 INFO - Downloading/unpacking jsonschema==2.5.1 09:19:25 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 09:19:25 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 09:19:25 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 09:19:25 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 09:19:25 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 09:19:25 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 09:19:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19:27 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 09:19:27 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 09:19:27 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 09:19:27 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 09:19:27 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 09:19:27 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 09:19:28 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:28 INFO - warning: no files found matching '*.txt' 09:19:28 INFO - no previously-included directories found matching 'build' 09:19:28 INFO - no previously-included directories found matching 'dist' 09:19:28 INFO - no previously-included directories found matching '.git*' 09:19:28 INFO - Installing collected packages: jsonschema, functools32 09:19:28 INFO - Running setup.py install for functools32 09:19:28 INFO - warning: no files found matching '*.txt' 09:19:28 INFO - no previously-included directories found matching 'build' 09:19:28 INFO - no previously-included directories found matching 'dist' 09:19:28 INFO - no previously-included directories found matching '.git*' 09:19:28 INFO - Successfully installed jsonschema functools32 09:19:28 INFO - Cleaning up... 09:19:28 INFO - Return code: 0 09:19:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:19:28 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')]} 09:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:28 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')]} 09:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:28 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 0x10ba08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81cd30>, '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 0x10b682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b814b20>, '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.NFcVh67gRM/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.e81TxuFC0s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 09:19:28 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 09:19:28 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 09:19:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NFcVh67gRM/Render', 09:19:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:28 INFO - 'HOME': '/Users/cltbld', 09:19:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:28 INFO - 'LOGNAME': 'cltbld', 09:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:28 INFO - 'MOZ_NO_REMOTE': '1', 09:19:28 INFO - 'NO_EM_RESTART': '1', 09:19:28 INFO - 'PAGER': '/bin/cat', 09:19:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:28 INFO - 'PWD': '/builds/slave/test', 09:19:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:28 INFO - 'SHELL': '/bin/bash', 09:19:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e81TxuFC0s/Listeners', 09:19:28 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 09:19:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:28 INFO - 'USER': 'cltbld', 09:19:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:28 INFO - 'XPC_FLAGS': '0x0', 09:19:28 INFO - 'XPC_SERVICE_NAME': '0', 09:19:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:19:28 INFO - Cleaning up... 09:19:28 INFO - Return code: 0 09:19:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19:28 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')]} 09:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:28 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')]} 09:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:28 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 0x10ba08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81cd30>, '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 0x10b682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b814b20>, '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.NFcVh67gRM/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.e81TxuFC0s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 09:19:28 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 09:19:28 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 09:19:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NFcVh67gRM/Render', 09:19:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:28 INFO - 'HOME': '/Users/cltbld', 09:19:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:28 INFO - 'LOGNAME': 'cltbld', 09:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:28 INFO - 'MOZ_NO_REMOTE': '1', 09:19:28 INFO - 'NO_EM_RESTART': '1', 09:19:28 INFO - 'PAGER': '/bin/cat', 09:19:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:28 INFO - 'PWD': '/builds/slave/test', 09:19:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:28 INFO - 'SHELL': '/bin/bash', 09:19:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e81TxuFC0s/Listeners', 09:19:28 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 09:19:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:28 INFO - 'USER': 'cltbld', 09:19:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:28 INFO - 'XPC_FLAGS': '0x0', 09:19:28 INFO - 'XPC_SERVICE_NAME': '0', 09:19:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:28 INFO - Downloading/unpacking blobuploader==1.2.4 09:19:28 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 09:19:28 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 09:19:28 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 09:19:28 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 09:19:28 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 09:19:28 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 09:19:31 INFO - Downloading blobuploader-1.2.4.tar.gz 09:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:19:32 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 09:19:32 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 09:19:32 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 09:19:32 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 09:19:32 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 09:19:32 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 09:19:32 INFO - Downloading docopt-0.6.1.tar.gz 09:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:32 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:32 INFO - Running setup.py install for blobuploader 09:19:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:32 INFO - Running setup.py install for requests 09:19:33 INFO - Running setup.py install for docopt 09:19:33 INFO - Successfully installed blobuploader requests docopt 09:19:33 INFO - Cleaning up... 09:19:33 INFO - Return code: 0 09:19:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:33 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')]} 09:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:33 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')]} 09:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:33 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 0x10ba08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81cd30>, '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 0x10b682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b814b20>, '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.NFcVh67gRM/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.e81TxuFC0s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 09:19:33 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 09:19:33 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 09:19:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NFcVh67gRM/Render', 09:19:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:33 INFO - 'HOME': '/Users/cltbld', 09:19:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:33 INFO - 'LOGNAME': 'cltbld', 09:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:33 INFO - 'MOZ_NO_REMOTE': '1', 09:19:33 INFO - 'NO_EM_RESTART': '1', 09:19:33 INFO - 'PAGER': '/bin/cat', 09:19:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:33 INFO - 'PWD': '/builds/slave/test', 09:19:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:33 INFO - 'SHELL': '/bin/bash', 09:19:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e81TxuFC0s/Listeners', 09:19:33 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 09:19:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:33 INFO - 'USER': 'cltbld', 09:19:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:33 INFO - 'XPC_FLAGS': '0x0', 09:19:33 INFO - 'XPC_SERVICE_NAME': '0', 09:19:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-KnJhjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-vOx6jS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-sshvY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-A_vbAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-S3ZQBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-SkVWz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-pymdIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-xsSw6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-FG09Wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-sEBwMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-d5tcqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-FtGYAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-tjGfWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-E12OoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-lpB8lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-cJy4HX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-MvasRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:35 INFO - Running setup.py install for manifestparser 09:19:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:35 INFO - Running setup.py install for mozcrash 09:19:36 INFO - Running setup.py install for mozdebug 09:19:36 INFO - Running setup.py install for mozdevice 09:19:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:19:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:19:36 INFO - Running setup.py install for mozfile 09:19:36 INFO - Running setup.py install for mozhttpd 09:19:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:19:36 INFO - Running setup.py install for mozinfo 09:19:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:36 INFO - Running setup.py install for mozInstall 09:19:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:36 INFO - Running setup.py install for mozleak 09:19:37 INFO - Running setup.py install for mozlog 09:19:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for moznetwork 09:19:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozprocess 09:19:37 INFO - Running setup.py install for mozprofile 09:19:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozrunner 09:19:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozscreenshot 09:19:38 INFO - Running setup.py install for moztest 09:19:38 INFO - Running setup.py install for mozversion 09:19:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:38 INFO - Cleaning up... 09:19:38 INFO - Return code: 0 09:19:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:38 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')]} 09:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:38 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')]} 09:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:38 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 0x10ba08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81cd30>, '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 0x10b682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b814b20>, '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.NFcVh67gRM/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.e81TxuFC0s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 09:19:38 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 09:19:38 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 09:19:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NFcVh67gRM/Render', 09:19:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:38 INFO - 'HOME': '/Users/cltbld', 09:19:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:38 INFO - 'LOGNAME': 'cltbld', 09:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:38 INFO - 'MOZ_NO_REMOTE': '1', 09:19:38 INFO - 'NO_EM_RESTART': '1', 09:19:38 INFO - 'PAGER': '/bin/cat', 09:19:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:38 INFO - 'PWD': '/builds/slave/test', 09:19:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:38 INFO - 'SHELL': '/bin/bash', 09:19:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e81TxuFC0s/Listeners', 09:19:38 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 09:19:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:38 INFO - 'USER': 'cltbld', 09:19:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:38 INFO - 'XPC_FLAGS': '0x0', 09:19:38 INFO - 'XPC_SERVICE_NAME': '0', 09:19:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:38 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-OOe3OH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:38 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)) 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:38 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-AlTbbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:38 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)) 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:38 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Tgkdhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:38 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)) 09:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:38 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-zXTXsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-CMS1Gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-vH2rB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-kKUvvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-iVRBy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-l3ZGh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-02OKLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-M2Cc6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-u3Sik_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-V2pICx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:40 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-R__SIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:40 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-1_MvIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:40 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-aGWq71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:40 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-ojMERZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:42 INFO - Downloading blessings-1.6.tar.gz 09:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:43 INFO - Installing collected packages: blessings 09:19:43 INFO - Running setup.py install for blessings 09:19:43 INFO - Successfully installed blessings 09:19:43 INFO - Cleaning up... 09:19:43 INFO - Return code: 0 09:19:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:43 INFO - Reading from file tmpfile_stdout 09:19:43 INFO - Current package versions: 09:19:43 INFO - blessings == 1.6 09:19:43 INFO - blobuploader == 1.2.4 09:19:43 INFO - docopt == 0.6.1 09:19:43 INFO - functools32 == 3.2.3-2 09:19:43 INFO - jsonschema == 2.5.1 09:19:43 INFO - manifestparser == 1.1 09:19:43 INFO - mozInstall == 1.12 09:19:43 INFO - mozcrash == 0.17 09:19:43 INFO - mozdebug == 0.1 09:19:43 INFO - mozdevice == 0.48 09:19:43 INFO - mozfile == 1.2 09:19:43 INFO - mozhttpd == 0.7 09:19:43 INFO - mozinfo == 0.9 09:19:43 INFO - mozleak == 0.1 09:19:43 INFO - mozlog == 3.4 09:19:43 INFO - moznetwork == 0.27 09:19:43 INFO - mozprocess == 0.23 09:19:43 INFO - mozprofile == 0.28 09:19:43 INFO - mozrunner == 6.12 09:19:43 INFO - mozscreenshot == 0.1 09:19:43 INFO - mozsystemmonitor == 0.3 09:19:43 INFO - moztest == 0.7 09:19:43 INFO - mozversion == 1.4 09:19:43 INFO - psutil == 3.1.1 09:19:43 INFO - requests == 1.2.3 09:19:43 INFO - wsgiref == 0.1.2 09:19:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:43 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 0x10ba08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81cd30>, '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 0x10b682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b814b20>, '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.NFcVh67gRM/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.e81TxuFC0s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 09:19:43 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 09:19:43 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 09:19:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NFcVh67gRM/Render', 09:19:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:43 INFO - 'HOME': '/Users/cltbld', 09:19:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:43 INFO - 'LOGNAME': 'cltbld', 09:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:43 INFO - 'MOZ_NO_REMOTE': '1', 09:19:43 INFO - 'NO_EM_RESTART': '1', 09:19:43 INFO - 'PAGER': '/bin/cat', 09:19:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:43 INFO - 'PWD': '/builds/slave/test', 09:19:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:43 INFO - 'SHELL': '/bin/bash', 09:19:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e81TxuFC0s/Listeners', 09:19:43 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 09:19:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:43 INFO - 'USER': 'cltbld', 09:19:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:43 INFO - 'XPC_FLAGS': '0x0', 09:19:43 INFO - 'XPC_SERVICE_NAME': '0', 09:19:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 INFO - Cleaning up... 09:19:43 INFO - Return code: 0 09:19:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba08490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b97e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d9c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81cd30>, '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 0x10b682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b814b20>, '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.NFcVh67gRM/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.e81TxuFC0s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 09:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:19:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NFcVh67gRM/Render', 09:19:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:43 INFO - 'HOME': '/Users/cltbld', 09:19:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:43 INFO - 'LOGNAME': 'cltbld', 09:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:43 INFO - 'MOZ_NO_REMOTE': '1', 09:19:43 INFO - 'NO_EM_RESTART': '1', 09:19:43 INFO - 'PAGER': '/bin/cat', 09:19:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:43 INFO - 'PWD': '/builds/slave/test', 09:19:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:43 INFO - 'SHELL': '/bin/bash', 09:19:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e81TxuFC0s/Listeners', 09:19:43 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 09:19:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:43 INFO - 'USER': 'cltbld', 09:19:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:43 INFO - 'XPC_FLAGS': '0x0', 09:19:43 INFO - 'XPC_SERVICE_NAME': '0', 09:19:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:19:44 INFO - Cleaning up... 09:19:44 INFO - Return code: 0 09:19:44 INFO - Running post-action listener: _resource_record_post_action 09:19:44 INFO - Running post-action listener: _start_resource_monitoring 09:19:44 INFO - Starting resource monitoring. 09:19:44 INFO - [mozharness: 2016-10-14 16:19:44.212154Z] Finished create-virtualenv step (success) 09:19:44 INFO - [mozharness: 2016-10-14 16:19:44.213131Z] Running install step. 09:19:44 INFO - Running pre-action listener: _resource_record_pre_action 09:19:44 INFO - Running main action method: install 09:19:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:44 INFO - Reading from file tmpfile_stdout 09:19:44 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:44 INFO - Reading from file tmpfile_stdout 09:19:44 INFO - Output received: 09:19:44 INFO - Usage: mozinstall [options] installer 09:19:44 INFO - Options: 09:19:44 INFO - -h, --help show this help message and exit 09:19:44 INFO - -d DEST, --destination=DEST 09:19:44 INFO - Directory to install application into. [default: 09:19:44 INFO - "/builds/slave/test"] 09:19:44 INFO - --app=APP Application being installed. [default: firefox] 09:19:44 INFO - mkdir: /builds/slave/test/build/application 09:19:44 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'] 09:19:44 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 09:20:17 INFO - Reading from file tmpfile_stdout 09:20:17 INFO - Output received: 09:20:17 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:20:17 INFO - Running post-action listener: _resource_record_post_action 09:20:17 INFO - [mozharness: 2016-10-14 16:20:17.163748Z] Finished install step (success) 09:20:17 INFO - [mozharness: 2016-10-14 16:20:17.163901Z] Running run-tests step. 09:20:17 INFO - Running pre-action listener: _resource_record_pre_action 09:20:17 INFO - Running main action method: run_tests 09:20:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:20:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:20:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:20:17 INFO - 2016-10-14 09:20:17.178 screenresolution[1645:7551] starting screenresolution argv=screenresolution get 09:20:17 INFO - 2016-10-14 09:20:17.180 screenresolution[1645:7551] Display 0: 1600x1200x32@60 09:20:17 INFO - 2016-10-14 09:20:17.186 screenresolution[1646:7553] starting screenresolution argv=screenresolution list 09:20:17 INFO - Available Modes on Display 0 09:20:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:20:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:20:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:20:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:20:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:20:17 INFO - Intel Iris: 09:20:17 INFO - Chipset Model: Intel Iris 09:20:17 INFO - Type: GPU 09:20:17 INFO - Bus: Built-In 09:20:17 INFO - VRAM (Dynamic, Max): 1536 MB 09:20:17 INFO - Vendor: Intel (0x8086) 09:20:17 INFO - Device ID: 0x0a2e 09:20:17 INFO - Revision ID: 0x0009 09:20:17 INFO - Displays: 09:20:17 INFO - Display: 09:20:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:20:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:20:17 INFO - Display Serial Number: 1600x1200 60 09:20:17 INFO - Main Display: Yes 09:20:17 INFO - Mirror: Off 09:20:17 INFO - Online: Yes 09:20:17 INFO - Rotation: Supported 09:20:17 INFO - Return code: 0 09:20:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:20:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:20:17 INFO - Python 2.7.3 09:20:17 INFO - Return code: 0 09:20:17 INFO - grabbing minidump binary from tooltool 09:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:17 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 0x10b81cd30>, '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 0x10b682db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b814b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:20:17 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 09:20:17 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 09:20:17 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 09:20:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:20:17 INFO - Return code: 0 09:20:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:20:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:20:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:20:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:20:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:20:17 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0151', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:20:17 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0151 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:20:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NFcVh67gRM/Render', 09:20:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:17 INFO - 'HOME': '/Users/cltbld', 09:20:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:17 INFO - 'LOGNAME': 'cltbld', 09:20:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:17 INFO - 'MOZ_NO_REMOTE': '1', 09:20:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:17 INFO - 'NO_EM_RESTART': '1', 09:20:17 INFO - 'PAGER': '/bin/cat', 09:20:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:17 INFO - 'PWD': '/builds/slave/test', 09:20:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:17 INFO - 'SHELL': '/bin/bash', 09:20:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e81TxuFC0s/Listeners', 09:20:17 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 09:20:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:17 INFO - 'USER': 'cltbld', 09:20:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:17 INFO - 'XPC_FLAGS': '0x0', 09:20:17 INFO - 'XPC_SERVICE_NAME': '0', 09:20:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0151', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:20:17 INFO - mozversion application_buildid: 20161014065436 09:20:17 INFO - mozversion application_changeset: 5fca1c8ef0b8198e902a3c1f640a49cd4d76905b 09:20:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:20:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:20:17 INFO - mozversion application_name: Firefox 09:20:17 INFO - mozversion application_remotingname: firefox-dev 09:20:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:20:17 INFO - mozversion application_vendor: Mozilla 09:20:17 INFO - mozversion application_version: 51.0a2 09:20:17 INFO - mozversion platform_buildid: 20161014065436 09:20:17 INFO - mozversion platform_changeset: 5fca1c8ef0b8198e902a3c1f640a49cd4d76905b 09:20:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:20:17 INFO - mozversion platform_version: 51.0a2 09:20:17 INFO - using testdate: 1476462017 09:20:17 INFO - actual date: 1476462017 09:20:17 INFO - starting webserver on 'localhost:49273' 09:20:17 INFO - SUITE-START | Running 2 tests 09:20:17 INFO - TEST-START | dromaeo_css 09:20:17 INFO - operating with platform_type : mac_ 09:20:17 INFO - Initialising browser for dromaeo_css test... 09:20:17 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmpQn994E/profile http://localhost:49273/getInfo.html) 09:20:20 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 09:20:20 INFO - PROCESS | 1656 | colorDepth:24 09:20:20 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 09:20:20 INFO - PROCESS | 1656 | __metrics 09:20:20 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 09:20:21 INFO - TEST-INFO | 1656: exit 0 09:20:21 INFO - Browser initialized. 09:20:21 INFO - Running cycle 1/1 for dromaeo_css test... 09:20:21 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmpQn994E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:33 INFO - PROCESS | 1659 | RSS: Main: 225030144 09:20:33 INFO - PROCESS | 1659 | 09:21:23 INFO - PROCESS | 1659 | 1476462083083 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] 09:23:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 09:23:36 INFO - PROCESS | 1659 | RSS: Main: 238579712 09:23:36 INFO - PROCESS | 1659 | 09:26:38 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 09:26:39 INFO - PROCESS | 1659 | RSS: Main: 248938496 09:26:39 INFO - PROCESS | 1659 | 09:29:41 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 09:29:41 INFO - PROCESS | 1659 | RSS: Main: 252174336 09:29:41 INFO - PROCESS | 1659 | 09:32:43 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 09:32:44 INFO - PROCESS | 1659 | RSS: Main: 252456960 09:32:44 INFO - PROCESS | 1659 | 09:35:46 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 09:35:47 INFO - PROCESS | 1659 | RSS: Main: 256847872 09:35:47 INFO - PROCESS | 1659 | 09:38:50 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 09:38:50 INFO - PROCESS | 1659 | RSS: Main: 258744320 09:38:50 INFO - PROCESS | 1659 | 09:38:50 INFO - PROCESS | 1659 | __start_tp_report 09:38:50 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 09:38:50 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 09:38:50 INFO - PROCESS | 1659 | |i|pagename|runs| 09:38:50 INFO - PROCESS | 1659 | |0;dojo.html;3408.7443441741866;3410.3179364127172;3411.948820767689;3436.931261374771;3465.6707612776777;5744;5806.709664516773;5813.33146688131;5833.3874943130995;5848.444397782204;5889.2049573307595;5928.7035648217525;5968.940310596893;5986.371430999737;5995.730192141354;5267.47325267473;5353.116735738598;5355.250264962889;5398.2982212312345;5465.098258787295;5114.923276150861;5385.569154467653;5386.542143917772;5391.919121213185;5409.053415652264;5270.894582108355;5327;5404.756785944642;5410.91883621746;5412.485813847678;4501.639868810487;5107.391171780896;5322.7072511011875;5325.866853328678;5341.839744807662;5244.029854476896;5276.683398996072;5316.069687804618;5355.732213389315;5394.1908713692865;5781.624194427391;5959.135925290809;5994;5998;6015.2781666200335;6109.101029780123;6165.106059621375;6197.101420294077;6202;6217.471514921192;6280.2777680566405;6306.527010474187;6314.652694101823;6323.778667746653;6339.270983836872;5991.7902873399225;6039.245094363205;6055.333913269493;6065.787697430569;6084.361142080106;6372.490200783926;6440.323766004596;6472.741090356427;6480.773172938924;6486.05952136947;4730.503297153749;5656.575756818255;5766.04860198071;6188.381161883775;6251.3123556408755;6133.151048553363;6137.877242455126;6341.8097457076365;6374.713137908805;6378;6133.671320645534;6139.30815411195;6213.751449941951;6219.782307619212;6235.376462353819;5858.652509922742;6269.937300627026;6270.749170033238;6283.874322513616;6291.559590828598;4113.424120623115;5014.749262536859;5040.647154699209;5055.797768089235;5073.137566613685;4418.028033832552;4431.423914891108;4477.686561940698;4483.237849565582;4523.525029871882;6014.849628759316;6124.991279909952;6154.753809847645;6157.538184636171;6169.5064394848305;6324.3043265240785;6360;6363.077353783676;6374.745010199633;6386.552941294158;5984.072468767348;6010.909836352458;6050.183225264533;6057.909131363033;6077.3314935357075;5472.370677372073;5507.394186639466;5523.420040895729;5538.169274608841;5540.418256083134;6405.263394709668;6419.358064193543;6432.35676432353;6447.1296374989715;6458.128152699325;6215.098810672517;6244.438000579969;6266.780662676784;6296.401841825019;6327.96836015817;6520.315366886409;6535.901961470487;6544.803655890331;6547.869042619026;6562.146920900444;6221.346758590464;6297.842553936005;6304.495640348669;6313.9897616383;6324.30432652417;6120.632762034292;6215.502759779117;6222.875542489215;6247.468965138014;6341.556091073765;6157.507399407947;6240.687965601793;6268.028455589391;6281.057841323838;6295.244570651368;6226.25284965807;6242.875142497215;6247.219097612799;6251.218597675291;6257.530685198537;4798.688085274585;6029.336772955059;6086.7260973255425;6102.0541816018585;6210.378962103753;6138.081874381997;6154.261488621394;6171.290301615371;6222.81331560054;6251.749930002931;6129.84675383119;6142.754289828356;6145.723442445012;6161.291451483136;6164.691765411621 09:38:50 INFO - PROCESS | 1659 | |1;ext.html;436.17562806296127;508.1184145507544;509.8215624531414;515.2863284351173;526.4630077321135;35893.82053089731;39489.60510394899;39865;41510.16979660405;41588.37617435737;42417.36373954393;42768.786156069255;42881;42950.57049429505;42998;9811.607535698564;9854.901450985506;9984;9991.500424978722;10012.249081318894;9763.560639771193;9766.560504777266;9832.459214743187;9874.753131171743;9937.552810123561;9880.604775808959;9883.802323953516;9923.950380248089;9927.751806204866;9936.35413698111;9836.262280328969;9844.803103937917;9854.901450985542;9890.505474726235;9897.15874150698;9748.025197480196;9787.608495660237;9851.310408271424;9861.309708320421;9871.60513579456;33133.83433082819;40384.78845634636;40500.98747531306;40534;40952;3259.2503724143344;3306.8677252909856;3460.74044446665;3534.0458076319505;3714.8699795507027;30449.391012179854;30454.390912181854;30752.846235768902;30866.38267234665;31390.843045784626;2721.537338652414;3134.044116544453;3255.8697652094124;3259.576255086847;3336.4161271777584;515702;521390;521508.3924580391;521790;523153;32814.50778238328;34208.315833683184;59584.40415595788;59918.400815991285;60078.098828517606;34625.48061779075;34936.825315873255;34947.65052349495;35042;35054.12364690852;14726;14808.555743327717;14832;14867.479638212611;14883.627909302355;10140.492975351202;12454.439550220262;12617.927476164445;12619.242845429304;12673.493060277486;7531.096268447822;7593.1647518774;7705.42209334291;7775.688972441152;7779.338756205786;3236.8057916525086;3257.413665540178;3277.19708671377;3280.8851690190727;3303.3723592517345;781.0744268042388;997.8453339732353;1007.2043085962155;1073.4525392050111;1110.2006555280186;23435.7656423437;24295.392615184763;29595.260118497208;30393.392132157234;31057.844710776302;991.6677912899115;1008.8638033865334;1017.1944797983638;1030.8814486334168;1103.6413165721012;11239.719007024727;11668.94165529167;14613;15282.98322878248;15303.540893773205;668913;681246;682192;684322;685417;54008.72995634997;55213.72393138009;55562;55639.72180139073;55646.16530752042;1369.7192075624473;1371.1567386057502;1395.3441882315499;1401.9018668693298;1407.4018542119559;28188.43623127567;28968.420631587673;29264.853675731487;29351.706482934896;29455.705442946153;48557.02885942191;49188.75405622949;49281.26078108759;49347;49363.753181233864;577498;579744;579776;579976;581418;24964.876580554283;25487.36281592901;25734.356641084123;26010.60984085278;26047.348816279744;44296.55703442924;44855.77572112119;45269.54730452785;45683.77158114188;46243;38023.61976380201;38141;38236.42645360266;38297;38856.80571597124;37546.249075018895;37694.8115259422;38208.80895595504;38671.41992870053;38931.805340973115;31540.842295788374;31958.36083278275;36284.63715362812;36702.63297366992;37090.629093709795;26354.341141471617;31786.682133178372;33439.66560334463;33515.497267540515;33573.32853342871;25229;25283.87358063198;25387.111451099125;25739.356516087246;25763.484730304914 09:38:50 INFO - PROCESS | 1659 | |2;jquery.html;373.0598890795196;374.1040208700163;383.15323135869727;388.98638547650836;402.86392373506703;18917.16242563616;19783.703244451346;21155.153793848247;21451.892740536314;21560.460988475297;11622.418879056057;11836.467358968846;12003.63989080329;12035.338056406894;19373;5309.469053094698;5513.558915286788;5630.493255606994;5633.352164501094;5633.492985631292;5284.392294886099;5459.781608735646;5489.094299440588;5492.780288788444;5504.256925315071;5490.450954904518;5495.53287970523;5500.119980803072;5515.503604675579;5515.558755299567;5414.8917021659545;5903.675297858637;6055.818325450244;6098.847528811793;6153.046277826944;5124.718140502308;5345.465453454663;5363.383210930754;5376.032314183445;5383.327084114486;13119.737605247938;13374.665633359147;13378.264195469244;13415.128016678884;13427.932860335635;2202.449387653087;2360.929172124839;2429.9514009719705;2481.5409149307434;2681.825681330707;10042.146417554517;10193.694189174337;10225.181985441146;10484.475776211235;10526.42104684242;1864.8321651051335;1888.2069530796962;1923.1538123225876;1958.598487310098;1990.3431867483696;120916;125140.37429812792;127446.36276818649;127490.36254818666;130236.3488182553;9641;11339.092872570174;11832;11905.226160299553;12277.38613069343;12586.118971672078;14735.968482206143;14798.446163152928;14850.851491485162;14867.884908631895;7728.343090837229;8040.713485842237;8375.371847111492;8545.145485451405;8717.52053637056;6895.310468953065;8577.528235946958;8611.870821937677;8724.302055835518;8800.767892495056;4214.4310518079665;4481.75350355727;4584.862454126315;4640.744759038285;4656.092062047868;1666.4334126397084;1776.9693577724888;1814.8294350144083;1911.9426417207505;1969.6060787842202;714.5141303913389;723.64541374726;886.4415418286567;888.4624801994701;892.455602082729;16162.59593510148;20044.59910801776;21190.576188476145;21234;21286.467838304165;848.7692845374108;925.4031149908271;927.3091546797679;943.740471370365;987.2644879564626;8555.657773689107;10710.785784284426;11240.943795281135;11242.887571124347;11271.09831213501;565215.1739241277;595675;637433;645553;652468;88612.55693721618;106405;107736;112779.87220127694;132081;979.314479864098;1003.1673710820002;1039.5581877701945;1040.9635662751768;1043.6973277749369;18534.536636584195;18944.810551894305;19152.425427237205;19157.509702169176;19193.32823351176;52193.478065218864;53162.734186328824;53868.92262154657;55181.44818551763;56387.71806141107;78268.60865695635;80676.59661701653;81063.59468202622;82195;82291.58854205691;8093;8110.83778324442;8129.8374032520205;8350.707725229588;8501;7254;11709.590164344207;12792;12907.806382904077;13185.340732963505;11110.944445278044;11118;11137.888621114009;11309.886901131213;11371.43142842871;11014.559417623206;11070.28043177191;11119.666410007712;11229.494672739584;11475.483603237708;11167.553297868319;11410.600628977945;11477.942610286895;11498.965093141658;11669.59156429521;7794.2985131338455;8007.119216886022;8013.559254241072;8172.019357677117;8256.876146857681;9715.36850104741;10834.783304334027;10902.78194436091;11108.111351092055;11110.444477775916 09:38:50 INFO - PROCESS | 1659 | |3;mootools.html;1487.471947458652;1494.8953573249871;1710.016740374285;1839;1848.085197827075;8111.067227268851;8352.665893364257;8623.439476434027;9213;9218.262538996882;8640.956795216016;8923.509206993613;8961.148690874357;9045.3668243223;9047.502387368708;2394.2218778896886;2420.4432980414517;2429.5991161458337;2429.854208747472;2440.2801173653725;2390.557746816836;2398.8920498577518;2407.7832995030444;2442.05980697431;2442.792362649177;2403.831731778776;2410.963835542468;2422.9273121806373;2437.061731233479;2439.6462512935614;2396.2332053742807;2400.699912510936;2407.350015495815;2413.143334116381;2422.6729391532094;2380.3335066181326;2390.497995420964;2405.5068710914397;2409.7590240975937;2411.9758802411925;7570;7696.730614428524;8931.50876701781;9134.223590994774;9170.816583668357;4417.271150260203;5474.890502189934;5481.013417584833;5485.890282194374;5526.447355264481;3572.446270828;3698.2418604186078;3711.5546134463766;3747.775133491999;3764.3976963685955;931.6180366049955;1086.2559146984263;1104.6741211342674;1105.4969988655143;1110.2450333773031;10293.279470437072;11454.312741235553;12019.338936358497;12084.093692972974;12136.57521986735;4745.715257084586;4786.8085276588545;4807.543283388072;4928.778204980785;4951.529604687549;8384.455010424303;9990.950045249727;10174.13519850821;10234.948825255975;10254.28220024591;5312.017276803804;5367.2485851980755;5372.167314066326;5375.435579264121;5377.601823525912;4292.59220374064;4477.485089214782;4628.352030715702;4668.276417155346;4873.342098816685;4005.1989602079702;4032.395140728914;4114.300568903293;4148.709590328648;4153.522344930311;1116.1405717597568;1310.462710288777;1317.078045368246;1327.5419980106847;1330.3414809669275;754.2156157596039;861.9827603448022;900.5767289373983;910.8815853938945;916.8578870275118;5785.71071446426;5805.7387417566315;5875.089361149029;5879.706014699248;6102.511799056154;724.9420046396276;942.9245660347156;956.8899576548786;959.5777857742711;974.6686126716809;3894.902627434337;3973.4238535412205;4065.837366505366;4102.241085399151;4118.9588104119175;10664.933506649273;11045.282056666452;11056.447177641086;11100.777984440267;11137.387443690513;10936.179786516042;10942.726431839108;10967.341959482297;10971.506282217319;11006.229563930448;7916.722914697958;8178.304844088319;8234.382421318425;8256.752297431087;8263.917360826315;5007.649464537448;5961.701914904151;5982.222311099703;6022.48808851235;6092.116643086816;10167.898321016695;10180.949095254477;10194.235432342455;10349.586016559555;10353.06822385989;9858.704238872846;9942.254330925065;10161.237907157141;10261.9486902565;10365.84451233217;7528.247175282428;7763.6413627616075;8015.318697910509;8160.5103693778565;8421.663133474838;8328.583570821556;8502.617382217939;8522.147785221428;8533.359998000298;8535.0184728757;7491.3632341251605;7620.771376858703;7623.847523049619;7657.310842024244;7830.765077047698;7389.630518474162;7420.666070026754;7477.027986361738;7517.849643007;7557.433192510473;6747.628880411625;6917.550359226634;7084.46866485026;7115.075040244735;7133.82165445868;4860.684055536379;4876.268559716071;4978.4274808397495;5057.241413787961;5084.161113416245;5006.374203224597;5101.51535604117;5105.668131571436;5156.639035267645;5162.303089082926 09:38:50 INFO - PROCESS | 1659 | |4;prototype.html;264.3035601190862;299.3414488126123;307.67232896964737;310.6784478065203;313.0342892177632;4583.8395656152;5323.8136665216725;5516.841752960984;5527.281453411061;5659.698269398041;5311.62818602698;5489.615726899118;5491.478309560585;5499.7250137493165;5513.669179849212;4115.71190016699;4165.458490396244;4171.520275168349;4196.853110141131;4204.432401625787;4053.8581149659767;4181.686373521983;4190.664746820247;4205.957940420602;4218.409422680812;3551.520544726455;4131.979340103296;4160.687948403866;4169.916601667965;4173.269677806387;3416;3595.334863050318;4151.107511884944;4156.688248381383;4167.979160104195;3174.841182968223;3620.6922411595046;3634.2186429917697;3646.7629604075914;3657.7439579229463;5144.665596736238;5323.494268044529;5349.298604204891;5371.650842695251;5389.865253368658;4817.735024573647;4840.903181936342;4845.927311090337;4850.902981940341;4853.005133947532;4525.705829121097;5627.214528808226;5830.4169583041785;5832.912506312408;5903.5572332074835;3710.628937106295;3768.8869333920024;3902.1464804218053;3965.643092121694;4000.9199816003515;4639.443266807971;5328.413874473844;5516.972415137899;5659.830205093854;5860;3359.338321229822;3391.3047825195777;3864.7487913285545;4055.5538890721996;4072.205919845661;3160.5891234139413;4026.939595906064;4097.160082183145;4109.8972525686495;4160;4796.232602783538;4817.205161148371;4825.879353016133;4845.9030819383415;4872.805087796449;5065.189569668909;5822.417758224144;5859.589828712034;5874.853128671817;5948.67282299469;1158.2760774515928;1267.8446143971073;1402.4810819996667;1402.9158250504797;1407.9436822527189;677.7356830835978;837.8897960202755;839.8026463781007;858.2018722588053;862.2369203255039;4287.571242875688;4333.316680821276;4452.955470445254;4623.56076172763;4678.181318269358;4186.874393768131;4417.3815665806815;4715.622750179978;4821.962163836831;4981.825636102719;3888.7666739995125;4545.886352841139;4563.859035241189;4605.6085232755595;4678.883027924329;2173.739151301854;2335.2293743064747;2737.2609395463114;2992.354205187138;3046.471428714162;6222.657753823492;6236.634355950852;6297.520082780543;6302.306746257908;6339.936600634027;5152.613553983391;5156.484351564814;6095.146679464879;6212.546044312471;6278.340774218733;5160.458151894072;5182.559482444034;5820.854478638068;6296.811095667045;6331.873362532723;5727.8854422912145;6047.78832740852;6121.143039974496;6135.815925522242;6157.938420615916;4585.839495617771;5400.973814975142;5980;5981.880362392815;5989.401059893976;6242.28213755424;6320.209973753281;6338.366163383625;6362.518617739178;6374.904376434264;3859.9807000964815;3979.92040159201;4001.899952501211;4003.899902502344;4020.5927925227106;4460.910781784281;4645.976770116128;6021.139958519668;6044.788432404845;6075;4821.855344339676;5570.6657600544095;5750.654960702372;5871.73757642109;5913.201717768218;4975.228839529878;5152;5455.509004189642;5524.977879092381;5828.475437210672;4240.872773816791;5440.945590544044;5684.573656975826;5704.174664107446;5736.254286942671;4846.781894814671;4991.376077990251;5780.971095144666;5835.183074369676;5870.55970802183;5139.794408223779;5545.4490934170735;5722.513586345207;5733.942660573341;5740.282464691913 09:38:50 INFO - PROCESS | 1659 | |5;yui.html;681.7545683553923;756.5876597254496;775.631575001874;788.7002938883223;790.7232468635974;15528.223588820556;15819.762703559427;15895.682086358265;15896.920515397436;15940.282687279072;11781.408090220159;14253.50112746054;14286.642833929158;14298.927580431457;14313.642158946031;674.2919934069232;695.8434352270724;803.1968031968032;825.9297959673435;839.8992120945495;729.7591794707761;766.643510767493;785.0892964161574;857.0529564830865;858.2876212743439;718.9676464559108;740.2227660956002;862.2239984014375;905.0496978172926;906.2251774732607;893.6916763716507;894.5080205886769;901.1304091551651;903.7785742493065;904.9773755656096;567;669.7354544954765;670.9832254193684;671.509797847574;676.100785954679;14646.707065858624;14854.925725371411;14856.18290993995;14868.405263789435;14896.404143834234;11797.88202117985;14582.781258281135;14588.635284117876;14691.33888974988;14877.33052012662;11046.447677616168;11419.771604567944;11619.709507262301;11777.057835373234;12152.57465988695;3771.283456143324;3832.1186127190904;3881.8059097045316;3981.203759248133;3994.960050399517;121042.18436723456;124335.37832310781;130076.69923300834;130556;131145.34427327898;10823.512941917632;11048.944755276332;11179.161562882817;11426.143039272089;11444.656660300205;17269.481915542554;22149.889250553642;22873.656895146585;22911.656325155134;22980.88509557475;7769.339606133542;7931.28618424333;8209.343252539782;8292.460990035628;8325.209105135002;4289.142171565637;4407.382966384709;4494.10117976406;4552.863414097583;4604.332371806069;3541.7166626669805;3569.589497207802;3650.7261955353456;3663.6885864701267;3669.2661467706566;627.4227710506345;642.4988508963016;646.6281887914374;651.6383407209045;655.7049327802508;648.1832890557931;653.8234676637377;659.3768888400416;680.8604236131581;683.3917813146304;8692.304615630734;8754.51850148248;9245.676401325922;9457.810843783223;9637.036296370306;502.94719054499484;610.2981571193163;650.8535579494576;671.3957438305564;675.6587923098901;4332.783360832009;4677.929831052537;4679.836205732851;4717.9056418872115;4742.312364707167;170687;179616.20383795994;182817;184407.0779646093;185149.07425463057;118215.40892295656;151870.24064879605;152814;154719;154794.22602887137;83565.58217208875;123271;132633.3368333152;135079.3246033783;137136;8659.87010194835;8772.78068048304;9076.910770707558;9116.042815504277;9291.76770580741;43502;48784;57996.13005804832;61931;64492.67753661202;95784.52107739417;96624;96832.51583742036;99273;102988;11105.444727763741;11205.207166853264;11301.491432885376;11317.773644526898;11824.940875295568;12404.81392779127;12410.937945310216;12448.190867593577;12468.563600273947;12664.936675316565;11527.711807204552;11626.360550169822;12192.695182620506;12608.36958152107;12631.81052284198;11932.403379831147;12152.513899443924;12292.385380731106;12598.433070512032;12622.305773182563;9739.366941148803;11870.584529541424;11988.940055299669;11998.460069296729;12351.629451116482;9160.90603024083;10209.897901020895;10229.132569558018;10246.231532634933;10286;9467.810643787223;10029.54867031;10184.796304074025;10197.439140847324;10199.949000254952 09:38:50 INFO - PROCESS | 1659 | __end_tp_report 09:38:50 INFO - PROCESS | 1659 | __start_cc_report 09:38:50 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,359 09:38:50 INFO - PROCESS | 1659 | __end_cc_report 09:38:50 INFO - PROCESS | 1659 | __startTimestamp1476463130438__endTimestamp 09:38:50 INFO - PROCESS | 1659 | 09:38:50 INFO - PROCESS | 1659 | ------- Summary: start ------- 09:38:50 INFO - PROCESS | 1659 | Number of tests: 6 09:38:50 INFO - PROCESS | 1659 | 09:38:50 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5842.97 Median:6129.85 stddev:670.36 (10.9%) stddev-sans-first:644.64 09:38:50 INFO - PROCESS | 1659 | Values: 3408.7 3410.3 3411.9 3436.9 3465.7 5744.0 5806.7 5813.3 5833.4 5848.4 5889.2 5928.7 5968.9 5986.4 5995.7 5267.5 5353.1 5355.3 5398.3 5465.1 5114.9 5385.6 5386.5 5391.9 5409.1 5270.9 5327.0 5404.8 5410.9 5412.5 4501.6 5107.4 5322.7 5325.9 5341.8 5244.0 5276.7 5316.1 5355.7 5394.2 5781.6 5959.1 5994.0 5998.0 6015.3 6109.1 6165.1 6197.1 6202.0 6217.5 6280.3 6306.5 6314.7 6323.8 6339.3 5991.8 6039.2 6055.3 6065.8 6084.4 6372.5 6440.3 6472.7 6480.8 6486.1 4730.5 5656.6 5766.0 6188.4 6251.3 6133.2 6137.9 6341.8 6374.7 6378.0 6133.7 6139.3 6213.8 6219.8 6235.4 5858.7 6269.9 6270.7 6283.9 6291.6 4113.4 5014.7 5040.6 5055.8 5073.1 4418.0 4431.4 4477.7 4483.2 4523.5 6014.8 6125.0 6154.8 6157.5 6169.5 6324.3 6360.0 6363.1 6374.7 6386.6 5984.1 6010.9 6050.2 6057.9 6077.3 5472.4 5507.4 5523.4 5538.2 5540.4 6405.3 6419.4 6432.4 6447.1 6458.1 6215.1 6244.4 6266.8 6296.4 6328.0 6520.3 6535.9 6544.8 6547.9 6562.1 6221.3 6297.8 6304.5 6314.0 6324.3 6120.6 6215.5 6222.9 6247.5 6341.6 6157.5 6240.7 6268.0 6281.1 6295.2 6226.3 6242.9 6247.2 6251.2 6257.5 4798.7 6029.3 6086.7 6102.1 6210.4 6138.1 6154.3 6171.3 6222.8 6251.7 6129.8 6142.8 6145.7 6161.3 6164.7 09:38:50 INFO - PROCESS | 1659 | 09:38:50 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:70258.59 Median:38174.90 stddev:160213.68 (419.7%) stddev-sans-first:160577.35 09:38:50 INFO - PROCESS | 1659 | Values: 436.2 508.1 509.8 515.3 526.5 35893.8 39489.6 39865.0 41510.2 41588.4 42417.4 42768.8 42881.0 42950.6 42998.0 9811.6 9854.9 9984.0 9991.5 10012.2 9763.6 9766.6 9832.5 9874.8 9937.6 9880.6 9883.8 9924.0 9927.8 9936.4 9836.3 9844.8 9854.9 9890.5 9897.2 9748.0 9787.6 9851.3 9861.3 9871.6 33133.8 40384.8 40501.0 40534.0 40952.0 3259.3 3306.9 3460.7 3534.0 3714.9 30449.4 30454.4 30752.8 30866.4 31390.8 2721.5 3134.0 3255.9 3259.6 3336.4 515702.0 521390.0 521508.4 521790.0 523153.0 32814.5 34208.3 59584.4 59918.4 60078.1 34625.5 34936.8 34947.7 35042.0 35054.1 14726.0 14808.6 14832.0 14867.5 14883.6 10140.5 12454.4 12617.9 12619.2 12673.5 7531.1 7593.2 7705.4 7775.7 7779.3 3236.8 3257.4 3277.2 3280.9 3303.4 781.1 997.8 1007.2 1073.5 1110.2 23435.8 24295.4 29595.3 30393.4 31057.8 991.7 1008.9 1017.2 1030.9 1103.6 11239.7 11668.9 14613.0 15283.0 15303.5 668913.0 681246.0 682192.0 684322.0 685417.0 54008.7 55213.7 55562.0 55639.7 55646.2 1369.7 1371.2 1395.3 1401.9 1407.4 28188.4 28968.4 29264.9 29351.7 29455.7 48557.0 49188.8 49281.3 49347.0 49363.8 577498.0 579744.0 579776.0 579976.0 581418.0 24964.9 25487.4 25734.4 26010.6 26047.3 44296.6 44855.8 45269.5 45683.8 46243.0 38023.6 38141.0 38236.4 38297.0 38856.8 37546.2 37694.8 38208.8 38671.4 38931.8 31540.8 31958.4 36284.6 36702.6 37090.6 26354.3 31786.7 33439.7 33515.5 33573.3 25229.0 25283.9 25387.1 25739.4 25763.5 09:38:50 INFO - PROCESS | 1659 | 09:38:50 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:34823.68 Median:2395.44 stddev:103268.64 (4311.1%) stddev-sans-first:103525.94 09:38:50 INFO - PROCESS | 1659 | Values: 373.1 374.1 383.2 389.0 402.9 18917.2 19783.7 21155.2 21451.9 21560.5 11622.4 11836.5 12003.6 12035.3 19373.0 5309.5 5513.6 5630.5 5633.4 5633.5 5284.4 5459.8 5489.1 5492.8 5504.3 5490.5 5495.5 5500.1 5515.5 5515.6 5414.9 5903.7 6055.8 6098.8 6153.0 5124.7 5345.5 5363.4 5376.0 5383.3 13119.7 13374.7 13378.3 13415.1 13427.9 2202.4 2360.9 2430.0 2481.5 2681.8 10042.1 10193.7 10225.2 10484.5 10526.4 1864.8 1888.2 1923.2 1958.6 1990.3 120916.0 125140.4 127446.4 127490.4 130236.3 9641.0 11339.1 11832.0 11905.2 12277.4 12586.1 14736.0 14798.4 14850.9 14867.9 7728.3 8040.7 8375.4 8545.1 8717.5 6895.3 8577.5 8611.9 8724.3 8800.8 4214.4 4481.8 4584.9 4640.7 4656.1 1666.4 1777.0 1814.8 1911.9 1969.6 714.5 723.6 886.4 888.5 892.5 16162.6 20044.6 21190.6 21234.0 21286.5 848.8 925.4 927.3 943.7 987.3 8555.7 10710.8 11240.9 11242.9 11271.1 565215.2 595675.0 637433.0 645553.0 652468.0 88612.6 106405.0 107736.0 112779.9 132081.0 979.3 1003.2 1039.6 1041.0 1043.7 18534.5 18944.8 19152.4 19157.5 19193.3 52193.5 53162.7 53868.9 55181.4 56387.7 78268.6 80676.6 81063.6 82195.0 82291.6 8093.0 8110.8 8129.8 8350.7 8501.0 7254.0 11709.6 12792.0 12907.8 13185.3 11110.9 11118.0 11137.9 11309.9 11371.4 11014.6 11070.3 11119.7 11229.5 11475.5 11167.6 11410.6 11477.9 11499.0 11669.6 7794.3 8007.1 8013.6 8172.0 8256.9 9715.4 10834.8 10902.8 11108.1 11110.4 09:38:50 INFO - PROCESS | 1659 | 09:38:50 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5782.27 Median:4902.52 stddev:3235.71 (66.0%) stddev-sans-first:3228.69 09:38:50 INFO - PROCESS | 1659 | Values: 1487.5 1494.9 1710.0 1839.0 1848.1 8111.1 8352.7 8623.4 9213.0 9218.3 8641.0 8923.5 8961.1 9045.4 9047.5 2394.2 2420.4 2429.6 2429.9 2440.3 2390.6 2398.9 2407.8 2442.1 2442.8 2403.8 2411.0 2422.9 2437.1 2439.6 2396.2 2400.7 2407.4 2413.1 2422.7 2380.3 2390.5 2405.5 2409.8 2412.0 7570.0 7696.7 8931.5 9134.2 9170.8 4417.3 5474.9 5481.0 5485.9 5526.4 3572.4 3698.2 3711.6 3747.8 3764.4 931.6 1086.3 1104.7 1105.5 1110.2 10293.3 11454.3 12019.3 12084.1 12136.6 4745.7 4786.8 4807.5 4928.8 4951.5 8384.5 9991.0 10174.1 10234.9 10254.3 5312.0 5367.2 5372.2 5375.4 5377.6 4292.6 4477.5 4628.4 4668.3 4873.3 4005.2 4032.4 4114.3 4148.7 4153.5 1116.1 1310.5 1317.1 1327.5 1330.3 754.2 862.0 900.6 910.9 916.9 5785.7 5805.7 5875.1 5879.7 6102.5 724.9 942.9 956.9 959.6 974.7 3894.9 3973.4 4065.8 4102.2 4119.0 10664.9 11045.3 11056.4 11100.8 11137.4 10936.2 10942.7 10967.3 10971.5 11006.2 7916.7 8178.3 8234.4 8256.8 8263.9 5007.6 5961.7 5982.2 6022.5 6092.1 10167.9 10180.9 10194.2 10349.6 10353.1 9858.7 9942.3 10161.2 10261.9 10365.8 7528.2 7763.6 8015.3 8160.5 8421.7 8328.6 8502.6 8522.1 8533.4 8535.0 7491.4 7620.8 7623.8 7657.3 7830.8 7389.6 7420.7 7477.0 7517.8 7557.4 6747.6 6917.6 7084.5 7115.1 7133.8 4860.7 4876.3 4978.4 5057.2 5084.2 5006.4 5101.5 5105.7 5156.6 5162.3 09:38:50 INFO - PROCESS | 1659 | 09:38:50 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4583.56 Median:4851.95 stddev:1459.96 (30.1%) stddev-sans-first:1427.61 09:38:50 INFO - PROCESS | 1659 | Values: 264.3 299.3 307.7 310.7 313.0 4583.8 5323.8 5516.8 5527.3 5659.7 5311.6 5489.6 5491.5 5499.7 5513.7 4115.7 4165.5 4171.5 4196.9 4204.4 4053.9 4181.7 4190.7 4206.0 4218.4 3551.5 4132.0 4160.7 4169.9 4173.3 3416.0 3595.3 4151.1 4156.7 4168.0 3174.8 3620.7 3634.2 3646.8 3657.7 5144.7 5323.5 5349.3 5371.7 5389.9 4817.7 4840.9 4845.9 4850.9 4853.0 4525.7 5627.2 5830.4 5832.9 5903.6 3710.6 3768.9 3902.1 3965.6 4000.9 4639.4 5328.4 5517.0 5659.8 5860.0 3359.3 3391.3 3864.7 4055.6 4072.2 3160.6 4026.9 4097.2 4109.9 4160.0 4796.2 4817.2 4825.9 4845.9 4872.8 5065.2 5822.4 5859.6 5874.9 5948.7 1158.3 1267.8 1402.5 1402.9 1407.9 677.7 837.9 839.8 858.2 862.2 4287.6 4333.3 4453.0 4623.6 4678.2 4186.9 4417.4 4715.6 4822.0 4981.8 3888.8 4545.9 4563.9 4605.6 4678.9 2173.7 2335.2 2737.3 2992.4 3046.5 6222.7 6236.6 6297.5 6302.3 6339.9 5152.6 5156.5 6095.1 6212.5 6278.3 5160.5 5182.6 5820.9 6296.8 6331.9 5727.9 6047.8 6121.1 6135.8 6157.9 4585.8 5401.0 5980.0 5981.9 5989.4 6242.3 6320.2 6338.4 6362.5 6374.9 3860.0 3979.9 4001.9 4003.9 4020.6 4460.9 4646.0 6021.1 6044.8 6075.0 4821.9 5570.7 5750.7 5871.7 5913.2 4975.2 5152.0 5455.5 5525.0 5828.5 4240.9 5440.9 5684.6 5704.2 5736.3 4846.8 4991.4 5781.0 5835.2 5870.6 5139.8 5545.4 5722.5 5733.9 5740.3 09:38:50 INFO - PROCESS | 1659 | 09:38:50 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:26743.88 Median:3666.48 stddev:46003.83 (1254.7%) stddev-sans-first:46091.27 09:38:50 INFO - PROCESS | 1659 | Values: 681.8 756.6 775.6 788.7 790.7 15528.2 15819.8 15895.7 15896.9 15940.3 11781.4 14253.5 14286.6 14298.9 14313.6 674.3 695.8 803.2 825.9 839.9 729.8 766.6 785.1 857.1 858.3 719.0 740.2 862.2 905.0 906.2 893.7 894.5 901.1 903.8 905.0 567.0 669.7 671.0 671.5 676.1 14646.7 14854.9 14856.2 14868.4 14896.4 11797.9 14582.8 14588.6 14691.3 14877.3 11046.4 11419.8 11619.7 11777.1 12152.6 3771.3 3832.1 3881.8 3981.2 3995.0 121042.2 124335.4 130076.7 130556.0 131145.3 10823.5 11048.9 11179.2 11426.1 11444.7 17269.5 22149.9 22873.7 22911.7 22980.9 7769.3 7931.3 8209.3 8292.5 8325.2 4289.1 4407.4 4494.1 4552.9 4604.3 3541.7 3569.6 3650.7 3663.7 3669.3 627.4 642.5 646.6 651.6 655.7 648.2 653.8 659.4 680.9 683.4 8692.3 8754.5 9245.7 9457.8 9637.0 502.9 610.3 650.9 671.4 675.7 4332.8 4677.9 4679.8 4717.9 4742.3 170687.0 179616.2 182817.0 184407.1 185149.1 118215.4 151870.2 152814.0 154719.0 154794.2 83565.6 123271.0 132633.3 135079.3 137136.0 8659.9 8772.8 9076.9 9116.0 9291.8 43502.0 48784.0 57996.1 61931.0 64492.7 95784.5 96624.0 96832.5 99273.0 102988.0 11105.4 11205.2 11301.5 11317.8 11824.9 12404.8 12410.9 12448.2 12468.6 12664.9 11527.7 11626.4 12192.7 12608.4 12631.8 11932.4 12152.5 12292.4 12598.4 12622.3 9739.4 11870.6 11988.9 11998.5 12351.6 9160.9 10209.9 10229.1 10246.2 10286.0 9467.8 10029.5 10184.8 10197.4 10199.9 09:38:50 INFO - PROCESS | 1659 | -------- Summary: end -------- 09:38:50 INFO - PROCESS | 1659 | 09:38:51 INFO - TEST-INFO | 1659: exit 0 09:38:51 INFO - TEST-OK | dromaeo_css | took 1113336ms 09:38:51 INFO - TEST-START | kraken 09:38:51 INFO - operating with platform_type : mac_ 09:38:51 INFO - Initialising browser for kraken test... 09:38:51 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmp31dIP5/profile http://localhost:49273/getInfo.html) 09:38:53 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 09:38:53 INFO - PROCESS | 1669 | colorDepth:24 09:38:53 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 09:38:53 INFO - PROCESS | 1669 | __metrics 09:38:53 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 09:38:54 INFO - TEST-INFO | 1669: exit 0 09:38:54 INFO - Browser initialized. 09:38:54 INFO - Running cycle 1/1 for kraken test... 09:38:54 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmp31dIP5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:06 INFO - PROCESS | 1671 | RSS: Main: 224894976 09:39:06 INFO - PROCESS | 1671 | 09:39:09 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 09:39:10 INFO - PROCESS | 1671 | RSS: Main: 237461504 09:39:10 INFO - PROCESS | 1671 | 09:39:13 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 09:39:13 INFO - PROCESS | 1671 | RSS: Main: 245968896 09:39:13 INFO - PROCESS | 1671 | 09:39:16 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 09:39:17 INFO - PROCESS | 1671 | RSS: Main: 248918016 09:39:17 INFO - PROCESS | 1671 | 09:39:19 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 09:39:20 INFO - PROCESS | 1671 | RSS: Main: 248934400 09:39:20 INFO - PROCESS | 1671 | 09:39:21 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:39:22 INFO - PROCESS | 1671 | RSS: Main: 249069568 09:39:22 INFO - PROCESS | 1671 | 09:39:25 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 09:39:26 INFO - PROCESS | 1671 | RSS: Main: 249618432 09:39:26 INFO - PROCESS | 1671 | 09:39:28 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 09:39:29 INFO - PROCESS | 1671 | RSS: Main: 250679296 09:39:29 INFO - PROCESS | 1671 | 09:39:32 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 09:39:33 INFO - PROCESS | 1671 | RSS: Main: 251162624 09:39:33 INFO - PROCESS | 1671 | 09:39:34 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:39:35 INFO - PROCESS | 1671 | RSS: Main: 250863616 09:39:35 INFO - PROCESS | 1671 | 09:39:37 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:39:37 INFO - PROCESS | 1671 | RSS: Main: 250994688 09:39:37 INFO - PROCESS | 1671 | 09:39:39 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:39:40 INFO - PROCESS | 1671 | RSS: Main: 250867712 09:39:40 INFO - PROCESS | 1671 | 09:39:43 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:44 INFO - PROCESS | 1671 | RSS: Main: 250929152 09:39:44 INFO - PROCESS | 1671 | 09:39:47 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:47 INFO - PROCESS | 1671 | RSS: Main: 251338752 09:39:47 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 09:39:49 INFO - PROCESS | 1671 | RSS: Main: 253005824 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | __start_tp_report 09:39:49 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 09:39:49 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 09:39:49 INFO - PROCESS | 1671 | |i|pagename|runs| 09:39:49 INFO - PROCESS | 1671 | |0;ai-astar;107;139;118;117;120;148;170;96;175;175 09:39:49 INFO - PROCESS | 1671 | |1;audio-beat-detection;172;143;140;135;102;132;97;135;176;112 09:39:49 INFO - PROCESS | 1671 | |2;audio-dft;223;265;197;199;194;189;194;202;198;196 09:39:49 INFO - PROCESS | 1671 | |3;audio-fft;80;57;56;86;57;59;60;60;77;59 09:39:49 INFO - PROCESS | 1671 | |4;audio-oscillator;79;70;90;71;70;95;73;73;59;100 09:39:49 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;89;111;103;88;91;87;90;88;89;86 09:39:49 INFO - PROCESS | 1671 | |6;imaging-darkroom;96;96;96;118;96;96;96;95;96;95 09:39:49 INFO - PROCESS | 1671 | |7;imaging-desaturate;89;133;106;142;91;153;154;113;91;90 09:39:49 INFO - PROCESS | 1671 | |8;json-parse-financial;56;55;57;56;59;59;59;62;60;59 09:39:49 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;67;75;66;73;73;69;69;69;72;72 09:39:49 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;83;82;83;84;85;84;83;87;84;82 09:39:49 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;140;152;152;155;146;143;158;164;199;142 09:39:49 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;167;166;162;164;164;163;171;166;173;228 09:39:49 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;67;66;68;66;68;66;66;67;67;63 09:39:49 INFO - PROCESS | 1671 | __end_tp_report 09:39:49 INFO - PROCESS | 1671 | __start_cc_report 09:39:49 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,942 09:39:49 INFO - PROCESS | 1671 | __end_cc_report 09:39:49 INFO - PROCESS | 1671 | __startTimestamp1476463189696__endTimestamp 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | ------- Summary: start ------- 09:39:49 INFO - PROCESS | 1671 | Number of tests: 14 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:136.50 Median:159.00 stddev:29.31 (18.4%) stddev-sans-first:29.08 09:39:49 INFO - PROCESS | 1671 | Values: 107.0 139.0 118.0 117.0 120.0 148.0 170.0 96.0 175.0 175.0 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:141.50 stddev:26.26 (18.6%) stddev-sans-first:24.07 09:39:49 INFO - PROCESS | 1671 | Values: 172.0 143.0 140.0 135.0 102.0 132.0 97.0 135.0 176.0 112.0 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:205.70 Median:198.50 stddev:22.75 (11.5%) stddev-sans-first:23.25 09:39:49 INFO - PROCESS | 1671 | Values: 223.0 265.0 197.0 199.0 194.0 189.0 194.0 202.0 198.0 196.0 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:65.10 Median:60.00 stddev:11.26 (18.8%) stddev-sans-first:10.57 09:39:49 INFO - PROCESS | 1671 | Values: 80.0 57.0 56.0 86.0 57.0 59.0 60.0 60.0 77.0 59.0 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:73.00 stddev:12.94 (17.7%) stddev-sans-first:13.72 09:39:49 INFO - PROCESS | 1671 | Values: 79.0 70.0 90.0 71.0 70.0 95.0 73.0 73.0 59.0 100.0 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:92.20 Median:88.50 stddev:8.15 (9.2%) stddev-sans-first:8.56 09:39:49 INFO - PROCESS | 1671 | Values: 89.0 111.0 103.0 88.0 91.0 87.0 90.0 88.0 89.0 86.0 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:98.00 Median:96.00 stddev:7.04 (7.3%) stddev-sans-first:7.43 09:39:49 INFO - PROCESS | 1671 | Values: 96.0 96.0 96.0 118.0 96.0 96.0 96.0 95.0 96.0 95.0 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:116.20 Median:121.50 stddev:26.96 (22.2%) stddev-sans-first:26.74 09:39:49 INFO - PROCESS | 1671 | Values: 89.0 133.0 106.0 142.0 91.0 153.0 154.0 113.0 91.0 90.0 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:59.00 stddev:2.15 (3.6%) stddev-sans-first:2.13 09:39:49 INFO - PROCESS | 1671 | Values: 56.0 55.0 57.0 56.0 59.0 59.0 59.0 62.0 60.0 59.0 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:72.00 stddev:2.92 (4.0%) stddev-sans-first:2.80 09:39:49 INFO - PROCESS | 1671 | Values: 67.0 75.0 66.0 73.0 73.0 69.0 69.0 69.0 72.0 72.0 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.49 (1.8%) stddev-sans-first:1.56 09:39:49 INFO - PROCESS | 1671 | Values: 83.0 82.0 83.0 84.0 85.0 84.0 83.0 87.0 84.0 82.0 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:155.10 Median:153.50 stddev:17.20 (11.2%) stddev-sans-first:17.35 09:39:49 INFO - PROCESS | 1671 | Values: 140.0 152.0 152.0 155.0 146.0 143.0 158.0 164.0 199.0 142.0 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:166.50 stddev:19.84 (11.9%) stddev-sans-first:20.95 09:39:49 INFO - PROCESS | 1671 | Values: 167.0 166.0 162.0 164.0 164.0 163.0 171.0 166.0 173.0 228.0 09:39:49 INFO - PROCESS | 1671 | 09:39:49 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.43 (2.1%) stddev-sans-first:1.50 09:39:49 INFO - PROCESS | 1671 | Values: 67.0 66.0 68.0 66.0 68.0 66.0 66.0 67.0 67.0 63.0 09:39:49 INFO - PROCESS | 1671 | -------- Summary: end -------- 09:39:49 INFO - PROCESS | 1671 | 09:39:50 INFO - TEST-INFO | 1671: exit 0 09:39:50 INFO - TEST-OK | kraken | took 59377ms 09:39:50 INFO - SUITE-END | took 1172s 09:39:50 INFO - Completed test suite (00:19:33) 09:39:50 INFO - javascript benchmark 09:39:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7241.505594497692, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3408.7443441741866, 3410.3179364127172, 3411.948820767689, 3436.931261374771, 3465.6707612776777, 5744.0, 5806.709664516773, 5813.33146688131, 5833.3874943130995, 5848.444397782204, 5889.2049573307595, 5928.7035648217525, 5968.940310596893, 5986.371430999737, 5995.730192141354, 5267.47325267473, 5353.116735738598, 5355.250264962889, 5398.2982212312345, 5465.098258787295, 5114.923276150861, 5385.569154467653, 5386.542143917772, 5391.919121213185, 5409.053415652264, 5270.894582108355, 5327.0, 5404.756785944642, 5410.91883621746, 5412.485813847678, 4501.639868810487, 5107.391171780896, 5322.7072511011875, 5325.866853328678, 5341.839744807662, 5244.029854476896, 5276.683398996072, 5316.069687804618, 5355.732213389315, 5394.1908713692865, 5781.624194427391, 5959.135925290809, 5994.0, 5998.0, 6015.2781666200335, 6109.101029780123, 6165.106059621375, 6197.101420294077, 6202.0, 6217.471514921192, 6280.2777680566405, 6306.527010474187, 6314.652694101823, 6323.778667746653, 6339.270983836872, 5991.7902873399225, 6039.245094363205, 6055.333913269493, 6065.787697430569, 6084.361142080106, 6372.490200783926, 6440.323766004596, 6472.741090356427, 6480.773172938924, 6486.05952136947, 4730.503297153749, 5656.575756818255, 5766.04860198071, 6188.381161883775, 6251.3123556408755, 6133.151048553363, 6137.877242455126, 6341.8097457076365, 6374.713137908805, 6378.0, 6133.671320645534, 6139.30815411195, 6213.751449941951, 6219.782307619212, 6235.376462353819, 5858.652509922742, 6269.937300627026, 6270.749170033238, 6283.874322513616, 6291.559590828598, 4113.424120623115, 5014.749262536859, 5040.647154699209, 5055.797768089235, 5073.137566613685, 4418.028033832552, 4431.423914891108, 4477.686561940698, 4483.237849565582, 4523.525029871882, 6014.849628759316, 6124.991279909952, 6154.753809847645, 6157.538184636171, 6169.5064394848305, 6324.3043265240785, 6360.0, 6363.077353783676, 6374.745010199633, 6386.552941294158, 5984.072468767348, 6010.909836352458, 6050.183225264533, 6057.909131363033, 6077.3314935357075, 5472.370677372073, 5507.394186639466, 5523.420040895729, 5538.169274608841, 5540.418256083134, 6405.263394709668, 6419.358064193543, 6432.35676432353, 6447.1296374989715, 6458.128152699325, 6215.098810672517, 6244.438000579969, 6266.780662676784, 6296.401841825019, 6327.96836015817, 6520.315366886409, 6535.901961470487, 6544.803655890331, 6547.869042619026, 6562.146920900444, 6221.346758590464, 6297.842553936005, 6304.495640348669, 6313.9897616383, 6324.30432652417, 6120.632762034292, 6215.502759779117, 6222.875542489215, 6247.468965138014, 6341.556091073765, 6157.507399407947, 6240.687965601793, 6268.028455589391, 6281.057841323838, 6295.244570651368, 6226.25284965807, 6242.875142497215, 6247.219097612799, 6251.218597675291, 6257.530685198537, 4798.688085274585, 6029.336772955059, 6086.7260973255425, 6102.0541816018585, 6210.378962103753, 6138.081874381997, 6154.261488621394, 6171.290301615371, 6222.81331560054, 6251.749930002931, 6129.84675383119, 6142.754289828356, 6145.723442445012, 6161.291451483136, 6164.691765411621], "value": 5800.089602479871, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.17562806296127, 508.1184145507544, 509.8215624531414, 515.2863284351173, 526.4630077321135, 35893.82053089731, 39489.60510394899, 39865.0, 41510.16979660405, 41588.37617435737, 42417.36373954393, 42768.786156069255, 42881.0, 42950.57049429505, 42998.0, 9811.607535698564, 9854.901450985506, 9984.0, 9991.500424978722, 10012.249081318894, 9763.560639771193, 9766.560504777266, 9832.459214743187, 9874.753131171743, 9937.552810123561, 9880.604775808959, 9883.802323953516, 9923.950380248089, 9927.751806204866, 9936.35413698111, 9836.262280328969, 9844.803103937917, 9854.901450985542, 9890.505474726235, 9897.15874150698, 9748.025197480196, 9787.608495660237, 9851.310408271424, 9861.309708320421, 9871.60513579456, 33133.83433082819, 40384.78845634636, 40500.98747531306, 40534.0, 40952.0, 3259.2503724143344, 3306.8677252909856, 3460.74044446665, 3534.0458076319505, 3714.8699795507027, 30449.391012179854, 30454.390912181854, 30752.846235768902, 30866.38267234665, 31390.843045784626, 2721.537338652414, 3134.044116544453, 3255.8697652094124, 3259.576255086847, 3336.4161271777584, 515702.0, 521390.0, 521508.3924580391, 521790.0, 523153.0, 32814.50778238328, 34208.315833683184, 59584.40415595788, 59918.400815991285, 60078.098828517606, 34625.48061779075, 34936.825315873255, 34947.65052349495, 35042.0, 35054.12364690852, 14726.0, 14808.555743327717, 14832.0, 14867.479638212611, 14883.627909302355, 10140.492975351202, 12454.439550220262, 12617.927476164445, 12619.242845429304, 12673.493060277486, 7531.096268447822, 7593.1647518774, 7705.42209334291, 7775.688972441152, 7779.338756205786, 3236.8057916525086, 3257.413665540178, 3277.19708671377, 3280.8851690190727, 3303.3723592517345, 781.0744268042388, 997.8453339732353, 1007.2043085962155, 1073.4525392050111, 1110.2006555280186, 23435.7656423437, 24295.392615184763, 29595.260118497208, 30393.392132157234, 31057.844710776302, 991.6677912899115, 1008.8638033865334, 1017.1944797983638, 1030.8814486334168, 1103.6413165721012, 11239.719007024727, 11668.94165529167, 14613.0, 15282.98322878248, 15303.540893773205, 668913.0, 681246.0, 682192.0, 684322.0, 685417.0, 54008.72995634997, 55213.72393138009, 55562.0, 55639.72180139073, 55646.16530752042, 1369.7192075624473, 1371.1567386057502, 1395.3441882315499, 1401.9018668693298, 1407.4018542119559, 28188.43623127567, 28968.420631587673, 29264.853675731487, 29351.706482934896, 29455.705442946153, 48557.02885942191, 49188.75405622949, 49281.26078108759, 49347.0, 49363.753181233864, 577498.0, 579744.0, 579776.0, 579976.0, 581418.0, 24964.876580554283, 25487.36281592901, 25734.356641084123, 26010.60984085278, 26047.348816279744, 44296.55703442924, 44855.77572112119, 45269.54730452785, 45683.77158114188, 46243.0, 38023.61976380201, 38141.0, 38236.42645360266, 38297.0, 38856.80571597124, 37546.249075018895, 37694.8115259422, 38208.80895595504, 38671.41992870053, 38931.805340973115, 31540.842295788374, 31958.36083278275, 36284.63715362812, 36702.63297366992, 37090.629093709795, 26354.341141471617, 31786.682133178372, 33439.66560334463, 33515.497267540515, 33573.32853342871, 25229.0, 25283.87358063198, 25387.111451099125, 25739.356516087246, 25763.484730304914], "value": 18392.425985847465, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.0598890795196, 374.1040208700163, 383.15323135869727, 388.98638547650836, 402.86392373506703, 18917.16242563616, 19783.703244451346, 21155.153793848247, 21451.892740536314, 21560.460988475297, 11622.418879056057, 11836.467358968846, 12003.63989080329, 12035.338056406894, 19373.0, 5309.469053094698, 5513.558915286788, 5630.493255606994, 5633.352164501094, 5633.492985631292, 5284.392294886099, 5459.781608735646, 5489.094299440588, 5492.780288788444, 5504.256925315071, 5490.450954904518, 5495.53287970523, 5500.119980803072, 5515.503604675579, 5515.558755299567, 5414.8917021659545, 5903.675297858637, 6055.818325450244, 6098.847528811793, 6153.046277826944, 5124.718140502308, 5345.465453454663, 5363.383210930754, 5376.032314183445, 5383.327084114486, 13119.737605247938, 13374.665633359147, 13378.264195469244, 13415.128016678884, 13427.932860335635, 2202.449387653087, 2360.929172124839, 2429.9514009719705, 2481.5409149307434, 2681.825681330707, 10042.146417554517, 10193.694189174337, 10225.181985441146, 10484.475776211235, 10526.42104684242, 1864.8321651051335, 1888.2069530796962, 1923.1538123225876, 1958.598487310098, 1990.3431867483696, 120916.0, 125140.37429812792, 127446.36276818649, 127490.36254818666, 130236.3488182553, 9641.0, 11339.092872570174, 11832.0, 11905.226160299553, 12277.38613069343, 12586.118971672078, 14735.968482206143, 14798.446163152928, 14850.851491485162, 14867.884908631895, 7728.343090837229, 8040.713485842237, 8375.371847111492, 8545.145485451405, 8717.52053637056, 6895.310468953065, 8577.528235946958, 8611.870821937677, 8724.302055835518, 8800.767892495056, 4214.4310518079665, 4481.75350355727, 4584.862454126315, 4640.744759038285, 4656.092062047868, 1666.4334126397084, 1776.9693577724888, 1814.8294350144083, 1911.9426417207505, 1969.6060787842202, 714.5141303913389, 723.64541374726, 886.4415418286567, 888.4624801994701, 892.455602082729, 16162.59593510148, 20044.59910801776, 21190.576188476145, 21234.0, 21286.467838304165, 848.7692845374108, 925.4031149908271, 927.3091546797679, 943.740471370365, 987.2644879564626, 8555.657773689107, 10710.785784284426, 11240.943795281135, 11242.887571124347, 11271.09831213501, 565215.1739241277, 595675.0, 637433.0, 645553.0, 652468.0, 88612.55693721618, 106405.0, 107736.0, 112779.87220127694, 132081.0, 979.314479864098, 1003.1673710820002, 1039.5581877701945, 1040.9635662751768, 1043.6973277749369, 18534.536636584195, 18944.810551894305, 19152.425427237205, 19157.509702169176, 19193.32823351176, 52193.478065218864, 53162.734186328824, 53868.92262154657, 55181.44818551763, 56387.71806141107, 78268.60865695635, 80676.59661701653, 81063.59468202622, 82195.0, 82291.58854205691, 8093.0, 8110.83778324442, 8129.8374032520205, 8350.707725229588, 8501.0, 7254.0, 11709.590164344207, 12792.0, 12907.806382904077, 13185.340732963505, 11110.944445278044, 11118.0, 11137.888621114009, 11309.886901131213, 11371.43142842871, 11014.559417623206, 11070.28043177191, 11119.666410007712, 11229.494672739584, 11475.483603237708, 11167.553297868319, 11410.600628977945, 11477.942610286895, 11498.965093141658, 11669.59156429521, 7794.2985131338455, 8007.119216886022, 8013.559254241072, 8172.019357677117, 8256.876146857681, 9715.36850104741, 10834.783304334027, 10902.78194436091, 11108.111351092055, 11110.444477775916], "value": 9181.750812644686, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.471947458652, 1494.8953573249871, 1710.016740374285, 1839.0, 1848.085197827075, 8111.067227268851, 8352.665893364257, 8623.439476434027, 9213.0, 9218.262538996882, 8640.956795216016, 8923.509206993613, 8961.148690874357, 9045.3668243223, 9047.502387368708, 2394.2218778896886, 2420.4432980414517, 2429.5991161458337, 2429.854208747472, 2440.2801173653725, 2390.557746816836, 2398.8920498577518, 2407.7832995030444, 2442.05980697431, 2442.792362649177, 2403.831731778776, 2410.963835542468, 2422.9273121806373, 2437.061731233479, 2439.6462512935614, 2396.2332053742807, 2400.699912510936, 2407.350015495815, 2413.143334116381, 2422.6729391532094, 2380.3335066181326, 2390.497995420964, 2405.5068710914397, 2409.7590240975937, 2411.9758802411925, 7570.0, 7696.730614428524, 8931.50876701781, 9134.223590994774, 9170.816583668357, 4417.271150260203, 5474.890502189934, 5481.013417584833, 5485.890282194374, 5526.447355264481, 3572.446270828, 3698.2418604186078, 3711.5546134463766, 3747.775133491999, 3764.3976963685955, 931.6180366049955, 1086.2559146984263, 1104.6741211342674, 1105.4969988655143, 1110.2450333773031, 10293.279470437072, 11454.312741235553, 12019.338936358497, 12084.093692972974, 12136.57521986735, 4745.715257084586, 4786.8085276588545, 4807.543283388072, 4928.778204980785, 4951.529604687549, 8384.455010424303, 9990.950045249727, 10174.13519850821, 10234.948825255975, 10254.28220024591, 5312.017276803804, 5367.2485851980755, 5372.167314066326, 5375.435579264121, 5377.601823525912, 4292.59220374064, 4477.485089214782, 4628.352030715702, 4668.276417155346, 4873.342098816685, 4005.1989602079702, 4032.395140728914, 4114.300568903293, 4148.709590328648, 4153.522344930311, 1116.1405717597568, 1310.462710288777, 1317.078045368246, 1327.5419980106847, 1330.3414809669275, 754.2156157596039, 861.9827603448022, 900.5767289373983, 910.8815853938945, 916.8578870275118, 5785.71071446426, 5805.7387417566315, 5875.089361149029, 5879.706014699248, 6102.511799056154, 724.9420046396276, 942.9245660347156, 956.8899576548786, 959.5777857742711, 974.6686126716809, 3894.902627434337, 3973.4238535412205, 4065.837366505366, 4102.241085399151, 4118.9588104119175, 10664.933506649273, 11045.282056666452, 11056.447177641086, 11100.777984440267, 11137.387443690513, 10936.179786516042, 10942.726431839108, 10967.341959482297, 10971.506282217319, 11006.229563930448, 7916.722914697958, 8178.304844088319, 8234.382421318425, 8256.752297431087, 8263.917360826315, 5007.649464537448, 5961.701914904151, 5982.222311099703, 6022.48808851235, 6092.116643086816, 10167.898321016695, 10180.949095254477, 10194.235432342455, 10349.586016559555, 10353.06822385989, 9858.704238872846, 9942.254330925065, 10161.237907157141, 10261.9486902565, 10365.84451233217, 7528.247175282428, 7763.6413627616075, 8015.318697910509, 8160.5103693778565, 8421.663133474838, 8328.583570821556, 8502.617382217939, 8522.147785221428, 8533.359998000298, 8535.0184728757, 7491.3632341251605, 7620.771376858703, 7623.847523049619, 7657.310842024244, 7830.765077047698, 7389.630518474162, 7420.666070026754, 7477.027986361738, 7517.849643007, 7557.433192510473, 6747.628880411625, 6917.550359226634, 7084.46866485026, 7115.075040244735, 7133.82165445868, 4860.684055536379, 4876.268559716071, 4978.4274808397495, 5057.241413787961, 5084.161113416245, 5006.374203224597, 5101.51535604117, 5105.668131571436, 5156.639035267645, 5162.303089082926], "value": 4645.784086163737, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.3035601190862, 299.3414488126123, 307.67232896964737, 310.6784478065203, 313.0342892177632, 4583.8395656152, 5323.8136665216725, 5516.841752960984, 5527.281453411061, 5659.698269398041, 5311.62818602698, 5489.615726899118, 5491.478309560585, 5499.7250137493165, 5513.669179849212, 4115.71190016699, 4165.458490396244, 4171.520275168349, 4196.853110141131, 4204.432401625787, 4053.8581149659767, 4181.686373521983, 4190.664746820247, 4205.957940420602, 4218.409422680812, 3551.520544726455, 4131.979340103296, 4160.687948403866, 4169.916601667965, 4173.269677806387, 3416.0, 3595.334863050318, 4151.107511884944, 4156.688248381383, 4167.979160104195, 3174.841182968223, 3620.6922411595046, 3634.2186429917697, 3646.7629604075914, 3657.7439579229463, 5144.665596736238, 5323.494268044529, 5349.298604204891, 5371.650842695251, 5389.865253368658, 4817.735024573647, 4840.903181936342, 4845.927311090337, 4850.902981940341, 4853.005133947532, 4525.705829121097, 5627.214528808226, 5830.4169583041785, 5832.912506312408, 5903.5572332074835, 3710.628937106295, 3768.8869333920024, 3902.1464804218053, 3965.643092121694, 4000.9199816003515, 4639.443266807971, 5328.413874473844, 5516.972415137899, 5659.830205093854, 5860.0, 3359.338321229822, 3391.3047825195777, 3864.7487913285545, 4055.5538890721996, 4072.205919845661, 3160.5891234139413, 4026.939595906064, 4097.160082183145, 4109.8972525686495, 4160.0, 4796.232602783538, 4817.205161148371, 4825.879353016133, 4845.9030819383415, 4872.805087796449, 5065.189569668909, 5822.417758224144, 5859.589828712034, 5874.853128671817, 5948.67282299469, 1158.2760774515928, 1267.8446143971073, 1402.4810819996667, 1402.9158250504797, 1407.9436822527189, 677.7356830835978, 837.8897960202755, 839.8026463781007, 858.2018722588053, 862.2369203255039, 4287.571242875688, 4333.316680821276, 4452.955470445254, 4623.56076172763, 4678.181318269358, 4186.874393768131, 4417.3815665806815, 4715.622750179978, 4821.962163836831, 4981.825636102719, 3888.7666739995125, 4545.886352841139, 4563.859035241189, 4605.6085232755595, 4678.883027924329, 2173.739151301854, 2335.2293743064747, 2737.2609395463114, 2992.354205187138, 3046.471428714162, 6222.657753823492, 6236.634355950852, 6297.520082780543, 6302.306746257908, 6339.936600634027, 5152.613553983391, 5156.484351564814, 6095.146679464879, 6212.546044312471, 6278.340774218733, 5160.458151894072, 5182.559482444034, 5820.854478638068, 6296.811095667045, 6331.873362532723, 5727.8854422912145, 6047.78832740852, 6121.143039974496, 6135.815925522242, 6157.938420615916, 4585.839495617771, 5400.973814975142, 5980.0, 5981.880362392815, 5989.401059893976, 6242.28213755424, 6320.209973753281, 6338.366163383625, 6362.518617739178, 6374.904376434264, 3859.9807000964815, 3979.92040159201, 4001.899952501211, 4003.899902502344, 4020.5927925227106, 4460.910781784281, 4645.976770116128, 6021.139958519668, 6044.788432404845, 6075.0, 4821.855344339676, 5570.6657600544095, 5750.654960702372, 5871.73757642109, 5913.201717768218, 4975.228839529878, 5152.0, 5455.509004189642, 5524.977879092381, 5828.475437210672, 4240.872773816791, 5440.945590544044, 5684.573656975826, 5704.174664107446, 5736.254286942671, 4846.781894814671, 4991.376077990251, 5780.971095144666, 5835.183074369676, 5870.55970802183, 5139.794408223779, 5545.4490934170735, 5722.513586345207, 5733.942660573341, 5740.282464691913], "value": 4113.012838440719, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.7545683553923, 756.5876597254496, 775.631575001874, 788.7002938883223, 790.7232468635974, 15528.223588820556, 15819.762703559427, 15895.682086358265, 15896.920515397436, 15940.282687279072, 11781.408090220159, 14253.50112746054, 14286.642833929158, 14298.927580431457, 14313.642158946031, 674.2919934069232, 695.8434352270724, 803.1968031968032, 825.9297959673435, 839.8992120945495, 729.7591794707761, 766.643510767493, 785.0892964161574, 857.0529564830865, 858.2876212743439, 718.9676464559108, 740.2227660956002, 862.2239984014375, 905.0496978172926, 906.2251774732607, 893.6916763716507, 894.5080205886769, 901.1304091551651, 903.7785742493065, 904.9773755656096, 567.0, 669.7354544954765, 670.9832254193684, 671.509797847574, 676.100785954679, 14646.707065858624, 14854.925725371411, 14856.18290993995, 14868.405263789435, 14896.404143834234, 11797.88202117985, 14582.781258281135, 14588.635284117876, 14691.33888974988, 14877.33052012662, 11046.447677616168, 11419.771604567944, 11619.709507262301, 11777.057835373234, 12152.57465988695, 3771.283456143324, 3832.1186127190904, 3881.8059097045316, 3981.203759248133, 3994.960050399517, 121042.18436723456, 124335.37832310781, 130076.69923300834, 130556.0, 131145.34427327898, 10823.512941917632, 11048.944755276332, 11179.161562882817, 11426.143039272089, 11444.656660300205, 17269.481915542554, 22149.889250553642, 22873.656895146585, 22911.656325155134, 22980.88509557475, 7769.339606133542, 7931.28618424333, 8209.343252539782, 8292.460990035628, 8325.209105135002, 4289.142171565637, 4407.382966384709, 4494.10117976406, 4552.863414097583, 4604.332371806069, 3541.7166626669805, 3569.589497207802, 3650.7261955353456, 3663.6885864701267, 3669.2661467706566, 627.4227710506345, 642.4988508963016, 646.6281887914374, 651.6383407209045, 655.7049327802508, 648.1832890557931, 653.8234676637377, 659.3768888400416, 680.8604236131581, 683.3917813146304, 8692.304615630734, 8754.51850148248, 9245.676401325922, 9457.810843783223, 9637.036296370306, 502.94719054499484, 610.2981571193163, 650.8535579494576, 671.3957438305564, 675.6587923098901, 4332.783360832009, 4677.929831052537, 4679.836205732851, 4717.9056418872115, 4742.312364707167, 170687.0, 179616.20383795994, 182817.0, 184407.0779646093, 185149.07425463057, 118215.40892295656, 151870.24064879605, 152814.0, 154719.0, 154794.22602887137, 83565.58217208875, 123271.0, 132633.3368333152, 135079.3246033783, 137136.0, 8659.87010194835, 8772.78068048304, 9076.910770707558, 9116.042815504277, 9291.76770580741, 43502.0, 48784.0, 57996.13005804832, 61931.0, 64492.67753661202, 95784.52107739417, 96624.0, 96832.51583742036, 99273.0, 102988.0, 11105.444727763741, 11205.207166853264, 11301.491432885376, 11317.773644526898, 11824.940875295568, 12404.81392779127, 12410.937945310216, 12448.190867593577, 12468.563600273947, 12664.936675316565, 11527.711807204552, 11626.360550169822, 12192.695182620506, 12608.36958152107, 12631.81052284198, 11932.403379831147, 12152.513899443924, 12292.385380731106, 12598.433070512032, 12622.305773182563, 9739.366941148803, 11870.584529541424, 11988.940055299669, 11998.460069296729, 12351.629451116482, 9160.90603024083, 10209.897901020895, 10229.132569558018, 10246.231532634933, 10286.0, 9467.810643787223, 10029.54867031, 10184.796304074025, 10197.439140847324, 10199.949000254952], "value": 7703.951302371493, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 139.0, 118.0, 117.0, 120.0, 148.0, 170.0, 96.0, 175.0, 175.0], "value": 136.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 143.0, 140.0, 135.0, 102.0, 132.0, 97.0, 135.0, 176.0, 112.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [223.0, 265.0, 197.0, 199.0, 194.0, 189.0, 194.0, 202.0, 198.0, 196.0], "value": 205.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 56.0, 86.0, 57.0, 59.0, 60.0, 60.0, 77.0, 59.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 70.0, 90.0, 71.0, 70.0, 95.0, 73.0, 73.0, 59.0, 100.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 111.0, 103.0, 88.0, 91.0, 87.0, 90.0, 88.0, 89.0, 86.0], "value": 92.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 118.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 98.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 133.0, 106.0, 142.0, 91.0, 153.0, 154.0, 113.0, 91.0, 90.0], "value": 116.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 56.0, 59.0, 59.0, 59.0, 62.0, 60.0, 59.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 66.0, 73.0, 73.0, 69.0, 69.0, 69.0, 72.0, 72.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 84.0, 85.0, 84.0, 83.0, 87.0, 84.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 152.0, 152.0, 155.0, 146.0, 143.0, 158.0, 164.0, 199.0, 142.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 162.0, 164.0, 164.0, 163.0, 171.0, 166.0, 173.0, 228.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 66.0, 68.0, 66.0, 66.0, 67.0, 67.0, 63.0], "value": 66.4, "unit": "score"}]}]} 09:39:50 INFO - Return code: 0 09:39:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:39:51 ERROR - # TBPL SUCCESS # 09:39:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:39:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:39:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:39:51 INFO - 2016-10-14 09:39:51.039 screenresolution[1676:10477] starting screenresolution argv=screenresolution get 09:39:51 INFO - 2016-10-14 09:39:51.042 screenresolution[1676:10477] Display 0: 1600x1200x32@60 09:39:51 INFO - 2016-10-14 09:39:51.048 screenresolution[1677:10480] starting screenresolution argv=screenresolution list 09:39:51 INFO - Available Modes on Display 0 09:39:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:39:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:39:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:39:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:39:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:39:51 INFO - Intel Iris: 09:39:51 INFO - Chipset Model: Intel Iris 09:39:51 INFO - Type: GPU 09:39:51 INFO - Bus: Built-In 09:39:51 INFO - VRAM (Dynamic, Max): 1536 MB 09:39:51 INFO - Vendor: Intel (0x8086) 09:39:51 INFO - Device ID: 0x0a2e 09:39:51 INFO - Revision ID: 0x0009 09:39:51 INFO - Displays: 09:39:51 INFO - Display: 09:39:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:39:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:39:51 INFO - Display Serial Number: 1600x1200 60 09:39:51 INFO - Main Display: Yes 09:39:51 INFO - Mirror: Off 09:39:51 INFO - Online: Yes 09:39:51 INFO - Rotation: Supported 09:39:51 INFO - Return code: 0 09:39:51 INFO - Running post-action listener: _resource_record_post_action 09:39:51 INFO - [mozharness: 2016-10-14 16:39:51.283730Z] Finished run-tests step (success) 09:39:51 INFO - Running post-run listener: _resource_record_post_run 09:39:51 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 38454272; Write bytes: 666655232; Read time: 378; Write time: 2126 09:39:51 INFO - TinderboxPrint: CPU usage
54.1% 09:39:51 INFO - TinderboxPrint: I/O read bytes / time
38,454,272 / 378 09:39:51 INFO - TinderboxPrint: I/O write bytes / time
666,655,232 / 2,126 09:39:51 INFO - TinderboxPrint: CPU idle
2,213.2 (45.9%) 09:39:51 INFO - TinderboxPrint: CPU system
974.8 (20.2%) 09:39:51 INFO - TinderboxPrint: CPU user
1,637.8 (33.9%) 09:39:51 INFO - TinderboxPrint: Swap in / out
401,821,696 / 0 09:39:51 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 357247488; Write bytes: 345572864; Read time: 27800; Write time: 643 09:39:51 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 32128000; Write bytes: 299113472; Read time: 298; Write time: 1416 09:39:51 INFO - Running post-run listener: _upload_blobber_files 09:39:51 INFO - Blob upload gear active. 09:39:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:51 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 09:39:51 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'] 09:39:51 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 09:39:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:39:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:39:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:53 INFO - (blobuploader) - INFO - Done attempting. 09:39:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:39:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:39:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:54 INFO - (blobuploader) - INFO - Done attempting. 09:39:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:39:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:57 INFO - (blobuploader) - INFO - Done attempting. 09:39:57 INFO - (blobuploader) - INFO - Iteration through files over. 09:39:57 INFO - Return code: 0 09:39:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/793459c8098c64bbe35d3317e265bb90a8bfb82fcc2f628373dd2826369ce73c5c2cb13af0d6aa8329e5f186c0b06aa6c54a3f72a24f38a7c448ce01151284cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f67f1690e9fd26090a30e9cf0d7a2670ca985e95aa429c21027cdab500ae6062ea3d7287acf7140aad2f9f9e12abee76e465eabf14687dbfb7dacbcf6940c15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1041e800718d83109e89c99ba9b3538e26d97afa3a0c0034c5790319255fcea373a28b053f34aca205fa77bca01832163bd0e012d2e3623b0309f24e22a36547"} 09:39:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:57 INFO - Contents: 09:39:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/793459c8098c64bbe35d3317e265bb90a8bfb82fcc2f628373dd2826369ce73c5c2cb13af0d6aa8329e5f186c0b06aa6c54a3f72a24f38a7c448ce01151284cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f67f1690e9fd26090a30e9cf0d7a2670ca985e95aa429c21027cdab500ae6062ea3d7287acf7140aad2f9f9e12abee76e465eabf14687dbfb7dacbcf6940c15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1041e800718d83109e89c99ba9b3538e26d97afa3a0c0034c5790319255fcea373a28b053f34aca205fa77bca01832163bd0e012d2e3623b0309f24e22a36547"} 09:39:57 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:57 INFO - Copying logs to upload dir... 09:39:57 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.515226 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-14 09:39:57.274432) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 09:39:57.277628) ========= 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.NFcVh67gRM/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.e81TxuFC0s/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/793459c8098c64bbe35d3317e265bb90a8bfb82fcc2f628373dd2826369ce73c5c2cb13af0d6aa8329e5f186c0b06aa6c54a3f72a24f38a7c448ce01151284cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f67f1690e9fd26090a30e9cf0d7a2670ca985e95aa429c21027cdab500ae6062ea3d7287acf7140aad2f9f9e12abee76e465eabf14687dbfb7dacbcf6940c15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1041e800718d83109e89c99ba9b3538e26d97afa3a0c0034c5790319255fcea373a28b053f34aca205fa77bca01832163bd0e012d2e3623b0309f24e22a36547"} build_url:https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010829 build_url: 'https://queue.taskcluster.net/v1/task/EaZzCY5PRsa1dXq_Ls0ypw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/793459c8098c64bbe35d3317e265bb90a8bfb82fcc2f628373dd2826369ce73c5c2cb13af0d6aa8329e5f186c0b06aa6c54a3f72a24f38a7c448ce01151284cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f67f1690e9fd26090a30e9cf0d7a2670ca985e95aa429c21027cdab500ae6062ea3d7287acf7140aad2f9f9e12abee76e465eabf14687dbfb7dacbcf6940c15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1041e800718d83109e89c99ba9b3538e26d97afa3a0c0034c5790319255fcea373a28b053f34aca205fa77bca01832163bd0e012d2e3623b0309f24e22a36547"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 09:39:57.313133) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:39:57.313451) ========= 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.NFcVh67gRM/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.e81TxuFC0s/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.005030 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:39:57.362116) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 09:39:57.362447) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 09:39:57.362774) ========= ========= Total master_lag: 0.18 =========