builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0061 starttime: 1474347906.29 results: success (0) buildid: 20160919200817 builduid: 47fb44262e294c658195f9dc5dcf656e revision: ef0680dc3d4feb015a07b3edefe0b9d2a095bdec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 22:05:06.287249) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 22:05:06.287698) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 22:05:06.287970) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 22:05:06.315119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 22:05:06.315800) ========= 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.5G7U7JelgP/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.7SnijmIKmx/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-09-19 22:05:06-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 70.6M=0s 2016-09-19 22:05:06 (70.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.472388 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 22:05:06.857929) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 22:05:06.858208) ========= 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.5G7U7JelgP/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.7SnijmIKmx/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.028887 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 22:05:06.996180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-09-19 22:05:06.999516) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ef0680dc3d4feb015a07b3edefe0b9d2a095bdec --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 ef0680dc3d4feb015a07b3edefe0b9d2a095bdec --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5G7U7JelgP/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.7SnijmIKmx/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-09-19 22:05:07,096 truncating revision to first 12 chars 2016-09-19 22:05:07,097 Setting DEBUG logging. 2016-09-19 22:05:07,097 attempt 1/10 2016-09-19 22:05:07,097 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ef0680dc3d4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-19 22:05:07,746 unpacking tar archive at: mozilla-aurora-ef0680dc3d4f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.897419 ========= master_lag: 2.58 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-09-19 22:05:10.478603) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 22:05:10.478872) ========= script_repo_revision: ef0680dc3d4feb015a07b3edefe0b9d2a095bdec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 22:05:10.479214) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 22:05:10.479491) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 22:05:10.520589) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-19 22:05:10.520938) ========= /tools/buildbot/bin/python 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', '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.5G7U7JelgP/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.7SnijmIKmx/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 22:05:10 INFO - MultiFileLogger online at 20160919 22:05:10 in /builds/slave/test 22:05:10 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 22:05:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:05:10 INFO - {'append_to_log': False, 22:05:10 INFO - 'base_work_dir': '/builds/slave/test', 22:05:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:05:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:05:10 INFO - 'branch': 'Mozilla-Aurora', 22:05:10 INFO - 'buildbot_json_path': 'buildprops.json', 22:05:10 INFO - 'config_files': ('talos/mac_config.py',), 22:05:10 INFO - 'default_actions': ('clobber', 22:05:10 INFO - 'read-buildbot-config', 22:05:10 INFO - 'download-and-extract', 22:05:10 INFO - 'populate-webroot', 22:05:10 INFO - 'create-virtualenv', 22:05:10 INFO - 'install', 22:05:10 INFO - 'run-tests'), 22:05:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:05:10 INFO - 'download_minidump_stackwalk': True, 22:05:10 INFO - 'download_symbols': 'ondemand', 22:05:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:05:10 INFO - 'tooltool.py': '/tools/tooltool.py', 22:05:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:05:10 INFO - '/tools/misc-python/virtualenv.py')}, 22:05:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:05:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:05:10 INFO - 'installer_path': 'installer.exe', 22:05:10 INFO - 'log_level': 'info', 22:05:10 INFO - 'log_name': 'talos', 22:05:10 INFO - 'log_to_console': True, 22:05:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:05:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:05:10 INFO - 'opt_config_files': (), 22:05:10 INFO - 'pip_index': False, 22:05:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:05:10 INFO - 'cmd': ('bash', 22:05:10 INFO - '-c', 22:05:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:05:10 INFO - 'enabled': True, 22:05:10 INFO - 'halt_on_failure': False, 22:05:10 INFO - 'name': 'check_screen_resolution'},), 22:05:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:05:10 INFO - 'cmd': ('bash', 22:05:10 INFO - '-c', 22:05:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:05:10 INFO - 'enabled': True, 22:05:10 INFO - 'halt_on_failure': False, 22:05:10 INFO - 'name': 'check_screen_resolution'},), 22:05:10 INFO - 'run_cmd_checks_enabled': True, 22:05:10 INFO - 'sps_profile': False, 22:05:10 INFO - 'sps_profile_interval': 0, 22:05:10 INFO - 'suite': 'dromaeojs-e10s', 22:05:10 INFO - 'system_bits': '32', 22:05:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:05:10 INFO - 'title': 't-yosemite-r7-0061', 22:05:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:05:10 INFO - 'use_talos_json': True, 22:05:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:05:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:05:10 INFO - 'work_dir': 'build'} 22:05:10 INFO - [mozharness: 2016-09-20 05:05:10.727632Z] Running clobber step. 22:05:10 INFO - Running pre-action listener: _resource_record_pre_action 22:05:10 INFO - Running main action method: clobber 22:05:10 INFO - rmtree: /builds/slave/test/build 22:05:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:05:12 INFO - Running post-action listener: _resource_record_post_action 22:05:12 INFO - [mozharness: 2016-09-20 05:05:12.831325Z] Finished clobber step (success) 22:05:12 INFO - [mozharness: 2016-09-20 05:05:12.831479Z] Running read-buildbot-config step. 22:05:12 INFO - Running pre-action listener: _resource_record_pre_action 22:05:12 INFO - Running main action method: read_buildbot_config 22:05:12 INFO - Using buildbot properties: 22:05:12 INFO - { 22:05:12 INFO - "project": "", 22:05:12 INFO - "product": "firefox", 22:05:12 INFO - "script_repo_revision": "production", 22:05:12 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 22:05:12 INFO - "repository": "", 22:05:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 22:05:12 INFO - "buildid": "20160919200817", 22:05:12 INFO - "pgo_build": "False", 22:05:12 INFO - "basedir": "/builds/slave/test", 22:05:12 INFO - "buildnumber": 95, 22:05:12 INFO - "slavename": "t-yosemite-r7-0061", 22:05:12 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 22:05:12 INFO - "platform": "yosemite_r7", 22:05:12 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 22:05:12 INFO - "branch": "mozilla-aurora", 22:05:12 INFO - "repo_path": "releases/mozilla-aurora", 22:05:12 INFO - "revision": "ef0680dc3d4feb015a07b3edefe0b9d2a095bdec", 22:05:12 INFO - "stage_platform": "macosx64", 22:05:12 INFO - "builduid": "47fb44262e294c658195f9dc5dcf656e", 22:05:12 INFO - "slavebuilddir": "test" 22:05:12 INFO - } 22:05:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 22:05:12 INFO - Running post-action listener: _resource_record_post_action 22:05:12 INFO - [mozharness: 2016-09-20 05:05:12.834693Z] Finished read-buildbot-config step (success) 22:05:12 INFO - [mozharness: 2016-09-20 05:05:12.834798Z] Running download-and-extract step. 22:05:12 INFO - Running pre-action listener: _resource_record_pre_action 22:05:12 INFO - Running main action method: download_and_extract 22:05:12 INFO - mkdir: /builds/slave/test/build/tests 22:05:12 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')]} 22:05:12 INFO - trying https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 22:05:12 INFO - Downloading https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/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 22:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/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 22:05:14 INFO - Downloaded 1199 bytes. 22:05:14 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 22:05:14 INFO - Using the following test package requirements: 22:05:14 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 22:05:14 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:05:14 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 22:05:14 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:05:14 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 22:05:14 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:05:14 INFO - u'jsshell-mac.zip'], 22:05:14 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:05:14 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 22:05:14 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 22:05:14 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:05:14 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 22:05:14 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:05:14 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 22:05:14 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:05:14 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 22:05:14 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:05:14 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 22:05:14 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 22:05:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 22:05:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 22:05:14 INFO - Fetch https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 22:05:14 INFO - Expected file size: 16426174 22:05:21 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 22:05:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 22:05:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 22:05:21 INFO - Fetch https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 22:05:22 INFO - Expected file size: 16426174 22:05:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 22:05:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 22:05:28 INFO - Fetch https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 22:05:29 INFO - Expected file size: 14414059 22:05:29 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')]} 22:05:29 INFO - trying https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 22:05:29 INFO - Downloading https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 22:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/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 22:05:32 INFO - Downloaded 115240164 bytes. 22:05:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 22:05:32 INFO - mkdir: /builds/slave/test/properties 22:05:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:05:32 INFO - Writing to file /builds/slave/test/properties/build_url 22:05:32 INFO - Contents: 22:05:32 INFO - build_url:https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 22:05:33 INFO - Running post-action listener: _resource_record_post_action 22:05:33 INFO - Running post-action listener: set_extra_try_arguments 22:05:33 INFO - [mozharness: 2016-09-20 05:05:33.656063Z] Finished download-and-extract step (success) 22:05:33 INFO - [mozharness: 2016-09-20 05:05:33.656183Z] Running populate-webroot step. 22:05:33 INFO - Running pre-action listener: _resource_record_pre_action 22:05:33 INFO - Running main action method: populate_webroot 22:05:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:05:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:05:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:05:33 INFO - '--tppagecycles', 22:05:33 INFO - '7'], 22:05:33 INFO - 'tests': ['tsvgm']}}, 22:05:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:05:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:05:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:05:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:05:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:05:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:05:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:33 INFO - 'talos_options': ['--disable-e10s'], 22:05:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:05:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:05:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:33 INFO - 'talos_options': ['--disable-e10s'], 22:05:33 INFO - 'tests': ['damp', 'tps']}, 22:05:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:33 INFO - 'tests': ['damp', 'tps']}, 22:05:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:05:33 INFO - 'tests': ['dromaeo_dom']}, 22:05:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:05:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:05:33 INFO - 'tests': ['basic_compositor_video']}, 22:05:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:05:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:05:33 INFO - 'tests': ['a11yr', 22:05:33 INFO - 'ts_paint', 22:05:33 INFO - 'tpaint', 22:05:33 INFO - 'sessionrestore', 22:05:33 INFO - 'sessionrestore_no_auto_restore', 22:05:33 INFO - 'tabpaint']}, 22:05:33 INFO - 'other-e10s': {'tests': ['a11yr', 22:05:33 INFO - 'ts_paint', 22:05:33 INFO - 'tpaint', 22:05:33 INFO - 'sessionrestore', 22:05:33 INFO - 'sessionrestore_no_auto_restore', 22:05:33 INFO - 'tabpaint']}, 22:05:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:05:33 INFO - 'ts_paint', 22:05:33 INFO - 'tpaint', 22:05:33 INFO - 'sessionrestore', 22:05:33 INFO - 'sessionrestore_no_auto_restore', 22:05:33 INFO - 'tabpaint']}, 22:05:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:05:33 INFO - 'ts_paint', 22:05:33 INFO - 'tpaint', 22:05:33 INFO - 'sessionrestore', 22:05:33 INFO - 'sessionrestore_no_auto_restore', 22:05:33 INFO - 'tabpaint']}, 22:05:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:05:33 INFO - 'tests': ['a11yr', 22:05:33 INFO - 'ts_paint', 22:05:33 INFO - 'tpaint', 22:05:33 INFO - 'sessionrestore', 22:05:33 INFO - 'sessionrestore_no_auto_restore', 22:05:33 INFO - 'tabpaint']}, 22:05:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:05:33 INFO - 'tests': ['a11yr', 22:05:33 INFO - 'ts_paint', 22:05:33 INFO - 'tpaint', 22:05:33 INFO - 'sessionrestore', 22:05:33 INFO - 'sessionrestore_no_auto_restore', 22:05:33 INFO - 'tabpaint']}, 22:05:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:05:33 INFO - 'tests': ['tsvgx', 22:05:33 INFO - 'tsvgr_opacity', 22:05:33 INFO - 'tart', 22:05:33 INFO - 'tscrollx', 22:05:33 INFO - 'cart']}, 22:05:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:05:33 INFO - 'tsvgr_opacity', 22:05:33 INFO - 'tart', 22:05:33 INFO - 'tscrollx', 22:05:33 INFO - 'cart']}, 22:05:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:33 INFO - 'talos_options': ['--disable-e10s'], 22:05:33 INFO - 'tests': ['tp5o']}, 22:05:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:33 INFO - 'tests': ['tp5o']}, 22:05:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:33 INFO - 'talos_options': ['--disable-e10s', 22:05:33 INFO - '--xperf_path', 22:05:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:05:33 INFO - 'tests': ['tp5n']}, 22:05:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:05:33 INFO - 'talos_options': ['--xperf_path', 22:05:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:05:33 INFO - 'tests': ['tp5n']}}, 22:05:33 INFO - 'talos.zip': {'path': '', 22:05:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:05:33 INFO - Running post-action listener: _resource_record_post_action 22:05:33 INFO - [mozharness: 2016-09-20 05:05:33.674535Z] Finished populate-webroot step (success) 22:05:33 INFO - [mozharness: 2016-09-20 05:05:33.674672Z] Running create-virtualenv step. 22:05:33 INFO - Running pre-action listener: _resource_record_pre_action 22:05:33 INFO - Running main action method: create_virtualenv 22:05:33 INFO - Creating virtualenv /builds/slave/test/build/venv 22:05:33 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 22:05:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:05:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:05:33 INFO - Using real prefix '/tools/python27' 22:05:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:05:34 INFO - Installing distribute.............................................................................................................................................................................................done. 22:05:37 INFO - Installing pip.................done. 22:05:37 INFO - Return code: 0 22:05:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:37 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 0x102b4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ac2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e14cbc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102960d30>, '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 0x1027c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102958b20>, '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.5G7U7JelgP/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.7SnijmIKmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 22:05:37 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 22:05:37 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 22:05:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5G7U7JelgP/Render', 22:05:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:37 INFO - 'HOME': '/Users/cltbld', 22:05:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:37 INFO - 'LOGNAME': 'cltbld', 22:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:37 INFO - 'MOZ_NO_REMOTE': '1', 22:05:37 INFO - 'NO_EM_RESTART': '1', 22:05:37 INFO - 'PAGER': '/bin/cat', 22:05:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:37 INFO - 'PWD': '/builds/slave/test', 22:05:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:37 INFO - 'SHELL': '/bin/bash', 22:05:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SnijmIKmx/Listeners', 22:05:37 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 22:05:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:37 INFO - 'USER': 'cltbld', 22:05:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:37 INFO - 'XPC_FLAGS': '0x0', 22:05:37 INFO - 'XPC_SERVICE_NAME': '0', 22:05:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:37 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 22:05:37 INFO - Cleaning up... 22:05:37 INFO - Return code: 0 22:05:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:37 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 0x102b4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ac2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e14cbc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102960d30>, '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 0x1027c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102958b20>, '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.5G7U7JelgP/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.7SnijmIKmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 22:05:37 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 22:05:37 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 22:05:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5G7U7JelgP/Render', 22:05:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:37 INFO - 'HOME': '/Users/cltbld', 22:05:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:37 INFO - 'LOGNAME': 'cltbld', 22:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:37 INFO - 'MOZ_NO_REMOTE': '1', 22:05:37 INFO - 'NO_EM_RESTART': '1', 22:05:37 INFO - 'PAGER': '/bin/cat', 22:05:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:37 INFO - 'PWD': '/builds/slave/test', 22:05:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:37 INFO - 'SHELL': '/bin/bash', 22:05:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SnijmIKmx/Listeners', 22:05:37 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 22:05:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:37 INFO - 'USER': 'cltbld', 22:05:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:37 INFO - 'XPC_FLAGS': '0x0', 22:05:37 INFO - 'XPC_SERVICE_NAME': '0', 22:05:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:37 INFO - Downloading/unpacking psutil>=3.1.1 22:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:05:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:05:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:05:41 INFO - Installing collected packages: psutil 22:05:41 INFO - Running setup.py install for psutil 22:05:41 INFO - building 'psutil._psutil_osx' extension 22:05:41 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 22:05:41 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 22:05:41 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 22:05:42 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 22:05:42 INFO - building 'psutil._psutil_posix' extension 22:05:42 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 22:05:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:05:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:05:42 INFO - ^ 22:05:42 INFO - 1 warning generated. 22:05:42 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 22:05:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:05:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:05:42 INFO - Successfully installed psutil 22:05:42 INFO - Cleaning up... 22:05:42 INFO - Return code: 0 22:05:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:05:42 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')]} 22:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:42 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')]} 22:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:42 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 0x102b4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ac2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e14cbc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102960d30>, '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 0x1027c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102958b20>, '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.5G7U7JelgP/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.7SnijmIKmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 22:05:42 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 22:05:42 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 22:05:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5G7U7JelgP/Render', 22:05:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:42 INFO - 'HOME': '/Users/cltbld', 22:05:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:42 INFO - 'LOGNAME': 'cltbld', 22:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:42 INFO - 'MOZ_NO_REMOTE': '1', 22:05:42 INFO - 'NO_EM_RESTART': '1', 22:05:42 INFO - 'PAGER': '/bin/cat', 22:05:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:42 INFO - 'PWD': '/builds/slave/test', 22:05:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:42 INFO - 'SHELL': '/bin/bash', 22:05:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SnijmIKmx/Listeners', 22:05:42 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 22:05:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:42 INFO - 'USER': 'cltbld', 22:05:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:42 INFO - 'XPC_FLAGS': '0x0', 22:05:42 INFO - 'XPC_SERVICE_NAME': '0', 22:05:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:05:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:05:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:05:45 INFO - Installing collected packages: mozsystemmonitor 22:05:45 INFO - Running setup.py install for mozsystemmonitor 22:05:45 INFO - Successfully installed mozsystemmonitor 22:05:45 INFO - Cleaning up... 22:05:45 INFO - Return code: 0 22:05:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:45 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 0x102b4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ac2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e14cbc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102960d30>, '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 0x1027c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102958b20>, '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.5G7U7JelgP/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.7SnijmIKmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 22:05:45 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 22:05:45 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 22:05:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5G7U7JelgP/Render', 22:05:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:45 INFO - 'HOME': '/Users/cltbld', 22:05:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:45 INFO - 'LOGNAME': 'cltbld', 22:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:45 INFO - 'MOZ_NO_REMOTE': '1', 22:05:45 INFO - 'NO_EM_RESTART': '1', 22:05:45 INFO - 'PAGER': '/bin/cat', 22:05:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:45 INFO - 'PWD': '/builds/slave/test', 22:05:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:45 INFO - 'SHELL': '/bin/bash', 22:05:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SnijmIKmx/Listeners', 22:05:45 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 22:05:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:45 INFO - 'USER': 'cltbld', 22:05:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:45 INFO - 'XPC_FLAGS': '0x0', 22:05:45 INFO - 'XPC_SERVICE_NAME': '0', 22:05:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:45 INFO - Downloading/unpacking jsonschema==2.5.1 22:05:45 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 22:05:45 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 22:05:45 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 22:05:45 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 22:05:45 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 22:05:45 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 22:05:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:05:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:05:48 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 22:05:48 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 22:05:48 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 22:05:48 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 22:05:48 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 22:05:48 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 22:05:48 INFO - Downloading functools32-3.2.3-2.tar.gz 22:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:05:48 INFO - warning: no files found matching '*.txt' 22:05:48 INFO - no previously-included directories found matching 'build' 22:05:48 INFO - no previously-included directories found matching 'dist' 22:05:48 INFO - no previously-included directories found matching '.git*' 22:05:48 INFO - Installing collected packages: jsonschema, functools32 22:05:48 INFO - Running setup.py install for functools32 22:05:48 INFO - warning: no files found matching '*.txt' 22:05:48 INFO - no previously-included directories found matching 'build' 22:05:48 INFO - no previously-included directories found matching 'dist' 22:05:48 INFO - no previously-included directories found matching '.git*' 22:05:48 INFO - Successfully installed jsonschema functools32 22:05:48 INFO - Cleaning up... 22:05:48 INFO - Return code: 0 22:05:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:48 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 0x102b4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ac2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e14cbc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102960d30>, '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 0x1027c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102958b20>, '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.5G7U7JelgP/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.7SnijmIKmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 22:05:48 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 22:05:48 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 22:05:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5G7U7JelgP/Render', 22:05:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:48 INFO - 'HOME': '/Users/cltbld', 22:05:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:48 INFO - 'LOGNAME': 'cltbld', 22:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:48 INFO - 'MOZ_NO_REMOTE': '1', 22:05:48 INFO - 'NO_EM_RESTART': '1', 22:05:48 INFO - 'PAGER': '/bin/cat', 22:05:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:48 INFO - 'PWD': '/builds/slave/test', 22:05:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:48 INFO - 'SHELL': '/bin/bash', 22:05:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SnijmIKmx/Listeners', 22:05:48 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 22:05:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:48 INFO - 'USER': 'cltbld', 22:05:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:48 INFO - 'XPC_FLAGS': '0x0', 22:05:48 INFO - 'XPC_SERVICE_NAME': '0', 22:05:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:05:49 INFO - Cleaning up... 22:05:49 INFO - Return code: 0 22:05:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102b4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ac2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e14cbc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102960d30>, '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 0x1027c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102958b20>, '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.5G7U7JelgP/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.7SnijmIKmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 22:05:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:05:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5G7U7JelgP/Render', 22:05:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:49 INFO - 'HOME': '/Users/cltbld', 22:05:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:49 INFO - 'LOGNAME': 'cltbld', 22:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:49 INFO - 'MOZ_NO_REMOTE': '1', 22:05:49 INFO - 'NO_EM_RESTART': '1', 22:05:49 INFO - 'PAGER': '/bin/cat', 22:05:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:49 INFO - 'PWD': '/builds/slave/test', 22:05:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:49 INFO - 'SHELL': '/bin/bash', 22:05:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SnijmIKmx/Listeners', 22:05:49 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 22:05:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:49 INFO - 'USER': 'cltbld', 22:05:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:49 INFO - 'XPC_FLAGS': '0x0', 22:05:49 INFO - 'XPC_SERVICE_NAME': '0', 22:05:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:49 INFO - Downloading/unpacking blobuploader==1.2.4 22:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:51 INFO - Downloading blobuploader-1.2.4.tar.gz 22:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:05:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:05:51 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 22:05:51 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 22:05:51 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 22:05:51 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 22:05:51 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 22:05:51 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 22:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:05:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:52 INFO - Downloading docopt-0.6.1.tar.gz 22:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:05:53 INFO - Installing collected packages: blobuploader, requests, docopt 22:05:53 INFO - Running setup.py install for blobuploader 22:05:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:05:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:05:53 INFO - Running setup.py install for requests 22:05:53 INFO - Running setup.py install for docopt 22:05:53 INFO - Successfully installed blobuploader requests docopt 22:05:53 INFO - Cleaning up... 22:05:53 INFO - Return code: 0 22:05:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:53 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 0x102b4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ac2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e14cbc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102960d30>, '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 0x1027c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102958b20>, '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.5G7U7JelgP/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.7SnijmIKmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 22:05:53 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 22:05:53 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 22:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5G7U7JelgP/Render', 22:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:53 INFO - 'HOME': '/Users/cltbld', 22:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:53 INFO - 'LOGNAME': 'cltbld', 22:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:53 INFO - 'MOZ_NO_REMOTE': '1', 22:05:53 INFO - 'NO_EM_RESTART': '1', 22:05:53 INFO - 'PAGER': '/bin/cat', 22:05:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:53 INFO - 'PWD': '/builds/slave/test', 22:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:53 INFO - 'SHELL': '/bin/bash', 22:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SnijmIKmx/Listeners', 22:05:53 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 22:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:53 INFO - 'USER': 'cltbld', 22:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:53 INFO - 'XPC_FLAGS': '0x0', 22:05:53 INFO - 'XPC_SERVICE_NAME': '0', 22:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:05:54 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-GW7DI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:05:54 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-5akev3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:05:54 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-IcJ6w0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:05:54 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-_o2E6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:05:54 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-biEr8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:05:54 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ST3Et4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:05:54 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-yd0p4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:05:54 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Jl89CN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:05:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-W518eS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:05:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-HzhA7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:05:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-p0PKTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:05:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ds2xEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:05:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-DROlxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:05:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-9Tktsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:05:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Sr3k32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:05:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-5kjetU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:05:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-uWjVaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:05:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:05:55 INFO - Running setup.py install for manifestparser 22:05:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:05:56 INFO - Running setup.py install for mozcrash 22:05:56 INFO - Running setup.py install for mozdebug 22:05:56 INFO - Running setup.py install for mozdevice 22:05:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:05:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:05:56 INFO - Running setup.py install for mozfile 22:05:56 INFO - Running setup.py install for mozhttpd 22:05:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:05:56 INFO - Running setup.py install for mozinfo 22:05:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:05:56 INFO - Running setup.py install for mozInstall 22:05:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:05:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:05:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:05:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:05:57 INFO - Running setup.py install for mozleak 22:05:57 INFO - Running setup.py install for mozlog 22:05:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:05:57 INFO - Running setup.py install for moznetwork 22:05:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:05:57 INFO - Running setup.py install for mozprocess 22:05:57 INFO - Running setup.py install for mozprofile 22:05:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:05:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:05:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:05:57 INFO - Running setup.py install for mozrunner 22:05:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:05:58 INFO - Running setup.py install for mozscreenshot 22:05:58 INFO - Running setup.py install for moztest 22:05:58 INFO - Running setup.py install for mozversion 22:05:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:05:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:05:58 INFO - Cleaning up... 22:05:58 INFO - Return code: 0 22:05:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:58 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 0x102b4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ac2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e14cbc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102960d30>, '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 0x1027c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102958b20>, '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.5G7U7JelgP/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.7SnijmIKmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 22:05:58 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 22:05:58 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 22:05:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5G7U7JelgP/Render', 22:05:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:05:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:05:58 INFO - 'HOME': '/Users/cltbld', 22:05:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:05:58 INFO - 'LOGNAME': 'cltbld', 22:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:58 INFO - 'MOZ_NO_REMOTE': '1', 22:05:58 INFO - 'NO_EM_RESTART': '1', 22:05:58 INFO - 'PAGER': '/bin/cat', 22:05:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:05:58 INFO - 'PWD': '/builds/slave/test', 22:05:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:05:58 INFO - 'SHELL': '/bin/bash', 22:05:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SnijmIKmx/Listeners', 22:05:58 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 22:05:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:05:58 INFO - 'USER': 'cltbld', 22:05:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:05:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:58 INFO - 'XPC_FLAGS': '0x0', 22:05:58 INFO - 'XPC_SERVICE_NAME': '0', 22:05:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:05:58 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-SIVbYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:05:58 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)) 22:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:05:58 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-xVrse3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:05:59 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)) 22:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:05:59 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Qoo8to-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:05:59 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)) 22:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:05:59 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-sQUpBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:05:59 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)) 22:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:05:59 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-bYqPUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:05:59 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)) 22:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:05:59 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-0eKzcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:05:59 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)) 22:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:05:59 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-59WA_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:05:59 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)) 22:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:05:59 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-wg7oVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:05:59 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)) 22:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:05:59 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-B0v5je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:05:59 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)) 22:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:05:59 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-c8pebr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:05:59 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)) 22:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:05:59 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ZB0Gjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:05:59 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)) 22:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:05:59 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-W_0IYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:06:00 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)) 22:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:06:00 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Lcd5Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:06:00 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)) 22:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:06:00 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-XL6UMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:06:00 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)) 22:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:00 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-z7Q1GX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:00 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)) 22:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:06:00 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-1njbwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:06:00 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)) 22:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:06:00 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-I8gAd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:06:00 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)) 22:06:00 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)) 22:06:00 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)) 22:06:00 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)) 22:06:00 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)) 22:06:00 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)) 22:06:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:06:03 INFO - Downloading blessings-1.6.tar.gz 22:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:06:03 INFO - Installing collected packages: blessings 22:06:03 INFO - Running setup.py install for blessings 22:06:03 INFO - Successfully installed blessings 22:06:03 INFO - Cleaning up... 22:06:03 INFO - Return code: 0 22:06:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:06:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:06:03 INFO - Reading from file tmpfile_stdout 22:06:03 INFO - Current package versions: 22:06:03 INFO - blessings == 1.6 22:06:03 INFO - blobuploader == 1.2.4 22:06:03 INFO - docopt == 0.6.1 22:06:03 INFO - functools32 == 3.2.3-2 22:06:03 INFO - jsonschema == 2.5.1 22:06:03 INFO - manifestparser == 1.1 22:06:03 INFO - mozInstall == 1.12 22:06:03 INFO - mozcrash == 0.17 22:06:03 INFO - mozdebug == 0.1 22:06:03 INFO - mozdevice == 0.48 22:06:03 INFO - mozfile == 1.2 22:06:03 INFO - mozhttpd == 0.7 22:06:03 INFO - mozinfo == 0.9 22:06:03 INFO - mozleak == 0.1 22:06:03 INFO - mozlog == 3.4 22:06:03 INFO - moznetwork == 0.27 22:06:03 INFO - mozprocess == 0.23 22:06:03 INFO - mozprofile == 0.28 22:06:03 INFO - mozrunner == 6.12 22:06:03 INFO - mozscreenshot == 0.1 22:06:03 INFO - mozsystemmonitor == 0.3 22:06:03 INFO - moztest == 0.7 22:06:03 INFO - mozversion == 1.4 22:06:03 INFO - psutil == 3.1.1 22:06:03 INFO - requests == 1.2.3 22:06:03 INFO - wsgiref == 0.1.2 22:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:06:03 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')]} 22:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:03 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')]} 22:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:03 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 0x102b4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ac2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e14cbc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102960d30>, '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 0x1027c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102958b20>, '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.5G7U7JelgP/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.7SnijmIKmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 22:06:03 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 22:06:03 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 22:06:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5G7U7JelgP/Render', 22:06:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:06:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:06:03 INFO - 'HOME': '/Users/cltbld', 22:06:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:06:03 INFO - 'LOGNAME': 'cltbld', 22:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:03 INFO - 'MOZ_NO_REMOTE': '1', 22:06:03 INFO - 'NO_EM_RESTART': '1', 22:06:03 INFO - 'PAGER': '/bin/cat', 22:06:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:03 INFO - 'PWD': '/builds/slave/test', 22:06:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:06:03 INFO - 'SHELL': '/bin/bash', 22:06:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SnijmIKmx/Listeners', 22:06:03 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 22:06:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:06:03 INFO - 'USER': 'cltbld', 22:06:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:06:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:03 INFO - 'XPC_FLAGS': '0x0', 22:06:03 INFO - 'XPC_SERVICE_NAME': '0', 22:06:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:03 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)) 22:06:03 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)) 22:06:03 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)) 22:06:03 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)) 22:06:03 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)) 22:06:03 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)) 22:06:03 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)) 22:06:03 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)) 22:06:03 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)) 22:06:03 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)) 22:06:03 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)) 22:06:03 INFO - Cleaning up... 22:06:03 INFO - Return code: 0 22:06:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:06:03 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')]} 22:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:03 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')]} 22:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:03 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 0x102b4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ac2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e14cbc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102960d30>, '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 0x1027c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102958b20>, '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.5G7U7JelgP/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.7SnijmIKmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 22:06:03 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 22:06:03 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 22:06:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5G7U7JelgP/Render', 22:06:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:06:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:06:03 INFO - 'HOME': '/Users/cltbld', 22:06:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:06:03 INFO - 'LOGNAME': 'cltbld', 22:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:03 INFO - 'MOZ_NO_REMOTE': '1', 22:06:03 INFO - 'NO_EM_RESTART': '1', 22:06:03 INFO - 'PAGER': '/bin/cat', 22:06:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:03 INFO - 'PWD': '/builds/slave/test', 22:06:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:06:03 INFO - 'SHELL': '/bin/bash', 22:06:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SnijmIKmx/Listeners', 22:06:03 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 22:06:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:06:03 INFO - 'USER': 'cltbld', 22:06:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:06:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:03 INFO - 'XPC_FLAGS': '0x0', 22:06:03 INFO - 'XPC_SERVICE_NAME': '0', 22:06:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:06:04 INFO - Cleaning up... 22:06:04 INFO - Return code: 0 22:06:04 INFO - Running post-action listener: _resource_record_post_action 22:06:04 INFO - Running post-action listener: _start_resource_monitoring 22:06:04 INFO - Starting resource monitoring. 22:06:04 INFO - [mozharness: 2016-09-20 05:06:04.268822Z] Finished create-virtualenv step (success) 22:06:04 INFO - [mozharness: 2016-09-20 05:06:04.269767Z] Running install step. 22:06:04 INFO - Running pre-action listener: _resource_record_pre_action 22:06:04 INFO - Running main action method: install 22:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:06:04 INFO - Reading from file tmpfile_stdout 22:06:04 INFO - Detecting whether we're running mozinstall >=1.0... 22:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:06:04 INFO - Reading from file tmpfile_stdout 22:06:04 INFO - Output received: 22:06:04 INFO - Usage: mozinstall [options] installer 22:06:04 INFO - Options: 22:06:04 INFO - -h, --help show this help message and exit 22:06:04 INFO - -d DEST, --destination=DEST 22:06:04 INFO - Directory to install application into. [default: 22:06:04 INFO - "/builds/slave/test"] 22:06:04 INFO - --app=APP Application being installed. [default: firefox] 22:06:04 INFO - mkdir: /builds/slave/test/build/application 22:06:04 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'] 22:06:04 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 22:06:37 INFO - Reading from file tmpfile_stdout 22:06:37 INFO - Output received: 22:06:37 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 22:06:37 INFO - Running post-action listener: _resource_record_post_action 22:06:37 INFO - [mozharness: 2016-09-20 05:06:37.090903Z] Finished install step (success) 22:06:37 INFO - [mozharness: 2016-09-20 05:06:37.091018Z] Running run-tests step. 22:06:37 INFO - Running pre-action listener: _resource_record_pre_action 22:06:37 INFO - Running main action method: run_tests 22:06:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:06:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:06:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:06:37 INFO - 2016-09-19 22:06:37.105 screenresolution[1646:8025] starting screenresolution argv=screenresolution get 22:06:37 INFO - 2016-09-19 22:06:37.108 screenresolution[1646:8025] Display 0: 1600x1200x32@60 22:06:37 INFO - 2016-09-19 22:06:37.114 screenresolution[1647:8029] starting screenresolution argv=screenresolution list 22:06:37 INFO - Available Modes on Display 0 22:06:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:06:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:06:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:06:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:06:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:06:37 INFO - Intel Iris: 22:06:37 INFO - Chipset Model: Intel Iris 22:06:37 INFO - Type: GPU 22:06:37 INFO - Bus: Built-In 22:06:37 INFO - VRAM (Dynamic, Max): 1536 MB 22:06:37 INFO - Vendor: Intel (0x8086) 22:06:37 INFO - Device ID: 0x0a2e 22:06:37 INFO - Revision ID: 0x0009 22:06:37 INFO - Displays: 22:06:37 INFO - Display: 22:06:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:06:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:06:37 INFO - Display Serial Number: 1600x1200 60 22:06:37 INFO - Main Display: Yes 22:06:37 INFO - Mirror: Off 22:06:37 INFO - Online: Yes 22:06:37 INFO - Rotation: Supported 22:06:37 INFO - Return code: 0 22:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:06:37 INFO - Python 2.7.3 22:06:37 INFO - Return code: 0 22:06:37 INFO - grabbing minidump binary from tooltool 22:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:06:37 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 0x102960d30>, '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 0x1027c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102958b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:06:37 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 22:06:37 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 22:06:37 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 22:06:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:06:37 INFO - Return code: 0 22:06:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:06:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:06:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:06:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:06:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:06:37 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/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 22:06:37 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/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0061 --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 22:06:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5G7U7JelgP/Render', 22:06:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:06:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:06:37 INFO - 'HOME': '/Users/cltbld', 22:06:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:06:37 INFO - 'LOGNAME': 'cltbld', 22:06:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:06:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:37 INFO - 'MOZ_NO_REMOTE': '1', 22:06:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:06:37 INFO - 'NO_EM_RESTART': '1', 22:06:37 INFO - 'PAGER': '/bin/cat', 22:06:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:37 INFO - 'PWD': '/builds/slave/test', 22:06:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:06:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:06:37 INFO - 'SHELL': '/bin/bash', 22:06:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7SnijmIKmx/Listeners', 22:06:37 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 22:06:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:06:37 INFO - 'USER': 'cltbld', 22:06:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:06:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:37 INFO - 'XPC_FLAGS': '0x0', 22:06:37 INFO - 'XPC_SERVICE_NAME': '0', 22:06:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:06:37 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/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 22:06:37 INFO - mozversion application_buildid: 20160919200817 22:06:37 INFO - mozversion application_changeset: ef0680dc3d4feb015a07b3edefe0b9d2a095bdec 22:06:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:06:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:06:37 INFO - mozversion application_name: Firefox 22:06:37 INFO - mozversion application_remotingname: firefox-dev 22:06:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:06:37 INFO - mozversion application_vendor: Mozilla 22:06:37 INFO - mozversion application_version: 51.0a2 22:06:37 INFO - mozversion platform_buildid: 20160919200817 22:06:37 INFO - mozversion platform_changeset: ef0680dc3d4feb015a07b3edefe0b9d2a095bdec 22:06:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:06:37 INFO - mozversion platform_version: 51.0a2 22:06:37 INFO - using testdate: 1474347997 22:06:37 INFO - actual date: 1474347997 22:06:37 INFO - starting webserver on 'localhost:49274' 22:06:37 INFO - SUITE-START | Running 2 tests 22:06:37 INFO - TEST-START | dromaeo_css 22:06:37 INFO - operating with platform_type : mac_ 22:06:37 INFO - Initialising browser for dromaeo_css test... 22:06:37 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpAmZqxs/profile http://localhost:49274/getInfo.html) 22:06:40 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 22:06:40 INFO - PROCESS | 1657 | colorDepth:24 22:06:40 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 22:06:40 INFO - PROCESS | 1657 | __metrics 22:06:40 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 22:06:41 INFO - TEST-INFO | 1657: exit 0 22:06:41 INFO - Browser initialized. 22:06:41 INFO - Running cycle 1/1 for dromaeo_css test... 22:06:41 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpAmZqxs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:06:53 INFO - PROCESS | 1661 | RSS: Main: 224632832 22:06:53 INFO - PROCESS | 1661 | 22:07:42 INFO - PROCESS | 1661 | 1474348062860 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] 22:09:55 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 22:09:56 INFO - PROCESS | 1661 | RSS: Main: 237092864 22:09:56 INFO - PROCESS | 1661 | 22:12:58 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 22:12:59 INFO - PROCESS | 1661 | RSS: Main: 246865920 22:12:59 INFO - PROCESS | 1661 | 22:16:01 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 22:16:02 INFO - PROCESS | 1661 | RSS: Main: 250249216 22:16:02 INFO - PROCESS | 1661 | 22:19:03 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 22:19:04 INFO - PROCESS | 1661 | RSS: Main: 251506688 22:19:04 INFO - PROCESS | 1661 | 22:22:07 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 22:22:07 INFO - PROCESS | 1661 | RSS: Main: 255942656 22:22:07 INFO - PROCESS | 1661 | 22:25:10 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 22:25:10 INFO - PROCESS | 1661 | RSS: Main: 257589248 22:25:10 INFO - PROCESS | 1661 | 22:25:10 INFO - PROCESS | 1661 | __start_tp_report 22:25:10 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 22:25:10 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 22:25:10 INFO - PROCESS | 1661 | |i|pagename|runs| 22:25:10 INFO - PROCESS | 1661 | |0;dojo.html;3455.2053027803604;3478.0261526772497;3503.5795704515444;3509.7894126352435;3512.174638959844;5016.4231113421965;5680.204771332012;5976.641401515907;6138.938610613893;6139;6085.604435711675;6147.569670123094;6154.415330543602;6168.784092556762;6189.288231853327;5439.619226654136;5474.945250547484;5491.780328786844;5529.225908372831;5644.717764111799;5558.805441809537;5575.163725441196;5577.69322687252;5577.860553486175;5578.609497335168;5325.094733895247;5351.17056856186;5552.11166213406;5556.555475561945;5577.163425486169;5454.127339625661;5473.972630136844;5480.506754392084;5488.396276409591;5526.253955716007;5345.679259244419;5427.782888684448;5508.14623733322;5529.253550770634;5547.916781248285;4334.829596009092;5862.973979553561;6099.756009759604;6172.814815555541;6188.257409110891;5882.499987501067;6203.782867599657;6245.656488893109;6277.654728989904;6312.905306420407;6407.615543067384;6418.165638467016;6484.773032943825;6499.8700025999215;6499.93500064998;5941.049432090931;6176.4749996250375;6189.87620247597;6212.9068063979075;6228.688565571703;5624.521915637135;6038.731866308124;6379.904301435482;6385.457236134887;6482.027695845661;5910.586258961831;6315.5894866833505;6358.109864618957;6363.204599425072;6377.298497165308;6244.500439964792;6449.5485316027425;6470.09418681385;6475.7733479328;6498.707558159894;5561.4427960171215;6134.650895842745;6278.560500764903;6316.273628532777;6360.1731774869895;5091.41448733393;6311.400416960381;6313.9368606314265;6346.17499725042;6357.8728425432155;5080.085584594734;5110.66780659256;5116.897662046813;5147.613928955343;5153.639245252796;4011.859584914514;4507.053518761031;4507.211238033331;4535.659825513034;4620.214563524209;6121.387861213843;6134.78528251509;6203.131561581382;6208.00671892504;6228.34602366754;6426.389492998158;6442.774502892376;6461.64460954652;6466.6766661666725;6477.805665830033;5893.557983151195;6096.908546371808;6106.612350340322;6124.228368151176;6144.3717414885095;5547.140193270049;5604.8038318658655;5609.186667933127;5613.129964855454;5613.214150019001;6557.9344206557325;6586.604803711793;6624.238212605515;6626.171728533934;6629.7679581214425;6275.623462592259;6276.278228003838;6299.401556852092;6316.715747791269;6436.645984470899;5313.973430132824;6494.740210391531;6501.057346684799;6505.31694172124;6548.47612191014;6346.301906790157;6353.205849268841;6353.555251132561;6392.68036598159;6396.976483762575;6284.622922624657;6287;6303.873922521616;6350.110984462087;6359.777407790705;6134.650895842656;6177.413145751147;6325.525585581192;6327.810165695037;6343.175387199634;6281.59169653971;6312.3056463788025;6318.894193516025;6325.082862984749;6339.587926784744;6049.122877182872;6088.269407671108;6112.47308512798;6161.229846269216;6208.720607572761;5967.373425790403;6288.27684816252;6311.958526843019;6344.555881088279;6346.841328966812;6249.78125765596;6258.499320054294;6310.5267104968225;6311.715972781144;6342.778002769881 22:25:10 INFO - PROCESS | 1661 | |1;ext.html;433.56643356643355;488.9658372542075;514.3005512502996;518.2537146509029;539.8866238090001;38823.22353552931;40706.59293407065;40811;40811.59188408119;40815.387769183486;33807.492887606706;35723.64276357236;43174.35238471426;43583.78208108955;44197.116057678824;9750.658726944559;9805.607775688999;9911.306208565404;9921.305508614363;9924.801503969917;8242.29940455062;9641.758956026086;9775.217982561378;9778.217742580577;9801.509924503745;9755.41467511948;9773.657921972732;9792.020797920186;9804.362716423446;9843.753906152331;9746.853797193047;9777.706668799947;9782.364146330467;9784;9802.509874506246;9752.317337786288;9810.21518278536;9825.852612210823;9884.604615815359;9924.851127233098;40029.39955900664;40038.19923601541;40269;40464.79767601172;40521.392179117334;3151.952720709191;3154.1846711404132;3473.913152171216;3555.6799888010205;3950.920981580381;30008.699913001026;30445.69554304451;30824.53763193554;31255.84372078125;31585;3222.323312104461;3273.3780581689402;3318.4026875162463;3327.035159803654;3369.359821633882;515017.9999999963;515627.42186289205;516016.419917898;519723;520568;33072.1731956703;45957.080858382644;50943.74528127335;57751.711241443525;58076.8384632305;33347.83326083403;33537.99386018424;33751.987440376826;33776.83111584427;33870.830645847105;15090.54728358151;15194.772078418833;15209.467668631765;15246.313915873812;15250;12711.55509557161;12850.55023074188;13019.349032548334;13020;13046.217226966412;7533.7363192288;7689.807754806175;7692.076950765944;7713.575753333508;7739.92260077392;3191.7446604271604;3240.22234663679;3249.821259830732;3255.300110476259;3288.6546912573835;945.9952700236455;947.6920000999703;962.4898803634085;1019.3883669798062;1052.8526006359116;23409.595424274597;30494.08517744471;30586.38827223443;30594.235144121576;30826.53760193599;1069.059227879461;1072.9624463143753;1103.6799328194895;1109.2457129152253;1143.0512674480162;13587;16414.276500967466;16569;16608.25262863174;16961.236744346286;681763;727026;739570;742529;742963;57367.13949290764;57926.13110803341;58045.70977145087;58097;58266.12600810991;1366.2511984659652;1366.5422083602105;1398.3707331700775;1399.307342865288;1404.7401230772543;30450.390992180477;30954;31514;31942.52086218755;32234;48713;54200.915981679354;55862.72068639631;55928;59612.70193649177;583690;585145;591819;592097;592326;43013.053498846784;43145.784271078446;43181.784091079346;43253.13493730171;43738.56261437345;42819.785901070296;44642.10715785731;47624.761876190394;47666.28500572564;48145.277820832016;37943.05142371352;39022;39197.74841654303;39837.203255935296;40222.59777402189;31132;32884.83557582197;39597.80201098976;40161.598384015786;40346.79826600848;38056;38419.80790096144;38782.61217387903;39030.024249393995;39233.60766392414;27436;32907.341853163285;35009.64990350064;35107;35143.75724758432;18927.810721892605;20735.377938661863;25959.351016224744;26196.345091372867;26539 22:25:10 INFO - PROCESS | 1661 | |2;jquery.html;375.96234393075105;376.68358578793806;382.852601748327;385.6066811851913;402.6155021954034;18021.909890450563;18142.002189879553;19244.556658250636;20596.8970155149;20764.065617047232;20009.299674511396;20581.794182058176;21063.47341316468;21231.68152477714;21390.786092139075;4836.274558816171;5861.062230043204;5958.940410595904;6013.579049466539;6121.051237058241;5901.911471327933;5981.910271345933;5999.760009599632;6006.7897623583185;6009.4591486766185;5723.685197314146;5914;5939.584229103964;5941.168236446901;6000.429959153874;5915.852103697421;5938.317093534256;5944.286685597756;5963.403659634046;5971.193888825018;4973.950260497385;5106.795728170906;5162.328897243372;5197.246399272084;5205.453427390107;25676.743232567624;25786.35534111662;25934.74065259342;26066.478670426484;26266.080687176047;2308.319045881469;2443.963340549893;2773.9736297569825;3145.4207549809166;3195.6484786673445;15300;15476.845231547766;15650.217489125498;15776.132312722795;16224.918875405665;1855.9814401856079;1875.6717574424422;1941.8155275248828;1950.980490195094;1958.2362878477404;94860.10279794435;117464.41267793607;123518.61888589968;125439.37280313631;126873;10869.347839129678;10893.074088702391;11395.259308144945;11405.258658187191;11561.826572601418;13715.382807773674;14077.859221407654;14079.929600352138;14089.929550352183;14102.576922692335;8643.049264580892;8847.778805529913;8900.599473023729;8984.416012959136;9076.228520575693;9054.139856713733;9068.8639670405;9074.727758167266;9200.723978280663;9221.400608960395;6740.359665831738;6790.796276111724;6840.144981877265;6861.897071543931;6863.622500762506;1830.4874635102192;1869.691500902363;1873.147717788403;1874.4845167578753;1874.7656542932134;895.6641259527677;970.9563069661741;979.4906648542718;1020.3316827478013;1055.519738518972;22037.449063773212;22548.88725556362;22555.323340299816;22615.208467703553;22622.886885565465;970.2529052629436;975.5366201054584;984.6701355045997;990.7325022243954;1003.9046290602381;9619.759506012406;9849.803003939882;11362.886371136183;11760.235584686969;12002.879971200351;631650;637953;643360;646714;646892;88021.55989220012;104851.4757426208;106395;118216;123937;968.5109019945023;995.0745806400117;1013.6300250408548;1016.4714348538866;1017.6794309792392;18626.534336641693;19317.51706207356;19412.514687132934;19487.317943871898;19563.706544402132;37998.810005949796;49272.260916087005;53048.73475632597;53869.46130538801;54249;80167.1983280183;80942.59528702318;82703.5864820672;84863.5756821212;85126;7826.647800848861;7929.246721561442;8050.832629268841;8066.717664881936;8231.300339471212;8947.97098333674;11887.28676279426;12758;12805.71942805712;13022.674433139247;10885.945570272099;11122.666320010412;11214.046806021579;11297.209195356247;11303.943480282875;10573.2598718089;10731.248812583357;11167.944160279147;11177.273477223955;11357.943210284226;11120.277181983145;11209.663710088384;11338.659840204808;11467.139964502863;11533;7904.44823618104;7932.104781754733;8090.514569125636;8149.225823546753;8236.50580965144;10835.241533092609;10929.781404372026;10960.506777195205;11204.775904482029;11341.829872551752 22:25:10 INFO - PROCESS | 1661 | |3;mootools.html;1426.6789972256242;1513;1701.3364787732787;1832.7800663920332;1835.13748538187;8211.589420528964;8488.363372747037;8750;9310.581023853925;9333.066693330673;8711.782205444852;9045.366824322284;9067.455952642846;9135.725928222148;9139.588718507666;2372.95254094918;2376.180217824852;2408.3256688127353;2409.6024156014237;2417.830751847371;1959.980400195994;2380.2026321182425;2394.4971555973266;2418.9758102418928;2423.4062654649633;2386.152915714922;2397.3407312988893;2398.2325655790155;2407.4462873539096;2420.6732091167733;2379.892904819287;2380.2264264114146;2380.9166679166233;2397.3766820626674;2407.518496300747;2380.51199504103;2382.4520360317224;2392.174699728591;2392.9710224603414;2398.280515845257;9091.590878410487;9147.2682185425;9231.538423078819;9235.353525253235;9248.953755231249;5338.27933229013;5483.424240454735;5485.122380419114;5501.312335958005;5528.55771538276;3639.94540081899;3678.8896333109783;3713;3732.794696291703;3739.1773809761808;923.4597760310227;992.270681049428;1095.8630171228597;1095.9671209863716;1108.501174471483;12029.93985030078;12068.818967715491;12135.93932030343;12209.755804883853;12231.510739570407;4463.464384273908;4557.817687292538;4694.319323698045;4702.9764851176205;4706.670533062653;9317.860232096524;9475.763105922408;9486.762830929281;9491.050894910453;9492.477913714674;5274.446183150791;5315.468453154731;5353.946460535422;5368.624196306299;5370.167624018283;4178.791060447026;4467.530909254547;4609.861704148881;4819.180739274261;5018.698878067327;3821.5796262411113;3863.4204869269834;3953.584873588232;3958.5447673517338;3980.104476492766;1011.2213595531547;1196.4735516372768;1199.0467578275293;1213.5570516761318;1216.9817452738216;804.0150815251387;811.3144392987916;870.4951128345544;905.4612505559181;923.0031565908803;5828.562857785599;5858.355580886185;5887.558433117448;5969.52243820502;6006.609570377911;434.30511182108376;437.87082810570956;446.47985097361857;447.7492604141691;449.9212637788374;3809.42858571211;3824.2733880562605;4009.4587230723478;4108.281050816096;4139.234241665241;10179.745506362253;10880.347179169117;10883.727906802393;11040.723981900517;11048.116150707923;9367.484788336707;10675.626353077605;10791.136709063256;11008.284461509977;11013.394263315435;6851.45188384928;8443.113473085361;8451.577421128919;8472.279856212168;8504.362172837062;4847.733374664286;5698.886022279614;5867.911981320198;5894.174815525744;5948.464638182584;10083.697489075339;10106.494675266355;10225.693229203136;10305.793884122426;10388.636397726346;8921.330900182382;9253.444793312423;9276.2578993679;9402.95298523503;10288.176945844165;5910.320313163869;7327.926720732938;7445.590492522963;7615.771526854203;7797.259260370256;7908.406869484927;8460.661573536989;8621.956890215508;8633.179847914438;8647.783805404915;7565.43259255547;7661.344625836107;7717.459777815499;7808.141104478616;7850.842983140191;7243.710251589878;7428.665710042953;7439.404847612286;7487.663055162422;7497.512661676974;7052.929470705228;7071.398931090915;7185.856282874418;7232.963835180791;7239.746608868664;4935.210366341368;4964.851054468371;5017.8243761468175;5083;5098.209777484496;5055.34280543527;5113.386393632639;5136.357955255593;5156.690598564098;5187.429382767968 22:25:10 INFO - PROCESS | 1661 | |4;prototype.html;300.80598014280787;302.38313839766874;310.0203357390646;310.84923811951205;315.30160694062647;4762.976185119078;5481.780728770845;5578.665280083188;5670.8582285442835;5709.000924838152;4481.910361792762;5245.921311180336;5465.6447330923465;5592.496675299222;5670.716464176795;3994.9800250998705;4258.425112609804;4282.764447955361;4294.849680261192;4308.9353659695125;3682.8342724577324;4132.442120313749;4237.406763053175;4280.785960701968;4307.870763877073;3932.3315036443732;4210.894727631803;4235.2800023996;4253.617174454299;4260.2532961485795;3796.0320118369914;4023.3964905264297;4053.047533829548;4270.615644591986;4279.358096285551;3080.0451859923496;3238.5627940228005;3692.335379631665;3711.2577484502935;3731.776093434403;4707.952920470786;5081.974590127025;5447.918281225785;5513.8345849624575;5528.51216952369;4262.911173524982;4842.44311904132;4891.046245982035;4924.513120873971;4933.777979990909;4914.975425122887;5672.4894759471845;5919.052951527735;5956.808638272363;5977.970110149465;3506.2293541761246;4042.3734321180264;4049.797510124482;4062.329715596923;4068.7355321903983;5283.815066472694;6246.750129994794;6287.591306565105;6333.24001119864;6342.334054924213;3603;4081.6122468365456;4093.7748423836974;4133.793310334531;4135.31767258405;3827.3110840048503;4048.149888523384;4110.362893751473;4113.794310284474;4119.814608342632;4058.918821623551;4856.271559266138;4859.441164266084;4875.24433712775;4880.365552478226;5941.288646042229;6032.517398608101;6059.787907423219;6062.787802426894;6078.593020060509;1063.3460421840512;1203.9699007524882;1281.423359488234;1292.5411478924846;1374.216696482995;648.45205801098;788.5268838696736;816.6814942172557;847.4533925618065;856.8090354407378;4430.183624713852;4460.8661740147845;4792.976035119802;4795.880102997383;4836.637252206098;4385.798367191967;4857.489963553847;5210.426853046162;5263.842084737464;5269.36413874433;4326.480822301344;4388.166248412791;4460.687751857339;4678.485366609671;4751.954569994596;2630.368711509262;2773.1957732257824;2959.985200074029;3262.771605987558;3274.9345013100083;5716.828495145152;6068.029115341524;6428.19647544057;6454.290028096905;6473.935260647428;5306.655067420683;5582.134769110794;6230.875382492415;6400.775972840928;6430.839229019219;5995.760169593254;6093.573449858467;6470.45001174896;6486.124373209556;6554.3614096475885;5350.705711185922;5894.526368407898;6275.215598050244;6321.5574909757715;6329.050642403677;4918.508149185053;5854.94145058561;6107.816765497042;6148.1085242640465;6189.5048396129105;5243.501867322599;6510.414062734188;6517.4134327910715;6529.388244702157;6549.836254093686;3300.752443566694;3908.69387061635;3918.451416801707;4053.7973101344223;4058.228936502055;5643.379228284967;5777.075667893117;6203.96898015507;6271.777003484277;6305.306416294112;5271.258945348321;5338.332708411449;5827.854303642443;6024;6175.62946223228;4863.8569936065705;5043.344365232496;5972.820815375546;5991.741734235859;6036.788712395045;5211.348581427322;5958.225430693982;5983.311919129356;5986.341502434641;5986.964432093109;5739.397363276796;5930;6001.309849367204;6032.819015429544;6033.9698301508215;5010.223415370623;5313.946860531345;5970.940290597038;5971.373005834324;5989.286642281813 22:25:10 INFO - PROCESS | 1661 | |5;yui.html;678.6776281266399;722.2777222777223;786.90557133144;818.3821214982695;831.6631764135524;15511.224438778057;15801.972871763328;15819.288132034057;15828.841711582882;15881.602959926007;11229.831552526719;13419.798703019462;13599.93200034001;13615.931920340385;13653.863461365383;653.6111013946718;671.5299290496647;816.7713040348712;823.625250511016;841.2260720137489;850.5237067242333;854.0434713121282;854.2781349759443;854.6026097864523;855.4610595324937;905.8188362327561;910.5765818894213;914.9085091490864;915.9404638698496;917.3624331089895;892.1569117184264;905.6015353244551;909.822584596004;910.2626872233479;912.1471424218344;673.3804899492429;675.999520709348;678.3081257117761;678.4301187002941;683.8119517132778;14724.779128313085;14742.852571474255;14743.631409214748;14758.55724328272;14806.481773137995;13034.608961731163;13550.86449135506;14470;14476.493322733653;14776.408943642242;11343.035841953444;11535.365554894477;11576.942115289454;11987.280763154238;12166.936111610112;3782.5460944686815;3869.9613003870163;3914.178022615254;4011.3982902564558;4019.517657881073;109446;121874;133943;135264.32367838098;136887;10812.297200682087;10992.835107473395;11007.284526505751;11323.43382830855;11327.603533876274;23010.884945575166;23015.53968920612;23032.7696723034;23049.42376440569;23075.96158172886;7790.493617914817;7952.761417157494;8137.064237612751;8180.018397792184;8304.460210086325;4450.777461126931;4468.821247150077;4548.249538826123;4557.635389168859;4584.358189853423;3614.855405783792;3732.458793474931;3739.420389839579;3746.8875933722034;3747.3254814133174;597.7071235094772;649.870025994803;658.2463079773632;660.0956689335641;660.4122331125302;579.0792639702809;580.924479817621;606.7330374635146;656.9441597464269;712.7754757251449;7911.881321780178;8178.877316840252;8722.389432739774;9154.313426492907;9465.810683786423;658.4337469775988;668.5688571527437;671.7783131566571;678.4707927816311;685.6160550091964;4328.744664047454;4704.600108990706;4738.786754596052;4741.810327586858;4801.969631537939;158319;166076;168178.1591092061;168882;169644.15177924032;80928;83840.16159838445;87796.24407511814;104946;130872;85969;110547.34178987322;112354;114484;115344;8860.424072435271;9842.901570984199;10012.69961901144;10167.389956602627;10173.542190601589;50923.490765091876;51332.74333628308;64911;64935.35064649293;67512.6624366875;57367;100660;101156;103709;106514.80455586345;12569.120161588968;12785.48858045705;13278.797963393208;13429.127106738031;13474.461021559027;12320.507179712711;14374.568762937128;15081.622959425664;15733.292001860173;15751.527454176394;13477.46090156422;14101.506447274296;14455.710885782435;14633.707325853211;14641.194734289717;13803.378847951666;13805.24071176095;13811.51659691906;14006.369713363127;14148.78776818328;13265.933670331586;13279;13389.598312050264;13425.328733563087;13496.190228586316;10666.306690065121;10976.176786740867;11188.496517656888;11444.084473242287;11587.42062896835;9632.32573719861;11494.89581876678;11676.88323116792;11836.76326473483;11882.16824822254 22:25:10 INFO - PROCESS | 1661 | __end_tp_report 22:25:10 INFO - PROCESS | 1661 | __start_cc_report 22:25:10 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,357 22:25:10 INFO - PROCESS | 1661 | __end_cc_report 22:25:10 INFO - PROCESS | 1661 | __startTimestamp1474349110809__endTimestamp 22:25:10 INFO - PROCESS | 1661 | 22:25:10 INFO - PROCESS | 1661 | ------- Summary: start ------- 22:25:10 INFO - PROCESS | 1661 | Number of tests: 6 22:25:10 INFO - PROCESS | 1661 | 22:25:10 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5926.11 Median:6188.26 stddev:661.39 (10.7%) stddev-sans-first:634.37 22:25:10 INFO - PROCESS | 1661 | Values: 3455.2 3478.0 3503.6 3509.8 3512.2 5016.4 5680.2 5976.6 6138.9 6139.0 6085.6 6147.6 6154.4 6168.8 6189.3 5439.6 5474.9 5491.8 5529.2 5644.7 5558.8 5575.2 5577.7 5577.9 5578.6 5325.1 5351.2 5552.1 5556.6 5577.2 5454.1 5474.0 5480.5 5488.4 5526.3 5345.7 5427.8 5508.1 5529.3 5547.9 4334.8 5863.0 6099.8 6172.8 6188.3 5882.5 6203.8 6245.7 6277.7 6312.9 6407.6 6418.2 6484.8 6499.9 6499.9 5941.0 6176.5 6189.9 6212.9 6228.7 5624.5 6038.7 6379.9 6385.5 6482.0 5910.6 6315.6 6358.1 6363.2 6377.3 6244.5 6449.5 6470.1 6475.8 6498.7 5561.4 6134.7 6278.6 6316.3 6360.2 5091.4 6311.4 6313.9 6346.2 6357.9 5080.1 5110.7 5116.9 5147.6 5153.6 4011.9 4507.1 4507.2 4535.7 4620.2 6121.4 6134.8 6203.1 6208.0 6228.3 6426.4 6442.8 6461.6 6466.7 6477.8 5893.6 6096.9 6106.6 6124.2 6144.4 5547.1 5604.8 5609.2 5613.1 5613.2 6557.9 6586.6 6624.2 6626.2 6629.8 6275.6 6276.3 6299.4 6316.7 6436.6 5314.0 6494.7 6501.1 6505.3 6548.5 6346.3 6353.2 6353.6 6392.7 6397.0 6284.6 6287.0 6303.9 6350.1 6359.8 6134.7 6177.4 6325.5 6327.8 6343.2 6281.6 6312.3 6318.9 6325.1 6339.6 6049.1 6088.3 6112.5 6161.2 6208.7 5967.4 6288.3 6312.0 6344.6 6346.8 6249.8 6258.5 6310.5 6311.7 6342.8 22:25:10 INFO - PROCESS | 1661 | 22:25:10 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:72681.06 Median:40192.10 stddev:165640.22 (412.1%) stddev-sans-first:166016.06 22:25:10 INFO - PROCESS | 1661 | Values: 433.6 489.0 514.3 518.3 539.9 38823.2 40706.6 40811.0 40811.6 40815.4 33807.5 35723.6 43174.4 43583.8 44197.1 9750.7 9805.6 9911.3 9921.3 9924.8 8242.3 9641.8 9775.2 9778.2 9801.5 9755.4 9773.7 9792.0 9804.4 9843.8 9746.9 9777.7 9782.4 9784.0 9802.5 9752.3 9810.2 9825.9 9884.6 9924.9 40029.4 40038.2 40269.0 40464.8 40521.4 3152.0 3154.2 3473.9 3555.7 3950.9 30008.7 30445.7 30824.5 31255.8 31585.0 3222.3 3273.4 3318.4 3327.0 3369.4 515018.0 515627.4 516016.4 519723.0 520568.0 33072.2 45957.1 50943.7 57751.7 58076.8 33347.8 33538.0 33752.0 33776.8 33870.8 15090.5 15194.8 15209.5 15246.3 15250.0 12711.6 12850.6 13019.3 13020.0 13046.2 7533.7 7689.8 7692.1 7713.6 7739.9 3191.7 3240.2 3249.8 3255.3 3288.7 946.0 947.7 962.5 1019.4 1052.9 23409.6 30494.1 30586.4 30594.2 30826.5 1069.1 1073.0 1103.7 1109.2 1143.1 13587.0 16414.3 16569.0 16608.3 16961.2 681763.0 727026.0 739570.0 742529.0 742963.0 57367.1 57926.1 58045.7 58097.0 58266.1 1366.3 1366.5 1398.4 1399.3 1404.7 30450.4 30954.0 31514.0 31942.5 32234.0 48713.0 54200.9 55862.7 55928.0 59612.7 583690.0 585145.0 591819.0 592097.0 592326.0 43013.1 43145.8 43181.8 43253.1 43738.6 42819.8 44642.1 47624.8 47666.3 48145.3 37943.1 39022.0 39197.7 39837.2 40222.6 31132.0 32884.8 39597.8 40161.6 40346.8 38056.0 38419.8 38782.6 39030.0 39233.6 27436.0 32907.3 35009.6 35107.0 35143.8 18927.8 20735.4 25959.4 26196.3 26539.0 22:25:10 INFO - PROCESS | 1661 | 22:25:10 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:35983.83 Median:26000.61 stddev:106247.74 (408.6%) stddev-sans-first:106512.16 22:25:10 INFO - PROCESS | 1661 | Values: 376.0 376.7 382.9 385.6 402.6 18021.9 18142.0 19244.6 20596.9 20764.1 20009.3 20581.8 21063.5 21231.7 21390.8 4836.3 5861.1 5958.9 6013.6 6121.1 5901.9 5981.9 5999.8 6006.8 6009.5 5723.7 5914.0 5939.6 5941.2 6000.4 5915.9 5938.3 5944.3 5963.4 5971.2 4974.0 5106.8 5162.3 5197.2 5205.5 25676.7 25786.4 25934.7 26066.5 26266.1 2308.3 2444.0 2774.0 3145.4 3195.6 15300.0 15476.8 15650.2 15776.1 16224.9 1856.0 1875.7 1941.8 1951.0 1958.2 94860.1 117464.4 123518.6 125439.4 126873.0 10869.3 10893.1 11395.3 11405.3 11561.8 13715.4 14077.9 14079.9 14089.9 14102.6 8643.0 8847.8 8900.6 8984.4 9076.2 9054.1 9068.9 9074.7 9200.7 9221.4 6740.4 6790.8 6840.1 6861.9 6863.6 1830.5 1869.7 1873.1 1874.5 1874.8 895.7 971.0 979.5 1020.3 1055.5 22037.4 22548.9 22555.3 22615.2 22622.9 970.3 975.5 984.7 990.7 1003.9 9619.8 9849.8 11362.9 11760.2 12002.9 631650.0 637953.0 643360.0 646714.0 646892.0 88021.6 104851.5 106395.0 118216.0 123937.0 968.5 995.1 1013.6 1016.5 1017.7 18626.5 19317.5 19412.5 19487.3 19563.7 37998.8 49272.3 53048.7 53869.5 54249.0 80167.2 80942.6 82703.6 84863.6 85126.0 7826.6 7929.2 8050.8 8066.7 8231.3 8948.0 11887.3 12758.0 12805.7 13022.7 10885.9 11122.7 11214.0 11297.2 11303.9 10573.3 10731.2 11167.9 11177.3 11357.9 11120.3 11209.7 11338.7 11467.1 11533.0 7904.4 7932.1 8090.5 8149.2 8236.5 10835.2 10929.8 10960.5 11204.8 11341.8 22:25:10 INFO - PROCESS | 1661 | 22:25:10 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5727.37 Median:5018.26 stddev:3249.89 (64.8%) stddev-sans-first:3242.93 22:25:10 INFO - PROCESS | 1661 | Values: 1426.7 1513.0 1701.3 1832.8 1835.1 8211.6 8488.4 8750.0 9310.6 9333.1 8711.8 9045.4 9067.5 9135.7 9139.6 2373.0 2376.2 2408.3 2409.6 2417.8 1960.0 2380.2 2394.5 2419.0 2423.4 2386.2 2397.3 2398.2 2407.4 2420.7 2379.9 2380.2 2380.9 2397.4 2407.5 2380.5 2382.5 2392.2 2393.0 2398.3 9091.6 9147.3 9231.5 9235.4 9249.0 5338.3 5483.4 5485.1 5501.3 5528.6 3639.9 3678.9 3713.0 3732.8 3739.2 923.5 992.3 1095.9 1096.0 1108.5 12029.9 12068.8 12135.9 12209.8 12231.5 4463.5 4557.8 4694.3 4703.0 4706.7 9317.9 9475.8 9486.8 9491.1 9492.5 5274.4 5315.5 5353.9 5368.6 5370.2 4178.8 4467.5 4609.9 4819.2 5018.7 3821.6 3863.4 3953.6 3958.5 3980.1 1011.2 1196.5 1199.0 1213.6 1217.0 804.0 811.3 870.5 905.5 923.0 5828.6 5858.4 5887.6 5969.5 6006.6 434.3 437.9 446.5 447.7 449.9 3809.4 3824.3 4009.5 4108.3 4139.2 10179.7 10880.3 10883.7 11040.7 11048.1 9367.5 10675.6 10791.1 11008.3 11013.4 6851.5 8443.1 8451.6 8472.3 8504.4 4847.7 5698.9 5867.9 5894.2 5948.5 10083.7 10106.5 10225.7 10305.8 10388.6 8921.3 9253.4 9276.3 9403.0 10288.2 5910.3 7327.9 7445.6 7615.8 7797.3 7908.4 8460.7 8622.0 8633.2 8647.8 7565.4 7661.3 7717.5 7808.1 7850.8 7243.7 7428.7 7439.4 7487.7 7497.5 7052.9 7071.4 7185.9 7233.0 7239.7 4935.2 4964.9 5017.8 5083.0 5098.2 5055.3 5113.4 5136.4 5156.7 5187.4 22:25:10 INFO - PROCESS | 1661 | 22:25:10 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4728.03 Median:5146.20 stddev:1524.19 (29.6%) stddev-sans-first:1491.81 22:25:10 INFO - PROCESS | 1661 | Values: 300.8 302.4 310.0 310.8 315.3 4763.0 5481.8 5578.7 5670.9 5709.0 4481.9 5245.9 5465.6 5592.5 5670.7 3995.0 4258.4 4282.8 4294.8 4308.9 3682.8 4132.4 4237.4 4280.8 4307.9 3932.3 4210.9 4235.3 4253.6 4260.3 3796.0 4023.4 4053.0 4270.6 4279.4 3080.0 3238.6 3692.3 3711.3 3731.8 4708.0 5082.0 5447.9 5513.8 5528.5 4262.9 4842.4 4891.0 4924.5 4933.8 4915.0 5672.5 5919.1 5956.8 5978.0 3506.2 4042.4 4049.8 4062.3 4068.7 5283.8 6246.8 6287.6 6333.2 6342.3 3603.0 4081.6 4093.8 4133.8 4135.3 3827.3 4048.1 4110.4 4113.8 4119.8 4058.9 4856.3 4859.4 4875.2 4880.4 5941.3 6032.5 6059.8 6062.8 6078.6 1063.3 1204.0 1281.4 1292.5 1374.2 648.5 788.5 816.7 847.5 856.8 4430.2 4460.9 4793.0 4795.9 4836.6 4385.8 4857.5 5210.4 5263.8 5269.4 4326.5 4388.2 4460.7 4678.5 4752.0 2630.4 2773.2 2960.0 3262.8 3274.9 5716.8 6068.0 6428.2 6454.3 6473.9 5306.7 5582.1 6230.9 6400.8 6430.8 5995.8 6093.6 6470.5 6486.1 6554.4 5350.7 5894.5 6275.2 6321.6 6329.1 4918.5 5854.9 6107.8 6148.1 6189.5 5243.5 6510.4 6517.4 6529.4 6549.8 3300.8 3908.7 3918.5 4053.8 4058.2 5643.4 5777.1 6204.0 6271.8 6305.3 5271.3 5338.3 5827.9 6024.0 6175.6 4863.9 5043.3 5972.8 5991.7 6036.8 5211.3 5958.2 5983.3 5986.3 5987.0 5739.4 5930.0 6001.3 6032.8 6034.0 5010.2 5313.9 5970.9 5971.4 5989.3 22:25:10 INFO - PROCESS | 1661 | 22:25:10 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:24957.38 Median:23062.69 stddev:40648.98 (176.3%) stddev-sans-first:40722.14 22:25:10 INFO - PROCESS | 1661 | Values: 678.7 722.3 786.9 818.4 831.7 15511.2 15802.0 15819.3 15828.8 15881.6 11229.8 13419.8 13599.9 13615.9 13653.9 653.6 671.5 816.8 823.6 841.2 850.5 854.0 854.3 854.6 855.5 905.8 910.6 914.9 915.9 917.4 892.2 905.6 909.8 910.3 912.1 673.4 676.0 678.3 678.4 683.8 14724.8 14742.9 14743.6 14758.6 14806.5 13034.6 13550.9 14470.0 14476.5 14776.4 11343.0 11535.4 11576.9 11987.3 12166.9 3782.5 3870.0 3914.2 4011.4 4019.5 109446.0 121874.0 133943.0 135264.3 136887.0 10812.3 10992.8 11007.3 11323.4 11327.6 23010.9 23015.5 23032.8 23049.4 23076.0 7790.5 7952.8 8137.1 8180.0 8304.5 4450.8 4468.8 4548.2 4557.6 4584.4 3614.9 3732.5 3739.4 3746.9 3747.3 597.7 649.9 658.2 660.1 660.4 579.1 580.9 606.7 656.9 712.8 7911.9 8178.9 8722.4 9154.3 9465.8 658.4 668.6 671.8 678.5 685.6 4328.7 4704.6 4738.8 4741.8 4802.0 158319.0 166076.0 168178.2 168882.0 169644.2 80928.0 83840.2 87796.2 104946.0 130872.0 85969.0 110547.3 112354.0 114484.0 115344.0 8860.4 9842.9 10012.7 10167.4 10173.5 50923.5 51332.7 64911.0 64935.4 67512.7 57367.0 100660.0 101156.0 103709.0 106514.8 12569.1 12785.5 13278.8 13429.1 13474.5 12320.5 14374.6 15081.6 15733.3 15751.5 13477.5 14101.5 14455.7 14633.7 14641.2 13803.4 13805.2 13811.5 14006.4 14148.8 13265.9 13279.0 13389.6 13425.3 13496.2 10666.3 10976.2 11188.5 11444.1 11587.4 9632.3 11494.9 11676.9 11836.8 11882.2 22:25:10 INFO - PROCESS | 1661 | -------- Summary: end -------- 22:25:10 INFO - PROCESS | 1661 | 22:25:11 INFO - TEST-INFO | 1661: exit 0 22:25:11 INFO - TEST-OK | dromaeo_css | took 1113719ms 22:25:11 INFO - TEST-START | kraken 22:25:11 INFO - operating with platform_type : mac_ 22:25:11 INFO - Initialising browser for kraken test... 22:25:11 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpkxrFM6/profile http://localhost:49274/getInfo.html) 22:25:14 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 22:25:14 INFO - PROCESS | 1668 | colorDepth:24 22:25:14 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 22:25:14 INFO - PROCESS | 1668 | __metrics 22:25:14 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 22:25:15 INFO - TEST-INFO | 1668: exit 0 22:25:15 INFO - Browser initialized. 22:25:15 INFO - Running cycle 1/1 for kraken test... 22:25:15 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpkxrFM6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:25:27 INFO - PROCESS | 1670 | RSS: Main: 225050624 22:25:27 INFO - PROCESS | 1670 | 22:25:30 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 22:25:31 INFO - PROCESS | 1670 | RSS: Main: 237948928 22:25:31 INFO - PROCESS | 1670 | 22:25:33 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 22:25:34 INFO - PROCESS | 1670 | RSS: Main: 244867072 22:25:34 INFO - PROCESS | 1670 | 22:25:37 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 22:25:37 INFO - PROCESS | 1670 | RSS: Main: 248770560 22:25:37 INFO - PROCESS | 1670 | 22:25:39 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 22:25:40 INFO - PROCESS | 1670 | RSS: Main: 249237504 22:25:40 INFO - PROCESS | 1670 | 22:25:42 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:25:43 INFO - PROCESS | 1670 | RSS: Main: 250392576 22:25:43 INFO - PROCESS | 1670 | 22:25:45 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 22:25:46 INFO - PROCESS | 1670 | RSS: Main: 250662912 22:25:46 INFO - PROCESS | 1670 | 22:25:49 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 22:25:50 INFO - PROCESS | 1670 | RSS: Main: 250499072 22:25:50 INFO - PROCESS | 1670 | 22:25:53 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 22:25:53 INFO - PROCESS | 1670 | RSS: Main: 251162624 22:25:53 INFO - PROCESS | 1670 | 22:25:55 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:25:56 INFO - PROCESS | 1670 | RSS: Main: 250748928 22:25:56 INFO - PROCESS | 1670 | 22:25:58 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:25:58 INFO - PROCESS | 1670 | RSS: Main: 250818560 22:25:58 INFO - PROCESS | 1670 | 22:26:00 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:26:01 INFO - PROCESS | 1670 | RSS: Main: 250785792 22:26:01 INFO - PROCESS | 1670 | 22:26:04 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:26:05 INFO - PROCESS | 1670 | RSS: Main: 250650624 22:26:05 INFO - PROCESS | 1670 | 22:26:07 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:26:08 INFO - PROCESS | 1670 | RSS: Main: 251023360 22:26:08 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 22:26:10 INFO - PROCESS | 1670 | RSS: Main: 252645376 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | __start_tp_report 22:26:10 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 22:26:10 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 22:26:10 INFO - PROCESS | 1670 | |i|pagename|runs| 22:26:10 INFO - PROCESS | 1670 | |0;ai-astar;106;120;118;117;119;119;119;113;119;119 22:26:10 INFO - PROCESS | 1670 | |1;audio-beat-detection;140;112;111;141;110;112;112;111;138;113 22:26:10 INFO - PROCESS | 1670 | |2;audio-dft;195;205;195;193;198;197;198;197;197;196 22:26:10 INFO - PROCESS | 1670 | |3;audio-fft;75;65;83;101;60;59;59;80;105;51 22:26:10 INFO - PROCESS | 1670 | |4;audio-oscillator;84;69;89;73;69;71;89;70;70;85 22:26:10 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;91;89;90;88;92;87;91;90;98;115 22:26:10 INFO - PROCESS | 1670 | |6;imaging-darkroom;90;91;152;93;153;99;97;97;130;101 22:26:10 INFO - PROCESS | 1670 | |7;imaging-desaturate;86;98;83;75;78;137;77;107;145;151 22:26:10 INFO - PROCESS | 1670 | |8;json-parse-financial;54;56;54;57;60;60;60;60;60;61 22:26:10 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;69;75;69;87;74;73;67;66;68;71 22:26:10 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;84;82;87;88;82;85;86;86;84;90 22:26:10 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;150;154;151;134;137;129;134;157;198;145 22:26:10 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;218;172;164;170;170;167;165;170;167;167 22:26:10 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;71;87;91;79;68;67;68;69;68;69 22:26:10 INFO - PROCESS | 1670 | __end_tp_report 22:26:10 INFO - PROCESS | 1670 | __start_cc_report 22:26:10 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,941 22:26:10 INFO - PROCESS | 1670 | __end_cc_report 22:26:10 INFO - PROCESS | 1670 | __startTimestamp1474349170628__endTimestamp 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | ------- Summary: start ------- 22:26:10 INFO - PROCESS | 1670 | Number of tests: 14 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:116.90 Median:119.00 stddev:4.31 (3.6%) stddev-sans-first:2.09 22:26:10 INFO - PROCESS | 1670 | Values: 106.0 120.0 118.0 117.0 119.0 119.0 119.0 113.0 119.0 119.0 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:120.00 Median:112.50 stddev:13.61 (12.1%) stddev-sans-first:12.37 22:26:10 INFO - PROCESS | 1670 | Values: 140.0 112.0 111.0 141.0 110.0 112.0 112.0 111.0 138.0 113.0 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:197.10 Median:197.00 stddev:3.18 (1.6%) stddev-sans-first:3.28 22:26:10 INFO - PROCESS | 1670 | Values: 195.0 205.0 195.0 193.0 198.0 197.0 198.0 197.0 197.0 196.0 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:73.80 Median:62.50 stddev:18.45 (29.5%) stddev-sans-first:19.56 22:26:10 INFO - PROCESS | 1670 | Values: 75.0 65.0 83.0 101.0 60.0 59.0 59.0 80.0 105.0 51.0 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:78.50 stddev:8.69 (11.1%) stddev-sans-first:8.82 22:26:10 INFO - PROCESS | 1670 | Values: 84.0 69.0 89.0 73.0 69.0 71.0 89.0 70.0 70.0 85.0 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:90.50 stddev:8.25 (9.1%) stddev-sans-first:8.72 22:26:10 INFO - PROCESS | 1670 | Values: 91.0 89.0 90.0 88.0 92.0 87.0 91.0 90.0 98.0 115.0 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:110.30 Median:92.00 stddev:24.95 (27.1%) stddev-sans-first:25.36 22:26:10 INFO - PROCESS | 1670 | Values: 90.0 91.0 152.0 93.0 153.0 99.0 97.0 97.0 130.0 101.0 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:103.70 Median:77.50 stddev:29.88 (38.6%) stddev-sans-first:31.00 22:26:10 INFO - PROCESS | 1670 | Values: 86.0 98.0 83.0 75.0 78.0 137.0 77.0 107.0 145.0 151.0 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:60.00 stddev:2.70 (4.5%) stddev-sans-first:2.40 22:26:10 INFO - PROCESS | 1670 | Values: 54.0 56.0 54.0 57.0 60.0 60.0 60.0 60.0 60.0 61.0 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:72.00 stddev:6.10 (8.5%) stddev-sans-first:6.38 22:26:10 INFO - PROCESS | 1670 | Values: 69.0 75.0 69.0 87.0 74.0 73.0 67.0 66.0 68.0 71.0 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:86.00 stddev:2.55 (3.0%) stddev-sans-first:2.65 22:26:10 INFO - PROCESS | 1670 | Values: 84.0 82.0 87.0 88.0 82.0 85.0 86.0 86.0 84.0 90.0 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:150.50 stddev:19.73 (13.1%) stddev-sans-first:20.93 22:26:10 INFO - PROCESS | 1670 | Values: 150.0 154.0 151.0 134.0 137.0 129.0 134.0 157.0 198.0 145.0 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:170.00 stddev:16.01 (9.4%) stddev-sans-first:2.65 22:26:10 INFO - PROCESS | 1670 | Values: 218.0 172.0 164.0 170.0 170.0 167.0 165.0 170.0 167.0 167.0 22:26:10 INFO - PROCESS | 1670 | 22:26:10 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:70.00 stddev:8.81 (12.6%) stddev-sans-first:9.29 22:26:10 INFO - PROCESS | 1670 | Values: 71.0 87.0 91.0 79.0 68.0 67.0 68.0 69.0 68.0 69.0 22:26:10 INFO - PROCESS | 1670 | -------- Summary: end -------- 22:26:10 INFO - PROCESS | 1670 | 22:26:11 INFO - TEST-INFO | 1670: exit 0 22:26:11 INFO - TEST-OK | kraken | took 60195ms 22:26:11 INFO - SUITE-END | took 1173s 22:26:11 INFO - Completed test suite (00:19:34) 22:26:11 INFO - javascript benchmark 22:26:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7407.929095261453, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3455.2053027803604, 3478.0261526772497, 3503.5795704515444, 3509.7894126352435, 3512.174638959844, 5016.4231113421965, 5680.204771332012, 5976.641401515907, 6138.938610613893, 6139.0, 6085.604435711675, 6147.569670123094, 6154.415330543602, 6168.784092556762, 6189.288231853327, 5439.619226654136, 5474.945250547484, 5491.780328786844, 5529.225908372831, 5644.717764111799, 5558.805441809537, 5575.163725441196, 5577.69322687252, 5577.860553486175, 5578.609497335168, 5325.094733895247, 5351.17056856186, 5552.11166213406, 5556.555475561945, 5577.163425486169, 5454.127339625661, 5473.972630136844, 5480.506754392084, 5488.396276409591, 5526.253955716007, 5345.679259244419, 5427.782888684448, 5508.14623733322, 5529.253550770634, 5547.916781248285, 4334.829596009092, 5862.973979553561, 6099.756009759604, 6172.814815555541, 6188.257409110891, 5882.499987501067, 6203.782867599657, 6245.656488893109, 6277.654728989904, 6312.905306420407, 6407.615543067384, 6418.165638467016, 6484.773032943825, 6499.8700025999215, 6499.93500064998, 5941.049432090931, 6176.4749996250375, 6189.87620247597, 6212.9068063979075, 6228.688565571703, 5624.521915637135, 6038.731866308124, 6379.904301435482, 6385.457236134887, 6482.027695845661, 5910.586258961831, 6315.5894866833505, 6358.109864618957, 6363.204599425072, 6377.298497165308, 6244.500439964792, 6449.5485316027425, 6470.09418681385, 6475.7733479328, 6498.707558159894, 5561.4427960171215, 6134.650895842745, 6278.560500764903, 6316.273628532777, 6360.1731774869895, 5091.41448733393, 6311.400416960381, 6313.9368606314265, 6346.17499725042, 6357.8728425432155, 5080.085584594734, 5110.66780659256, 5116.897662046813, 5147.613928955343, 5153.639245252796, 4011.859584914514, 4507.053518761031, 4507.211238033331, 4535.659825513034, 4620.214563524209, 6121.387861213843, 6134.78528251509, 6203.131561581382, 6208.00671892504, 6228.34602366754, 6426.389492998158, 6442.774502892376, 6461.64460954652, 6466.6766661666725, 6477.805665830033, 5893.557983151195, 6096.908546371808, 6106.612350340322, 6124.228368151176, 6144.3717414885095, 5547.140193270049, 5604.8038318658655, 5609.186667933127, 5613.129964855454, 5613.214150019001, 6557.9344206557325, 6586.604803711793, 6624.238212605515, 6626.171728533934, 6629.7679581214425, 6275.623462592259, 6276.278228003838, 6299.401556852092, 6316.715747791269, 6436.645984470899, 5313.973430132824, 6494.740210391531, 6501.057346684799, 6505.31694172124, 6548.47612191014, 6346.301906790157, 6353.205849268841, 6353.555251132561, 6392.68036598159, 6396.976483762575, 6284.622922624657, 6287.0, 6303.873922521616, 6350.110984462087, 6359.777407790705, 6134.650895842656, 6177.413145751147, 6325.525585581192, 6327.810165695037, 6343.175387199634, 6281.59169653971, 6312.3056463788025, 6318.894193516025, 6325.082862984749, 6339.587926784744, 6049.122877182872, 6088.269407671108, 6112.47308512798, 6161.229846269216, 6208.720607572761, 5967.373425790403, 6288.27684816252, 6311.958526843019, 6344.555881088279, 6346.841328966812, 6249.78125765596, 6258.499320054294, 6310.5267104968225, 6311.715972781144, 6342.778002769881], "value": 5886.328344342126, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.56643356643355, 488.9658372542075, 514.3005512502996, 518.2537146509029, 539.8866238090001, 38823.22353552931, 40706.59293407065, 40811.0, 40811.59188408119, 40815.387769183486, 33807.492887606706, 35723.64276357236, 43174.35238471426, 43583.78208108955, 44197.116057678824, 9750.658726944559, 9805.607775688999, 9911.306208565404, 9921.305508614363, 9924.801503969917, 8242.29940455062, 9641.758956026086, 9775.217982561378, 9778.217742580577, 9801.509924503745, 9755.41467511948, 9773.657921972732, 9792.020797920186, 9804.362716423446, 9843.753906152331, 9746.853797193047, 9777.706668799947, 9782.364146330467, 9784.0, 9802.509874506246, 9752.317337786288, 9810.21518278536, 9825.852612210823, 9884.604615815359, 9924.851127233098, 40029.39955900664, 40038.19923601541, 40269.0, 40464.79767601172, 40521.392179117334, 3151.952720709191, 3154.1846711404132, 3473.913152171216, 3555.6799888010205, 3950.920981580381, 30008.699913001026, 30445.69554304451, 30824.53763193554, 31255.84372078125, 31585.0, 3222.323312104461, 3273.3780581689402, 3318.4026875162463, 3327.035159803654, 3369.359821633882, 515017.9999999963, 515627.42186289205, 516016.419917898, 519723.0, 520568.0, 33072.1731956703, 45957.080858382644, 50943.74528127335, 57751.711241443525, 58076.8384632305, 33347.83326083403, 33537.99386018424, 33751.987440376826, 33776.83111584427, 33870.830645847105, 15090.54728358151, 15194.772078418833, 15209.467668631765, 15246.313915873812, 15250.0, 12711.55509557161, 12850.55023074188, 13019.349032548334, 13020.0, 13046.217226966412, 7533.7363192288, 7689.807754806175, 7692.076950765944, 7713.575753333508, 7739.92260077392, 3191.7446604271604, 3240.22234663679, 3249.821259830732, 3255.300110476259, 3288.6546912573835, 945.9952700236455, 947.6920000999703, 962.4898803634085, 1019.3883669798062, 1052.8526006359116, 23409.595424274597, 30494.08517744471, 30586.38827223443, 30594.235144121576, 30826.53760193599, 1069.059227879461, 1072.9624463143753, 1103.6799328194895, 1109.2457129152253, 1143.0512674480162, 13587.0, 16414.276500967466, 16569.0, 16608.25262863174, 16961.236744346286, 681763.0, 727026.0, 739570.0, 742529.0, 742963.0, 57367.13949290764, 57926.13110803341, 58045.70977145087, 58097.0, 58266.12600810991, 1366.2511984659652, 1366.5422083602105, 1398.3707331700775, 1399.307342865288, 1404.7401230772543, 30450.390992180477, 30954.0, 31514.0, 31942.52086218755, 32234.0, 48713.0, 54200.915981679354, 55862.72068639631, 55928.0, 59612.70193649177, 583690.0, 585145.0, 591819.0, 592097.0, 592326.0, 43013.053498846784, 43145.784271078446, 43181.784091079346, 43253.13493730171, 43738.56261437345, 42819.785901070296, 44642.10715785731, 47624.761876190394, 47666.28500572564, 48145.277820832016, 37943.05142371352, 39022.0, 39197.74841654303, 39837.203255935296, 40222.59777402189, 31132.0, 32884.83557582197, 39597.80201098976, 40161.598384015786, 40346.79826600848, 38056.0, 38419.80790096144, 38782.61217387903, 39030.024249393995, 39233.60766392414, 27436.0, 32907.341853163285, 35009.64990350064, 35107.0, 35143.75724758432, 18927.810721892605, 20735.377938661863, 25959.351016224744, 26196.345091372867, 26539.0], "value": 19014.837861412863, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.96234393075105, 376.68358578793806, 382.852601748327, 385.6066811851913, 402.6155021954034, 18021.909890450563, 18142.002189879553, 19244.556658250636, 20596.8970155149, 20764.065617047232, 20009.299674511396, 20581.794182058176, 21063.47341316468, 21231.68152477714, 21390.786092139075, 4836.274558816171, 5861.062230043204, 5958.940410595904, 6013.579049466539, 6121.051237058241, 5901.911471327933, 5981.910271345933, 5999.760009599632, 6006.7897623583185, 6009.4591486766185, 5723.685197314146, 5914.0, 5939.584229103964, 5941.168236446901, 6000.429959153874, 5915.852103697421, 5938.317093534256, 5944.286685597756, 5963.403659634046, 5971.193888825018, 4973.950260497385, 5106.795728170906, 5162.328897243372, 5197.246399272084, 5205.453427390107, 25676.743232567624, 25786.35534111662, 25934.74065259342, 26066.478670426484, 26266.080687176047, 2308.319045881469, 2443.963340549893, 2773.9736297569825, 3145.4207549809166, 3195.6484786673445, 15300.0, 15476.845231547766, 15650.217489125498, 15776.132312722795, 16224.918875405665, 1855.9814401856079, 1875.6717574424422, 1941.8155275248828, 1950.980490195094, 1958.2362878477404, 94860.10279794435, 117464.41267793607, 123518.61888589968, 125439.37280313631, 126873.0, 10869.347839129678, 10893.074088702391, 11395.259308144945, 11405.258658187191, 11561.826572601418, 13715.382807773674, 14077.859221407654, 14079.929600352138, 14089.929550352183, 14102.576922692335, 8643.049264580892, 8847.778805529913, 8900.599473023729, 8984.416012959136, 9076.228520575693, 9054.139856713733, 9068.8639670405, 9074.727758167266, 9200.723978280663, 9221.400608960395, 6740.359665831738, 6790.796276111724, 6840.144981877265, 6861.897071543931, 6863.622500762506, 1830.4874635102192, 1869.691500902363, 1873.147717788403, 1874.4845167578753, 1874.7656542932134, 895.6641259527677, 970.9563069661741, 979.4906648542718, 1020.3316827478013, 1055.519738518972, 22037.449063773212, 22548.88725556362, 22555.323340299816, 22615.208467703553, 22622.886885565465, 970.2529052629436, 975.5366201054584, 984.6701355045997, 990.7325022243954, 1003.9046290602381, 9619.759506012406, 9849.803003939882, 11362.886371136183, 11760.235584686969, 12002.879971200351, 631650.0, 637953.0, 643360.0, 646714.0, 646892.0, 88021.55989220012, 104851.4757426208, 106395.0, 118216.0, 123937.0, 968.5109019945023, 995.0745806400117, 1013.6300250408548, 1016.4714348538866, 1017.6794309792392, 18626.534336641693, 19317.51706207356, 19412.514687132934, 19487.317943871898, 19563.706544402132, 37998.810005949796, 49272.260916087005, 53048.73475632597, 53869.46130538801, 54249.0, 80167.1983280183, 80942.59528702318, 82703.5864820672, 84863.5756821212, 85126.0, 7826.647800848861, 7929.246721561442, 8050.832629268841, 8066.717664881936, 8231.300339471212, 8947.97098333674, 11887.28676279426, 12758.0, 12805.71942805712, 13022.674433139247, 10885.945570272099, 11122.666320010412, 11214.046806021579, 11297.209195356247, 11303.943480282875, 10573.2598718089, 10731.248812583357, 11167.944160279147, 11177.273477223955, 11357.943210284226, 11120.277181983145, 11209.663710088384, 11338.659840204808, 11467.139964502863, 11533.0, 7904.44823618104, 7932.104781754733, 8090.514569125636, 8149.225823546753, 8236.50580965144, 10835.241533092609, 10929.781404372026, 10960.506777195205, 11204.775904482029, 11341.829872551752], "value": 9868.583722608944, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.6789972256242, 1513.0, 1701.3364787732787, 1832.7800663920332, 1835.13748538187, 8211.589420528964, 8488.363372747037, 8750.0, 9310.581023853925, 9333.066693330673, 8711.782205444852, 9045.366824322284, 9067.455952642846, 9135.725928222148, 9139.588718507666, 2372.95254094918, 2376.180217824852, 2408.3256688127353, 2409.6024156014237, 2417.830751847371, 1959.980400195994, 2380.2026321182425, 2394.4971555973266, 2418.9758102418928, 2423.4062654649633, 2386.152915714922, 2397.3407312988893, 2398.2325655790155, 2407.4462873539096, 2420.6732091167733, 2379.892904819287, 2380.2264264114146, 2380.9166679166233, 2397.3766820626674, 2407.518496300747, 2380.51199504103, 2382.4520360317224, 2392.174699728591, 2392.9710224603414, 2398.280515845257, 9091.590878410487, 9147.2682185425, 9231.538423078819, 9235.353525253235, 9248.953755231249, 5338.27933229013, 5483.424240454735, 5485.122380419114, 5501.312335958005, 5528.55771538276, 3639.94540081899, 3678.8896333109783, 3713.0, 3732.794696291703, 3739.1773809761808, 923.4597760310227, 992.270681049428, 1095.8630171228597, 1095.9671209863716, 1108.501174471483, 12029.93985030078, 12068.818967715491, 12135.93932030343, 12209.755804883853, 12231.510739570407, 4463.464384273908, 4557.817687292538, 4694.319323698045, 4702.9764851176205, 4706.670533062653, 9317.860232096524, 9475.763105922408, 9486.762830929281, 9491.050894910453, 9492.477913714674, 5274.446183150791, 5315.468453154731, 5353.946460535422, 5368.624196306299, 5370.167624018283, 4178.791060447026, 4467.530909254547, 4609.861704148881, 4819.180739274261, 5018.698878067327, 3821.5796262411113, 3863.4204869269834, 3953.584873588232, 3958.5447673517338, 3980.104476492766, 1011.2213595531547, 1196.4735516372768, 1199.0467578275293, 1213.5570516761318, 1216.9817452738216, 804.0150815251387, 811.3144392987916, 870.4951128345544, 905.4612505559181, 923.0031565908803, 5828.562857785599, 5858.355580886185, 5887.558433117448, 5969.52243820502, 6006.609570377911, 434.30511182108376, 437.87082810570956, 446.47985097361857, 447.7492604141691, 449.9212637788374, 3809.42858571211, 3824.2733880562605, 4009.4587230723478, 4108.281050816096, 4139.234241665241, 10179.745506362253, 10880.347179169117, 10883.727906802393, 11040.723981900517, 11048.116150707923, 9367.484788336707, 10675.626353077605, 10791.136709063256, 11008.284461509977, 11013.394263315435, 6851.45188384928, 8443.113473085361, 8451.577421128919, 8472.279856212168, 8504.362172837062, 4847.733374664286, 5698.886022279614, 5867.911981320198, 5894.174815525744, 5948.464638182584, 10083.697489075339, 10106.494675266355, 10225.693229203136, 10305.793884122426, 10388.636397726346, 8921.330900182382, 9253.444793312423, 9276.2578993679, 9402.95298523503, 10288.176945844165, 5910.320313163869, 7327.926720732938, 7445.590492522963, 7615.771526854203, 7797.259260370256, 7908.406869484927, 8460.661573536989, 8621.956890215508, 8633.179847914438, 8647.783805404915, 7565.43259255547, 7661.344625836107, 7717.459777815499, 7808.141104478616, 7850.842983140191, 7243.710251589878, 7428.665710042953, 7439.404847612286, 7487.663055162422, 7497.512661676974, 7052.929470705228, 7071.398931090915, 7185.856282874418, 7232.963835180791, 7239.746608868664, 4935.210366341368, 4964.851054468371, 5017.8243761468175, 5083.0, 5098.209777484496, 5055.34280543527, 5113.386393632639, 5136.357955255593, 5156.690598564098, 5187.429382767968], "value": 4505.979071006239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.80598014280787, 302.38313839766874, 310.0203357390646, 310.84923811951205, 315.30160694062647, 4762.976185119078, 5481.780728770845, 5578.665280083188, 5670.8582285442835, 5709.000924838152, 4481.910361792762, 5245.921311180336, 5465.6447330923465, 5592.496675299222, 5670.716464176795, 3994.9800250998705, 4258.425112609804, 4282.764447955361, 4294.849680261192, 4308.9353659695125, 3682.8342724577324, 4132.442120313749, 4237.406763053175, 4280.785960701968, 4307.870763877073, 3932.3315036443732, 4210.894727631803, 4235.2800023996, 4253.617174454299, 4260.2532961485795, 3796.0320118369914, 4023.3964905264297, 4053.047533829548, 4270.615644591986, 4279.358096285551, 3080.0451859923496, 3238.5627940228005, 3692.335379631665, 3711.2577484502935, 3731.776093434403, 4707.952920470786, 5081.974590127025, 5447.918281225785, 5513.8345849624575, 5528.51216952369, 4262.911173524982, 4842.44311904132, 4891.046245982035, 4924.513120873971, 4933.777979990909, 4914.975425122887, 5672.4894759471845, 5919.052951527735, 5956.808638272363, 5977.970110149465, 3506.2293541761246, 4042.3734321180264, 4049.797510124482, 4062.329715596923, 4068.7355321903983, 5283.815066472694, 6246.750129994794, 6287.591306565105, 6333.24001119864, 6342.334054924213, 3603.0, 4081.6122468365456, 4093.7748423836974, 4133.793310334531, 4135.31767258405, 3827.3110840048503, 4048.149888523384, 4110.362893751473, 4113.794310284474, 4119.814608342632, 4058.918821623551, 4856.271559266138, 4859.441164266084, 4875.24433712775, 4880.365552478226, 5941.288646042229, 6032.517398608101, 6059.787907423219, 6062.787802426894, 6078.593020060509, 1063.3460421840512, 1203.9699007524882, 1281.423359488234, 1292.5411478924846, 1374.216696482995, 648.45205801098, 788.5268838696736, 816.6814942172557, 847.4533925618065, 856.8090354407378, 4430.183624713852, 4460.8661740147845, 4792.976035119802, 4795.880102997383, 4836.637252206098, 4385.798367191967, 4857.489963553847, 5210.426853046162, 5263.842084737464, 5269.36413874433, 4326.480822301344, 4388.166248412791, 4460.687751857339, 4678.485366609671, 4751.954569994596, 2630.368711509262, 2773.1957732257824, 2959.985200074029, 3262.771605987558, 3274.9345013100083, 5716.828495145152, 6068.029115341524, 6428.19647544057, 6454.290028096905, 6473.935260647428, 5306.655067420683, 5582.134769110794, 6230.875382492415, 6400.775972840928, 6430.839229019219, 5995.760169593254, 6093.573449858467, 6470.45001174896, 6486.124373209556, 6554.3614096475885, 5350.705711185922, 5894.526368407898, 6275.215598050244, 6321.5574909757715, 6329.050642403677, 4918.508149185053, 5854.94145058561, 6107.816765497042, 6148.1085242640465, 6189.5048396129105, 5243.501867322599, 6510.414062734188, 6517.4134327910715, 6529.388244702157, 6549.836254093686, 3300.752443566694, 3908.69387061635, 3918.451416801707, 4053.7973101344223, 4058.228936502055, 5643.379228284967, 5777.075667893117, 6203.96898015507, 6271.777003484277, 6305.306416294112, 5271.258945348321, 5338.332708411449, 5827.854303642443, 6024.0, 6175.62946223228, 4863.8569936065705, 5043.344365232496, 5972.820815375546, 5991.741734235859, 6036.788712395045, 5211.348581427322, 5958.225430693982, 5983.311919129356, 5986.341502434641, 5986.964432093109, 5739.397363276796, 5930.0, 6001.309849367204, 6032.819015429544, 6033.9698301508215, 5010.223415370623, 5313.946860531345, 5970.940290597038, 5971.373005834324, 5989.286642281813], "value": 4226.367170150524, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.6776281266399, 722.2777222777223, 786.90557133144, 818.3821214982695, 831.6631764135524, 15511.224438778057, 15801.972871763328, 15819.288132034057, 15828.841711582882, 15881.602959926007, 11229.831552526719, 13419.798703019462, 13599.93200034001, 13615.931920340385, 13653.863461365383, 653.6111013946718, 671.5299290496647, 816.7713040348712, 823.625250511016, 841.2260720137489, 850.5237067242333, 854.0434713121282, 854.2781349759443, 854.6026097864523, 855.4610595324937, 905.8188362327561, 910.5765818894213, 914.9085091490864, 915.9404638698496, 917.3624331089895, 892.1569117184264, 905.6015353244551, 909.822584596004, 910.2626872233479, 912.1471424218344, 673.3804899492429, 675.999520709348, 678.3081257117761, 678.4301187002941, 683.8119517132778, 14724.779128313085, 14742.852571474255, 14743.631409214748, 14758.55724328272, 14806.481773137995, 13034.608961731163, 13550.86449135506, 14470.0, 14476.493322733653, 14776.408943642242, 11343.035841953444, 11535.365554894477, 11576.942115289454, 11987.280763154238, 12166.936111610112, 3782.5460944686815, 3869.9613003870163, 3914.178022615254, 4011.3982902564558, 4019.517657881073, 109446.0, 121874.0, 133943.0, 135264.32367838098, 136887.0, 10812.297200682087, 10992.835107473395, 11007.284526505751, 11323.43382830855, 11327.603533876274, 23010.884945575166, 23015.53968920612, 23032.7696723034, 23049.42376440569, 23075.96158172886, 7790.493617914817, 7952.761417157494, 8137.064237612751, 8180.018397792184, 8304.460210086325, 4450.777461126931, 4468.821247150077, 4548.249538826123, 4557.635389168859, 4584.358189853423, 3614.855405783792, 3732.458793474931, 3739.420389839579, 3746.8875933722034, 3747.3254814133174, 597.7071235094772, 649.870025994803, 658.2463079773632, 660.0956689335641, 660.4122331125302, 579.0792639702809, 580.924479817621, 606.7330374635146, 656.9441597464269, 712.7754757251449, 7911.881321780178, 8178.877316840252, 8722.389432739774, 9154.313426492907, 9465.810683786423, 658.4337469775988, 668.5688571527437, 671.7783131566571, 678.4707927816311, 685.6160550091964, 4328.744664047454, 4704.600108990706, 4738.786754596052, 4741.810327586858, 4801.969631537939, 158319.0, 166076.0, 168178.1591092061, 168882.0, 169644.15177924032, 80928.0, 83840.16159838445, 87796.24407511814, 104946.0, 130872.0, 85969.0, 110547.34178987322, 112354.0, 114484.0, 115344.0, 8860.424072435271, 9842.901570984199, 10012.69961901144, 10167.389956602627, 10173.542190601589, 50923.490765091876, 51332.74333628308, 64911.0, 64935.35064649293, 67512.6624366875, 57367.0, 100660.0, 101156.0, 103709.0, 106514.80455586345, 12569.120161588968, 12785.48858045705, 13278.797963393208, 13429.127106738031, 13474.461021559027, 12320.507179712711, 14374.568762937128, 15081.622959425664, 15733.292001860173, 15751.527454176394, 13477.46090156422, 14101.506447274296, 14455.710885782435, 14633.707325853211, 14641.194734289717, 13803.378847951666, 13805.24071176095, 13811.51659691906, 14006.369713363127, 14148.78776818328, 13265.933670331586, 13279.0, 13389.598312050264, 13425.328733563087, 13496.190228586316, 10666.306690065121, 10976.176786740867, 11188.496517656888, 11444.084473242287, 11587.42062896835, 9632.32573719861, 11494.89581876678, 11676.88323116792, 11836.76326473483, 11882.16824822254], "value": 7855.779422954994, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 120.0, 118.0, 117.0, 119.0, 119.0, 119.0, 113.0, 119.0, 119.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 112.0, 111.0, 141.0, 110.0, 112.0, 112.0, 111.0, 138.0, 113.0], "value": 120.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 205.0, 195.0, 193.0, 198.0, 197.0, 198.0, 197.0, 197.0, 196.0], "value": 197.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 65.0, 83.0, 101.0, 60.0, 59.0, 59.0, 80.0, 105.0, 51.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 89.0, 73.0, 69.0, 71.0, 89.0, 70.0, 70.0, 85.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 90.0, 88.0, 92.0, 87.0, 91.0, 90.0, 98.0, 115.0], "value": 93.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 152.0, 93.0, 153.0, 99.0, 97.0, 97.0, 130.0, 101.0], "value": 110.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 98.0, 83.0, 75.0, 78.0, 137.0, 77.0, 107.0, 145.0, 151.0], "value": 103.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 57.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 69.0, 87.0, 74.0, 73.0, 67.0, 66.0, 68.0, 71.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 87.0, 88.0, 82.0, 85.0, 86.0, 86.0, 84.0, 90.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 154.0, 151.0, 134.0, 137.0, 129.0, 134.0, 157.0, 198.0, 145.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [218.0, 172.0, 164.0, 170.0, 170.0, 167.0, 165.0, 170.0, 167.0, 167.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 87.0, 91.0, 79.0, 68.0, 67.0, 68.0, 69.0, 68.0, 69.0], "value": 73.7, "unit": "score"}]}]} 22:26:11 INFO - Return code: 0 22:26:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:26:11 ERROR - # TBPL SUCCESS # 22:26:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:26:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:26:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:26:11 INFO - 2016-09-19 22:26:11.938 screenresolution[1675:11005] starting screenresolution argv=screenresolution get 22:26:11 INFO - 2016-09-19 22:26:11.940 screenresolution[1675:11005] Display 0: 1600x1200x32@60 22:26:11 INFO - 2016-09-19 22:26:11.946 screenresolution[1676:11008] starting screenresolution argv=screenresolution list 22:26:11 INFO - Available Modes on Display 0 22:26:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:26:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:26:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:26:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:26:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:26:12 INFO - Intel Iris: 22:26:12 INFO - Chipset Model: Intel Iris 22:26:12 INFO - Type: GPU 22:26:12 INFO - Bus: Built-In 22:26:12 INFO - VRAM (Dynamic, Max): 1536 MB 22:26:12 INFO - Vendor: Intel (0x8086) 22:26:12 INFO - Device ID: 0x0a2e 22:26:12 INFO - Revision ID: 0x0009 22:26:12 INFO - Displays: 22:26:12 INFO - Display: 22:26:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:26:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:26:12 INFO - Display Serial Number: 1600x1200 60 22:26:12 INFO - Main Display: Yes 22:26:12 INFO - Mirror: Off 22:26:12 INFO - Online: Yes 22:26:12 INFO - Rotation: Supported 22:26:12 INFO - Return code: 0 22:26:12 INFO - Running post-action listener: _resource_record_post_action 22:26:12 INFO - [mozharness: 2016-09-20 05:26:12.187168Z] Finished run-tests step (success) 22:26:12 INFO - Running post-run listener: _resource_record_post_run 22:26:12 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 32197632; Write bytes: 666027008; Read time: 321; Write time: 2023 22:26:12 INFO - TinderboxPrint: CPU usage
54.3% 22:26:12 INFO - TinderboxPrint: I/O read bytes / time
32,197,632 / 321 22:26:12 INFO - TinderboxPrint: I/O write bytes / time
666,027,008 / 2,023 22:26:12 INFO - TinderboxPrint: CPU idle
2,208.8 (45.7%) 22:26:12 INFO - TinderboxPrint: CPU system
976.0 (20.2%) 22:26:12 INFO - TinderboxPrint: CPU user
1,644.9 (34.1%) 22:26:12 INFO - TinderboxPrint: Swap in / out
391,049,216 / 0 22:26:12 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 354869760; Write bytes: 356083200; Read time: 27457; Write time: 656 22:26:12 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 31230976; Write bytes: 299765248; Read time: 307; Write time: 1331 22:26:12 INFO - Running post-run listener: _upload_blobber_files 22:26:12 INFO - Blob upload gear active. 22:26:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:26:12 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 22:26:12 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'] 22:26:12 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 22:26:13 INFO - (blobuploader) - INFO - Open directory for files ... 22:26:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:26:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:26:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:26:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:14 INFO - (blobuploader) - INFO - Done attempting. 22:26:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:26:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:26:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:26:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:15 INFO - (blobuploader) - INFO - Done attempting. 22:26:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:26:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:26:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:26:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:26:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:26:17 INFO - (blobuploader) - INFO - Done attempting. 22:26:17 INFO - (blobuploader) - INFO - Iteration through files over. 22:26:17 INFO - Return code: 0 22:26:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:26:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:26:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/989df521179c9c7bce865765a78ded9c7b47ba6a51c6b08b8e195dcbe30856f182108b6dfaea3555353f6cde475c74a59c4ecd5039b1232f1deedd61b4566c87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26e4d2876f216538a6513f294bc4af35f738ab43e12f5988c82110203aa2fad6a0fce1413e61e51084798f4031515adee2ccf34184df910848addb6da4004f99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca222ebbea84edccca4df03c6486ea66c1dffbe0e0db5fb346fc14dbfb0c5a17512646a454f0f4c77de565a4d2fa34f5ec246193b129d1747ee2302e11b3bbca"} 22:26:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:26:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:26:17 INFO - Contents: 22:26:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/989df521179c9c7bce865765a78ded9c7b47ba6a51c6b08b8e195dcbe30856f182108b6dfaea3555353f6cde475c74a59c4ecd5039b1232f1deedd61b4566c87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26e4d2876f216538a6513f294bc4af35f738ab43e12f5988c82110203aa2fad6a0fce1413e61e51084798f4031515adee2ccf34184df910848addb6da4004f99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca222ebbea84edccca4df03c6486ea66c1dffbe0e0db5fb346fc14dbfb0c5a17512646a454f0f4c77de565a4d2fa34f5ec246193b129d1747ee2302e11b3bbca"} 22:26:17 INFO - Running post-run listener: copy_logs_to_upload_dir 22:26:17 INFO - Copying logs to upload dir... 22:26:17 INFO - mkdir: /builds/slave/test/build/upload/logs 22:26:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.218345 ========= master_lag: 1.75 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-19 22:26:19.487623) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 22:26:19.490666) ========= 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.5G7U7JelgP/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.7SnijmIKmx/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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/989df521179c9c7bce865765a78ded9c7b47ba6a51c6b08b8e195dcbe30856f182108b6dfaea3555353f6cde475c74a59c4ecd5039b1232f1deedd61b4566c87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26e4d2876f216538a6513f294bc4af35f738ab43e12f5988c82110203aa2fad6a0fce1413e61e51084798f4031515adee2ccf34184df910848addb6da4004f99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca222ebbea84edccca4df03c6486ea66c1dffbe0e0db5fb346fc14dbfb0c5a17512646a454f0f4c77de565a4d2fa34f5ec246193b129d1747ee2302e11b3bbca"} build_url:https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/A37W180iQayqlWe-tTDf_g/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/989df521179c9c7bce865765a78ded9c7b47ba6a51c6b08b8e195dcbe30856f182108b6dfaea3555353f6cde475c74a59c4ecd5039b1232f1deedd61b4566c87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26e4d2876f216538a6513f294bc4af35f738ab43e12f5988c82110203aa2fad6a0fce1413e61e51084798f4031515adee2ccf34184df910848addb6da4004f99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca222ebbea84edccca4df03c6486ea66c1dffbe0e0db5fb346fc14dbfb0c5a17512646a454f0f4c77de565a4d2fa34f5ec246193b129d1747ee2302e11b3bbca"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 22:26:19.528992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 22:26:19.529321) ========= 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.5G7U7JelgP/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.7SnijmIKmx/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.005221 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 22:26:19.582866) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 22:26:19.583149) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 22:26:19.583468) ========= ========= Total master_lag: 4.58 =========