builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0204 starttime: 1478663210.65 results: success (0) buildid: 20161108173621 builduid: 083c302c289d4fffa60edb78cf695dbd revision: ae3b6bfb810476141647ad681b796ed118062412 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:50.653183) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:50.653634) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:50.653904) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:50.676495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:50.676763) ========= 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.PQUIaNdmp8/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.0ObP0UycqR/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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-11-08 19:46:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-11-08 19:46:50 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093070 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:50.791225) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:50.791579) ========= 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.PQUIaNdmp8/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.0ObP0UycqR/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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.019913 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:50.839780) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-08 19:46:50.840091) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ae3b6bfb810476141647ad681b796ed118062412 --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 ae3b6bfb810476141647ad681b796ed118062412 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PQUIaNdmp8/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.0ObP0UycqR/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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-11-08 19:46:50,909 truncating revision to first 12 chars 2016-11-08 19:46:50,910 Setting DEBUG logging. 2016-11-08 19:46:50,910 attempt 1/10 2016-11-08 19:46:50,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ae3b6bfb8104?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-08 19:46:53,187 unpacking tar archive at: mozilla-aurora-ae3b6bfb8104/testing/mozharness/ program finished with exit code 0 elapsedTime=2.537580 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-08 19:46:53.399434) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:53.399756) ========= script_repo_revision: ae3b6bfb810476141647ad681b796ed118062412 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:53.400142) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:53.400466) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 19:46:53.418631) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-08 19:46:53.418933) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PQUIaNdmp8/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.0ObP0UycqR/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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 19:46:53 INFO - MultiFileLogger online at 20161108 19:46:53 in /builds/slave/test 19:46:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:46:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:46:53 INFO - {'append_to_log': False, 19:46:53 INFO - 'base_work_dir': '/builds/slave/test', 19:46:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:46:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:46:53 INFO - 'branch': 'Mozilla-Aurora', 19:46:53 INFO - 'buildbot_json_path': 'buildprops.json', 19:46:53 INFO - 'config_files': ('talos/mac_config.py',), 19:46:53 INFO - 'default_actions': ('clobber', 19:46:53 INFO - 'read-buildbot-config', 19:46:53 INFO - 'download-and-extract', 19:46:53 INFO - 'populate-webroot', 19:46:53 INFO - 'create-virtualenv', 19:46:53 INFO - 'install', 19:46:53 INFO - 'run-tests'), 19:46:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:46:53 INFO - 'download_minidump_stackwalk': True, 19:46:53 INFO - 'download_symbols': 'ondemand', 19:46:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:46:53 INFO - 'tooltool.py': '/tools/tooltool.py', 19:46:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:46:53 INFO - '/tools/misc-python/virtualenv.py')}, 19:46:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:46:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:46:53 INFO - 'installer_path': 'installer.exe', 19:46:53 INFO - 'log_level': 'info', 19:46:53 INFO - 'log_name': 'talos', 19:46:53 INFO - 'log_to_console': True, 19:46:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:46:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:46:53 INFO - 'opt_config_files': (), 19:46:53 INFO - 'pip_index': False, 19:46:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:46:53 INFO - 'cmd': ('bash', 19:46:53 INFO - '-c', 19:46:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:46:53 INFO - 'enabled': True, 19:46:53 INFO - 'halt_on_failure': False, 19:46:53 INFO - 'name': 'check_screen_resolution'},), 19:46:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:46:53 INFO - 'cmd': ('bash', 19:46:53 INFO - '-c', 19:46:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:46:53 INFO - 'enabled': True, 19:46:53 INFO - 'halt_on_failure': False, 19:46:53 INFO - 'name': 'check_screen_resolution'},), 19:46:53 INFO - 'run_cmd_checks_enabled': True, 19:46:53 INFO - 'sps_profile': False, 19:46:53 INFO - 'sps_profile_interval': 0, 19:46:53 INFO - 'suite': 'dromaeojs', 19:46:53 INFO - 'system_bits': '32', 19:46:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:46:53 INFO - 'title': 't-yosemite-r7-0204', 19:46:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:46:53 INFO - 'use_talos_json': True, 19:46:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:46:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:46:53 INFO - 'work_dir': 'build'} 19:46:53 INFO - [mozharness: 2016-11-09 03:46:53.613432Z] Running clobber step. 19:46:53 INFO - Running pre-action listener: _resource_record_pre_action 19:46:53 INFO - Running main action method: clobber 19:46:53 INFO - rmtree: /builds/slave/test/build 19:46:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:46:55 INFO - Running post-action listener: _resource_record_post_action 19:46:55 INFO - [mozharness: 2016-11-09 03:46:55.578591Z] Finished clobber step (success) 19:46:55 INFO - [mozharness: 2016-11-09 03:46:55.578713Z] Running read-buildbot-config step. 19:46:55 INFO - Running pre-action listener: _resource_record_pre_action 19:46:55 INFO - Running main action method: read_buildbot_config 19:46:55 INFO - Using buildbot properties: 19:46:55 INFO - { 19:46:55 INFO - "project": "", 19:46:55 INFO - "product": "firefox", 19:46:55 INFO - "script_repo_revision": "production", 19:46:55 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 19:46:55 INFO - "repository": "", 19:46:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 19:46:55 INFO - "buildid": "20161108173621", 19:46:55 INFO - "pgo_build": "False", 19:46:55 INFO - "basedir": "/builds/slave/test", 19:46:55 INFO - "buildnumber": 83, 19:46:55 INFO - "slavename": "t-yosemite-r7-0204", 19:46:55 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 19:46:55 INFO - "platform": "yosemite_r7", 19:46:55 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:46:55 INFO - "branch": "mozilla-aurora", 19:46:55 INFO - "repo_path": "releases/mozilla-aurora", 19:46:55 INFO - "revision": "ae3b6bfb810476141647ad681b796ed118062412", 19:46:55 INFO - "stage_platform": "macosx64", 19:46:55 INFO - "builduid": "083c302c289d4fffa60edb78cf695dbd", 19:46:55 INFO - "slavebuilddir": "test" 19:46:55 INFO - } 19:46:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 19:46:55 INFO - Running post-action listener: _resource_record_post_action 19:46:55 INFO - [mozharness: 2016-11-09 03:46:55.582004Z] Finished read-buildbot-config step (success) 19:46:55 INFO - [mozharness: 2016-11-09 03:46:55.582145Z] Running download-and-extract step. 19:46:55 INFO - Running pre-action listener: _resource_record_pre_action 19:46:55 INFO - Running main action method: download_and_extract 19:46:55 INFO - mkdir: /builds/slave/test/build/tests 19:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:46:55 INFO - trying https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 19:46:55 INFO - Downloading https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/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 19:46:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/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 19:46:57 INFO - Downloaded 1199 bytes. 19:46:57 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 19:46:57 INFO - Using the following test package requirements: 19:46:57 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:46:57 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:57 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 19:46:57 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:57 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 19:46:57 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:57 INFO - u'jsshell-mac.zip'], 19:46:57 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:57 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 19:46:57 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:46:57 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:57 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 19:46:57 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:57 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 19:46:57 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:57 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 19:46:57 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:46:57 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 19:46:57 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:46:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 19:46:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:46:57 INFO - Fetch https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:46:57 INFO - Expected file size: 16423395 19:47:04 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 19:47:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 19:47:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:47:04 INFO - Fetch https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:47:05 INFO - Expected file size: 16423395 19:47:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 19:47:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 19:47:11 INFO - Fetch https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 19:47:13 INFO - Expected file size: 14414089 19:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:13 INFO - trying https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:47:13 INFO - Downloading https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 19:47:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/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 19:47:16 INFO - Downloaded 115464056 bytes. 19:47:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:47:16 INFO - mkdir: /builds/slave/test/properties 19:47:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:47:16 INFO - Writing to file /builds/slave/test/properties/build_url 19:47:16 INFO - Contents: 19:47:16 INFO - build_url:https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:47:17 INFO - Running post-action listener: _resource_record_post_action 19:47:17 INFO - Running post-action listener: set_extra_try_arguments 19:47:17 INFO - [mozharness: 2016-11-09 03:47:17.397663Z] Finished download-and-extract step (success) 19:47:17 INFO - [mozharness: 2016-11-09 03:47:17.397764Z] Running populate-webroot step. 19:47:17 INFO - Running pre-action listener: _resource_record_pre_action 19:47:17 INFO - Running main action method: populate_webroot 19:47:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:47:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:47:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:47:17 INFO - '--tppagecycles', 19:47:17 INFO - '7'], 19:47:17 INFO - 'tests': ['tsvgm']}}, 19:47:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:47:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:47:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:47:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:47:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:47:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:47:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:17 INFO - 'talos_options': ['--disable-e10s'], 19:47:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:47:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:47:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:17 INFO - 'talos_options': ['--disable-e10s'], 19:47:17 INFO - 'tests': ['damp', 'tps']}, 19:47:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:17 INFO - 'tests': ['damp', 'tps']}, 19:47:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:47:17 INFO - 'tests': ['dromaeo_dom']}, 19:47:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:47:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:47:17 INFO - 'tests': ['basic_compositor_video']}, 19:47:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:47:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:47:17 INFO - 'tests': ['a11yr', 19:47:17 INFO - 'ts_paint', 19:47:17 INFO - 'tpaint', 19:47:17 INFO - 'sessionrestore', 19:47:17 INFO - 'sessionrestore_no_auto_restore', 19:47:17 INFO - 'tabpaint']}, 19:47:17 INFO - 'other-e10s': {'tests': ['a11yr', 19:47:17 INFO - 'ts_paint', 19:47:17 INFO - 'tpaint', 19:47:17 INFO - 'sessionrestore', 19:47:17 INFO - 'sessionrestore_no_auto_restore', 19:47:17 INFO - 'tabpaint']}, 19:47:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:47:17 INFO - 'ts_paint', 19:47:17 INFO - 'tpaint', 19:47:17 INFO - 'sessionrestore', 19:47:17 INFO - 'sessionrestore_no_auto_restore', 19:47:17 INFO - 'tabpaint']}, 19:47:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:47:17 INFO - 'ts_paint', 19:47:17 INFO - 'tpaint', 19:47:17 INFO - 'sessionrestore', 19:47:17 INFO - 'sessionrestore_no_auto_restore', 19:47:17 INFO - 'tabpaint']}, 19:47:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:47:17 INFO - 'tests': ['a11yr', 19:47:17 INFO - 'ts_paint', 19:47:17 INFO - 'tpaint', 19:47:17 INFO - 'sessionrestore', 19:47:17 INFO - 'sessionrestore_no_auto_restore', 19:47:17 INFO - 'tabpaint']}, 19:47:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:47:17 INFO - 'tests': ['a11yr', 19:47:17 INFO - 'ts_paint', 19:47:17 INFO - 'tpaint', 19:47:17 INFO - 'sessionrestore', 19:47:17 INFO - 'sessionrestore_no_auto_restore', 19:47:17 INFO - 'tabpaint']}, 19:47:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:47:17 INFO - 'tests': ['tsvgx', 19:47:17 INFO - 'tsvgr_opacity', 19:47:17 INFO - 'tart', 19:47:17 INFO - 'tscrollx', 19:47:17 INFO - 'cart']}, 19:47:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:47:17 INFO - 'tsvgr_opacity', 19:47:17 INFO - 'tart', 19:47:17 INFO - 'tscrollx', 19:47:17 INFO - 'cart']}, 19:47:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:17 INFO - 'talos_options': ['--disable-e10s'], 19:47:17 INFO - 'tests': ['tp5o']}, 19:47:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:17 INFO - 'tests': ['tp5o']}, 19:47:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:17 INFO - 'talos_options': ['--disable-e10s', 19:47:17 INFO - '--xperf_path', 19:47:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:47:17 INFO - 'tests': ['tp5n']}, 19:47:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:17 INFO - 'talos_options': ['--xperf_path', 19:47:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:47:17 INFO - 'tests': ['tp5n']}}, 19:47:17 INFO - 'talos.zip': {'path': '', 19:47:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:47:17 INFO - Running post-action listener: _resource_record_post_action 19:47:17 INFO - [mozharness: 2016-11-09 03:47:17.416394Z] Finished populate-webroot step (success) 19:47:17 INFO - [mozharness: 2016-11-09 03:47:17.416497Z] Running create-virtualenv step. 19:47:17 INFO - Running pre-action listener: _resource_record_pre_action 19:47:17 INFO - Running main action method: create_virtualenv 19:47:17 INFO - Creating virtualenv /builds/slave/test/build/venv 19:47:17 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 19:47:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:47:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:47:17 INFO - Using real prefix '/tools/python27' 19:47:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:47:18 INFO - Installing distribute.............................................................................................................................................................................................done. 19:47:21 INFO - Installing pip.................done. 19:47:21 INFO - Return code: 0 19:47:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107134490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3fadbeea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f48d30>, '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 0x106daedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f40b20>, '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.PQUIaNdmp8/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.0ObP0UycqR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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 19:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:47:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PQUIaNdmp8/Render', 19:47:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:21 INFO - 'HOME': '/Users/cltbld', 19:47:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:21 INFO - 'LOGNAME': 'cltbld', 19:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:21 INFO - 'MOZ_NO_REMOTE': '1', 19:47:21 INFO - 'NO_EM_RESTART': '1', 19:47:21 INFO - 'PAGER': '/bin/cat', 19:47:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:21 INFO - 'PWD': '/builds/slave/test', 19:47:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:21 INFO - 'SHELL': '/bin/bash', 19:47:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0ObP0UycqR/Listeners', 19:47:21 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 19:47:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:21 INFO - 'USER': 'cltbld', 19:47:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:21 INFO - 'XPC_FLAGS': '0x0', 19:47:21 INFO - 'XPC_SERVICE_NAME': '0', 19:47:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:21 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 19:47:21 INFO - Cleaning up... 19:47:21 INFO - Return code: 0 19:47:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107134490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3fadbeea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f48d30>, '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 0x106daedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f40b20>, '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.PQUIaNdmp8/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.0ObP0UycqR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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 19:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:47:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PQUIaNdmp8/Render', 19:47:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:21 INFO - 'HOME': '/Users/cltbld', 19:47:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:21 INFO - 'LOGNAME': 'cltbld', 19:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:21 INFO - 'MOZ_NO_REMOTE': '1', 19:47:21 INFO - 'NO_EM_RESTART': '1', 19:47:21 INFO - 'PAGER': '/bin/cat', 19:47:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:21 INFO - 'PWD': '/builds/slave/test', 19:47:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:21 INFO - 'SHELL': '/bin/bash', 19:47:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0ObP0UycqR/Listeners', 19:47:21 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 19:47:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:21 INFO - 'USER': 'cltbld', 19:47:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:21 INFO - 'XPC_FLAGS': '0x0', 19:47:21 INFO - 'XPC_SERVICE_NAME': '0', 19:47:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:21 INFO - Downloading/unpacking psutil>=3.1.1 19:47:21 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 19:47:21 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 19:47:21 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 19:47:21 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 19:47:21 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 19:47:21 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 19:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:47:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:47:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:47:24 INFO - Installing collected packages: psutil 19:47:24 INFO - Running setup.py install for psutil 19:47:24 INFO - building 'psutil._psutil_osx' extension 19:47:24 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 19:47:25 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 19:47:25 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 19:47:25 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 19:47:25 INFO - building 'psutil._psutil_posix' extension 19:47:25 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 19:47:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:47:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:47:25 INFO - ^ 19:47:25 INFO - 1 warning generated. 19:47:25 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 19:47:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:47:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:47:25 INFO - Successfully installed psutil 19:47:25 INFO - Cleaning up... 19:47:25 INFO - Return code: 0 19:47:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:47:25 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')]} 19:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:25 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')]} 19:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:25 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 0x107134490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3fadbeea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f48d30>, '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 0x106daedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f40b20>, '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.PQUIaNdmp8/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.0ObP0UycqR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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 19:47:25 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 19:47:25 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 19:47:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PQUIaNdmp8/Render', 19:47:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:25 INFO - 'HOME': '/Users/cltbld', 19:47:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:25 INFO - 'LOGNAME': 'cltbld', 19:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:25 INFO - 'MOZ_NO_REMOTE': '1', 19:47:25 INFO - 'NO_EM_RESTART': '1', 19:47:25 INFO - 'PAGER': '/bin/cat', 19:47:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:25 INFO - 'PWD': '/builds/slave/test', 19:47:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:25 INFO - 'SHELL': '/bin/bash', 19:47:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0ObP0UycqR/Listeners', 19:47:25 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 19:47:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:25 INFO - 'USER': 'cltbld', 19:47:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:25 INFO - 'XPC_FLAGS': '0x0', 19:47:25 INFO - 'XPC_SERVICE_NAME': '0', 19:47:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:47:26 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 19:47:26 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 19:47:26 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 19:47:26 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 19:47:26 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 19:47:26 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 19:47:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:47:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:47:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:47:28 INFO - Installing collected packages: mozsystemmonitor 19:47:28 INFO - Running setup.py install for mozsystemmonitor 19:47:28 INFO - Successfully installed mozsystemmonitor 19:47:28 INFO - Cleaning up... 19:47:28 INFO - Return code: 0 19:47:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107134490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3fadbeea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f48d30>, '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 0x106daedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f40b20>, '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.PQUIaNdmp8/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.0ObP0UycqR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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 19:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:47:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PQUIaNdmp8/Render', 19:47:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:28 INFO - 'HOME': '/Users/cltbld', 19:47:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:28 INFO - 'LOGNAME': 'cltbld', 19:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:28 INFO - 'MOZ_NO_REMOTE': '1', 19:47:28 INFO - 'NO_EM_RESTART': '1', 19:47:28 INFO - 'PAGER': '/bin/cat', 19:47:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:28 INFO - 'PWD': '/builds/slave/test', 19:47:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:28 INFO - 'SHELL': '/bin/bash', 19:47:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0ObP0UycqR/Listeners', 19:47:28 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 19:47:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:28 INFO - 'USER': 'cltbld', 19:47:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:28 INFO - 'XPC_FLAGS': '0x0', 19:47:28 INFO - 'XPC_SERVICE_NAME': '0', 19:47:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:29 INFO - Downloading/unpacking jsonschema==2.5.1 19:47:29 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 19:47:29 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 19:47:29 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 19:47:29 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 19:47:29 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 19:47:29 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 19:47:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:47:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:31 INFO - Downloading functools32-3.2.3-2.tar.gz 19:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:47:32 INFO - warning: no files found matching '*.txt' 19:47:32 INFO - no previously-included directories found matching 'build' 19:47:32 INFO - no previously-included directories found matching 'dist' 19:47:32 INFO - no previously-included directories found matching '.git*' 19:47:32 INFO - Installing collected packages: jsonschema, functools32 19:47:32 INFO - Running setup.py install for functools32 19:47:32 INFO - warning: no files found matching '*.txt' 19:47:32 INFO - no previously-included directories found matching 'build' 19:47:32 INFO - no previously-included directories found matching 'dist' 19:47:32 INFO - no previously-included directories found matching '.git*' 19:47:32 INFO - Successfully installed jsonschema functools32 19:47:32 INFO - Cleaning up... 19:47:32 INFO - Return code: 0 19:47:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:47:32 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')]} 19:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:32 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')]} 19:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:32 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 0x107134490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3fadbeea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f48d30>, '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 0x106daedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f40b20>, '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.PQUIaNdmp8/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.0ObP0UycqR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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 19:47:32 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 19:47:32 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 19:47:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PQUIaNdmp8/Render', 19:47:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:32 INFO - 'HOME': '/Users/cltbld', 19:47:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:32 INFO - 'LOGNAME': 'cltbld', 19:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:32 INFO - 'MOZ_NO_REMOTE': '1', 19:47:32 INFO - 'NO_EM_RESTART': '1', 19:47:32 INFO - 'PAGER': '/bin/cat', 19:47:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:32 INFO - 'PWD': '/builds/slave/test', 19:47:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:32 INFO - 'SHELL': '/bin/bash', 19:47:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0ObP0UycqR/Listeners', 19:47:32 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 19:47:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:32 INFO - 'USER': 'cltbld', 19:47:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:32 INFO - 'XPC_FLAGS': '0x0', 19:47:32 INFO - 'XPC_SERVICE_NAME': '0', 19:47:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:47:32 INFO - Cleaning up... 19:47:32 INFO - Return code: 0 19:47:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:47:32 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')]} 19:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:32 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')]} 19:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:32 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 0x107134490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3fadbeea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f48d30>, '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 0x106daedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f40b20>, '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.PQUIaNdmp8/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.0ObP0UycqR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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 19:47:32 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 19:47:32 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 19:47:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PQUIaNdmp8/Render', 19:47:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:32 INFO - 'HOME': '/Users/cltbld', 19:47:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:32 INFO - 'LOGNAME': 'cltbld', 19:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:32 INFO - 'MOZ_NO_REMOTE': '1', 19:47:32 INFO - 'NO_EM_RESTART': '1', 19:47:32 INFO - 'PAGER': '/bin/cat', 19:47:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:32 INFO - 'PWD': '/builds/slave/test', 19:47:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:32 INFO - 'SHELL': '/bin/bash', 19:47:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0ObP0UycqR/Listeners', 19:47:32 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 19:47:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:32 INFO - 'USER': 'cltbld', 19:47:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:32 INFO - 'XPC_FLAGS': '0x0', 19:47:32 INFO - 'XPC_SERVICE_NAME': '0', 19:47:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:32 INFO - Downloading/unpacking blobuploader==1.2.4 19:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:35 INFO - Downloading blobuploader-1.2.4.tar.gz 19:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:47:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:47:35 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 19:47:35 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 19:47:35 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 19:47:35 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 19:47:35 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 19:47:35 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 19:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:47:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:47:36 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 19:47:36 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 19:47:36 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 19:47:36 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 19:47:36 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 19:47:36 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 19:47:36 INFO - Downloading docopt-0.6.1.tar.gz 19:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:47:36 INFO - Installing collected packages: blobuploader, requests, docopt 19:47:36 INFO - Running setup.py install for blobuploader 19:47:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:47:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:47:36 INFO - Running setup.py install for requests 19:47:37 INFO - Running setup.py install for docopt 19:47:37 INFO - Successfully installed blobuploader requests docopt 19:47:37 INFO - Cleaning up... 19:47:37 INFO - Return code: 0 19:47:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:47: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')]} 19:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47: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')]} 19:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:37 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 0x107134490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3fadbeea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f48d30>, '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 0x106daedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f40b20>, '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.PQUIaNdmp8/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.0ObP0UycqR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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 19:47:37 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 19:47:37 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 19:47:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PQUIaNdmp8/Render', 19:47:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:37 INFO - 'HOME': '/Users/cltbld', 19:47:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:37 INFO - 'LOGNAME': 'cltbld', 19:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:37 INFO - 'MOZ_NO_REMOTE': '1', 19:47:37 INFO - 'NO_EM_RESTART': '1', 19:47:37 INFO - 'PAGER': '/bin/cat', 19:47:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:37 INFO - 'PWD': '/builds/slave/test', 19:47:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:37 INFO - 'SHELL': '/bin/bash', 19:47:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0ObP0UycqR/Listeners', 19:47:37 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 19:47:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:37 INFO - 'USER': 'cltbld', 19:47:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:37 INFO - 'XPC_FLAGS': '0x0', 19:47:37 INFO - 'XPC_SERVICE_NAME': '0', 19:47:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:47:37 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-I9moFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:47:37 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-ttGO18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:47:37 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-P20Isk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:47:38 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-yX0bI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:47:38 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-BzVDwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:47:38 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-Damh3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:47:38 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-AS3zfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:47:38 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-7EJ_LE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:47:38 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-NcfXuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:47:38 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-GB33Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:47:38 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-lSNTZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:47:38 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-6v2404-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:47:39 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-QOsrvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:47:39 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-KljJx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:47:39 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-sbIvd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:47:39 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-lorDFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:47:39 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-kpyGc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:47:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:47:39 INFO - Running setup.py install for manifestparser 19:47:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:47:39 INFO - Running setup.py install for mozcrash 19:47:39 INFO - Running setup.py install for mozdebug 19:47:39 INFO - Running setup.py install for mozdevice 19:47:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:47:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:47:40 INFO - Running setup.py install for mozfile 19:47:40 INFO - Running setup.py install for mozhttpd 19:47:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:47:40 INFO - Running setup.py install for mozinfo 19:47:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:47:40 INFO - Running setup.py install for mozInstall 19:47:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:47:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:47:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:47:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:47:40 INFO - Running setup.py install for mozleak 19:47:40 INFO - Running setup.py install for mozlog 19:47:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:47:41 INFO - Running setup.py install for moznetwork 19:47:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:47:41 INFO - Running setup.py install for mozprocess 19:47:41 INFO - Running setup.py install for mozprofile 19:47:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:47:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:47:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:47:41 INFO - Running setup.py install for mozrunner 19:47:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:47:41 INFO - Running setup.py install for mozscreenshot 19:47:41 INFO - Running setup.py install for moztest 19:47:41 INFO - Running setup.py install for mozversion 19:47:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:47:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:47:42 INFO - Cleaning up... 19:47:42 INFO - Return code: 0 19:47:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:47: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')]} 19:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47: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')]} 19:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:42 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 0x107134490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3fadbeea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f48d30>, '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 0x106daedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f40b20>, '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.PQUIaNdmp8/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.0ObP0UycqR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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 19:47:42 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 19:47:42 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 19:47:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PQUIaNdmp8/Render', 19:47:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:42 INFO - 'HOME': '/Users/cltbld', 19:47:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:42 INFO - 'LOGNAME': 'cltbld', 19:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:42 INFO - 'MOZ_NO_REMOTE': '1', 19:47:42 INFO - 'NO_EM_RESTART': '1', 19:47:42 INFO - 'PAGER': '/bin/cat', 19:47:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:42 INFO - 'PWD': '/builds/slave/test', 19:47:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:42 INFO - 'SHELL': '/bin/bash', 19:47:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0ObP0UycqR/Listeners', 19:47:42 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 19:47:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:42 INFO - 'USER': 'cltbld', 19:47:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:42 INFO - 'XPC_FLAGS': '0x0', 19:47:42 INFO - 'XPC_SERVICE_NAME': '0', 19:47:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:47:42 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-ABtbje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:47:42 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-zD7ED3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:47:42 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-h6l0ei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:47:42 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-voQiGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:47:42 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-61Kwl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:47:42 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)) 19:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:47:42 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-jVLHgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:47:43 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)) 19:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:47:43 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-cF8Fxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:47:43 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)) 19:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:47:43 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-LubY9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:47:43 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)) 19:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:47:43 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-Ganz6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:47:43 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)) 19:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:47:43 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-TaXlZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:47:43 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)) 19:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:47:43 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-jDiTwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:47:43 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)) 19:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:47:43 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-s47b_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:47:43 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)) 19:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:47:43 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-Ur840B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:47:43 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)) 19:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:47:43 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-fZgQkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:47:43 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)) 19:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:47:43 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-TwfkY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:47:43 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)) 19:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:47:44 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-gd4EWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:47:44 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)) 19:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:47:44 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-cWVaze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:47:44 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)) 19:47:44 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)) 19:47:44 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)) 19:47:44 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)) 19:47:44 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)) 19:47:44 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)) 19:47:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:46 INFO - Downloading blessings-1.6.tar.gz 19:47:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:47:46 INFO - Installing collected packages: blessings 19:47:46 INFO - Running setup.py install for blessings 19:47:46 INFO - Successfully installed blessings 19:47:46 INFO - Cleaning up... 19:47:47 INFO - Return code: 0 19:47:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:47:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:47:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:47:47 INFO - Reading from file tmpfile_stdout 19:47:47 INFO - Current package versions: 19:47:47 INFO - blessings == 1.6 19:47:47 INFO - blobuploader == 1.2.4 19:47:47 INFO - docopt == 0.6.1 19:47:47 INFO - functools32 == 3.2.3-2 19:47:47 INFO - jsonschema == 2.5.1 19:47:47 INFO - manifestparser == 1.1 19:47:47 INFO - mozInstall == 1.12 19:47:47 INFO - mozcrash == 0.17 19:47:47 INFO - mozdebug == 0.1 19:47:47 INFO - mozdevice == 0.48 19:47:47 INFO - mozfile == 1.2 19:47:47 INFO - mozhttpd == 0.7 19:47:47 INFO - mozinfo == 0.9 19:47:47 INFO - mozleak == 0.1 19:47:47 INFO - mozlog == 3.4 19:47:47 INFO - moznetwork == 0.27 19:47:47 INFO - mozprocess == 0.23 19:47:47 INFO - mozprofile == 0.28 19:47:47 INFO - mozrunner == 6.12 19:47:47 INFO - mozscreenshot == 0.1 19:47:47 INFO - mozsystemmonitor == 0.3 19:47:47 INFO - moztest == 0.7 19:47:47 INFO - mozversion == 1.4 19:47:47 INFO - psutil == 3.1.1 19:47:47 INFO - requests == 1.2.3 19:47:47 INFO - wsgiref == 0.1.2 19:47:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:47 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 0x107134490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3fadbeea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f48d30>, '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 0x106daedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f40b20>, '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.PQUIaNdmp8/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.0ObP0UycqR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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 19:47:47 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 19:47:47 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 19:47:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PQUIaNdmp8/Render', 19:47:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:47 INFO - 'HOME': '/Users/cltbld', 19:47:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:47 INFO - 'LOGNAME': 'cltbld', 19:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:47 INFO - 'MOZ_NO_REMOTE': '1', 19:47:47 INFO - 'NO_EM_RESTART': '1', 19:47:47 INFO - 'PAGER': '/bin/cat', 19:47:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:47 INFO - 'PWD': '/builds/slave/test', 19:47:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:47 INFO - 'SHELL': '/bin/bash', 19:47:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0ObP0UycqR/Listeners', 19:47:47 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 19:47:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:47 INFO - 'USER': 'cltbld', 19:47:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:48 INFO - 'XPC_FLAGS': '0x0', 19:47:48 INFO - 'XPC_SERVICE_NAME': '0', 19:47:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:48 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)) 19:47:48 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)) 19:47:48 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)) 19:47:48 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)) 19:47:48 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)) 19:47:48 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)) 19:47:48 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)) 19:47:48 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)) 19:47:48 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)) 19:47:48 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)) 19:47:48 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)) 19:47:48 INFO - Cleaning up... 19:47:48 INFO - Return code: 0 19:47:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:47: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')]} 19:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47: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')]} 19:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107134490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3fadbeea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f48d30>, '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 0x106daedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f40b20>, '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.PQUIaNdmp8/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.0ObP0UycqR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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 19:47: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', 'jsonschema'] in /builds/slave/test/build 19:47: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 jsonschema 19:47:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PQUIaNdmp8/Render', 19:47:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:48 INFO - 'HOME': '/Users/cltbld', 19:47:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:48 INFO - 'LOGNAME': 'cltbld', 19:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:48 INFO - 'MOZ_NO_REMOTE': '1', 19:47:48 INFO - 'NO_EM_RESTART': '1', 19:47:48 INFO - 'PAGER': '/bin/cat', 19:47:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:48 INFO - 'PWD': '/builds/slave/test', 19:47:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:48 INFO - 'SHELL': '/bin/bash', 19:47:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0ObP0UycqR/Listeners', 19:47:48 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 19:47:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:48 INFO - 'USER': 'cltbld', 19:47:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:48 INFO - 'XPC_FLAGS': '0x0', 19:47:48 INFO - 'XPC_SERVICE_NAME': '0', 19:47:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:47:48 INFO - Cleaning up... 19:47:48 INFO - Return code: 0 19:47:48 INFO - Running post-action listener: _resource_record_post_action 19:47:48 INFO - Running post-action listener: _start_resource_monitoring 19:47:48 INFO - Starting resource monitoring. 19:47:48 INFO - [mozharness: 2016-11-09 03:47:48.570397Z] Finished create-virtualenv step (success) 19:47:48 INFO - [mozharness: 2016-11-09 03:47:48.571358Z] Running install step. 19:47:48 INFO - Running pre-action listener: _resource_record_pre_action 19:47:48 INFO - Running main action method: install 19:47:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:47:48 INFO - Reading from file tmpfile_stdout 19:47:48 INFO - Detecting whether we're running mozinstall >=1.0... 19:47:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:47:48 INFO - Reading from file tmpfile_stdout 19:47:48 INFO - Output received: 19:47:48 INFO - Usage: mozinstall [options] installer 19:47:48 INFO - Options: 19:47:48 INFO - -h, --help show this help message and exit 19:47:48 INFO - -d DEST, --destination=DEST 19:47:48 INFO - Directory to install application into. [default: 19:47:48 INFO - "/builds/slave/test"] 19:47:48 INFO - --app=APP Application being installed. [default: firefox] 19:47:48 INFO - mkdir: /builds/slave/test/build/application 19:47:48 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'] 19:47:48 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 19:48:20 INFO - Reading from file tmpfile_stdout 19:48:20 INFO - Output received: 19:48:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:48:20 INFO - Running post-action listener: _resource_record_post_action 19:48:20 INFO - [mozharness: 2016-11-09 03:48:20.933841Z] Finished install step (success) 19:48:20 INFO - [mozharness: 2016-11-09 03:48:20.934020Z] Running run-tests step. 19:48:20 INFO - Running pre-action listener: _resource_record_pre_action 19:48:20 INFO - Running main action method: run_tests 19:48:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:48:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:48:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:48:20 INFO - 2016-11-08 19:48:20.948 screenresolution[1928:21713] starting screenresolution argv=screenresolution get 19:48:20 INFO - 2016-11-08 19:48:20.951 screenresolution[1928:21713] Display 0: 1600x1200x32@60 19:48:20 INFO - 2016-11-08 19:48:20.956 screenresolution[1929:21715] starting screenresolution argv=screenresolution list 19:48:20 INFO - Available Modes on Display 0 19:48:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:48:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:48:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:48:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:48:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:48:21 INFO - Intel Iris: 19:48:21 INFO - Chipset Model: Intel Iris 19:48:21 INFO - Type: GPU 19:48:21 INFO - Bus: Built-In 19:48:21 INFO - VRAM (Dynamic, Max): 1536 MB 19:48:21 INFO - Vendor: Intel (0x8086) 19:48:21 INFO - Device ID: 0x0a2e 19:48:21 INFO - Revision ID: 0x0009 19:48:21 INFO - Displays: 19:48:21 INFO - Display: 19:48:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:48:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:48:21 INFO - Display Serial Number: 1600x1200 60 19:48:21 INFO - Main Display: Yes 19:48:21 INFO - Mirror: Off 19:48:21 INFO - Online: Yes 19:48:21 INFO - Rotation: Supported 19:48:21 INFO - Return code: 0 19:48:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:48:21 INFO - Python 2.7.3 19:48:21 INFO - Return code: 0 19:48:21 INFO - grabbing minidump binary from tooltool 19:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:48:21 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 0x106f48d30>, '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 0x106daedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f40b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:48:21 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 19:48:21 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 19:48:21 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 19:48:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:48:21 INFO - Return code: 0 19:48:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:48:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:48:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:48:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:48:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:48:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0204', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0204 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:48:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PQUIaNdmp8/Render', 19:48:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:48:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:48:21 INFO - 'HOME': '/Users/cltbld', 19:48:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:48:21 INFO - 'LOGNAME': 'cltbld', 19:48:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:48:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:21 INFO - 'MOZ_NO_REMOTE': '1', 19:48:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:48:21 INFO - 'NO_EM_RESTART': '1', 19:48:21 INFO - 'PAGER': '/bin/cat', 19:48:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:21 INFO - 'PWD': '/builds/slave/test', 19:48:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:48:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:48:21 INFO - 'SHELL': '/bin/bash', 19:48:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0ObP0UycqR/Listeners', 19:48:21 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 19:48:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:48:21 INFO - 'USER': 'cltbld', 19:48:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:48:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:21 INFO - 'XPC_FLAGS': '0x0', 19:48:21 INFO - 'XPC_SERVICE_NAME': '0', 19:48:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:48:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0204', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:48:21 INFO - mozversion application_buildid: 20161108173621 19:48:21 INFO - mozversion application_changeset: ae3b6bfb810476141647ad681b796ed118062412 19:48:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:48:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:48:21 INFO - mozversion application_name: Firefox 19:48:21 INFO - mozversion application_remotingname: firefox-dev 19:48:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:48:21 INFO - mozversion application_vendor: Mozilla 19:48:21 INFO - mozversion application_version: 51.0a2 19:48:21 INFO - mozversion platform_buildid: 20161108173621 19:48:21 INFO - mozversion platform_changeset: ae3b6bfb810476141647ad681b796ed118062412 19:48:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:48:21 INFO - mozversion platform_version: 51.0a2 19:48:21 INFO - using testdate: 1478663301 19:48:21 INFO - actual date: 1478663301 19:48:21 INFO - starting webserver on 'localhost:56577' 19:48:21 INFO - SUITE-START | Running 2 tests 19:48:21 INFO - TEST-START | dromaeo_css 19:48:21 INFO - operating with platform_type : mac_ 19:48:21 INFO - Initialising browser for dromaeo_css test... 19:48:21 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/tmpmpNpQW/profile http://localhost:56577/getInfo.html) 19:48:23 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 19:48:23 INFO - PROCESS | 1939 | colorDepth:24 19:48:23 INFO - PROCESS | 1939 | Browser inner width/height: 1024/689 19:48:23 INFO - PROCESS | 1939 | __metrics 19:48:24 INFO - PROCESS | 1939 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:48:24 INFO - PROCESS | 1939 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:48:24 INFO - TEST-INFO | 1939: exit 0 19:48:24 INFO - Browser initialized. 19:48:24 INFO - Running cycle 1/1 for dromaeo_css test... 19:48:24 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/tmpmpNpQW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:48:36 INFO - PROCESS | 1941 | RSS: Main: 219811840 19:48:36 INFO - PROCESS | 1941 | 19:49:28 INFO - PROCESS | 1941 | 1478663368073 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] 19:51:40 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56577/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56577/tests/dromaeo/cssquery-ext.html) 19:51:41 INFO - PROCESS | 1941 | RSS: Main: 364982272 19:51:41 INFO - PROCESS | 1941 | 19:54:44 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56577/tests/dromaeo/cssquery-ext.html (next: http://localhost:56577/tests/dromaeo/cssquery-jquery.html) 19:54:45 INFO - PROCESS | 1941 | RSS: Main: 353120256 19:54:45 INFO - PROCESS | 1941 | 19:57:47 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56577/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56577/tests/dromaeo/cssquery-mootools.html) 19:57:48 INFO - PROCESS | 1941 | RSS: Main: 333185024 19:57:48 INFO - PROCESS | 1941 | 20:00:50 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56577/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56577/tests/dromaeo/cssquery-prototype.html) 20:00:51 INFO - PROCESS | 1941 | RSS: Main: 320524288 20:00:51 INFO - PROCESS | 1941 | 20:03:54 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56577/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56577/tests/dromaeo/cssquery-yui.html) 20:03:55 INFO - PROCESS | 1941 | RSS: Main: 311775232 20:03:55 INFO - PROCESS | 1941 | 20:06:58 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56577/tests/dromaeo/cssquery-yui.html (next: http://localhost:56577/tests/dromaeo/cssquery-dojo.html) 20:06:58 INFO - PROCESS | 1941 | RSS: Main: 388104192 20:06:58 INFO - PROCESS | 1941 | 20:06:58 INFO - PROCESS | 1941 | __start_tp_report 20:06:58 INFO - PROCESS | 1941 | _x_x_mozilla_page_load 20:06:58 INFO - PROCESS | 1941 | _x_x_mozilla_page_load_details 20:06:58 INFO - PROCESS | 1941 | |i|pagename|runs| 20:06:58 INFO - PROCESS | 1941 | |0;dojo.html;3285.950710739339;3288.901332960011;3303.207230264737;3344.163959010249;3347.3138006708627;5571.275734154559;5678.716064196794;5682.886342273152;5689.2603961485;5747.224124743158;5666.773329066843;5715.599908006441;5759.680249755167;5759.971200143993;5769.990251705945;5208.322918020652;5228.503292187245;5237.3715154181555;5260.579153667697;5297.576193904479;5140.151874940649;5142.305788718512;5330.840074797762;5346.198070289449;5381.0852155133725;5188.974055129719;5237.057329680656;5241.868953276179;5243.4232234454175;5248.737563121828;5204.0372531081875;5227;5233.084210263227;5235.79056837728;5245.711485868275;5138.511841375063;5237.109691352479;5239.528442440161;5252.947470525284;5260.710660913648;5775.16260142277;5777.508911742507;5779;5789.305283365981;5791.044477661181;6108.129596501707;6120.271967778567;6140.815775526697;6145.985912324461;6174.814755557296;6215.471684906788;6223.439890409885;6226.066090086478;6260.499160067184;6272.3100458949475;5801.361850196475;5806.983777838904;5873.2658417697785;5879.79420720277;5906.232189815297;6118.204633397719;6146.661933593696;6163.84590385244;6222.408871157233;6228.128062071313;5927.585069045125;6019.277686677539;6028.457438830526;6045.063015232646;6047.425494578008;6186.690665466709;6198.194234749454;6212.316645169028;6214.067889816563;6218.782342617987;6087.756489740449;6111.760463554696;6125.326214116443;6140.5701600887505;6140.8771824563255;5161.3032240647035;6203.410675985864;6221.751129954841;6231.065340199007;6243.594166379171;4945.035718034948;4948.65359424844;4961.181405068123;4961.751912404366;4965.652404331734;4360.302351623725;4381.693281470267;4420.801063952065;4463.509014008457;4484.2376795944765;5831.650100993954;5884.6469211847425;5891.646501209942;5946.554008449383;5961.046232602849;6229.906551401733;6236.158118654014;6240.219972503437;6248;6249.50003999688;5739.770409183586;5750.482456578844;5767.279090113736;5892.823215303548;5919.230500034968;5310.468953104659;5326;5327.440618734977;5369.946300537023;5403.783848646089;6228.813135605939;6241.438270555672;6252.74989000444;6254.655993920378;6265.874682506415;5259.579233661374;6229.906551401642;6240.750369985331;6242.937570624417;6248.437640612185;6129.8784197560135;6130.581587307835;6165.72254248551;6203.720832562636;6215.316315205233;5910.054391297372;5938.703064846827;5966.284045914518;6008.7296071676;6018;4941.851744447672;6050.273967123973;6053.273607167168;6063.423974722395;6070.332263451105;5745.913811292918;5803.303603567599;5808.73860676279;5841.32824725162;5876.735546900314;5823.82528524145;5837.09525023622;5850.765969361178;5867.501262392574;5881.5588830837005;5775.537956963349;5778.8266352009505;5784.4504772046585;5785.30576330843;5785.623934444247;5893.793717219876;5912.763489460545;5912.852178695567;5912.970435147797;5977.701114944322;5175.663581867167;5792.478676919098;5866.941330586639;5918.082697181943;5987.2815262168815 20:06:58 INFO - PROCESS | 1941 | |1;ext.html;465.3624534387889;478.5023575481499;522.4957915611436;527.8574784808101;529.3198240261265;29301.56047659284;40537.79731101348;40981.59018409815;41747.58252417479;41873.37189942153;37963.24073518528;37984.62015379845;38071.42892856609;38235;38264.42603360952;9665.468399238021;9861.506924653775;9864.70405887821;9877.407355558653;9892;8713.520756358397;8935.28517718581;8940.508272045035;9050.683226087089;9068.77571527842;12025.51897924082;12287.631371058838;12294.016478681684;12493.312867792269;12510.874891251107;10328.32865863724;12094.758104837854;12100.394980250952;12219.694507637292;12312.630621081336;8577.957110214471;8829.20537151653;11847.763044739057;11938.880611193863;11985.460654270491;39421;39621.40567891484;39826.0043498912;42179.156416871796;42204;3338.132085657722;3346.6987971082717;3349;3393.5079413484905;3402.42158832999;28246;30655.38689226203;31357.686423135703;31534.211644709067;31546.526802097986;3152.2277042124824;3218.452863013293;3235.0780027691994;3354.7819391739704;3388.423967925459;536227;540907;540937;542082;546042;55005.44994550003;55345.44654553403;55367.72316138393;55583.72208138934;55649.443505565236;61324.38675613276;61484.077738833956;61521.38478615157;61568.384316157164;61571.38428615746;16004.599885002968;16132.75800862988;16590.921590096605;16596.6680666386;16607;13037.282949437682;13090.541831035867;13114.622964588772;13118.475260989453;13140.408681609351;13498.527551535846;13831.239281839395;13869.930650346885;15302.158381288913;15492.690146197237;6147.508199344131;7310.96344518274;7394.260573942563;7410.444216683771;7435.1449583297535;873.921347078766;984.4191926763244;1029.4183786160795;1038.3717850700218;1038.9220808439397;25651;28718;29954;30530.84734576313;30663.926762563202;1024.513356155835;1045.7803861189084;1054.878688950765;1091.230682368944;1098.593520397458;12304.938475307566;15433.228338583025;15571.61070973212;15654.686906261812;15818.288177032062;676366;685548;686732;690847;691287;49377.50622493729;50029.74985125051;57227.71386143126;59744.10383844246;60572.697136514034;1344.4487760018346;1352.959411217665;1386.3345594115083;1387.029079644233;1387.7085811979396;29699.406011880073;30472.695273047873;30946.84526577353;30988.53517197289;31793.682063179996;48184;48596.02807943892;48703.5129648699;48728.51271487382;48735.75632121817;620148;623488;624510;624811;626501;38390.808045959595;38539.6146038536;38615;38994.22011559696;39073.413898790976;44954.87612809706;45936;47484.2877356833;47771.52228477671;47860;37693.81153094217;37929.81035094917;38925.41611875881;39009;40196;31225.219369515944;37861.62138378581;38300.6169938297;38347.80826095852;38631.6136838628;36471;37902.8104859474;38060;38513.80743096267;38643;32886.83556582202;33719.662803371655;33896.983090507325;34660.82669586636;34792;25635;25842.449892198445;25985.20577868257;26050.86974565115;26238 20:06:58 INFO - PROCESS | 1941 | |2;jquery.html;359.5757006732055;374.7077279721818;381.24323218411456;390.13584909425623;409.20409802933307;14990.625234369132;15674.294656740445;19813.801861981396;21245.362639120853;21962;20354.08406621702;20836.791632083674;20937.790622093813;21026.89486552569;21164.57670846586;5547.611667183299;5897.233359663259;5905.202797622331;5907.320658124307;5907.497862681677;5589.245451863987;5754.942450575482;5783.103618939072;5811.854703632422;5907.734151963151;5723.51350135239;5740.655560666352;5742.569307301969;5752.568557358194;5764.135379693038;5506.339239291291;5669.574781891375;5712.485876271135;5714.485696287313;5726.971365143189;4960.627952903546;5017.724025178613;5020.497950204986;5026.648134630577;5027.824026159104;25582.97668093274;25985;26069.60895586568;26353.07764228262;26372.73627263722;2170.2295685031904;2253.1325439705665;2312.364099872532;2608.9478210435686;2642.960355594668;15382.3077961492;15514;15965.680686386208;16085.597860053475;16425.753613695684;1557.9143147126904;1747.2574155983657;1788.4813404112922;1827.6801559726994;1888.4145914766466;124355.13467297998;124957;126478;126551;130527;9275.860862087075;9737.172340351008;10546.894531054744;11085.50115244816;11288.250321200227;12101.394930253453;12813.487460501661;13218.60344189676;13345.66635834112;13766.380512876945;8635.309175265964;8709.738707838775;8744;8766.342524310703;8834.249088827393;8901.599428025755;8908;8930.062343453974;9063.13900179482;9089.772755681028;6538.803835884931;6620.304867988888;6622.2715501294815;6666.933330666729;6776.085228494188;1809.7375880497518;1849.1216672080654;1850;1852.4350073227527;1854.4065898912218;918.334207699426;919.6781126605634;947.7109481608038;982.0523195116604;1017.196414832289;21445.356639300848;22897.771022289897;22922.19772307961;22940.88529557375;23089.653655195187;983.2625530851861;1011.8633984412157;1021.3259248895694;1053.1260043014915;1064.0529928363608;11241.381724005258;11505.942470287762;11834.289942603471;11836.644900652995;11843.28940263587;470192;472874;473621;611527;638534;152218.23890880475;152665;154261;155421;161474;958.108958668445;986.3095832916844;999.6051559633904;1002.1682003936716;1006.225206590921;18424.81575184231;19389;19640.508987275432;19674.50813729668;19693.60612787765;56147;57071;60620.39379606147;61380.69309653423;61389.99999999821;85431.57284213539;87973;89028.5548572253;89557.65663515183;91654;7833.412494062854;7857.332126769289;7952.761417157494;8061.677532898619;8068.435209535276;11930.821037684269;12665.430055647334;12784.169029013085;13165.736685266433;13189.736205275649;8677.566121694017;8893.911060889308;10883.140053523817;11589.942050290032;11680.357580333164;10743.946280268548;11300.09599232043;11429.828552571884;11495.643393104561;11655.650330490098;11369.2609980351;11597.536098555964;11762.882371176178;11796.99847892545;12090.516379344728;7821.92178078212;8264.338852891635;8532.829343413221;12095.153339266168;12104.152709310263;9525.809483810424;11237.494312755782;11822.527098915947;11931.403429828648;12258.570950016707 20:06:58 INFO - PROCESS | 1941 | |3;mootools.html;1356.4913157565913;1517.5068102866571;1547.6672515409184;1735.1237624999374;1898.297629876945;8037.758867233985;8393.748187554376;8664.220220180174;8976.640934362635;8990.325725570592;8807.95596022019;8898.332625053115;8916.687915922945;8921.866172007409;8927.151920567552;2401.723801762798;2435.4520232947534;2440.0971640493044;2441.4872876695913;2445.0586524188225;2070.7058088694566;2391.497785465054;2422.757724227572;2427;2436.1717016214484;2406.2179791567723;2408.0488207158164;2428.040923835084;2430.8906099225487;2433.1483980606736;2358.162852187466;2367.0413482539598;2369.5142495788323;2370.111208296897;2410.8312418130736;2374.8693821839793;2384.201292566992;2399.4961058177805;2408.0728919365997;2410.0600765701392;8801.779955501099;8872.911270887338;8933;8942.731718048404;8961.46231226122;5254.605904557174;5471.316085489314;5478.698671573062;5480.890382192374;5482.396936337;3641.5266015417824;3661.6521430464063;3699.3711069118044;3699.4635777812337;3729.4032954727113;1023.6570748799087;1045.1586472889321;1089.3409487260174;1103.9227254092216;1128.5034584782752;11808.88191118095;11887.108466864933;11959.402029898558;12021.51913923442;12024.51901923922;4462.732236065782;4515.187266292099;4690;4692.812287508462;4697.882552936136;9277.628894844265;9300.813983720287;9315.487648179414;9333.579988900516;9365.438073715462;5277.393099793573;5281.287026251407;5282.630215884851;5285.339332583427;5292.603054770831;4188.874333769992;4457.175422546839;4576.931346029813;4589.724616523019;4943.406791185009;3824.043989002749;3859.5947425520476;3878.8642397516514;3902.9609703902597;3928.46965659638;1190.9460127786972;1195.7668254690252;1195.9521619135137;1205.138326096845;1212.9454174562165;829.5644786487022;843.9282660973763;885.3979294080087;930.4257117855524;944.4616568555995;5712;5713.371529131792;6015.819525414245;6057.151998720183;6242.937570624235;457.72307753809133;459.8275646632513;463.5897230950633;931.179543991495;955.4649396338073;3783.356829339019;3919.073420490167;3955.6044395560216;3998.620131087542;4028.7179897407486;10958.123350131971;11208.66374008781;11215.327080375204;11238.213325067167;11258.930401611833;11141.053010494037;11154.219204655596;11156.219064665396;11158.995690387741;11189.328640281608;7060.7528736495005;7863.567503787347;8504.914950850536;8521.275691566163;8525.95737021311;5922.615030023035;6014.188084608697;6124.95875701123;6175.907361389673;6190.533301351258;8657.696980605648;9914.553845077133;9980.153671570783;10334.896651033394;10348.379097254188;9581.952090239784;10247.180225582084;10370.896291036994;10394.22043346737;10551.630692925712;7170.498065135391;7293.161286452126;7705.653245603849;7778.872063550641;7911.84176316482;8324.458910170819;8459.111793261865;8490.872636910575;8499.490030598185;8569.571521423779;7590.430717696085;7597.810054748676;7617.619119044137;7651.1201211859125;7710.653020613973;7440.702371905063;7459.925400745923;7479.513831600929;7526.473146879666;7586.62066896664;7112.35988761014;7135.286471352823;7151.60666163366;7201.027861238876;7222.025026621549;5012.8496145115705;5036.622253330942;5051.570616497492;5118.488151184852;5120.743962801919;4987.401511818605;5026.095302845523;5103.87240318995;5188.896222075613;5206.453322401093 20:06:58 INFO - PROCESS | 1941 | |4;prototype.html;294.8201597025814;306.7101588998395;312.4781614703445;318.55561491719055;319.1303697424517;4451.577100175482;5229.712365819878;5375;5411.621186516945;5425.891482170354;4972.900541989167;5028.723420211887;5164.535191832734;5252.789888404459;5351.143816989283;3399.490076488534;4073.40935564343;4078.8164532596106;4078.9184216315657;4108.52093246431;3916.060145565072;4057.573954734755;4065.5934406559404;4106.28140075487;4118.670506359484;3513.805306195893;3636.709063274932;3781.508403907502;3909.276783795007;4026.2752704513177;3970.6029397060497;3983.6736325168517;4018.3570628699413;4031.093004074089;4034.798260086984;2932.325565120013;3503.2993401319836;3506.878338605158;3512.2799826035603;3522.8590856365713;3956.8021598920227;4291.91416171678;4955.28353734699;5137.48625137487;5180.943243486361;3911.4745249352777;4479.776011199459;4557.817687292504;4572.382728331666;4596.460725241579;4582.388038817875;5480.506754392084;5492.533134683556;5500.724963751796;5532.585056120807;3046.405950839587;3326.7005969462866;3722.7394082414244;3909.7849618270984;3910.980445097785;5568.23231591931;5625.493705566478;5696.11710184922;5728.510587247304;5740.3066095502345;3870.258383727334;3877.5734669186368;3882.4176373544196;3900.90247743803;3930.5676375599232;3385.864565417405;3955.110100227426;3958.346872766019;3974.2250261198787;3978.6817054635558;4276.807543660543;4312.935305970413;4595.4025976622825;4629.699069560468;4634.2585186370015;4660.720356778605;5474.808381706621;5481.040817856859;5488.231647569343;5496.587755918322;1322.9933850330688;1336.6190635668788;1341.3561490484622;1343.3350491506767;1357.1314358810369;724.9090119370419;746.5744525620345;855.7176131876466;888.706726780161;889.6975028490344;4481.35020422037;4828.05124747137;5242.475752424803;5291.560485684259;5336.466353364633;4509.437544339935;5113.926075524108;5436.619436639477;5500.642458240201;5771.336296325892;4818.7108773473;4854;5005.021008298411;5345.679259244458;5348.491893270133;2542.73258862361;2645.708972013077;2958.363951750384;2968.9257768555526;2996.520556710959;5811.970940145272;5882.882342353129;5888.205092312483;5925.111233314951;5964.254468191476;5180.559652429511;5414.561753286613;5880.911786323209;5882.794102206488;5888.322842873039;5218.765155567932;5670.688112153789;5880.94119058804;5922.822315330547;5930.140129681085;4380.934285985776;5663.9716801415725;5677.943220567741;5754.683492407958;5816.720321529257;5688.236646639555;5701.629394089371;5752.13717942312;5768.596198266081;5779.306483222041;5491.533219676372;5891.646501209942;5942.7920022799;5949.345571986992;6003.90994135097;3543.397622404249;3582.2835432913002;3817.5609804872797;3891.8637847675195;3926.5877082907027;4353.869383918487;5462.699551524545;5530.640508366943;5765.8558536036935;5845.912311315248;5090.287359769562;5607.523360514402;5633.957662862009;5668.319801623831;5745.971270143623;5340.570040631581;5400.945990540202;5581.014157425758;5631.380548139783;5646.520045796154;5513.558915286687;5527.866787308511;5533.557315414677;5533.889322213614;5563.831595365019;4692.671512994058;5401.677968049699;5409.2427060212385;5644.576656750678;5663.8017669383025;4744.146053710365;4961.677490963076;5253.423972808218;5297.920531192112;5551.750171242223 20:06:58 INFO - PROCESS | 1941 | |5;yui.html;561.7977528089887;729.9889652830831;785.4227143049858;793.3296364571942;793.7690618821964;14685;15468.922655386736;16015.958962667419;16057.116858572788;16061.75907361389;14676.97261191717;14721.558353249393;14875.107493550395;14911.030782999125;14925.029873058244;697.3584302441766;861.2076889261863;878.2490970220465;884.4074470105013;885.5616469847434;723.9755745619941;735.7902997645672;869.4565896314804;888.3958907942597;896.2964073202537;919.7654598077514;919.9816003679922;921.0329154387899;922.4004397141878;924.3575714878162;915.1626261970289;915.6932427636716;915.844306467902;916.587535608972;918.2699753695828;536.1421725239625;558.4192439862538;662.1061566884715;680.4896327754184;686.0292685849518;14937;14988.100713957198;15002.774958375632;15007.174605396698;15028.699426011528;13638.454461821515;13889.930550347284;13967.511137110152;13998.160110393306;14016.844447092933;12451.93774031133;12641.93679031599;12687.048471364593;13049.282289474075;13139.60581182566;4385.235079887798;4613.308003799423;4664.580187783082;4712.057588482317;4732.290156476522;108951.45524272407;111750.44124779405;112365.99999999919;112701;116073.99999999916;10877.891221087846;10953.397563134104;11116.388598627153;11255.549778008788;11343.376114313627;21437.571248575252;21441.78558214429;21629.24297649575;21687.78312216889;21689.132434702435;7817.8827317590285;7829.765107046797;8002.679892804339;8224.753257402288;8232.34141268697;4355.891102722394;4358.150160718693;4398.252297109499;4514.6614003949835;4625.421822272216;3090.8145511269395;3494.4758286257265;3573.4103872861206;3638.872639457606;3650.8539658413897;649.8050584824533;666.4701562258017;666.8899631560738;669.9698513566901;675.1627981303149;604.6764980735286;616.3528295289927;624.7313655128338;628.522323034497;635.9713812878432;8457.323414126855;8503.61733721984;9000.50497222659;9053.818923621491;9056.683016094537;582.347770497046;620.683451439769;630.713025573363;631.1003878326271;639.1339734659563;3571.7321200910037;4229.429027081366;4376.321670141133;4437.866863994085;4458.910821783546;160734;160869;163579.3642063588;164441;170083.29916700674;136633;138519.30740346437;139305.60694392928;140765.29617351847;143376;120172.3991380055;122251.77748222582;122534;124639.3768031154;126881;8297.087320394872;8346.916530834615;8558.400911936355;8598.61306241233;8761.649534018568;66817;66913.66543167253;67362.32637673756;68066;69065.65467172633;74671;95285;98184.50907745416;102527.94944101226;104433;10549.89450105489;10682;10936.098989778015;11121.388323642277;11200.607978720705;11845.170838041255;12225.938870305592;12318.876811231772;12804.29576373271;12847.100702951078;11702.005329547084;11745.236559623598;12073.517059317528;12275.263484190977;12356.443960022001;11498.77002459963;11552.422378880854;11633.941830290794;12195.51217951272;12371.072169587496;11290.604828830952;11340.489677964677;11373;11951.880481195076;12063.276203427822;8983.775405614912;9574.234061274941;9595.90404095978;9791.314607977372;9907.157891579296;8740.956295218482;9096.363254572381;9364.719058427985;10092.444915529717;11184.832227516432 20:06:58 INFO - PROCESS | 1941 | __end_tp_report 20:06:58 INFO - PROCESS | 1941 | __start_cc_report 20:06:58 INFO - PROCESS | 1941 | _x_x_mozilla_cycle_collect,1312 20:06:58 INFO - PROCESS | 1941 | __end_cc_report 20:06:58 INFO - PROCESS | 1941 | __startTimestamp1478664418626__endTimestamp 20:06:58 INFO - PROCESS | 1941 | 20:06:58 INFO - PROCESS | 1941 | ------- Summary: start ------- 20:06:58 INFO - PROCESS | 1941 | Number of tests: 6 20:06:58 INFO - PROCESS | 1941 | 20:06:58 INFO - PROCESS | 1941 | [#0] dojo.html Cycles:165 Average:5682.90 Median:5850.77 stddev:611.38 (10.4%) stddev-sans-first:583.62 20:06:58 INFO - PROCESS | 1941 | Values: 3286.0 3288.9 3303.2 3344.2 3347.3 5571.3 5678.7 5682.9 5689.3 5747.2 5666.8 5715.6 5759.7 5760.0 5770.0 5208.3 5228.5 5237.4 5260.6 5297.6 5140.2 5142.3 5330.8 5346.2 5381.1 5189.0 5237.1 5241.9 5243.4 5248.7 5204.0 5227.0 5233.1 5235.8 5245.7 5138.5 5237.1 5239.5 5252.9 5260.7 5775.2 5777.5 5779.0 5789.3 5791.0 6108.1 6120.3 6140.8 6146.0 6174.8 6215.5 6223.4 6226.1 6260.5 6272.3 5801.4 5807.0 5873.3 5879.8 5906.2 6118.2 6146.7 6163.8 6222.4 6228.1 5927.6 6019.3 6028.5 6045.1 6047.4 6186.7 6198.2 6212.3 6214.1 6218.8 6087.8 6111.8 6125.3 6140.6 6140.9 5161.3 6203.4 6221.8 6231.1 6243.6 4945.0 4948.7 4961.2 4961.8 4965.7 4360.3 4381.7 4420.8 4463.5 4484.2 5831.7 5884.6 5891.6 5946.6 5961.0 6229.9 6236.2 6240.2 6248.0 6249.5 5739.8 5750.5 5767.3 5892.8 5919.2 5310.5 5326.0 5327.4 5369.9 5403.8 6228.8 6241.4 6252.7 6254.7 6265.9 5259.6 6229.9 6240.8 6242.9 6248.4 6129.9 6130.6 6165.7 6203.7 6215.3 5910.1 5938.7 5966.3 6008.7 6018.0 4941.9 6050.3 6053.3 6063.4 6070.3 5745.9 5803.3 5808.7 5841.3 5876.7 5823.8 5837.1 5850.8 5867.5 5881.6 5775.5 5778.8 5784.5 5785.3 5785.6 5893.8 5912.8 5912.9 5913.0 5977.7 5175.7 5792.5 5866.9 5918.1 5987.3 20:06:58 INFO - PROCESS | 1941 | 20:06:58 INFO - PROCESS | 1941 | [#1] ext.html Cycles:180 Average:74151.28 Median:38065.71 stddev:165969.20 (436.0%) stddev-sans-first:166342.58 20:06:58 INFO - PROCESS | 1941 | Values: 465.4 478.5 522.5 527.9 529.3 29301.6 40537.8 40981.6 41747.6 41873.4 37963.2 37984.6 38071.4 38235.0 38264.4 9665.5 9861.5 9864.7 9877.4 9892.0 8713.5 8935.3 8940.5 9050.7 9068.8 12025.5 12287.6 12294.0 12493.3 12510.9 10328.3 12094.8 12100.4 12219.7 12312.6 8578.0 8829.2 11847.8 11938.9 11985.5 39421.0 39621.4 39826.0 42179.2 42204.0 3338.1 3346.7 3349.0 3393.5 3402.4 28246.0 30655.4 31357.7 31534.2 31546.5 3152.2 3218.5 3235.1 3354.8 3388.4 536227.0 540907.0 540937.0 542082.0 546042.0 55005.4 55345.4 55367.7 55583.7 55649.4 61324.4 61484.1 61521.4 61568.4 61571.4 16004.6 16132.8 16590.9 16596.7 16607.0 13037.3 13090.5 13114.6 13118.5 13140.4 13498.5 13831.2 13869.9 15302.2 15492.7 6147.5 7311.0 7394.3 7410.4 7435.1 873.9 984.4 1029.4 1038.4 1038.9 25651.0 28718.0 29954.0 30530.8 30663.9 1024.5 1045.8 1054.9 1091.2 1098.6 12304.9 15433.2 15571.6 15654.7 15818.3 676366.0 685548.0 686732.0 690847.0 691287.0 49377.5 50029.7 57227.7 59744.1 60572.7 1344.4 1353.0 1386.3 1387.0 1387.7 29699.4 30472.7 30946.8 30988.5 31793.7 48184.0 48596.0 48703.5 48728.5 48735.8 620148.0 623488.0 624510.0 624811.0 626501.0 38390.8 38539.6 38615.0 38994.2 39073.4 44954.9 45936.0 47484.3 47771.5 47860.0 37693.8 37929.8 38925.4 39009.0 40196.0 31225.2 37861.6 38300.6 38347.8 38631.6 36471.0 37902.8 38060.0 38513.8 38643.0 32886.8 33719.7 33897.0 34660.8 34792.0 25635.0 25842.4 25985.2 26050.9 26238.0 20:06:58 INFO - PROCESS | 1941 | 20:06:58 INFO - PROCESS | 1941 | [#2] jquery.html Cycles:180 Average:34966.70 Median:12701.01 stddev:91828.87 (723.0%) stddev-sans-first:92049.71 20:06:58 INFO - PROCESS | 1941 | Values: 359.6 374.7 381.2 390.1 409.2 14990.6 15674.3 19813.8 21245.4 21962.0 20354.1 20836.8 20937.8 21026.9 21164.6 5547.6 5897.2 5905.2 5907.3 5907.5 5589.2 5754.9 5783.1 5811.9 5907.7 5723.5 5740.7 5742.6 5752.6 5764.1 5506.3 5669.6 5712.5 5714.5 5727.0 4960.6 5017.7 5020.5 5026.6 5027.8 25583.0 25985.0 26069.6 26353.1 26372.7 2170.2 2253.1 2312.4 2608.9 2643.0 15382.3 15514.0 15965.7 16085.6 16425.8 1557.9 1747.3 1788.5 1827.7 1888.4 124355.1 124957.0 126478.0 126551.0 130527.0 9275.9 9737.2 10546.9 11085.5 11288.3 12101.4 12813.5 13218.6 13345.7 13766.4 8635.3 8709.7 8744.0 8766.3 8834.2 8901.6 8908.0 8930.1 9063.1 9089.8 6538.8 6620.3 6622.3 6666.9 6776.1 1809.7 1849.1 1850.0 1852.4 1854.4 918.3 919.7 947.7 982.1 1017.2 21445.4 22897.8 22922.2 22940.9 23089.7 983.3 1011.9 1021.3 1053.1 1064.1 11241.4 11505.9 11834.3 11836.6 11843.3 470192.0 472874.0 473621.0 611527.0 638534.0 152218.2 152665.0 154261.0 155421.0 161474.0 958.1 986.3 999.6 1002.2 1006.2 18424.8 19389.0 19640.5 19674.5 19693.6 56147.0 57071.0 60620.4 61380.7 61390.0 85431.6 87973.0 89028.6 89557.7 91654.0 7833.4 7857.3 7952.8 8061.7 8068.4 11930.8 12665.4 12784.2 13165.7 13189.7 8677.6 8893.9 10883.1 11589.9 11680.4 10743.9 11300.1 11429.8 11495.6 11655.7 11369.3 11597.5 11762.9 11797.0 12090.5 7821.9 8264.3 8532.8 12095.2 12104.2 9525.8 11237.5 11822.5 11931.4 12258.6 20:06:58 INFO - PROCESS | 1941 | 20:06:58 INFO - PROCESS | 1941 | [#3] mootools.html Cycles:180 Average:5763.99 Median:5019.47 stddev:3264.41 (65.0%) stddev-sans-first:3256.76 20:06:58 INFO - PROCESS | 1941 | Values: 1356.5 1517.5 1547.7 1735.1 1898.3 8037.8 8393.7 8664.2 8976.6 8990.3 8808.0 8898.3 8916.7 8921.9 8927.2 2401.7 2435.5 2440.1 2441.5 2445.1 2070.7 2391.5 2422.8 2427.0 2436.2 2406.2 2408.0 2428.0 2430.9 2433.1 2358.2 2367.0 2369.5 2370.1 2410.8 2374.9 2384.2 2399.5 2408.1 2410.1 8801.8 8872.9 8933.0 8942.7 8961.5 5254.6 5471.3 5478.7 5480.9 5482.4 3641.5 3661.7 3699.4 3699.5 3729.4 1023.7 1045.2 1089.3 1103.9 1128.5 11808.9 11887.1 11959.4 12021.5 12024.5 4462.7 4515.2 4690.0 4692.8 4697.9 9277.6 9300.8 9315.5 9333.6 9365.4 5277.4 5281.3 5282.6 5285.3 5292.6 4188.9 4457.2 4576.9 4589.7 4943.4 3824.0 3859.6 3878.9 3903.0 3928.5 1190.9 1195.8 1196.0 1205.1 1212.9 829.6 843.9 885.4 930.4 944.5 5712.0 5713.4 6015.8 6057.2 6242.9 457.7 459.8 463.6 931.2 955.5 3783.4 3919.1 3955.6 3998.6 4028.7 10958.1 11208.7 11215.3 11238.2 11258.9 11141.1 11154.2 11156.2 11159.0 11189.3 7060.8 7863.6 8504.9 8521.3 8526.0 5922.6 6014.2 6125.0 6175.9 6190.5 8657.7 9914.6 9980.2 10334.9 10348.4 9582.0 10247.2 10370.9 10394.2 10551.6 7170.5 7293.2 7705.7 7778.9 7911.8 8324.5 8459.1 8490.9 8499.5 8569.6 7590.4 7597.8 7617.6 7651.1 7710.7 7440.7 7459.9 7479.5 7526.5 7586.6 7112.4 7135.3 7151.6 7201.0 7222.0 5012.8 5036.6 5051.6 5118.5 5120.7 4987.4 5026.1 5103.9 5188.9 5206.5 20:06:58 INFO - PROCESS | 1941 | 20:06:58 INFO - PROCESS | 1941 | [#4] prototype.html Cycles:180 Average:4500.79 Median:5125.71 stddev:1400.55 (27.3%) stddev-sans-first:1368.44 20:06:58 INFO - PROCESS | 1941 | Values: 294.8 306.7 312.5 318.6 319.1 4451.6 5229.7 5375.0 5411.6 5425.9 4972.9 5028.7 5164.5 5252.8 5351.1 3399.5 4073.4 4078.8 4078.9 4108.5 3916.1 4057.6 4065.6 4106.3 4118.7 3513.8 3636.7 3781.5 3909.3 4026.3 3970.6 3983.7 4018.4 4031.1 4034.8 2932.3 3503.3 3506.9 3512.3 3522.9 3956.8 4291.9 4955.3 5137.5 5180.9 3911.5 4479.8 4557.8 4572.4 4596.5 4582.4 5480.5 5492.5 5500.7 5532.6 3046.4 3326.7 3722.7 3909.8 3911.0 5568.2 5625.5 5696.1 5728.5 5740.3 3870.3 3877.6 3882.4 3900.9 3930.6 3385.9 3955.1 3958.3 3974.2 3978.7 4276.8 4312.9 4595.4 4629.7 4634.3 4660.7 5474.8 5481.0 5488.2 5496.6 1323.0 1336.6 1341.4 1343.3 1357.1 724.9 746.6 855.7 888.7 889.7 4481.4 4828.1 5242.5 5291.6 5336.5 4509.4 5113.9 5436.6 5500.6 5771.3 4818.7 4854.0 5005.0 5345.7 5348.5 2542.7 2645.7 2958.4 2968.9 2996.5 5812.0 5882.9 5888.2 5925.1 5964.3 5180.6 5414.6 5880.9 5882.8 5888.3 5218.8 5670.7 5880.9 5922.8 5930.1 4380.9 5664.0 5677.9 5754.7 5816.7 5688.2 5701.6 5752.1 5768.6 5779.3 5491.5 5891.6 5942.8 5949.3 6003.9 3543.4 3582.3 3817.6 3891.9 3926.6 4353.9 5462.7 5530.6 5765.9 5845.9 5090.3 5607.5 5634.0 5668.3 5746.0 5340.6 5400.9 5581.0 5631.4 5646.5 5513.6 5527.9 5533.6 5533.9 5563.8 4692.7 5401.7 5409.2 5644.6 5663.8 4744.1 4961.7 5253.4 5297.9 5551.8 20:06:58 INFO - PROCESS | 1941 | 20:06:58 INFO - PROCESS | 1941 | [#5] yui.html Cycles:180 Average:25938.77 Median:4292.66 stddev:43118.13 (1004.5%) stddev-sans-first:43196.99 20:06:58 INFO - PROCESS | 1941 | Values: 561.8 730.0 785.4 793.3 793.8 14685.0 15468.9 16016.0 16057.1 16061.8 14677.0 14721.6 14875.1 14911.0 14925.0 697.4 861.2 878.2 884.4 885.6 724.0 735.8 869.5 888.4 896.3 919.8 920.0 921.0 922.4 924.4 915.2 915.7 915.8 916.6 918.3 536.1 558.4 662.1 680.5 686.0 14937.0 14988.1 15002.8 15007.2 15028.7 13638.5 13889.9 13967.5 13998.2 14016.8 12451.9 12641.9 12687.0 13049.3 13139.6 4385.2 4613.3 4664.6 4712.1 4732.3 108951.5 111750.4 112366.0 112701.0 116074.0 10877.9 10953.4 11116.4 11255.5 11343.4 21437.6 21441.8 21629.2 21687.8 21689.1 7817.9 7829.8 8002.7 8224.8 8232.3 4355.9 4358.2 4398.3 4514.7 4625.4 3090.8 3494.5 3573.4 3638.9 3650.9 649.8 666.5 666.9 670.0 675.2 604.7 616.4 624.7 628.5 636.0 8457.3 8503.6 9000.5 9053.8 9056.7 582.3 620.7 630.7 631.1 639.1 3571.7 4229.4 4376.3 4437.9 4458.9 160734.0 160869.0 163579.4 164441.0 170083.3 136633.0 138519.3 139305.6 140765.3 143376.0 120172.4 122251.8 122534.0 124639.4 126881.0 8297.1 8346.9 8558.4 8598.6 8761.6 66817.0 66913.7 67362.3 68066.0 69065.7 74671.0 95285.0 98184.5 102527.9 104433.0 10549.9 10682.0 10936.1 11121.4 11200.6 11845.2 12225.9 12318.9 12804.3 12847.1 11702.0 11745.2 12073.5 12275.3 12356.4 11498.8 11552.4 11633.9 12195.5 12371.1 11290.6 11340.5 11373.0 11951.9 12063.3 8983.8 9574.2 9595.9 9791.3 9907.2 8741.0 9096.4 9364.7 10092.4 11184.8 20:06:58 INFO - PROCESS | 1941 | -------- Summary: end -------- 20:06:58 INFO - PROCESS | 1941 | 20:06:59 INFO - TEST-INFO | 1941: exit 0 20:06:59 INFO - TEST-OK | dromaeo_css | took 1117722ms 20:06:59 INFO - TEST-START | kraken 20:06:59 INFO - operating with platform_type : mac_ 20:06:59 INFO - Initialising browser for kraken test... 20:06:59 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/tmpzBloO7/profile http://localhost:56577/getInfo.html) 20:07:01 INFO - PROCESS | 1943 | __metrics Screen width/height:1600/1200 20:07:01 INFO - PROCESS | 1943 | colorDepth:24 20:07:01 INFO - PROCESS | 1943 | Browser inner width/height: 1024/689 20:07:01 INFO - PROCESS | 1943 | __metrics 20:07:01 INFO - PROCESS | 1943 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:07:01 INFO - PROCESS | 1943 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:07:02 INFO - TEST-INFO | 1943: exit 0 20:07:02 INFO - Browser initialized. 20:07:02 INFO - Running cycle 1/1 for kraken test... 20:07:02 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/tmpzBloO7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:14 INFO - PROCESS | 1944 | RSS: Main: 219652096 20:07:14 INFO - PROCESS | 1944 | 20:07:17 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56577/tests/kraken/driver.html?testName=audio-beat-detection) 20:07:18 INFO - PROCESS | 1944 | RSS: Main: 270069760 20:07:18 INFO - PROCESS | 1944 | 20:07:20 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56577/tests/kraken/driver.html?testName=audio-dft) 20:07:21 INFO - PROCESS | 1944 | RSS: Main: 280543232 20:07:21 INFO - PROCESS | 1944 | 20:07:24 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56577/tests/kraken/driver.html?testName=audio-fft) 20:07:25 INFO - PROCESS | 1944 | RSS: Main: 377835520 20:07:25 INFO - PROCESS | 1944 | 20:07:27 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56577/tests/kraken/driver.html?testName=audio-oscillator) 20:07:27 INFO - PROCESS | 1944 | RSS: Main: 280330240 20:07:27 INFO - PROCESS | 1944 | 20:07:29 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56577/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:07:30 INFO - PROCESS | 1944 | RSS: Main: 280752128 20:07:30 INFO - PROCESS | 1944 | 20:07:33 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56577/tests/kraken/driver.html?testName=imaging-darkroom) 20:07:33 INFO - PROCESS | 1944 | RSS: Main: 318095360 20:07:33 INFO - PROCESS | 1944 | 20:07:36 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56577/tests/kraken/driver.html?testName=imaging-desaturate) 20:07:37 INFO - PROCESS | 1944 | RSS: Main: 318713856 20:07:37 INFO - PROCESS | 1944 | 20:07:40 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56577/tests/kraken/driver.html?testName=json-parse-financial) 20:07:40 INFO - PROCESS | 1944 | RSS: Main: 317648896 20:07:40 INFO - PROCESS | 1944 | 20:07:42 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56577/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:07:42 INFO - PROCESS | 1944 | RSS: Main: 295702528 20:07:42 INFO - PROCESS | 1944 | 20:07:44 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:07:45 INFO - PROCESS | 1944 | RSS: Main: 297041920 20:07:45 INFO - PROCESS | 1944 | 20:07:47 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:07:48 INFO - PROCESS | 1944 | RSS: Main: 301580288 20:07:48 INFO - PROCESS | 1944 | 20:07:51 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:07:51 INFO - PROCESS | 1944 | RSS: Main: 318521344 20:07:51 INFO - PROCESS | 1944 | 20:07:54 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:07:55 INFO - PROCESS | 1944 | RSS: Main: 312205312 20:07:55 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:56577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56577/tests/kraken/driver.html?testName=ai-astar) 20:07:57 INFO - PROCESS | 1944 | RSS: Main: 356147200 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | __start_tp_report 20:07:57 INFO - PROCESS | 1944 | _x_x_mozilla_page_load 20:07:57 INFO - PROCESS | 1944 | _x_x_mozilla_page_load_details 20:07:57 INFO - PROCESS | 1944 | |i|pagename|runs| 20:07:57 INFO - PROCESS | 1944 | |0;ai-astar;116;115;114;113;113;115;112;113;113;114 20:07:57 INFO - PROCESS | 1944 | |1;audio-beat-detection;146;95;125;178;110;107;107;108;158;140 20:07:57 INFO - PROCESS | 1944 | |2;audio-dft;183;183;182;185;188;183;184;183;185;183 20:07:57 INFO - PROCESS | 1944 | |3;audio-fft;82;62;49;88;76;85;87;82;82;57 20:07:57 INFO - PROCESS | 1944 | |4;audio-oscillator;84;68;94;69;68;68;91;67;68;89 20:07:57 INFO - PROCESS | 1944 | |5;imaging-gaussian-blur;89;84;87;84;87;83;87;84;87;84 20:07:57 INFO - PROCESS | 1944 | |6;imaging-darkroom;96;96;107;146;95;94;96;96;96;95 20:07:57 INFO - PROCESS | 1944 | |7;imaging-desaturate;86;86;84;86;84;85;83;86;84;86 20:07:57 INFO - PROCESS | 1944 | |8;json-parse-financial;55;55;55;53;58;59;56;56;56;57 20:07:57 INFO - PROCESS | 1944 | |9;json-stringify-tinderbox;65;66;79;74;73;70;72;71;72;73 20:07:57 INFO - PROCESS | 1944 | |10;stanford-crypto-aes;81;77;72;83;73;97;100;100;77;88 20:07:57 INFO - PROCESS | 1944 | |11;stanford-crypto-ccm;138;138;140;139;138;136;140;148;192;138 20:07:57 INFO - PROCESS | 1944 | |12;stanford-crypto-pbkdf2;166;163;163;169;223;194;161;161;162;165 20:07:57 INFO - PROCESS | 1944 | |13;stanford-crypto-sha256-iterative;67;66;65;66;66;66;67;68;77;64 20:07:57 INFO - PROCESS | 1944 | __end_tp_report 20:07:57 INFO - PROCESS | 1944 | __start_cc_report 20:07:57 INFO - PROCESS | 1944 | _x_x_mozilla_cycle_collect,1967 20:07:57 INFO - PROCESS | 1944 | __end_cc_report 20:07:57 INFO - PROCESS | 1944 | __startTimestamp1478664477386__endTimestamp 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | ------- Summary: start ------- 20:07:57 INFO - PROCESS | 1944 | Number of tests: 14 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:1.23 (1.1%) stddev-sans-first:1.01 20:07:57 INFO - PROCESS | 1944 | Values: 116.0 115.0 114.0 113.0 113.0 115.0 112.0 113.0 113.0 114.0 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:143.00 stddev:27.02 (18.9%) stddev-sans-first:27.80 20:07:57 INFO - PROCESS | 1944 | Values: 146.0 95.0 125.0 178.0 110.0 107.0 107.0 108.0 158.0 140.0 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | [#2] audio-dft Cycles:10 Average:183.90 Median:183.50 stddev:1.73 (0.9%) stddev-sans-first:1.80 20:07:57 INFO - PROCESS | 1944 | Values: 183.0 183.0 182.0 185.0 188.0 183.0 184.0 183.0 185.0 183.0 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | [#3] audio-fft Cycles:10 Average:75.00 Median:82.00 stddev:13.86 (16.9%) stddev-sans-first:14.47 20:07:57 INFO - PROCESS | 1944 | Values: 82.0 62.0 49.0 88.0 76.0 85.0 87.0 82.0 82.0 57.0 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:76.50 stddev:11.37 (14.9%) stddev-sans-first:11.74 20:07:57 INFO - PROCESS | 1944 | Values: 84.0 68.0 94.0 69.0 68.0 68.0 91.0 67.0 68.0 89.0 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:87.00 stddev:2.01 (2.3%) stddev-sans-first:1.72 20:07:57 INFO - PROCESS | 1944 | Values: 89.0 84.0 87.0 84.0 87.0 83.0 87.0 84.0 87.0 84.0 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | [#6] imaging-darkroom Cycles:10 Average:101.70 Median:96.00 stddev:15.99 (16.7%) stddev-sans-first:16.83 20:07:57 INFO - PROCESS | 1944 | Values: 96.0 96.0 107.0 146.0 95.0 94.0 96.0 96.0 96.0 95.0 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:86.00 stddev:1.15 (1.3%) stddev-sans-first:1.17 20:07:57 INFO - PROCESS | 1944 | Values: 86.0 86.0 84.0 86.0 84.0 85.0 83.0 86.0 84.0 86.0 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.70 (3.0%) stddev-sans-first:1.76 20:07:57 INFO - PROCESS | 1944 | Values: 55.0 55.0 55.0 53.0 58.0 59.0 56.0 56.0 56.0 57.0 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:72.50 stddev:3.98 (5.5%) stddev-sans-first:3.46 20:07:57 INFO - PROCESS | 1944 | Values: 65.0 66.0 79.0 74.0 73.0 70.0 72.0 71.0 72.0 73.0 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:79.00 stddev:10.87 (13.8%) stddev-sans-first:11.44 20:07:57 INFO - PROCESS | 1944 | Values: 81.0 77.0 72.0 83.0 73.0 97.0 100.0 100.0 77.0 88.0 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:139.50 stddev:16.93 (12.1%) stddev-sans-first:17.78 20:07:57 INFO - PROCESS | 1944 | Values: 138.0 138.0 140.0 139.0 138.0 136.0 140.0 148.0 192.0 138.0 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:165.50 stddev:20.22 (12.2%) stddev-sans-first:21.30 20:07:57 INFO - PROCESS | 1944 | Values: 166.0 163.0 163.0 169.0 223.0 194.0 161.0 161.0 162.0 165.0 20:07:57 INFO - PROCESS | 1944 | 20:07:57 INFO - PROCESS | 1944 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:66.50 stddev:3.61 (5.4%) stddev-sans-first:3.83 20:07:57 INFO - PROCESS | 1944 | Values: 67.0 66.0 65.0 66.0 66.0 66.0 67.0 68.0 77.0 64.0 20:07:57 INFO - PROCESS | 1944 | -------- Summary: end -------- 20:07:57 INFO - PROCESS | 1944 | 20:07:58 INFO - TEST-INFO | 1944: exit 0 20:07:58 INFO - TEST-OK | kraken | took 59076ms 20:07:58 INFO - SUITE-END | took 1176s 20:07:58 INFO - Completed test suite (00:19:37) 20:07:58 INFO - javascript benchmark 20:07:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.950710739339, 3288.901332960011, 3303.207230264737, 3344.163959010249, 3347.3138006708627, 5571.275734154559, 5678.716064196794, 5682.886342273152, 5689.2603961485, 5747.224124743158, 5666.773329066843, 5715.599908006441, 5759.680249755167, 5759.971200143993, 5769.990251705945, 5208.322918020652, 5228.503292187245, 5237.3715154181555, 5260.579153667697, 5297.576193904479, 5140.151874940649, 5142.305788718512, 5330.840074797762, 5346.198070289449, 5381.0852155133725, 5188.974055129719, 5237.057329680656, 5241.868953276179, 5243.4232234454175, 5248.737563121828, 5204.0372531081875, 5227.0, 5233.084210263227, 5235.79056837728, 5245.711485868275, 5138.511841375063, 5237.109691352479, 5239.528442440161, 5252.947470525284, 5260.710660913648, 5775.16260142277, 5777.508911742507, 5779.0, 5789.305283365981, 5791.044477661181, 6108.129596501707, 6120.271967778567, 6140.815775526697, 6145.985912324461, 6174.814755557296, 6215.471684906788, 6223.439890409885, 6226.066090086478, 6260.499160067184, 6272.3100458949475, 5801.361850196475, 5806.983777838904, 5873.2658417697785, 5879.79420720277, 5906.232189815297, 6118.204633397719, 6146.661933593696, 6163.84590385244, 6222.408871157233, 6228.128062071313, 5927.585069045125, 6019.277686677539, 6028.457438830526, 6045.063015232646, 6047.425494578008, 6186.690665466709, 6198.194234749454, 6212.316645169028, 6214.067889816563, 6218.782342617987, 6087.756489740449, 6111.760463554696, 6125.326214116443, 6140.5701600887505, 6140.8771824563255, 5161.3032240647035, 6203.410675985864, 6221.751129954841, 6231.065340199007, 6243.594166379171, 4945.035718034948, 4948.65359424844, 4961.181405068123, 4961.751912404366, 4965.652404331734, 4360.302351623725, 4381.693281470267, 4420.801063952065, 4463.509014008457, 4484.2376795944765, 5831.650100993954, 5884.6469211847425, 5891.646501209942, 5946.554008449383, 5961.046232602849, 6229.906551401733, 6236.158118654014, 6240.219972503437, 6248.0, 6249.50003999688, 5739.770409183586, 5750.482456578844, 5767.279090113736, 5892.823215303548, 5919.230500034968, 5310.468953104659, 5326.0, 5327.440618734977, 5369.946300537023, 5403.783848646089, 6228.813135605939, 6241.438270555672, 6252.74989000444, 6254.655993920378, 6265.874682506415, 5259.579233661374, 6229.906551401642, 6240.750369985331, 6242.937570624417, 6248.437640612185, 6129.8784197560135, 6130.581587307835, 6165.72254248551, 6203.720832562636, 6215.316315205233, 5910.054391297372, 5938.703064846827, 5966.284045914518, 6008.7296071676, 6018.0, 4941.851744447672, 6050.273967123973, 6053.273607167168, 6063.423974722395, 6070.332263451105, 5745.913811292918, 5803.303603567599, 5808.73860676279, 5841.32824725162, 5876.735546900314, 5823.82528524145, 5837.09525023622, 5850.765969361178, 5867.501262392574, 5881.5588830837005, 5775.537956963349, 5778.8266352009505, 5784.4504772046585, 5785.30576330843, 5785.623934444247, 5893.793717219876, 5912.763489460545, 5912.852178695567, 5912.970435147797, 5977.701114944322, 5175.663581867167, 5792.478676919098, 5866.941330586639, 5918.082697181943, 5987.2815262168815], "value": 5645.320661708772, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.3624534387889, 478.5023575481499, 522.4957915611436, 527.8574784808101, 529.3198240261265, 29301.56047659284, 40537.79731101348, 40981.59018409815, 41747.58252417479, 41873.37189942153, 37963.24073518528, 37984.62015379845, 38071.42892856609, 38235.0, 38264.42603360952, 9665.468399238021, 9861.506924653775, 9864.70405887821, 9877.407355558653, 9892.0, 8713.520756358397, 8935.28517718581, 8940.508272045035, 9050.683226087089, 9068.77571527842, 12025.51897924082, 12287.631371058838, 12294.016478681684, 12493.312867792269, 12510.874891251107, 10328.32865863724, 12094.758104837854, 12100.394980250952, 12219.694507637292, 12312.630621081336, 8577.957110214471, 8829.20537151653, 11847.763044739057, 11938.880611193863, 11985.460654270491, 39421.0, 39621.40567891484, 39826.0043498912, 42179.156416871796, 42204.0, 3338.132085657722, 3346.6987971082717, 3349.0, 3393.5079413484905, 3402.42158832999, 28246.0, 30655.38689226203, 31357.686423135703, 31534.211644709067, 31546.526802097986, 3152.2277042124824, 3218.452863013293, 3235.0780027691994, 3354.7819391739704, 3388.423967925459, 536227.0, 540907.0, 540937.0, 542082.0, 546042.0, 55005.44994550003, 55345.44654553403, 55367.72316138393, 55583.72208138934, 55649.443505565236, 61324.38675613276, 61484.077738833956, 61521.38478615157, 61568.384316157164, 61571.38428615746, 16004.599885002968, 16132.75800862988, 16590.921590096605, 16596.6680666386, 16607.0, 13037.282949437682, 13090.541831035867, 13114.622964588772, 13118.475260989453, 13140.408681609351, 13498.527551535846, 13831.239281839395, 13869.930650346885, 15302.158381288913, 15492.690146197237, 6147.508199344131, 7310.96344518274, 7394.260573942563, 7410.444216683771, 7435.1449583297535, 873.921347078766, 984.4191926763244, 1029.4183786160795, 1038.3717850700218, 1038.9220808439397, 25651.0, 28718.0, 29954.0, 30530.84734576313, 30663.926762563202, 1024.513356155835, 1045.7803861189084, 1054.878688950765, 1091.230682368944, 1098.593520397458, 12304.938475307566, 15433.228338583025, 15571.61070973212, 15654.686906261812, 15818.288177032062, 676366.0, 685548.0, 686732.0, 690847.0, 691287.0, 49377.50622493729, 50029.74985125051, 57227.71386143126, 59744.10383844246, 60572.697136514034, 1344.4487760018346, 1352.959411217665, 1386.3345594115083, 1387.029079644233, 1387.7085811979396, 29699.406011880073, 30472.695273047873, 30946.84526577353, 30988.53517197289, 31793.682063179996, 48184.0, 48596.02807943892, 48703.5129648699, 48728.51271487382, 48735.75632121817, 620148.0, 623488.0, 624510.0, 624811.0, 626501.0, 38390.808045959595, 38539.6146038536, 38615.0, 38994.22011559696, 39073.413898790976, 44954.87612809706, 45936.0, 47484.2877356833, 47771.52228477671, 47860.0, 37693.81153094217, 37929.81035094917, 38925.41611875881, 39009.0, 40196.0, 31225.219369515944, 37861.62138378581, 38300.6169938297, 38347.80826095852, 38631.6136838628, 36471.0, 37902.8104859474, 38060.0, 38513.80743096267, 38643.0, 32886.83556582202, 33719.662803371655, 33896.983090507325, 34660.82669586636, 34792.0, 25635.0, 25842.449892198445, 25985.20577868257, 26050.86974565115, 26238.0], "value": 20265.714086864788, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.5757006732055, 374.7077279721818, 381.24323218411456, 390.13584909425623, 409.20409802933307, 14990.625234369132, 15674.294656740445, 19813.801861981396, 21245.362639120853, 21962.0, 20354.08406621702, 20836.791632083674, 20937.790622093813, 21026.89486552569, 21164.57670846586, 5547.611667183299, 5897.233359663259, 5905.202797622331, 5907.320658124307, 5907.497862681677, 5589.245451863987, 5754.942450575482, 5783.103618939072, 5811.854703632422, 5907.734151963151, 5723.51350135239, 5740.655560666352, 5742.569307301969, 5752.568557358194, 5764.135379693038, 5506.339239291291, 5669.574781891375, 5712.485876271135, 5714.485696287313, 5726.971365143189, 4960.627952903546, 5017.724025178613, 5020.497950204986, 5026.648134630577, 5027.824026159104, 25582.97668093274, 25985.0, 26069.60895586568, 26353.07764228262, 26372.73627263722, 2170.2295685031904, 2253.1325439705665, 2312.364099872532, 2608.9478210435686, 2642.960355594668, 15382.3077961492, 15514.0, 15965.680686386208, 16085.597860053475, 16425.753613695684, 1557.9143147126904, 1747.2574155983657, 1788.4813404112922, 1827.6801559726994, 1888.4145914766466, 124355.13467297998, 124957.0, 126478.0, 126551.0, 130527.0, 9275.860862087075, 9737.172340351008, 10546.894531054744, 11085.50115244816, 11288.250321200227, 12101.394930253453, 12813.487460501661, 13218.60344189676, 13345.66635834112, 13766.380512876945, 8635.309175265964, 8709.738707838775, 8744.0, 8766.342524310703, 8834.249088827393, 8901.599428025755, 8908.0, 8930.062343453974, 9063.13900179482, 9089.772755681028, 6538.803835884931, 6620.304867988888, 6622.2715501294815, 6666.933330666729, 6776.085228494188, 1809.7375880497518, 1849.1216672080654, 1850.0, 1852.4350073227527, 1854.4065898912218, 918.334207699426, 919.6781126605634, 947.7109481608038, 982.0523195116604, 1017.196414832289, 21445.356639300848, 22897.771022289897, 22922.19772307961, 22940.88529557375, 23089.653655195187, 983.2625530851861, 1011.8633984412157, 1021.3259248895694, 1053.1260043014915, 1064.0529928363608, 11241.381724005258, 11505.942470287762, 11834.289942603471, 11836.644900652995, 11843.28940263587, 470192.0, 472874.0, 473621.0, 611527.0, 638534.0, 152218.23890880475, 152665.0, 154261.0, 155421.0, 161474.0, 958.108958668445, 986.3095832916844, 999.6051559633904, 1002.1682003936716, 1006.225206590921, 18424.81575184231, 19389.0, 19640.508987275432, 19674.50813729668, 19693.60612787765, 56147.0, 57071.0, 60620.39379606147, 61380.69309653423, 61389.99999999821, 85431.57284213539, 87973.0, 89028.5548572253, 89557.65663515183, 91654.0, 7833.412494062854, 7857.332126769289, 7952.761417157494, 8061.677532898619, 8068.435209535276, 11930.821037684269, 12665.430055647334, 12784.169029013085, 13165.736685266433, 13189.736205275649, 8677.566121694017, 8893.911060889308, 10883.140053523817, 11589.942050290032, 11680.357580333164, 10743.946280268548, 11300.09599232043, 11429.828552571884, 11495.643393104561, 11655.650330490098, 11369.2609980351, 11597.536098555964, 11762.882371176178, 11796.99847892545, 12090.516379344728, 7821.92178078212, 8264.338852891635, 8532.829343413221, 12095.153339266168, 12104.152709310263, 9525.809483810424, 11237.494312755782, 11822.527098915947, 11931.403429828648, 12258.570950016707], "value": 9937.40246303877, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.4913157565913, 1517.5068102866571, 1547.6672515409184, 1735.1237624999374, 1898.297629876945, 8037.758867233985, 8393.748187554376, 8664.220220180174, 8976.640934362635, 8990.325725570592, 8807.95596022019, 8898.332625053115, 8916.687915922945, 8921.866172007409, 8927.151920567552, 2401.723801762798, 2435.4520232947534, 2440.0971640493044, 2441.4872876695913, 2445.0586524188225, 2070.7058088694566, 2391.497785465054, 2422.757724227572, 2427.0, 2436.1717016214484, 2406.2179791567723, 2408.0488207158164, 2428.040923835084, 2430.8906099225487, 2433.1483980606736, 2358.162852187466, 2367.0413482539598, 2369.5142495788323, 2370.111208296897, 2410.8312418130736, 2374.8693821839793, 2384.201292566992, 2399.4961058177805, 2408.0728919365997, 2410.0600765701392, 8801.779955501099, 8872.911270887338, 8933.0, 8942.731718048404, 8961.46231226122, 5254.605904557174, 5471.316085489314, 5478.698671573062, 5480.890382192374, 5482.396936337, 3641.5266015417824, 3661.6521430464063, 3699.3711069118044, 3699.4635777812337, 3729.4032954727113, 1023.6570748799087, 1045.1586472889321, 1089.3409487260174, 1103.9227254092216, 1128.5034584782752, 11808.88191118095, 11887.108466864933, 11959.402029898558, 12021.51913923442, 12024.51901923922, 4462.732236065782, 4515.187266292099, 4690.0, 4692.812287508462, 4697.882552936136, 9277.628894844265, 9300.813983720287, 9315.487648179414, 9333.579988900516, 9365.438073715462, 5277.393099793573, 5281.287026251407, 5282.630215884851, 5285.339332583427, 5292.603054770831, 4188.874333769992, 4457.175422546839, 4576.931346029813, 4589.724616523019, 4943.406791185009, 3824.043989002749, 3859.5947425520476, 3878.8642397516514, 3902.9609703902597, 3928.46965659638, 1190.9460127786972, 1195.7668254690252, 1195.9521619135137, 1205.138326096845, 1212.9454174562165, 829.5644786487022, 843.9282660973763, 885.3979294080087, 930.4257117855524, 944.4616568555995, 5712.0, 5713.371529131792, 6015.819525414245, 6057.151998720183, 6242.937570624235, 457.72307753809133, 459.8275646632513, 463.5897230950633, 931.179543991495, 955.4649396338073, 3783.356829339019, 3919.073420490167, 3955.6044395560216, 3998.620131087542, 4028.7179897407486, 10958.123350131971, 11208.66374008781, 11215.327080375204, 11238.213325067167, 11258.930401611833, 11141.053010494037, 11154.219204655596, 11156.219064665396, 11158.995690387741, 11189.328640281608, 7060.7528736495005, 7863.567503787347, 8504.914950850536, 8521.275691566163, 8525.95737021311, 5922.615030023035, 6014.188084608697, 6124.95875701123, 6175.907361389673, 6190.533301351258, 8657.696980605648, 9914.553845077133, 9980.153671570783, 10334.896651033394, 10348.379097254188, 9581.952090239784, 10247.180225582084, 10370.896291036994, 10394.22043346737, 10551.630692925712, 7170.498065135391, 7293.161286452126, 7705.653245603849, 7778.872063550641, 7911.84176316482, 8324.458910170819, 8459.111793261865, 8490.872636910575, 8499.490030598185, 8569.571521423779, 7590.430717696085, 7597.810054748676, 7617.619119044137, 7651.1201211859125, 7710.653020613973, 7440.702371905063, 7459.925400745923, 7479.513831600929, 7526.473146879666, 7586.62066896664, 7112.35988761014, 7135.286471352823, 7151.60666163366, 7201.027861238876, 7222.025026621549, 5012.8496145115705, 5036.622253330942, 5051.570616497492, 5118.488151184852, 5120.743962801919, 4987.401511818605, 5026.095302845523, 5103.87240318995, 5188.896222075613, 5206.453322401093], "value": 4579.333153583521, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.8201597025814, 306.7101588998395, 312.4781614703445, 318.55561491719055, 319.1303697424517, 4451.577100175482, 5229.712365819878, 5375.0, 5411.621186516945, 5425.891482170354, 4972.900541989167, 5028.723420211887, 5164.535191832734, 5252.789888404459, 5351.143816989283, 3399.490076488534, 4073.40935564343, 4078.8164532596106, 4078.9184216315657, 4108.52093246431, 3916.060145565072, 4057.573954734755, 4065.5934406559404, 4106.28140075487, 4118.670506359484, 3513.805306195893, 3636.709063274932, 3781.508403907502, 3909.276783795007, 4026.2752704513177, 3970.6029397060497, 3983.6736325168517, 4018.3570628699413, 4031.093004074089, 4034.798260086984, 2932.325565120013, 3503.2993401319836, 3506.878338605158, 3512.2799826035603, 3522.8590856365713, 3956.8021598920227, 4291.91416171678, 4955.28353734699, 5137.48625137487, 5180.943243486361, 3911.4745249352777, 4479.776011199459, 4557.817687292504, 4572.382728331666, 4596.460725241579, 4582.388038817875, 5480.506754392084, 5492.533134683556, 5500.724963751796, 5532.585056120807, 3046.405950839587, 3326.7005969462866, 3722.7394082414244, 3909.7849618270984, 3910.980445097785, 5568.23231591931, 5625.493705566478, 5696.11710184922, 5728.510587247304, 5740.3066095502345, 3870.258383727334, 3877.5734669186368, 3882.4176373544196, 3900.90247743803, 3930.5676375599232, 3385.864565417405, 3955.110100227426, 3958.346872766019, 3974.2250261198787, 3978.6817054635558, 4276.807543660543, 4312.935305970413, 4595.4025976622825, 4629.699069560468, 4634.2585186370015, 4660.720356778605, 5474.808381706621, 5481.040817856859, 5488.231647569343, 5496.587755918322, 1322.9933850330688, 1336.6190635668788, 1341.3561490484622, 1343.3350491506767, 1357.1314358810369, 724.9090119370419, 746.5744525620345, 855.7176131876466, 888.706726780161, 889.6975028490344, 4481.35020422037, 4828.05124747137, 5242.475752424803, 5291.560485684259, 5336.466353364633, 4509.437544339935, 5113.926075524108, 5436.619436639477, 5500.642458240201, 5771.336296325892, 4818.7108773473, 4854.0, 5005.021008298411, 5345.679259244458, 5348.491893270133, 2542.73258862361, 2645.708972013077, 2958.363951750384, 2968.9257768555526, 2996.520556710959, 5811.970940145272, 5882.882342353129, 5888.205092312483, 5925.111233314951, 5964.254468191476, 5180.559652429511, 5414.561753286613, 5880.911786323209, 5882.794102206488, 5888.322842873039, 5218.765155567932, 5670.688112153789, 5880.94119058804, 5922.822315330547, 5930.140129681085, 4380.934285985776, 5663.9716801415725, 5677.943220567741, 5754.683492407958, 5816.720321529257, 5688.236646639555, 5701.629394089371, 5752.13717942312, 5768.596198266081, 5779.306483222041, 5491.533219676372, 5891.646501209942, 5942.7920022799, 5949.345571986992, 6003.90994135097, 3543.397622404249, 3582.2835432913002, 3817.5609804872797, 3891.8637847675195, 3926.5877082907027, 4353.869383918487, 5462.699551524545, 5530.640508366943, 5765.8558536036935, 5845.912311315248, 5090.287359769562, 5607.523360514402, 5633.957662862009, 5668.319801623831, 5745.971270143623, 5340.570040631581, 5400.945990540202, 5581.014157425758, 5631.380548139783, 5646.520045796154, 5513.558915286687, 5527.866787308511, 5533.557315414677, 5533.889322213614, 5563.831595365019, 4692.671512994058, 5401.677968049699, 5409.2427060212385, 5644.576656750678, 5663.8017669383025, 4744.146053710365, 4961.677490963076, 5253.423972808218, 5297.920531192112, 5551.750171242223], "value": 4053.6731498287945, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.7977528089887, 729.9889652830831, 785.4227143049858, 793.3296364571942, 793.7690618821964, 14685.0, 15468.922655386736, 16015.958962667419, 16057.116858572788, 16061.75907361389, 14676.97261191717, 14721.558353249393, 14875.107493550395, 14911.030782999125, 14925.029873058244, 697.3584302441766, 861.2076889261863, 878.2490970220465, 884.4074470105013, 885.5616469847434, 723.9755745619941, 735.7902997645672, 869.4565896314804, 888.3958907942597, 896.2964073202537, 919.7654598077514, 919.9816003679922, 921.0329154387899, 922.4004397141878, 924.3575714878162, 915.1626261970289, 915.6932427636716, 915.844306467902, 916.587535608972, 918.2699753695828, 536.1421725239625, 558.4192439862538, 662.1061566884715, 680.4896327754184, 686.0292685849518, 14937.0, 14988.100713957198, 15002.774958375632, 15007.174605396698, 15028.699426011528, 13638.454461821515, 13889.930550347284, 13967.511137110152, 13998.160110393306, 14016.844447092933, 12451.93774031133, 12641.93679031599, 12687.048471364593, 13049.282289474075, 13139.60581182566, 4385.235079887798, 4613.308003799423, 4664.580187783082, 4712.057588482317, 4732.290156476522, 108951.45524272407, 111750.44124779405, 112365.99999999919, 112701.0, 116073.99999999916, 10877.891221087846, 10953.397563134104, 11116.388598627153, 11255.549778008788, 11343.376114313627, 21437.571248575252, 21441.78558214429, 21629.24297649575, 21687.78312216889, 21689.132434702435, 7817.8827317590285, 7829.765107046797, 8002.679892804339, 8224.753257402288, 8232.34141268697, 4355.891102722394, 4358.150160718693, 4398.252297109499, 4514.6614003949835, 4625.421822272216, 3090.8145511269395, 3494.4758286257265, 3573.4103872861206, 3638.872639457606, 3650.8539658413897, 649.8050584824533, 666.4701562258017, 666.8899631560738, 669.9698513566901, 675.1627981303149, 604.6764980735286, 616.3528295289927, 624.7313655128338, 628.522323034497, 635.9713812878432, 8457.323414126855, 8503.61733721984, 9000.50497222659, 9053.818923621491, 9056.683016094537, 582.347770497046, 620.683451439769, 630.713025573363, 631.1003878326271, 639.1339734659563, 3571.7321200910037, 4229.429027081366, 4376.321670141133, 4437.866863994085, 4458.910821783546, 160734.0, 160869.0, 163579.3642063588, 164441.0, 170083.29916700674, 136633.0, 138519.30740346437, 139305.60694392928, 140765.29617351847, 143376.0, 120172.3991380055, 122251.77748222582, 122534.0, 124639.3768031154, 126881.0, 8297.087320394872, 8346.916530834615, 8558.400911936355, 8598.61306241233, 8761.649534018568, 66817.0, 66913.66543167253, 67362.32637673756, 68066.0, 69065.65467172633, 74671.0, 95285.0, 98184.50907745416, 102527.94944101226, 104433.0, 10549.89450105489, 10682.0, 10936.098989778015, 11121.388323642277, 11200.607978720705, 11845.170838041255, 12225.938870305592, 12318.876811231772, 12804.29576373271, 12847.100702951078, 11702.005329547084, 11745.236559623598, 12073.517059317528, 12275.263484190977, 12356.443960022001, 11498.77002459963, 11552.422378880854, 11633.941830290794, 12195.51217951272, 12371.072169587496, 11290.604828830952, 11340.489677964677, 11373.0, 11951.880481195076, 12063.276203427822, 8983.775405614912, 9574.234061274941, 9595.90404095978, 9791.314607977372, 9907.157891579296, 8740.956295218482, 9096.363254572381, 9364.719058427985, 10092.444915529717, 11184.832227516432], "value": 7693.367055730912, "unit": "score"}], "name": "dromaeo_css", "value": 7386.234402779322, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 114.0, 113.0, 113.0, 115.0, 112.0, 113.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 95.0, 125.0, 178.0, 110.0, 107.0, 107.0, 108.0, 158.0, 140.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 182.0, 185.0, 188.0, 183.0, 184.0, 183.0, 185.0, 183.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 49.0, 88.0, 76.0, 85.0, 87.0, 82.0, 82.0, 57.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 68.0, 94.0, 69.0, 68.0, 68.0, 91.0, 67.0, 68.0, 89.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 87.0, 84.0, 87.0, 83.0, 87.0, 84.0, 87.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 107.0, 146.0, 95.0, 94.0, 96.0, 96.0, 96.0, 95.0], "value": 101.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 84.0, 86.0, 84.0, 85.0, 83.0, 86.0, 84.0, 86.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 53.0, 58.0, 59.0, 56.0, 56.0, 56.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 79.0, 74.0, 73.0, 70.0, 72.0, 71.0, 72.0, 73.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 77.0, 72.0, 83.0, 73.0, 97.0, 100.0, 100.0, 77.0, 88.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 140.0, 139.0, 138.0, 136.0, 140.0, 148.0, 192.0, 138.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 163.0, 169.0, 223.0, 194.0, 161.0, 161.0, 162.0, 165.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 66.0, 66.0, 66.0, 67.0, 68.0, 77.0, 64.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1445.9000000000003, "alertThreshold": 2.0}]} 20:07:58 INFO - Return code: 0 20:07:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:07:58 INFO - # TBPL SUCCESS # 20:07:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:07:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:07:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:07:58 INFO - 2016-11-08 20:07:58.721 screenresolution[1948:23841] starting screenresolution argv=screenresolution get 20:07:58 INFO - 2016-11-08 20:07:58.724 screenresolution[1948:23841] Display 0: 1600x1200x32@60 20:07:58 INFO - 2016-11-08 20:07:58.730 screenresolution[1949:23844] starting screenresolution argv=screenresolution list 20:07:58 INFO - Available Modes on Display 0 20:07:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:07:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:07:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:07:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:07:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:07:58 INFO - Intel Iris: 20:07:58 INFO - Chipset Model: Intel Iris 20:07:58 INFO - Type: GPU 20:07:58 INFO - Bus: Built-In 20:07:58 INFO - VRAM (Dynamic, Max): 1536 MB 20:07:58 INFO - Vendor: Intel (0x8086) 20:07:58 INFO - Device ID: 0x0a2e 20:07:58 INFO - Revision ID: 0x0009 20:07:58 INFO - Displays: 20:07:58 INFO - Display: 20:07:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:07:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:07:58 INFO - Display Serial Number: 1600x1200 60 20:07:58 INFO - Main Display: Yes 20:07:58 INFO - Mirror: Off 20:07:58 INFO - Online: Yes 20:07:58 INFO - Rotation: Supported 20:07:58 INFO - Return code: 0 20:07:58 INFO - Running post-action listener: _resource_record_post_action 20:07:58 INFO - [mozharness: 2016-11-09 04:07:58.965814Z] Finished run-tests step (success) 20:07:58 INFO - Running post-run listener: _resource_record_post_run 20:07:59 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 950272; Write bytes: 660458496; Read time: 5; Write time: 1915 20:07:59 INFO - TinderboxPrint: CPU usage
53.6% 20:07:59 INFO - TinderboxPrint: I/O read bytes / time
950,272 / 5 20:07:59 INFO - TinderboxPrint: I/O write bytes / time
660,458,496 / 1,915 20:07:59 INFO - TinderboxPrint: CPU idle
2,247.0 (46.4%) 20:07:59 INFO - TinderboxPrint: CPU system
973.8 (20.1%) 20:07:59 INFO - TinderboxPrint: CPU user
1,616.9 (33.4%) 20:07:59 INFO - TinderboxPrint: Swap in / out
363,778,048 / 0 20:07:59 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360546816; Write bytes: 356013568; Read time: 27510; Write time: 745 20:07:59 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 114688; Write bytes: 293168640; Read time: 2; Write time: 1130 20:07:59 INFO - Running post-run listener: _upload_blobber_files 20:07:59 INFO - Blob upload gear active. 20:07:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:07:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:07:59 INFO - (blobuploader) - INFO - Open directory for files ... 20:07:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:07:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:07:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:08:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:08:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:08:00 INFO - (blobuploader) - INFO - Done attempting. 20:08:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:08:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:08:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:08:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:08:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:08:01 INFO - (blobuploader) - INFO - Done attempting. 20:08:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:08:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:08:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:08:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:08:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:08:04 INFO - (blobuploader) - INFO - Done attempting. 20:08:04 INFO - (blobuploader) - INFO - Iteration through files over. 20:08:04 INFO - Return code: 0 20:08:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:08:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:08:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf964b20a1f5b51d0bac5930fcb38ec3716c02e775aa0f2251ba7d596d2f0edd1aca0426a5ef4470aa8a05627d8b1611115c97656e82e2a5ecae8531616a9cce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ce580d49684843afe8d78cfd40c5b5282b813ec699a399daebd4598e4e4257b86ed3f69e0c2b18a84512f0a943c5b207558f1a5b1fd68d6dce41d0c838eff76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ebf8329d6e902c0d972084694e8123d3b72b6b28b819a42c4a00b57ea69bbf0c9114c1c92464db3b108ce23424f5d8039a70f51f2c4b1e7aec61f75337c3179"} 20:08:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:08:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:08:04 INFO - Contents: 20:08:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf964b20a1f5b51d0bac5930fcb38ec3716c02e775aa0f2251ba7d596d2f0edd1aca0426a5ef4470aa8a05627d8b1611115c97656e82e2a5ecae8531616a9cce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ce580d49684843afe8d78cfd40c5b5282b813ec699a399daebd4598e4e4257b86ed3f69e0c2b18a84512f0a943c5b207558f1a5b1fd68d6dce41d0c838eff76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ebf8329d6e902c0d972084694e8123d3b72b6b28b819a42c4a00b57ea69bbf0c9114c1c92464db3b108ce23424f5d8039a70f51f2c4b1e7aec61f75337c3179"} 20:08:04 INFO - Running post-run listener: copy_logs_to_upload_dir 20:08:04 INFO - Copying logs to upload dir... 20:08:04 INFO - mkdir: /builds/slave/test/build/upload/logs 20:08:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.876256 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-08 20:08:04.330930) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 20:08:04.334792) ========= 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.PQUIaNdmp8/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.0ObP0UycqR/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf964b20a1f5b51d0bac5930fcb38ec3716c02e775aa0f2251ba7d596d2f0edd1aca0426a5ef4470aa8a05627d8b1611115c97656e82e2a5ecae8531616a9cce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ce580d49684843afe8d78cfd40c5b5282b813ec699a399daebd4598e4e4257b86ed3f69e0c2b18a84512f0a943c5b207558f1a5b1fd68d6dce41d0c838eff76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ebf8329d6e902c0d972084694e8123d3b72b6b28b819a42c4a00b57ea69bbf0c9114c1c92464db3b108ce23424f5d8039a70f51f2c4b1e7aec61f75337c3179"} build_url:https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011103 build_url: 'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf964b20a1f5b51d0bac5930fcb38ec3716c02e775aa0f2251ba7d596d2f0edd1aca0426a5ef4470aa8a05627d8b1611115c97656e82e2a5ecae8531616a9cce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ce580d49684843afe8d78cfd40c5b5282b813ec699a399daebd4598e4e4257b86ed3f69e0c2b18a84512f0a943c5b207558f1a5b1fd68d6dce41d0c838eff76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ebf8329d6e902c0d972084694e8123d3b72b6b28b819a42c4a00b57ea69bbf0c9114c1c92464db3b108ce23424f5d8039a70f51f2c4b1e7aec61f75337c3179"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 20:08:04.367901) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 20:08:04.368198) ========= 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.PQUIaNdmp8/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.0ObP0UycqR/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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.005256 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 20:08:04.415855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 20:08:04.416132) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 20:08:04.416447) ========= ========= Total master_lag: 0.17 =========