builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0217 starttime: 1477353267.73 results: success (0) buildid: 20161024141422 builduid: e5f1982dda5a4e5aadd09b918805f2e6 revision: 89651cd49e8bd5d0256fefaeb281f7125fb790fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 16:54:27.730046) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 16:54:27.730554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 16:54:27.730860) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 16:54:27.762148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:54:27.762565) ========= 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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-24 16:54:27-- 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% 166M=0s 2016-10-24 16:54:28 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.378892 ========= master_lag: 0.41 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:54:28.548578) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:54:28.548994) ========= 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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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.028454 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 16:54:28.601222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-24 16:54:28.604750) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 89651cd49e8bd5d0256fefaeb281f7125fb790fa --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 89651cd49e8bd5d0256fefaeb281f7125fb790fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Lru6FKkVDx/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.FSWuz8DKTX/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-24 16:54:28,685 truncating revision to first 12 chars 2016-10-24 16:54:28,685 Setting DEBUG logging. 2016-10-24 16:54:28,685 attempt 1/10 2016-10-24 16:54:28,685 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/89651cd49e8b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 16:54:30,673 unpacking tar archive at: mozilla-aurora-89651cd49e8b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.250875 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-24 16:54:30.881205) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 16:54:30.881651) ========= script_repo_revision: 89651cd49e8bd5d0256fefaeb281f7125fb790fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 16:54:30.882096) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 16:54:30.882373) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 16:54:30.901433) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-24 16:54:30.901857) ========= /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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:54:31 INFO - MultiFileLogger online at 20161024 16:54:31 in /builds/slave/test 16:54:31 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 16:54:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:54:31 INFO - {'append_to_log': False, 16:54:31 INFO - 'base_work_dir': '/builds/slave/test', 16:54:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:54:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:54:31 INFO - 'branch': 'Mozilla-Aurora', 16:54:31 INFO - 'buildbot_json_path': 'buildprops.json', 16:54:31 INFO - 'config_files': ('talos/mac_config.py',), 16:54:31 INFO - 'default_actions': ('clobber', 16:54:31 INFO - 'read-buildbot-config', 16:54:31 INFO - 'download-and-extract', 16:54:31 INFO - 'populate-webroot', 16:54:31 INFO - 'create-virtualenv', 16:54:31 INFO - 'install', 16:54:31 INFO - 'run-tests'), 16:54:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:54:31 INFO - 'download_minidump_stackwalk': True, 16:54:31 INFO - 'download_symbols': 'ondemand', 16:54:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:54:31 INFO - 'tooltool.py': '/tools/tooltool.py', 16:54:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:54:31 INFO - '/tools/misc-python/virtualenv.py')}, 16:54:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:54:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:54:31 INFO - 'installer_path': 'installer.exe', 16:54:31 INFO - 'log_level': 'info', 16:54:31 INFO - 'log_name': 'talos', 16:54:31 INFO - 'log_to_console': True, 16:54:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:54:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:54:31 INFO - 'opt_config_files': (), 16:54:31 INFO - 'pip_index': False, 16:54:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:54:31 INFO - 'cmd': ('bash', 16:54:31 INFO - '-c', 16:54:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:54:31 INFO - 'enabled': True, 16:54:31 INFO - 'halt_on_failure': False, 16:54:31 INFO - 'name': 'check_screen_resolution'},), 16:54:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:54:31 INFO - 'cmd': ('bash', 16:54:31 INFO - '-c', 16:54:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:54:31 INFO - 'enabled': True, 16:54:31 INFO - 'halt_on_failure': False, 16:54:31 INFO - 'name': 'check_screen_resolution'},), 16:54:31 INFO - 'run_cmd_checks_enabled': True, 16:54:31 INFO - 'sps_profile': False, 16:54:31 INFO - 'sps_profile_interval': 0, 16:54:31 INFO - 'suite': 'dromaeojs', 16:54:31 INFO - 'system_bits': '32', 16:54:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:54:31 INFO - 'title': 't-yosemite-r7-0217', 16:54:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:54:31 INFO - 'use_talos_json': True, 16:54:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:54:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:54:31 INFO - 'work_dir': 'build'} 16:54:31 INFO - [mozharness: 2016-10-24 23:54:31.091934Z] Running clobber step. 16:54:31 INFO - Running pre-action listener: _resource_record_pre_action 16:54:31 INFO - Running main action method: clobber 16:54:31 INFO - rmtree: /builds/slave/test/build 16:54:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:54:33 INFO - Running post-action listener: _resource_record_post_action 16:54:33 INFO - [mozharness: 2016-10-24 23:54:33.230481Z] Finished clobber step (success) 16:54:33 INFO - [mozharness: 2016-10-24 23:54:33.230638Z] Running read-buildbot-config step. 16:54:33 INFO - Running pre-action listener: _resource_record_pre_action 16:54:33 INFO - Running main action method: read_buildbot_config 16:54:33 INFO - Using buildbot properties: 16:54:33 INFO - { 16:54:33 INFO - "project": "", 16:54:33 INFO - "product": "firefox", 16:54:33 INFO - "script_repo_revision": "production", 16:54:33 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:54:33 INFO - "repository": "", 16:54:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:54:33 INFO - "buildid": "20161024141422", 16:54:33 INFO - "pgo_build": "False", 16:54:33 INFO - "basedir": "/builds/slave/test", 16:54:33 INFO - "buildnumber": 110, 16:54:33 INFO - "slavename": "t-yosemite-r7-0217", 16:54:33 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 16:54:33 INFO - "platform": "yosemite_r7", 16:54:33 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:54:33 INFO - "branch": "mozilla-aurora", 16:54:33 INFO - "repo_path": "releases/mozilla-aurora", 16:54:33 INFO - "revision": "89651cd49e8bd5d0256fefaeb281f7125fb790fa", 16:54:33 INFO - "stage_platform": "macosx64", 16:54:33 INFO - "builduid": "e5f1982dda5a4e5aadd09b918805f2e6", 16:54:33 INFO - "slavebuilddir": "test" 16:54:33 INFO - } 16:54:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 16:54:33 INFO - Running post-action listener: _resource_record_post_action 16:54:33 INFO - [mozharness: 2016-10-24 23:54:33.233965Z] Finished read-buildbot-config step (success) 16:54:33 INFO - [mozharness: 2016-10-24 23:54:33.234089Z] Running download-and-extract step. 16:54:33 INFO - Running pre-action listener: _resource_record_pre_action 16:54:33 INFO - Running main action method: download_and_extract 16:54:33 INFO - mkdir: /builds/slave/test/build/tests 16:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:33 INFO - trying https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 16:54:33 INFO - Downloading https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/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 16:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/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 16:54:34 INFO - Downloaded 1199 bytes. 16:54:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:54:34 INFO - Using the following test package requirements: 16:54:34 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:54:34 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:54:34 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 16:54:34 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:54:34 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 16:54:34 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:54:34 INFO - u'jsshell-mac.zip'], 16:54:34 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:54:34 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 16:54:34 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:54:34 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:54:34 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 16:54:34 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:54:34 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 16:54:34 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:54:34 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 16:54:34 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:54:34 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 16:54:34 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:54:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:54:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:54:34 INFO - Fetch https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:54:35 INFO - Expected file size: 16438612 16:54:41 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 16:54:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:54:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:54:41 INFO - Fetch https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:54:42 INFO - Expected file size: 16438612 16:54:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 16:54:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:54:49 INFO - Fetch https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 16:54:49 INFO - Expected file size: 14414081 16:54:50 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')]} 16:54:50 INFO - trying https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:54:50 INFO - Downloading https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 16:54:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/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 16:54:53 INFO - Downloaded 115434552 bytes. 16:54:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:54:53 INFO - mkdir: /builds/slave/test/properties 16:54:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:54:53 INFO - Writing to file /builds/slave/test/properties/build_url 16:54:53 INFO - Contents: 16:54:53 INFO - build_url:https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:54:53 INFO - Running post-action listener: _resource_record_post_action 16:54:53 INFO - Running post-action listener: set_extra_try_arguments 16:54:53 INFO - [mozharness: 2016-10-24 23:54:53.922277Z] Finished download-and-extract step (success) 16:54:53 INFO - [mozharness: 2016-10-24 23:54:53.922401Z] Running populate-webroot step. 16:54:53 INFO - Running pre-action listener: _resource_record_pre_action 16:54:53 INFO - Running main action method: populate_webroot 16:54:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:54:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:54:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:54:53 INFO - '--tppagecycles', 16:54:53 INFO - '7'], 16:54:53 INFO - 'tests': ['tsvgm']}}, 16:54:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:54:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:54:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:54:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:54:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:54:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:54:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:53 INFO - 'talos_options': ['--disable-e10s'], 16:54:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:53 INFO - 'talos_options': ['--disable-e10s'], 16:54:53 INFO - 'tests': ['damp', 'tps']}, 16:54:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:53 INFO - 'tests': ['damp', 'tps']}, 16:54:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:54:53 INFO - 'tests': ['dromaeo_dom']}, 16:54:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:54:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:54:53 INFO - 'tests': ['basic_compositor_video']}, 16:54:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:54:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:54:53 INFO - 'tests': ['a11yr', 16:54:53 INFO - 'ts_paint', 16:54:53 INFO - 'tpaint', 16:54:53 INFO - 'sessionrestore', 16:54:53 INFO - 'sessionrestore_no_auto_restore', 16:54:53 INFO - 'tabpaint']}, 16:54:53 INFO - 'other-e10s': {'tests': ['a11yr', 16:54:53 INFO - 'ts_paint', 16:54:53 INFO - 'tpaint', 16:54:53 INFO - 'sessionrestore', 16:54:53 INFO - 'sessionrestore_no_auto_restore', 16:54:53 INFO - 'tabpaint']}, 16:54:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:54:53 INFO - 'ts_paint', 16:54:53 INFO - 'tpaint', 16:54:53 INFO - 'sessionrestore', 16:54:53 INFO - 'sessionrestore_no_auto_restore', 16:54:53 INFO - 'tabpaint']}, 16:54:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:54:53 INFO - 'ts_paint', 16:54:53 INFO - 'tpaint', 16:54:53 INFO - 'sessionrestore', 16:54:53 INFO - 'sessionrestore_no_auto_restore', 16:54:53 INFO - 'tabpaint']}, 16:54:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:54:53 INFO - 'tests': ['a11yr', 16:54:53 INFO - 'ts_paint', 16:54:53 INFO - 'tpaint', 16:54:53 INFO - 'sessionrestore', 16:54:53 INFO - 'sessionrestore_no_auto_restore', 16:54:53 INFO - 'tabpaint']}, 16:54:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:54:53 INFO - 'tests': ['a11yr', 16:54:53 INFO - 'ts_paint', 16:54:53 INFO - 'tpaint', 16:54:53 INFO - 'sessionrestore', 16:54:53 INFO - 'sessionrestore_no_auto_restore', 16:54:53 INFO - 'tabpaint']}, 16:54:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:54:53 INFO - 'tests': ['tsvgx', 16:54:53 INFO - 'tsvgr_opacity', 16:54:53 INFO - 'tart', 16:54:53 INFO - 'tscrollx', 16:54:53 INFO - 'cart']}, 16:54:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:54:53 INFO - 'tsvgr_opacity', 16:54:53 INFO - 'tart', 16:54:53 INFO - 'tscrollx', 16:54:53 INFO - 'cart']}, 16:54:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:53 INFO - 'talos_options': ['--disable-e10s'], 16:54:53 INFO - 'tests': ['tp5o']}, 16:54:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:53 INFO - 'tests': ['tp5o']}, 16:54:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:53 INFO - 'talos_options': ['--disable-e10s', 16:54:53 INFO - '--xperf_path', 16:54:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:53 INFO - 'tests': ['tp5n']}, 16:54:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:53 INFO - 'talos_options': ['--xperf_path', 16:54:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:53 INFO - 'tests': ['tp5n']}}, 16:54:53 INFO - 'talos.zip': {'path': '', 16:54:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:54:53 INFO - Running post-action listener: _resource_record_post_action 16:54:53 INFO - [mozharness: 2016-10-24 23:54:53.941078Z] Finished populate-webroot step (success) 16:54:53 INFO - [mozharness: 2016-10-24 23:54:53.941211Z] Running create-virtualenv step. 16:54:53 INFO - Running pre-action listener: _resource_record_pre_action 16:54:53 INFO - Running main action method: create_virtualenv 16:54:53 INFO - Creating virtualenv /builds/slave/test/build/venv 16:54:53 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 16:54:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:54:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:54:54 INFO - Using real prefix '/tools/python27' 16:54:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:54:54 INFO - Installing distribute.............................................................................................................................................................................................done. 16:54:57 INFO - Installing pip.................done. 16:54:57 INFO - Return code: 0 16:54:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:54:57 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')]} 16:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:57 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')]} 16:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:57 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 0x102c26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997257a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a3ad30>, '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 0x1028a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a32b20>, '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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:54:57 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 16:54:57 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 16:54:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lru6FKkVDx/Render', 16:54:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:57 INFO - 'HOME': '/Users/cltbld', 16:54:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:57 INFO - 'LOGNAME': 'cltbld', 16:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:57 INFO - 'MOZ_NO_REMOTE': '1', 16:54:57 INFO - 'NO_EM_RESTART': '1', 16:54:57 INFO - 'PAGER': '/bin/cat', 16:54:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:57 INFO - 'PWD': '/builds/slave/test', 16:54:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:57 INFO - 'SHELL': '/bin/bash', 16:54:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSWuz8DKTX/Listeners', 16:54:57 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:54:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:57 INFO - 'USER': 'cltbld', 16:54:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:57 INFO - 'XPC_FLAGS': '0x0', 16:54:57 INFO - 'XPC_SERVICE_NAME': '0', 16:54:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:57 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 16:54:57 INFO - Cleaning up... 16:54:57 INFO - Return code: 0 16:54:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:54:57 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')]} 16:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:57 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')]} 16:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:57 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 0x102c26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997257a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a3ad30>, '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 0x1028a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a32b20>, '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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:54:57 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 16:54:57 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 16:54:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lru6FKkVDx/Render', 16:54:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:57 INFO - 'HOME': '/Users/cltbld', 16:54:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:57 INFO - 'LOGNAME': 'cltbld', 16:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:57 INFO - 'MOZ_NO_REMOTE': '1', 16:54:57 INFO - 'NO_EM_RESTART': '1', 16:54:57 INFO - 'PAGER': '/bin/cat', 16:54:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:57 INFO - 'PWD': '/builds/slave/test', 16:54:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:57 INFO - 'SHELL': '/bin/bash', 16:54:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSWuz8DKTX/Listeners', 16:54:57 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:54:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:57 INFO - 'USER': 'cltbld', 16:54:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:57 INFO - 'XPC_FLAGS': '0x0', 16:54:57 INFO - 'XPC_SERVICE_NAME': '0', 16:54:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:58 INFO - Downloading/unpacking psutil>=3.1.1 16:54:58 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 16:54:58 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 16:54:58 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 16:54:58 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 16:54:58 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 16:54:58 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 16:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:55:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:01 INFO - Installing collected packages: psutil 16:55:01 INFO - Running setup.py install for psutil 16:55:01 INFO - building 'psutil._psutil_osx' extension 16:55:01 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 16:55:01 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 16:55:01 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 16:55:01 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 16:55:02 INFO - building 'psutil._psutil_posix' extension 16:55:02 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 16:55:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:55:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:55:02 INFO - ^ 16:55:02 INFO - 1 warning generated. 16:55:02 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 16:55:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:02 INFO - Successfully installed psutil 16:55:02 INFO - Cleaning up... 16:55:02 INFO - Return code: 0 16:55:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997257a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a3ad30>, '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 0x1028a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a32b20>, '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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:55:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:55:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lru6FKkVDx/Render', 16:55:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:02 INFO - 'HOME': '/Users/cltbld', 16:55:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:02 INFO - 'LOGNAME': 'cltbld', 16:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:02 INFO - 'MOZ_NO_REMOTE': '1', 16:55:02 INFO - 'NO_EM_RESTART': '1', 16:55:02 INFO - 'PAGER': '/bin/cat', 16:55:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:02 INFO - 'PWD': '/builds/slave/test', 16:55:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:02 INFO - 'SHELL': '/bin/bash', 16:55:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSWuz8DKTX/Listeners', 16:55:02 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:55:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:02 INFO - 'USER': 'cltbld', 16:55:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:02 INFO - 'XPC_FLAGS': '0x0', 16:55:02 INFO - 'XPC_SERVICE_NAME': '0', 16:55:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:55:05 INFO - Installing collected packages: mozsystemmonitor 16:55:05 INFO - Running setup.py install for mozsystemmonitor 16:55:05 INFO - Successfully installed mozsystemmonitor 16:55:05 INFO - Cleaning up... 16:55:05 INFO - Return code: 0 16:55:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102c26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997257a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a3ad30>, '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 0x1028a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a32b20>, '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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:55:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:55:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lru6FKkVDx/Render', 16:55:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:05 INFO - 'HOME': '/Users/cltbld', 16:55:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:05 INFO - 'LOGNAME': 'cltbld', 16:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:05 INFO - 'MOZ_NO_REMOTE': '1', 16:55:05 INFO - 'NO_EM_RESTART': '1', 16:55:05 INFO - 'PAGER': '/bin/cat', 16:55:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:05 INFO - 'PWD': '/builds/slave/test', 16:55:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:05 INFO - 'SHELL': '/bin/bash', 16:55:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSWuz8DKTX/Listeners', 16:55:05 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:55:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:05 INFO - 'USER': 'cltbld', 16:55:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:05 INFO - 'XPC_FLAGS': '0x0', 16:55:05 INFO - 'XPC_SERVICE_NAME': '0', 16:55:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:05 INFO - Downloading/unpacking jsonschema==2.5.1 16:55:05 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 16:55:05 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 16:55:05 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 16:55:05 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 16:55:05 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 16:55:05 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 16:55:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:55:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:08 INFO - Downloading functools32-3.2.3-2.tar.gz 16:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:55:08 INFO - warning: no files found matching '*.txt' 16:55:08 INFO - no previously-included directories found matching 'build' 16:55:08 INFO - no previously-included directories found matching 'dist' 16:55:08 INFO - no previously-included directories found matching '.git*' 16:55:08 INFO - Installing collected packages: jsonschema, functools32 16:55:08 INFO - Running setup.py install for functools32 16:55:08 INFO - warning: no files found matching '*.txt' 16:55:08 INFO - no previously-included directories found matching 'build' 16:55:08 INFO - no previously-included directories found matching 'dist' 16:55:08 INFO - no previously-included directories found matching '.git*' 16:55:08 INFO - Successfully installed jsonschema functools32 16:55:08 INFO - Cleaning up... 16:55:08 INFO - Return code: 0 16:55:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:55:08 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')]} 16:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:08 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')]} 16:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:08 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 0x102c26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997257a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a3ad30>, '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 0x1028a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a32b20>, '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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:55:08 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 16:55:08 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 16:55:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lru6FKkVDx/Render', 16:55:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:08 INFO - 'HOME': '/Users/cltbld', 16:55:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:08 INFO - 'LOGNAME': 'cltbld', 16:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:08 INFO - 'MOZ_NO_REMOTE': '1', 16:55:08 INFO - 'NO_EM_RESTART': '1', 16:55:08 INFO - 'PAGER': '/bin/cat', 16:55:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:08 INFO - 'PWD': '/builds/slave/test', 16:55:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:08 INFO - 'SHELL': '/bin/bash', 16:55:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSWuz8DKTX/Listeners', 16:55:08 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:55:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:08 INFO - 'USER': 'cltbld', 16:55:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:08 INFO - 'XPC_FLAGS': '0x0', 16:55:08 INFO - 'XPC_SERVICE_NAME': '0', 16:55:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:55:09 INFO - Cleaning up... 16:55:09 INFO - Return code: 0 16:55:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:09 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 0x102c26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997257a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a3ad30>, '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 0x1028a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a32b20>, '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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:55:09 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 16:55:09 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 16:55:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lru6FKkVDx/Render', 16:55:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:09 INFO - 'HOME': '/Users/cltbld', 16:55:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:09 INFO - 'LOGNAME': 'cltbld', 16:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:09 INFO - 'MOZ_NO_REMOTE': '1', 16:55:09 INFO - 'NO_EM_RESTART': '1', 16:55:09 INFO - 'PAGER': '/bin/cat', 16:55:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:09 INFO - 'PWD': '/builds/slave/test', 16:55:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:09 INFO - 'SHELL': '/bin/bash', 16:55:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSWuz8DKTX/Listeners', 16:55:09 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:55:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:09 INFO - 'USER': 'cltbld', 16:55:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:09 INFO - 'XPC_FLAGS': '0x0', 16:55:09 INFO - 'XPC_SERVICE_NAME': '0', 16:55:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:09 INFO - Downloading/unpacking blobuploader==1.2.4 16:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:11 INFO - Downloading blobuploader-1.2.4.tar.gz 16:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:55:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:55:12 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 16:55:12 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 16:55:12 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 16:55:12 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 16:55:12 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 16:55:12 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 16:55:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:55:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:55:12 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 16:55:12 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 16:55:12 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 16:55:12 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 16:55:12 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 16:55:12 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 16:55:13 INFO - Downloading docopt-0.6.1.tar.gz 16:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:55:13 INFO - Installing collected packages: blobuploader, requests, docopt 16:55:13 INFO - Running setup.py install for blobuploader 16:55:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:55:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:55:13 INFO - Running setup.py install for requests 16:55:13 INFO - Running setup.py install for docopt 16:55:14 INFO - Successfully installed blobuploader requests docopt 16:55:14 INFO - Cleaning up... 16:55:14 INFO - Return code: 0 16:55:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:55:14 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')]} 16:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:14 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')]} 16:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:14 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 0x102c26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997257a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a3ad30>, '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 0x1028a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a32b20>, '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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:55:14 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 16:55:14 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 16:55:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lru6FKkVDx/Render', 16:55:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:14 INFO - 'HOME': '/Users/cltbld', 16:55:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:14 INFO - 'LOGNAME': 'cltbld', 16:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:14 INFO - 'MOZ_NO_REMOTE': '1', 16:55:14 INFO - 'NO_EM_RESTART': '1', 16:55:14 INFO - 'PAGER': '/bin/cat', 16:55:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:14 INFO - 'PWD': '/builds/slave/test', 16:55:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:14 INFO - 'SHELL': '/bin/bash', 16:55:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSWuz8DKTX/Listeners', 16:55:14 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:55:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:14 INFO - 'USER': 'cltbld', 16:55:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:14 INFO - 'XPC_FLAGS': '0x0', 16:55:14 INFO - 'XPC_SERVICE_NAME': '0', 16:55:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:55:14 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-82gNi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:55:14 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-szwY7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:55:14 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-5LDS6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:55:14 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-cMFV3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:55:14 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-LWt9Xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:55:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-wZ3nnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:55:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-mhmAoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:55:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-robsui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:55:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-ZXEY8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:55:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-3MkOlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:55:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Mg61k1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:55:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-J_2vud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:55:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Kkc_zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:55:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-MssLTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Hn6zFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:55:16 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-hJgSGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:55:16 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-uT8GPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:55:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:55:16 INFO - Running setup.py install for manifestparser 16:55:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:55:16 INFO - Running setup.py install for mozcrash 16:55:16 INFO - Running setup.py install for mozdebug 16:55:16 INFO - Running setup.py install for mozdevice 16:55:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:55:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:55:16 INFO - Running setup.py install for mozfile 16:55:16 INFO - Running setup.py install for mozhttpd 16:55:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:55:17 INFO - Running setup.py install for mozinfo 16:55:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:55:17 INFO - Running setup.py install for mozInstall 16:55:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:55:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:55:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:55:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:55:17 INFO - Running setup.py install for mozleak 16:55:17 INFO - Running setup.py install for mozlog 16:55:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:55:17 INFO - Running setup.py install for moznetwork 16:55:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:55:17 INFO - Running setup.py install for mozprocess 16:55:18 INFO - Running setup.py install for mozprofile 16:55:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:55:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:55:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:55:18 INFO - Running setup.py install for mozrunner 16:55:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:55:18 INFO - Running setup.py install for mozscreenshot 16:55:18 INFO - Running setup.py install for moztest 16:55:18 INFO - Running setup.py install for mozversion 16:55:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:55:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:55:18 INFO - Cleaning up... 16:55:18 INFO - Return code: 0 16:55:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:55:18 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')]} 16:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:18 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')]} 16:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:18 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 0x102c26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997257a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a3ad30>, '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 0x1028a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a32b20>, '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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:55:18 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 16:55:18 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 16:55:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lru6FKkVDx/Render', 16:55:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:18 INFO - 'HOME': '/Users/cltbld', 16:55:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:18 INFO - 'LOGNAME': 'cltbld', 16:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:18 INFO - 'MOZ_NO_REMOTE': '1', 16:55:18 INFO - 'NO_EM_RESTART': '1', 16:55:18 INFO - 'PAGER': '/bin/cat', 16:55:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:18 INFO - 'PWD': '/builds/slave/test', 16:55:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:18 INFO - 'SHELL': '/bin/bash', 16:55:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSWuz8DKTX/Listeners', 16:55:18 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:55:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:18 INFO - 'USER': 'cltbld', 16:55:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:18 INFO - 'XPC_FLAGS': '0x0', 16:55:18 INFO - 'XPC_SERVICE_NAME': '0', 16:55:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:55:19 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-aJM6CL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:55:19 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)) 16:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:55:19 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-5SH17D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:55:19 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)) 16:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:55:19 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-ZJ9OXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:55:19 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)) 16:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:55:19 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-XKMtuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:55:19 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)) 16:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:55:19 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-5yS5te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:55:19 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)) 16:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:55:19 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-PHgIcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:55:19 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)) 16:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:55:19 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-XpdIXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:55:19 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)) 16:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:55:19 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-bdl3qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:55:19 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)) 16:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:55:19 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-mVWaXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:55:20 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)) 16:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:55:20 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-QYjerP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:55:20 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)) 16:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:55:20 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-0EjMHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:55:20 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)) 16:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:55:20 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-EGM4xO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:55:20 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)) 16:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:55:20 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-GejLPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:55:20 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)) 16:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:55:20 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-5rKyVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:55:20 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)) 16:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:20 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-mZqH_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:20 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)) 16:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:55:20 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-UgPO20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:55:20 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)) 16:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:55:20 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-kpFEem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:55:20 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)) 16:55:20 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)) 16:55:20 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)) 16:55:20 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)) 16:55:20 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)) 16:55:20 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)) 16:55:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:55:20 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 16:55:20 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 16:55:20 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 16:55:20 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 16:55:20 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 16:55:20 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 16:55:23 INFO - Downloading blessings-1.6.tar.gz 16:55:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:55:23 INFO - Installing collected packages: blessings 16:55:23 INFO - Running setup.py install for blessings 16:55:23 INFO - Successfully installed blessings 16:55:23 INFO - Cleaning up... 16:55:23 INFO - Return code: 0 16:55:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:55:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:55:24 INFO - Reading from file tmpfile_stdout 16:55:24 INFO - Current package versions: 16:55:24 INFO - blessings == 1.6 16:55:24 INFO - blobuploader == 1.2.4 16:55:24 INFO - docopt == 0.6.1 16:55:24 INFO - functools32 == 3.2.3-2 16:55:24 INFO - jsonschema == 2.5.1 16:55:24 INFO - manifestparser == 1.1 16:55:24 INFO - mozInstall == 1.12 16:55:24 INFO - mozcrash == 0.17 16:55:24 INFO - mozdebug == 0.1 16:55:24 INFO - mozdevice == 0.48 16:55:24 INFO - mozfile == 1.2 16:55:24 INFO - mozhttpd == 0.7 16:55:24 INFO - mozinfo == 0.9 16:55:24 INFO - mozleak == 0.1 16:55:24 INFO - mozlog == 3.4 16:55:24 INFO - moznetwork == 0.27 16:55:24 INFO - mozprocess == 0.23 16:55:24 INFO - mozprofile == 0.28 16:55:24 INFO - mozrunner == 6.12 16:55:24 INFO - mozscreenshot == 0.1 16:55:24 INFO - mozsystemmonitor == 0.3 16:55:24 INFO - moztest == 0.7 16:55:24 INFO - mozversion == 1.4 16:55:24 INFO - psutil == 3.1.1 16:55:24 INFO - requests == 1.2.3 16:55:24 INFO - wsgiref == 0.1.2 16:55:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:24 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 0x102c26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997257a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a3ad30>, '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 0x1028a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a32b20>, '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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:55:24 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 16:55:24 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 16:55:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lru6FKkVDx/Render', 16:55:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:24 INFO - 'HOME': '/Users/cltbld', 16:55:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:24 INFO - 'LOGNAME': 'cltbld', 16:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:24 INFO - 'MOZ_NO_REMOTE': '1', 16:55:24 INFO - 'NO_EM_RESTART': '1', 16:55:24 INFO - 'PAGER': '/bin/cat', 16:55:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:24 INFO - 'PWD': '/builds/slave/test', 16:55:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:24 INFO - 'SHELL': '/bin/bash', 16:55:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSWuz8DKTX/Listeners', 16:55:24 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:55:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:24 INFO - 'USER': 'cltbld', 16:55:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:24 INFO - 'XPC_FLAGS': '0x0', 16:55:24 INFO - 'XPC_SERVICE_NAME': '0', 16:55:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:24 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)) 16:55:24 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)) 16:55:24 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)) 16:55:24 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)) 16:55:24 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)) 16:55:24 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)) 16:55:24 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)) 16:55:24 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)) 16:55:24 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)) 16:55:24 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)) 16:55:24 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)) 16:55:24 INFO - Cleaning up... 16:55:24 INFO - Return code: 0 16:55:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c26490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b9c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f997257a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a3ad30>, '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 0x1028a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a32b20>, '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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:55:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lru6FKkVDx/Render', 16:55:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:24 INFO - 'HOME': '/Users/cltbld', 16:55:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:24 INFO - 'LOGNAME': 'cltbld', 16:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:24 INFO - 'MOZ_NO_REMOTE': '1', 16:55:24 INFO - 'NO_EM_RESTART': '1', 16:55:24 INFO - 'PAGER': '/bin/cat', 16:55:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:24 INFO - 'PWD': '/builds/slave/test', 16:55:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:24 INFO - 'SHELL': '/bin/bash', 16:55:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSWuz8DKTX/Listeners', 16:55:24 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:55:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:24 INFO - 'USER': 'cltbld', 16:55:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:24 INFO - 'XPC_FLAGS': '0x0', 16:55:24 INFO - 'XPC_SERVICE_NAME': '0', 16:55:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:55:24 INFO - Cleaning up... 16:55:24 INFO - Return code: 0 16:55:24 INFO - Running post-action listener: _resource_record_post_action 16:55:24 INFO - Running post-action listener: _start_resource_monitoring 16:55:24 INFO - Starting resource monitoring. 16:55:25 INFO - [mozharness: 2016-10-24 23:55:25.002446Z] Finished create-virtualenv step (success) 16:55:25 INFO - [mozharness: 2016-10-24 23:55:25.003491Z] Running install step. 16:55:25 INFO - Running pre-action listener: _resource_record_pre_action 16:55:25 INFO - Running main action method: install 16:55:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:55:25 INFO - Reading from file tmpfile_stdout 16:55:25 INFO - Detecting whether we're running mozinstall >=1.0... 16:55:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:55:25 INFO - Reading from file tmpfile_stdout 16:55:25 INFO - Output received: 16:55:25 INFO - Usage: mozinstall [options] installer 16:55:25 INFO - Options: 16:55:25 INFO - -h, --help show this help message and exit 16:55:25 INFO - -d DEST, --destination=DEST 16:55:25 INFO - Directory to install application into. [default: 16:55:25 INFO - "/builds/slave/test"] 16:55:25 INFO - --app=APP Application being installed. [default: firefox] 16:55:25 INFO - mkdir: /builds/slave/test/build/application 16:55:25 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'] 16:55:25 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 16:55:57 INFO - Reading from file tmpfile_stdout 16:55:57 INFO - Output received: 16:55:57 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:55:57 INFO - Running post-action listener: _resource_record_post_action 16:55:57 INFO - [mozharness: 2016-10-24 23:55:57.893585Z] Finished install step (success) 16:55:57 INFO - [mozharness: 2016-10-24 23:55:57.893686Z] Running run-tests step. 16:55:57 INFO - Running pre-action listener: _resource_record_pre_action 16:55:57 INFO - Running main action method: run_tests 16:55:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:55:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:55:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:55:57 INFO - 2016-10-24 16:55:57.906 screenresolution[1634:7399] starting screenresolution argv=screenresolution get 16:55:57 INFO - 2016-10-24 16:55:57.908 screenresolution[1634:7399] Display 0: 1600x1200x32@60 16:55:57 INFO - 2016-10-24 16:55:57.913 screenresolution[1635:7402] starting screenresolution argv=screenresolution list 16:55:57 INFO - Available Modes on Display 0 16:55:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:55:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:55:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:55:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:55:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:55:58 INFO - Intel Iris: 16:55:58 INFO - Chipset Model: Intel Iris 16:55:58 INFO - Type: GPU 16:55:58 INFO - Bus: Built-In 16:55:58 INFO - VRAM (Dynamic, Max): 1536 MB 16:55:58 INFO - Vendor: Intel (0x8086) 16:55:58 INFO - Device ID: 0x0a2e 16:55:58 INFO - Revision ID: 0x0009 16:55:58 INFO - Displays: 16:55:58 INFO - Display: 16:55:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:55:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:55:58 INFO - Display Serial Number: 1600x1200 60 16:55:58 INFO - Main Display: Yes 16:55:58 INFO - Mirror: Off 16:55:58 INFO - Online: Yes 16:55:58 INFO - Rotation: Supported 16:55:58 INFO - Return code: 0 16:55:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:55:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:55:58 INFO - Python 2.7.3 16:55:58 INFO - Return code: 0 16:55:58 INFO - grabbing minidump binary from tooltool 16:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:58 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 0x102a3ad30>, '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 0x1028a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a32b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:55:58 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 16:55:58 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 16:55:58 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 16:55:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:55:58 INFO - Return code: 0 16:55:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:55:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:55:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:55:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:55:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:55:58 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/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0217', '--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 16:55:58 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/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0217 --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 16:55:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lru6FKkVDx/Render', 16:55:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:58 INFO - 'HOME': '/Users/cltbld', 16:55:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:58 INFO - 'LOGNAME': 'cltbld', 16:55:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:55:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:58 INFO - 'MOZ_NO_REMOTE': '1', 16:55:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:55:58 INFO - 'NO_EM_RESTART': '1', 16:55:58 INFO - 'PAGER': '/bin/cat', 16:55:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:58 INFO - 'PWD': '/builds/slave/test', 16:55:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:55:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:58 INFO - 'SHELL': '/bin/bash', 16:55:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSWuz8DKTX/Listeners', 16:55:58 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:55:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:58 INFO - 'USER': 'cltbld', 16:55:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:58 INFO - 'XPC_FLAGS': '0x0', 16:55:58 INFO - 'XPC_SERVICE_NAME': '0', 16:55:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:58 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/WQKYPom2Q3C46E7BNK03Tw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0217', '--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 16:55:58 INFO - mozversion application_buildid: 20161024141422 16:55:58 INFO - mozversion application_changeset: 89651cd49e8bd5d0256fefaeb281f7125fb790fa 16:55:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:55:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:55:58 INFO - mozversion application_name: Firefox 16:55:58 INFO - mozversion application_remotingname: firefox-dev 16:55:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:55:58 INFO - mozversion application_vendor: Mozilla 16:55:58 INFO - mozversion application_version: 51.0a2 16:55:58 INFO - mozversion platform_buildid: 20161024141422 16:55:58 INFO - mozversion platform_changeset: 89651cd49e8bd5d0256fefaeb281f7125fb790fa 16:55:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:55:58 INFO - mozversion platform_version: 51.0a2 16:55:58 INFO - using testdate: 1477353358 16:55:58 INFO - actual date: 1477353358 16:55:58 INFO - starting webserver on 'localhost:49266' 16:55:58 INFO - SUITE-START | Running 2 tests 16:55:58 INFO - TEST-START | dromaeo_css 16:55:58 INFO - operating with platform_type : mac_ 16:55:58 INFO - Initialising browser for dromaeo_css test... 16:55:58 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpticYa0/profile http://localhost:49266/getInfo.html) 16:56:00 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 16:56:00 INFO - PROCESS | 1645 | colorDepth:24 16:56:00 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 16:56:00 INFO - PROCESS | 1645 | __metrics 16:56:00 INFO - PROCESS | 1645 | 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" 16:56:00 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:56:01 INFO - TEST-INFO | 1645: exit 0 16:56:01 INFO - Browser initialized. 16:56:01 INFO - Running cycle 1/1 for dromaeo_css test... 16:56:01 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpticYa0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:13 INFO - PROCESS | 1646 | RSS: Main: 219979776 16:56:13 INFO - PROCESS | 1646 | 16:57:04 INFO - PROCESS | 1646 | 1477353424422 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] 16:59:16 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 16:59:17 INFO - PROCESS | 1646 | RSS: Main: 363548672 16:59:17 INFO - PROCESS | 1646 | 17:02:20 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 17:02:21 INFO - PROCESS | 1646 | RSS: Main: 350945280 17:02:21 INFO - PROCESS | 1646 | 17:05:23 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 17:05:24 INFO - PROCESS | 1646 | RSS: Main: 318349312 17:05:24 INFO - PROCESS | 1646 | 17:08:26 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 17:08:26 INFO - PROCESS | 1646 | RSS: Main: 342228992 17:08:26 INFO - PROCESS | 1646 | 17:11:30 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 17:11:30 INFO - PROCESS | 1646 | RSS: Main: 311054336 17:11:30 INFO - PROCESS | 1646 | 17:14:34 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 17:14:34 INFO - PROCESS | 1646 | RSS: Main: 510017536 17:14:34 INFO - PROCESS | 1646 | 17:14:34 INFO - PROCESS | 1646 | __start_tp_report 17:14:34 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 17:14:34 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 17:14:34 INFO - PROCESS | 1646 | |i|pagename|runs| 17:14:34 INFO - PROCESS | 1646 | |0;dojo.html;2943.0140902797566;3347.9163020924475;3364.2262279675674;3397.5413319201903;3416.914577135571;5712.914306285399;5735.512481439077;5760.193572899798;5791.131330300452;5793.768249270035;5602.579806514507;5656.2081308616725;5696.829095127153;5717.771289148429;5719.485246327829;5192.714400707979;5195.350581177362;5197.038547868638;5229.3201883755055;5240.161574148137;5176.792928282883;5201.401838788531;5213.087709650815;5271.94561087782;5338.91991620126;5249.42256351801;5297.867553311159;5311.521963023327;5315.627906046579;5318.734063296839;5267.315249017642;5270.025045366619;5281.683099014033;5339.065663508871;5342.305500284938;5193.272941788153;5288.788448462057;5303.734813259361;5313.973430132824;5325.360956685223;5609.214709940612;5657.773689052433;5675.432456754333;5679.716014199274;5796.62321949072;6240.563160578761;6299.779507717254;6318.147050148263;6331.715072821734;6367.013112967497;5437.293151890269;6360.109584658151;6362.331955144736;6370.267419246799;6391.137196478462;5749.597528172988;5771.192033115367;5777.508911742465;5887.764489420418;5904.645721256781;5366.812161574326;6257.217847769029;6324.114623952651;6326.019466982625;6331.778387756499;6225.564210505221;6245.75016999324;6248.593841400295;6251.874962500725;6256;6198.163247961467;6298.938056623745;6323.841903952438;6346.873062538723;6347.238331400262;6014.127951447016;6117.583823141572;6122.642214636352;6185.226846644169;6235.469985051322;6271.372862713783;6314.936850631435;6315.5894866833505;6322.936770632326;6342.4926005919415;4895.534924182197;4897.755112244374;4932.950670493321;4949.604031677457;4982.77577509013;4395.956040439554;4401.22978478765;4409;4476.910461790746;4479.417675702138;5788.0449725795615;5836.007878660638;5836.270466191726;5878.147668588031;5899.203607513016;6327.303996560375;6357.141785858942;6361.777337793155;6364.777232796922;6395.872082558323;5798.565107616945;5838.416158384212;5854.4730974212525;5854.930271203495;5893.2044174035955;5333.839984800462;5378.381486129145;5378.596605254622;5412.107002344569;5417.485338892799;6342.6194428335375;6352.015437607179;6366.140571023038;6373.5857169283845;6384.680765961776;6371.55399122057;6374.490040796818;6378.234611846423;6389.840253993687;6393.968030159819;5218.55642270396;6296.6851657417865;6322.683865806599;6335.2714437838395;6385.361463853763;6182.443580077815;6196.1015652731;6219.657918814509;6251.68741562911;6291;6348.809535713936;6354.841128971812;6363.5863668861375;6375.840603984938;6382;6012.3386427493815;6144.56988010835;6222.657753823583;6229.5327850410495;6233.2208473940755;6054.122152287981;6107.431569637723;6120.9347721082095;6127.372786728296;6136.73353236607;6003.189569408074;6045.123457098608;6050.788222412194;6088.429087384993;6116.981396139352;6180.8763824722355;6228.719707613078;6243.531735119794;6255.71849266775;6257.186565746606;4885.9022819544125;6010.519158467225;6013.579049466495;6032.547558933185;6064.939350606437 17:14:34 INFO - PROCESS | 1646 | |1;ext.html;436.53290978652836;450.4144612004394;475.40811689446645;483.8282409744538;484.1261522951073;30839;38454.84635460937;41874.37188442168;42031.36952945704;44253.55746442534;43357.78321108398;43953.34069988953;44000.55999440005;44002;44071.89820254495;9841.852372214405;10004.59981600735;10034.247431442634;10040.09639132478;10047.145992590602;8853.557322133867;9047.638094476213;9821.410715357102;12303.815442768366;12617.242965422058;12352.567660131852;12373.752524949496;12380.195287306342;12383;12412.93793531031;12333.198342107735;12395.504179832886;12395.690107747288;12409;12419;8747.343949203836;8979.236764874993;10219.437930913797;10442.47787610624;12220.388980551026;41257;41638.58361416377;41650.583494164974;41732.79133604343;41780.164396711894;3335.983320083384;3424.109731469811;3709.2952339055764;3951.7036222283446;4066.0444795473336;30133;30195.943141989927;30991.22521936947;31367.686323136706;32319.353612927844;3190.872365105393;3216.437123503401;3233.7413006959387;3283.5238890360765;3289.1283809790425;519185;524401;525755;527861;530141.3492932549;61123;61436;61557.69221153955;61595;61646.38353616496;64324.35675643184;64510.35489645044;64526.677366612865;64622.67688661621;64639.67680161569;16839.905406148562;17417.65164696699;17419.912900435418;17426.564335891704;17433.389831355842;12123.454444550016;13365.46538138483;13442.865571344357;13447.26040067786;13465.798013029616;14353.712925741427;14764.335604897806;14767.556973290819;14785.778213326808;14816.851831481763;5612.5229355504425;6430.549861509649;6463.935360646334;6474.320196379406;6510.348965103546;758.836850077236;909.417972497602;929.702495201529;931.0549791961165;973.6489504242937;25236.24291271228;25759.484810304064;25919.74080259211;26235.475290494083;26290.948362065687;905.9184673379295;996.9651062212932;999.8500224966314;1033.4419413516616;1080.4543705428707;13301.600951971457;13725.901927845749;13893;16508;16589.004659720456;680685;685817;688267;688889;709534;47305;50395.74802125966;58279;59367.10949335763;59547;1365.6858922447893;1381.896357773171;1425.7219842130685;1426.992865035689;1428;29541.85229073841;30457.54313685252;30505.694943050286;30558.541621876135;31139.37721245608;51236;51580.74209628928;51848.222276665125;51879.48120518746;51955;605136;608982;609304;609380;609905;25769;26107.608385873846;26184.738152618993;26185.476290474464;26249.475010500064;44803.775981119885;45033;45710.77144614256;46515.6045318641;46984;30874;37719;38108.42837357497;38115.42826857655;38626.2274754509;37271.695490657694;37510.6248937518;37718.86843394703;37905;38057.238855223295;36656.63343366532;38040;38085.61914380821;38254;38284;32787.83606081954;33307.66692333046;34001.65998339985;34045.829770850985;34079.65920340864;24674.629880551445;24777.87611061933;24817.751822481543;25376.74623253818;25470.61794073053 17:14:34 INFO - PROCESS | 1646 | |2;jquery.html;320.5432259030881;355.06971734056776;380.9866654667087;381.93888977763544;404.93502089504597;14207.644808879782;15067.095974241553;15867.444639437608;20283.985800709943;20747.273845415413;19751.111199996034;20239.696404553943;20898.477538061557;20974.265900693477;21168.364949051516;5593.909187708398;5846.269216347957;6095.908561371561;6118.541109416789;6125.632462052269;5668.121441176624;6054.848628784293;6122.908156377658;6130.570860039799;6132.325444201134;5764.9423505765035;5933.436323549277;5972.283326000886;6053.969730151343;6065.757369705207;5942.465178133967;5993.370696076936;5994.100884867283;5997.190379298826;6001.939980600204;5033.647644664875;5140.33175687162;5152.845414637567;5209.765560549784;5228.189630607262;21274.787252127437;24412;24885;25258.24225273245;25422.491550168892;2148.34475484977;2392.784649381564;2419.63705444183;2583.9018417172815;2768.3632764464287;8400.537970411626;9749.561269742879;10013.39919604826;10182.28723989321;10340.586376544928;1894.810518948108;1915.348781414326;1926.094735474339;1927.7493925789697;1939.8836069835713;114084.42957785241;123598.38200809028;131013.34493327567;131119;132469;11138.777224455465;11463.197576169589;11522.36626985507;11543.36511491876;11664.300141991338;14101.57695269123;14506.492272770614;14542.563723088324;14562.490312839212;14581.052231605125;8395.53824539644;8640.827183456297;8667.696630618024;8805.779855503535;8822.558872056372;7735.535867847947;7842.9215707842195;8654.697085601974;8724.040355560883;8866.77833054166;4084.3254265751493;4267.722598031118;4445.110977804387;4525.683202175816;4594.5864872161665;1857.6934805757169;1915.7030660247683;1928.431112821693;1928.6914093744933;1934.5937353155714;368.9483472313878;381.09109773191136;421.62054151263493;861.3238607692931;937.4890684576922;11610.187286890006;11672.416379181177;11681.707957300965;11853.88146118545;12034.759304813855;427.1521030753951;430.184799804369;430.3587654394929;436.5067473754637;438.193723548672;4714.481407045222;5996.13056106862;6010.398960104042;6021.849453763691;6195.566310358232;514658;514697;517300;529682;612692;143433;151040;151735;154119;160125;974.4396971741277;999.2954966748425;1018.8930162332848;1019.8674172357546;1029.5161274201114;18869.622607548048;19435.3197638082;20026.799732002495;20031.699524506854;20053.097610607267;55118;56703.14945275907;57251.71374143103;57836.13245801232;59149;78925.60537197278;81079.18920810953;84256.15743842484;85163.14836851553;86448;7106.928930710834;7747.18654541265;8118.2693557580105;8244.83510329802;8481.067082620782;12582.748345033231;12813.359332033548;12826.294553799631;13192.076554641082;13351.198928064347;8848.557572121497;10766.569337226423;10925.180611454014;11080.61217857371;11443.427828608703;10998;11010.669679909295;11061.72345691332;11433;11480.598179064027;9749.512524373895;11008.779824403628;11047.944760276469;11114.22200445961;11391.886081139082;8022.558759268296;8242.464239824392;8278.586070696321;8339.95830020846;8373.958130209554;9964.302498825302;10829.079528240189;10922.781544369227;11048.116150708085;11122.499487522919 17:14:34 INFO - PROCESS | 1646 | |3;mootools.html;1362.645712114851;1540.2760702469839;1545.1192820092544;1738.3394310162137;1872.2510995601765;7850.214978502154;8370.497770133796;8376;8380.790480237996;8394.664213431462;8117.797055073612;8545.01732300784;8732.388732788691;8746.12538746125;8890;2232.352617740853;2247.3033359658475;2389.6773935518745;2391.545606334791;2425.4785221177444;2370.9762902370926;2413.710354757423;2424.1757802347197;2425.551273014489;2425.927222183337;2391.0435825669783;2406.133791834947;2420.455397535558;2423.672804171441;2424.2727181845376;2376.595978683628;2387.9970412426737;2395.233525271922;2395.856248625088;2403.3631087761755;2146.860454070496;2215.534737705084;2387.3554140382175;2390.940226494334;2391.485830546441;7689.961550192269;8889.822203555892;8922.509261990588;9006.684766033157;9033.503157326344;4759.786254505114;5027.974860125676;5030.471800460936;5177.068127737006;5181.766820493087;3617.656322649344;3711.406175012012;3715.8699445519546;3719.6838268747188;3721.0325315417917;1068.6099573655638;1078.7195329214383;1090.6346373964732;1090.7055095124351;1098.6649072033026;11802;11840.644780656594;11841.993430558412;11844;11873.871982161681;4518.344839998247;4526.818927242939;4672.135654903854;4705.811767529329;4723.8034314044135;9227.723168304961;9263.629454821732;9263.629454821867;9277.443353398683;9279.72160835176;5319.361676598755;5323.946760532423;5325.174597937326;5330.7068111253475;5331.920021199685;4210.961578221092;4449.844255451044;4554.271316589396;4930.7288099154175;4987.60099192071;3307.818070006125;3826.598207188205;3836.769793812324;3913.745606535566;3945.743526670757;1168.684455197109;1188.4651906642046;1189.9821502677466;1200.7178313096415;1201.0571701214506;836.7698882807155;890.5858775669216;905.1672461335587;923.6166990698919;946.5740416812462;5844.561657875676;5937.317208520989;5998.340182579913;6136.5721351362345;6189.566730328834;434.3571514158999;454.9772511374418;455.2261156034754;455.68102328370276;456.3041361923094;3621.8732344367822;3625.057485053905;3671.889843304705;3761.4169803680475;3769.5288088988877;10442.843357349646;10953.56185752561;10957.50691218897;10961.958613931823;10964.725881853017;10896.727581810519;10908.509117089592;10912.454377281263;10926.945365273281;10937.234393592373;8098.109207987117;8231.05342885564;8244.670213191404;8390.119037501097;8395.62219700115;5778.595498315078;5781.653100813965;5969.283685957713;5996;6021;10030.749231268985;10107.595696172071;10122.089011988663;10179.643712470028;10238.641647542301;9409.811803763749;9618.759531011781;9769.80460390774;10120.342177758423;10183.236257280585;6401.263854656774;7638.388928885787;7639.236076392539;7655.808604784702;7721.806954826175;8487.618057187317;8531.189536993976;8591.6992905248;8595.52724600153;8612.569371531523;7461.962690186514;7525.586092764732;7558.773236802905;7580.8483830324185;7662.348700360531;7379;7395.926040739739;7411.4070874331;7458.366038886756;7459.738909138154;6890.621015844176;6970.7211711533;7047.506674532733;7054.329838665319;7054.4003759681;4999.225120106389;5044.192929131322;5048.318477005557;5068.695878247317;5102.515261050195;4945.282933974481;5025.869179434598;5084.567811735896;5186.6369354144845;5272.156454967187 17:14:34 INFO - PROCESS | 1646 | |4;prototype.html;295.3811764353679;297.15015056937153;302.833441607116;307.58476057322616;310.0759735986758;5010.699358038516;5051.040302342552;5208.296879921209;5249.317588713471;5322.547583455411;4787.49731278216;5098.719570423626;5209.843704688856;5249.346455866409;5258.290130832336;4041.8682768824774;4045.5233839648463;4059.4722686050845;4060.9593904061026;4061.903286112748;3661.6155303693126;3809.5999920008417;4043.3624382125286;4072.470578824749;4087.1825634872994;3333.3333333333335;4034.8789536313957;4078.5921407859123;4081.469408976829;4097.815598298069;3136.8274744889136;3396.7961922284744;3651.233241019376;4001.339778936472;4033.4151548025666;3523.6828685418436;3534.5228394166716;3553.538040054802;3553.6091029986683;3557.6975957043683;4310.849120280806;4762.595179409755;4822.228443449067;4989.027139707759;5177.042247184283;4317.827286908519;4640.76796160194;4659.324397962277;4687.437507499122;4702.623790096784;4479.4176757021705;5552.86117847053;5569.610127291051;5591.30108736408;5659.4340565943485;3636.9272614547826;3657.140571965586;3884.3979183226643;3941.2314598653275;3944.3689009758587;5370.087085195487;5851.502622277111;5859.941400585983;5863.094494289373;5898.793542226002;3804.847806087781;3938.094238325144;3989.8005099744896;3996.6403023728003;4011.859584914514;3877.4796382351697;4025.6376926076796;4041.535223449282;4050.339360862032;4062.2484840304637;4635.235186194308;4646.605038571692;4649;4666.2067448533835;4741.478437371955;5249.950009998016;5610.663360198401;5648.265725455747;5728.369879313273;5747.885042299131;1169.6666450061862;1250.1498980693034;1281.557862537423;1363.8227030485973;1386.3692020130816;749.4641331447932;840.6633452809939;843.7047033538336;850.4812064640564;853.846307664614;3907.628775266345;4123.670106391482;4282.443282373271;4291.592298731615;4313.633341165973;4277.636400905895;4641.936322027445;4645.512221216791;4689.554492323224;4691.413573303337;3885.7668539887695;3956.5252169739238;4018.849915295303;4256.978715106405;4308.719933204395;2223.776922692545;2247.7639847815744;2315.664228686831;2481.478889433239;2526.13283922749;4212.136512015029;4760.523947605212;4814.903701925942;4822.373091498082;4888.413390393175;4122.814908098712;4358.4769827620885;4649.744264065509;4684.695494792828;4793.544613261734;4365.956340436618;4370.38814565961;4462.732236065782;4506.662000349921;4863.9513604864915;4732.201763329913;4750.429948406213;4765.070146590636;4813.374261346003;4827.831025914076;4137.81379837902;4548.2476956510345;4658.277966915133;4734.928976065293;4762.880927976828;4559.680822342404;4616.306954436504;4629.8611041667455;4900.656954013328;4956.702597844141;3201.807891526516;3387.6104248011793;3396.454613150961;3414.573178352706;3420.9486857696656;4074.2258970795456;4354.695171337976;4447.421835161537;4551.476580193188;4714.844863008448;4799.448063472606;4892.363992680928;5242.266082748342;5522.337319521683;5630.493255607015;5546.140348246028;5637.520810731134;5671.716414179357;5717.485426311652;5776.624519406225;5227.536289838851;5241;5543.251661025871;5580.544560393414;5602.915956260741;4563;5577.26713910173;5610.7755689773585;5629.915551266652;5711.428857114255;5224.604007395224;5517.006938751063;5546.500814926676;5581.358143813513;5590.273264475592 17:14:34 INFO - PROCESS | 1646 | |5;yui.html;705.9576425414475;739.5636574421097;765.8966039584654;777.2421888658558;806.3871457692156;14881.627959301022;15421.460248891291;15438.99646522978;15487.84512154878;15498.92250538747;14662.973591848575;14825.110493370405;14841.183734894577;14841.183734894577;14848.777268340957;684.0696652552524;702.2029995954603;704.9848218565276;842.0989541190928;848.5121055393158;865.5974971638218;867.8871746672955;875.6891303587198;880.7269746378611;880.973570792874;931.7903471718877;932.1657116880388;933.7945651956559;935.8409070458005;937.9062093790635;931.1852129386787;932.3892850183141;932.8740620016279;933.7478880702206;937.0910217089412;525.1859617592715;538.9622726409153;648.2545073165898;664.1996394344803;670.8725342185018;15046.172460514666;15079.24603769807;15106.924465377602;15116.017458865139;15116.848831511765;11543.653690389217;13724.862751372459;13995.117982099284;14276.428942842274;14529.927350363287;10880.183986200987;11258.211925165242;11416.543338266543;12387.318697471635;12731.872681273162;3865.6520913117674;4568.868980963046;4577.427821522309;4604.102200070987;4740.028294199681;93108;108779;108813;110749;112234.43882780615;10639.308444951208;10678.946605266923;10755.56977720898;10908.945455272673;11180.608678696206;17490.737638935425;20415.672981256466;20787.06458209384;20901;20916.84957327331;7702.152763196044;7744.57404842739;7802.453828231969;7899.486533375312;7967;4257;4352.717073390219;4431.844885429059;4514.593686568224;4621.4223222097235;3463.9134021649156;3598.4962105305276;3600.8199590020395;3601.2077342984503;3606.4590311452966;630.8296759874808;649.9252585952676;657.4510283912987;662.9403353698191;669.1835960128733;548.3611592494779;599.6821684507219;606.9817905462843;624.1055811734742;639.7121295417081;8477.915220847712;8543.188397102265;8770.517621530877;8973.775655608662;9045.140711632515;531.2854211086083;549.5878091431426;581.1921429213397;621.6767281013847;627.9811605651838;4405.559444055633;4464.933026004613;4466.932996005063;4483.843065492692;4545.272756358967;163306;165004.17497912433;166562;168784;175218.12390937965;120873;127140.36429817791;142660;144826;147771;43992;63290.68354658289;79667;113619.99999999834;118156;8351.415400921876;8439.282660973886;8452.450590711584;8513.602953983389;8633.30933525329;56159;59118.930837420485;62320.37679623146;64688;65357.673211633635;87216.56391718001;89096.43614255617;89779;92778.53610731903;96862;12848.871511284768;13070.34648267602;13121.343932803513;13200.933995329962;13341.66645833862;13795.379207935466;14533.854661453674;14787.852121479078;14857.331420086339;15083.245837707851;10850.67447976562;13352.265625390697;13358;13610.754225552673;14497.710045798814;13477.39351729155;14005.789913151515;14039.578812635636;14044.438222470986;14162.858371416154;13427.798583021067;13477.865221347662;13651.249181295125;14150.43398264099;14478.348474318891;9137.497437640994;10909.618163364245;11337.149713771336;11421.029212517029;11863.110266729856;9168.954155229181;10363.378197308186;11602.379771938522;11771.823422648496;11848.407579621156 17:14:34 INFO - PROCESS | 1646 | __end_tp_report 17:14:34 INFO - PROCESS | 1646 | __start_cc_report 17:14:34 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1441 17:14:34 INFO - PROCESS | 1646 | __end_cc_report 17:14:34 INFO - PROCESS | 1646 | __startTimestamp1477354474264__endTimestamp 17:14:34 INFO - PROCESS | 1646 | 17:14:34 INFO - PROCESS | 1646 | ------- Summary: start ------- 17:14:34 INFO - PROCESS | 1646 | Number of tests: 6 17:14:34 INFO - PROCESS | 1646 | 17:14:34 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5782.15 Median:6013.58 stddev:669.43 (11.1%) stddev-sans-first:633.35 17:14:34 INFO - PROCESS | 1646 | Values: 2943.0 3347.9 3364.2 3397.5 3416.9 5712.9 5735.5 5760.2 5791.1 5793.8 5602.6 5656.2 5696.8 5717.8 5719.5 5192.7 5195.4 5197.0 5229.3 5240.2 5176.8 5201.4 5213.1 5271.9 5338.9 5249.4 5297.9 5311.5 5315.6 5318.7 5267.3 5270.0 5281.7 5339.1 5342.3 5193.3 5288.8 5303.7 5314.0 5325.4 5609.2 5657.8 5675.4 5679.7 5796.6 6240.6 6299.8 6318.1 6331.7 6367.0 5437.3 6360.1 6362.3 6370.3 6391.1 5749.6 5771.2 5777.5 5887.8 5904.6 5366.8 6257.2 6324.1 6326.0 6331.8 6225.6 6245.8 6248.6 6251.9 6256.0 6198.2 6298.9 6323.8 6346.9 6347.2 6014.1 6117.6 6122.6 6185.2 6235.5 6271.4 6314.9 6315.6 6322.9 6342.5 4895.5 4897.8 4933.0 4949.6 4982.8 4396.0 4401.2 4409.0 4476.9 4479.4 5788.0 5836.0 5836.3 5878.1 5899.2 6327.3 6357.1 6361.8 6364.8 6395.9 5798.6 5838.4 5854.5 5854.9 5893.2 5333.8 5378.4 5378.6 5412.1 5417.5 6342.6 6352.0 6366.1 6373.6 6384.7 6371.6 6374.5 6378.2 6389.8 6394.0 5218.6 6296.7 6322.7 6335.3 6385.4 6182.4 6196.1 6219.7 6251.7 6291.0 6348.8 6354.8 6363.6 6375.8 6382.0 6012.3 6144.6 6222.7 6229.5 6233.2 6054.1 6107.4 6120.9 6127.4 6136.7 6003.2 6045.1 6050.8 6088.4 6117.0 6180.9 6228.7 6243.5 6255.7 6257.2 4885.9 6010.5 6013.6 6032.5 6064.9 17:14:34 INFO - PROCESS | 1646 | 17:14:34 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:73468.40 Median:37812.00 stddev:163843.03 (433.3%) stddev-sans-first:164210.90 17:14:34 INFO - PROCESS | 1646 | Values: 436.5 450.4 475.4 483.8 484.1 30839.0 38454.8 41874.4 42031.4 44253.6 43357.8 43953.3 44000.6 44002.0 44071.9 9841.9 10004.6 10034.2 10040.1 10047.1 8853.6 9047.6 9821.4 12303.8 12617.2 12352.6 12373.8 12380.2 12383.0 12412.9 12333.2 12395.5 12395.7 12409.0 12419.0 8747.3 8979.2 10219.4 10442.5 12220.4 41257.0 41638.6 41650.6 41732.8 41780.2 3336.0 3424.1 3709.3 3951.7 4066.0 30133.0 30195.9 30991.2 31367.7 32319.4 3190.9 3216.4 3233.7 3283.5 3289.1 519185.0 524401.0 525755.0 527861.0 530141.3 61123.0 61436.0 61557.7 61595.0 61646.4 64324.4 64510.4 64526.7 64622.7 64639.7 16839.9 17417.7 17419.9 17426.6 17433.4 12123.5 13365.5 13442.9 13447.3 13465.8 14353.7 14764.3 14767.6 14785.8 14816.9 5612.5 6430.5 6463.9 6474.3 6510.3 758.8 909.4 929.7 931.1 973.6 25236.2 25759.5 25919.7 26235.5 26290.9 905.9 997.0 999.9 1033.4 1080.5 13301.6 13725.9 13893.0 16508.0 16589.0 680685.0 685817.0 688267.0 688889.0 709534.0 47305.0 50395.7 58279.0 59367.1 59547.0 1365.7 1381.9 1425.7 1427.0 1428.0 29541.9 30457.5 30505.7 30558.5 31139.4 51236.0 51580.7 51848.2 51879.5 51955.0 605136.0 608982.0 609304.0 609380.0 609905.0 25769.0 26107.6 26184.7 26185.5 26249.5 44803.8 45033.0 45710.8 46515.6 46984.0 30874.0 37719.0 38108.4 38115.4 38626.2 37271.7 37510.6 37718.9 37905.0 38057.2 36656.6 38040.0 38085.6 38254.0 38284.0 32787.8 33307.7 34001.7 34045.8 34079.7 24674.6 24777.9 24817.8 25376.7 25470.6 17:14:34 INFO - PROCESS | 1646 | 17:14:34 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:33986.61 Median:374.97 stddev:91834.66 (24491.4%) stddev-sans-first:92057.49 17:14:34 INFO - PROCESS | 1646 | Values: 320.5 355.1 381.0 381.9 404.9 14207.6 15067.1 15867.4 20284.0 20747.3 19751.1 20239.7 20898.5 20974.3 21168.4 5593.9 5846.3 6095.9 6118.5 6125.6 5668.1 6054.8 6122.9 6130.6 6132.3 5764.9 5933.4 5972.3 6054.0 6065.8 5942.5 5993.4 5994.1 5997.2 6001.9 5033.6 5140.3 5152.8 5209.8 5228.2 21274.8 24412.0 24885.0 25258.2 25422.5 2148.3 2392.8 2419.6 2583.9 2768.4 8400.5 9749.6 10013.4 10182.3 10340.6 1894.8 1915.3 1926.1 1927.7 1939.9 114084.4 123598.4 131013.3 131119.0 132469.0 11138.8 11463.2 11522.4 11543.4 11664.3 14101.6 14506.5 14542.6 14562.5 14581.1 8395.5 8640.8 8667.7 8805.8 8822.6 7735.5 7842.9 8654.7 8724.0 8866.8 4084.3 4267.7 4445.1 4525.7 4594.6 1857.7 1915.7 1928.4 1928.7 1934.6 368.9 381.1 421.6 861.3 937.5 11610.2 11672.4 11681.7 11853.9 12034.8 427.2 430.2 430.4 436.5 438.2 4714.5 5996.1 6010.4 6021.8 6195.6 514658.0 514697.0 517300.0 529682.0 612692.0 143433.0 151040.0 151735.0 154119.0 160125.0 974.4 999.3 1018.9 1019.9 1029.5 18869.6 19435.3 20026.8 20031.7 20053.1 55118.0 56703.1 57251.7 57836.1 59149.0 78925.6 81079.2 84256.2 85163.1 86448.0 7106.9 7747.2 8118.3 8244.8 8481.1 12582.7 12813.4 12826.3 13192.1 13351.2 8848.6 10766.6 10925.2 11080.6 11443.4 10998.0 11010.7 11061.7 11433.0 11480.6 9749.5 11008.8 11047.9 11114.2 11391.9 8022.6 8242.5 8278.6 8340.0 8374.0 9964.3 10829.1 10922.8 11048.1 11122.5 17:14:34 INFO - PROCESS | 1646 | 17:14:34 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5683.51 Median:4845.26 stddev:3222.62 (66.5%) stddev-sans-first:3215.30 17:14:34 INFO - PROCESS | 1646 | Values: 1362.6 1540.3 1545.1 1738.3 1872.3 7850.2 8370.5 8376.0 8380.8 8394.7 8117.8 8545.0 8732.4 8746.1 8890.0 2232.4 2247.3 2389.7 2391.5 2425.5 2371.0 2413.7 2424.2 2425.6 2425.9 2391.0 2406.1 2420.5 2423.7 2424.3 2376.6 2388.0 2395.2 2395.9 2403.4 2146.9 2215.5 2387.4 2390.9 2391.5 7690.0 8889.8 8922.5 9006.7 9033.5 4759.8 5028.0 5030.5 5177.1 5181.8 3617.7 3711.4 3715.9 3719.7 3721.0 1068.6 1078.7 1090.6 1090.7 1098.7 11802.0 11840.6 11842.0 11844.0 11873.9 4518.3 4526.8 4672.1 4705.8 4723.8 9227.7 9263.6 9263.6 9277.4 9279.7 5319.4 5323.9 5325.2 5330.7 5331.9 4211.0 4449.8 4554.3 4930.7 4987.6 3307.8 3826.6 3836.8 3913.7 3945.7 1168.7 1188.5 1190.0 1200.7 1201.1 836.8 890.6 905.2 923.6 946.6 5844.6 5937.3 5998.3 6136.6 6189.6 434.4 455.0 455.2 455.7 456.3 3621.9 3625.1 3671.9 3761.4 3769.5 10442.8 10953.6 10957.5 10962.0 10964.7 10896.7 10908.5 10912.5 10926.9 10937.2 8098.1 8231.1 8244.7 8390.1 8395.6 5778.6 5781.7 5969.3 5996.0 6021.0 10030.7 10107.6 10122.1 10179.6 10238.6 9409.8 9618.8 9769.8 10120.3 10183.2 6401.3 7638.4 7639.2 7655.8 7721.8 8487.6 8531.2 8591.7 8595.5 8612.6 7462.0 7525.6 7558.8 7580.8 7662.3 7379.0 7395.9 7411.4 7458.4 7459.7 6890.6 6970.7 7047.5 7054.3 7054.4 4999.2 5044.2 5048.3 5068.7 5102.5 4945.3 5025.9 5084.6 5186.6 5272.2 17:14:34 INFO - PROCESS | 1646 | 17:14:34 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4235.11 Median:4632.55 stddev:1286.80 (27.8%) stddev-sans-first:1255.97 17:14:34 INFO - PROCESS | 1646 | Values: 295.4 297.2 302.8 307.6 310.1 5010.7 5051.0 5208.3 5249.3 5322.5 4787.5 5098.7 5209.8 5249.3 5258.3 4041.9 4045.5 4059.5 4061.0 4061.9 3661.6 3809.6 4043.4 4072.5 4087.2 3333.3 4034.9 4078.6 4081.5 4097.8 3136.8 3396.8 3651.2 4001.3 4033.4 3523.7 3534.5 3553.5 3553.6 3557.7 4310.8 4762.6 4822.2 4989.0 5177.0 4317.8 4640.8 4659.3 4687.4 4702.6 4479.4 5552.9 5569.6 5591.3 5659.4 3636.9 3657.1 3884.4 3941.2 3944.4 5370.1 5851.5 5859.9 5863.1 5898.8 3804.8 3938.1 3989.8 3996.6 4011.9 3877.5 4025.6 4041.5 4050.3 4062.2 4635.2 4646.6 4649.0 4666.2 4741.5 5250.0 5610.7 5648.3 5728.4 5747.9 1169.7 1250.1 1281.6 1363.8 1386.4 749.5 840.7 843.7 850.5 853.8 3907.6 4123.7 4282.4 4291.6 4313.6 4277.6 4641.9 4645.5 4689.6 4691.4 3885.8 3956.5 4018.8 4257.0 4308.7 2223.8 2247.8 2315.7 2481.5 2526.1 4212.1 4760.5 4814.9 4822.4 4888.4 4122.8 4358.5 4649.7 4684.7 4793.5 4366.0 4370.4 4462.7 4506.7 4864.0 4732.2 4750.4 4765.1 4813.4 4827.8 4137.8 4548.2 4658.3 4734.9 4762.9 4559.7 4616.3 4629.9 4900.7 4956.7 3201.8 3387.6 3396.5 3414.6 3420.9 4074.2 4354.7 4447.4 4551.5 4714.8 4799.4 4892.4 5242.3 5522.3 5630.5 5546.1 5637.5 5671.7 5717.5 5776.6 5227.5 5241.0 5543.3 5580.5 5602.9 4563.0 5577.3 5610.8 5629.9 5711.4 5224.6 5517.0 5546.5 5581.4 5590.3 17:14:34 INFO - PROCESS | 1646 | 17:14:34 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:24676.86 Median:4304.86 stddev:40742.31 (946.4%) stddev-sans-first:40816.85 17:14:34 INFO - PROCESS | 1646 | Values: 706.0 739.6 765.9 777.2 806.4 14881.6 15421.5 15439.0 15487.8 15498.9 14663.0 14825.1 14841.2 14841.2 14848.8 684.1 702.2 705.0 842.1 848.5 865.6 867.9 875.7 880.7 881.0 931.8 932.2 933.8 935.8 937.9 931.2 932.4 932.9 933.7 937.1 525.2 539.0 648.3 664.2 670.9 15046.2 15079.2 15106.9 15116.0 15116.8 11543.7 13724.9 13995.1 14276.4 14529.9 10880.2 11258.2 11416.5 12387.3 12731.9 3865.7 4568.9 4577.4 4604.1 4740.0 93108.0 108779.0 108813.0 110749.0 112234.4 10639.3 10678.9 10755.6 10908.9 11180.6 17490.7 20415.7 20787.1 20901.0 20916.8 7702.2 7744.6 7802.5 7899.5 7967.0 4257.0 4352.7 4431.8 4514.6 4621.4 3463.9 3598.5 3600.8 3601.2 3606.5 630.8 649.9 657.5 662.9 669.2 548.4 599.7 607.0 624.1 639.7 8477.9 8543.2 8770.5 8973.8 9045.1 531.3 549.6 581.2 621.7 628.0 4405.6 4464.9 4466.9 4483.8 4545.3 163306.0 165004.2 166562.0 168784.0 175218.1 120873.0 127140.4 142660.0 144826.0 147771.0 43992.0 63290.7 79667.0 113620.0 118156.0 8351.4 8439.3 8452.5 8513.6 8633.3 56159.0 59118.9 62320.4 64688.0 65357.7 87216.6 89096.4 89779.0 92778.5 96862.0 12848.9 13070.3 13121.3 13200.9 13341.7 13795.4 14533.9 14787.9 14857.3 15083.2 10850.7 13352.3 13358.0 13610.8 14497.7 13477.4 14005.8 14039.6 14044.4 14162.9 13427.8 13477.9 13651.2 14150.4 14478.3 9137.5 10909.6 11337.1 11421.0 11863.1 9169.0 10363.4 11602.4 11771.8 11848.4 17:14:34 INFO - PROCESS | 1646 | -------- Summary: end -------- 17:14:34 INFO - PROCESS | 1646 | 17:14:34 INFO - TEST-INFO | 1646: exit 0 17:14:34 INFO - TEST-OK | dromaeo_css | took 1116361ms 17:14:34 INFO - TEST-START | kraken 17:14:34 INFO - operating with platform_type : mac_ 17:14:34 INFO - Initialising browser for kraken test... 17:14:34 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpvy1VjT/profile http://localhost:49266/getInfo.html) 17:14:37 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 17:14:37 INFO - PROCESS | 1655 | colorDepth:24 17:14:37 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 17:14:37 INFO - PROCESS | 1655 | __metrics 17:14:37 INFO - PROCESS | 1655 | 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" 17:14:37 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:14:37 INFO - TEST-INFO | 1655: exit 0 17:14:37 INFO - Browser initialized. 17:14:37 INFO - Running cycle 1/1 for kraken test... 17:14:37 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpvy1VjT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:14:50 INFO - PROCESS | 1656 | RSS: Main: 219611136 17:14:50 INFO - PROCESS | 1656 | 17:14:52 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 17:14:53 INFO - PROCESS | 1656 | RSS: Main: 269660160 17:14:53 INFO - PROCESS | 1656 | 17:14:56 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 17:14:56 INFO - PROCESS | 1656 | RSS: Main: 280408064 17:14:56 INFO - PROCESS | 1656 | 17:14:59 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 17:15:00 INFO - PROCESS | 1656 | RSS: Main: 378392576 17:15:00 INFO - PROCESS | 1656 | 17:15:02 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 17:15:03 INFO - PROCESS | 1656 | RSS: Main: 280649728 17:15:03 INFO - PROCESS | 1656 | 17:15:05 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:15:05 INFO - PROCESS | 1656 | RSS: Main: 281554944 17:15:05 INFO - PROCESS | 1656 | 17:15:08 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 17:15:09 INFO - PROCESS | 1656 | RSS: Main: 319205376 17:15:09 INFO - PROCESS | 1656 | 17:15:12 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 17:15:12 INFO - PROCESS | 1656 | RSS: Main: 319475712 17:15:12 INFO - PROCESS | 1656 | 17:15:15 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 17:15:16 INFO - PROCESS | 1656 | RSS: Main: 317022208 17:15:16 INFO - PROCESS | 1656 | 17:15:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:15:18 INFO - PROCESS | 1656 | RSS: Main: 291028992 17:15:18 INFO - PROCESS | 1656 | 17:15:20 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:15:20 INFO - PROCESS | 1656 | RSS: Main: 296886272 17:15:20 INFO - PROCESS | 1656 | 17:15:22 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:15:23 INFO - PROCESS | 1656 | RSS: Main: 300535808 17:15:23 INFO - PROCESS | 1656 | 17:15:26 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:15:27 INFO - PROCESS | 1656 | RSS: Main: 315179008 17:15:27 INFO - PROCESS | 1656 | 17:15:30 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:15:30 INFO - PROCESS | 1656 | RSS: Main: 308944896 17:15:30 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 17:15:32 INFO - PROCESS | 1656 | RSS: Main: 352927744 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | __start_tp_report 17:15:32 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 17:15:32 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 17:15:32 INFO - PROCESS | 1656 | |i|pagename|runs| 17:15:32 INFO - PROCESS | 1656 | |0;ai-astar;117;116;114;113;115;113;114;113;115;114 17:15:32 INFO - PROCESS | 1656 | |1;audio-beat-detection;143;108;106;143;109;109;109;106;137;107 17:15:32 INFO - PROCESS | 1656 | |2;audio-dft;184;181;183;184;182;184;183;184;183;184 17:15:32 INFO - PROCESS | 1656 | |3;audio-fft;81;58;59;87;60;58;58;58;82;73 17:15:32 INFO - PROCESS | 1656 | |4;audio-oscillator;89;69;94;69;68;68;92;70;92;124 17:15:32 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;91;92;90;92;90;87;93;91;89;87 17:15:32 INFO - PROCESS | 1656 | |6;imaging-darkroom;94;94;94;95;98;94;94;100;145;105 17:15:32 INFO - PROCESS | 1656 | |7;imaging-desaturate;84;85;86;87;85;86;86;86;83;140 17:15:32 INFO - PROCESS | 1656 | |8;json-parse-financial;56;53;52;53;57;57;56;57;57;57 17:15:32 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;70;66;69;76;72;69;69;70;70;76 17:15:32 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;82;83;82;82;85;80;84;81;83;83 17:15:32 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;141;140;139;151;152;136;149;154;194;139 17:15:32 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;169;169;169;167;167;171;164;168;168;184 17:15:32 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;67;65;67;66;66;67;67;69;67;67 17:15:32 INFO - PROCESS | 1656 | __end_tp_report 17:15:32 INFO - PROCESS | 1656 | __start_cc_report 17:15:32 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2015 17:15:32 INFO - PROCESS | 1656 | __end_cc_report 17:15:32 INFO - PROCESS | 1656 | __startTimestamp1477354532717__endTimestamp 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | ------- Summary: start ------- 17:15:32 INFO - PROCESS | 1656 | Number of tests: 14 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.50 stddev:1.35 (1.2%) stddev-sans-first:1.05 17:15:32 INFO - PROCESS | 1656 | Values: 117.0 116.0 114.0 113.0 115.0 113.0 114.0 113.0 115.0 114.0 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:109.00 stddev:16.20 (14.9%) stddev-sans-first:14.37 17:15:32 INFO - PROCESS | 1656 | Values: 143.0 108.0 106.0 143.0 109.0 109.0 109.0 106.0 137.0 107.0 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:183.20 Median:184.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 17:15:32 INFO - PROCESS | 1656 | Values: 184.0 181.0 183.0 184.0 182.0 184.0 183.0 184.0 183.0 184.0 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:67.40 Median:66.50 stddev:11.98 (18.0%) stddev-sans-first:11.66 17:15:32 INFO - PROCESS | 1656 | Values: 81.0 58.0 59.0 87.0 60.0 58.0 58.0 58.0 82.0 73.0 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:83.50 Median:79.50 stddev:18.28 (23.0%) stddev-sans-first:19.28 17:15:32 INFO - PROCESS | 1656 | Values: 89.0 69.0 94.0 69.0 68.0 68.0 92.0 70.0 92.0 124.0 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:91.00 stddev:2.04 (2.2%) stddev-sans-first:2.15 17:15:32 INFO - PROCESS | 1656 | Values: 91.0 92.0 90.0 92.0 90.0 87.0 93.0 91.0 89.0 87.0 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:94.00 stddev:15.78 (16.8%) stddev-sans-first:16.52 17:15:32 INFO - PROCESS | 1656 | Values: 94.0 94.0 94.0 95.0 98.0 94.0 94.0 100.0 145.0 105.0 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:90.80 Median:86.00 stddev:17.33 (20.1%) stddev-sans-first:18.20 17:15:32 INFO - PROCESS | 1656 | Values: 84.0 85.0 86.0 87.0 85.0 86.0 86.0 86.0 83.0 140.0 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:57.00 stddev:2.01 (3.5%) stddev-sans-first:2.13 17:15:32 INFO - PROCESS | 1656 | Values: 56.0 53.0 52.0 53.0 57.0 57.0 56.0 57.0 57.0 57.0 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:70.00 stddev:3.16 (4.5%) stddev-sans-first:3.35 17:15:32 INFO - PROCESS | 1656 | Values: 70.0 66.0 69.0 76.0 72.0 69.0 69.0 70.0 70.0 76.0 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:1.43 (1.7%) stddev-sans-first:1.51 17:15:32 INFO - PROCESS | 1656 | Values: 82.0 83.0 82.0 82.0 85.0 80.0 84.0 81.0 83.0 83.0 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:150.00 stddev:16.91 (11.3%) stddev-sans-first:17.66 17:15:32 INFO - PROCESS | 1656 | Values: 141.0 140.0 139.0 151.0 152.0 136.0 149.0 154.0 194.0 139.0 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:169.00 stddev:5.38 (3.2%) stddev-sans-first:5.70 17:15:32 INFO - PROCESS | 1656 | Values: 169.0 169.0 169.0 167.0 167.0 171.0 164.0 168.0 168.0 184.0 17:15:32 INFO - PROCESS | 1656 | 17:15:32 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 17:15:32 INFO - PROCESS | 1656 | Values: 67.0 65.0 67.0 66.0 66.0 67.0 67.0 69.0 67.0 67.0 17:15:32 INFO - PROCESS | 1656 | -------- Summary: end -------- 17:15:32 INFO - PROCESS | 1656 | 17:15:33 INFO - TEST-INFO | 1656: exit 0 17:15:33 INFO - TEST-OK | kraken | took 58771ms 17:15:33 INFO - SUITE-END | took 1175s 17:15:33 INFO - Completed test suite (00:19:35) 17:15:33 INFO - javascript benchmark 17:15:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2943.0140902797566, 3347.9163020924475, 3364.2262279675674, 3397.5413319201903, 3416.914577135571, 5712.914306285399, 5735.512481439077, 5760.193572899798, 5791.131330300452, 5793.768249270035, 5602.579806514507, 5656.2081308616725, 5696.829095127153, 5717.771289148429, 5719.485246327829, 5192.714400707979, 5195.350581177362, 5197.038547868638, 5229.3201883755055, 5240.161574148137, 5176.792928282883, 5201.401838788531, 5213.087709650815, 5271.94561087782, 5338.91991620126, 5249.42256351801, 5297.867553311159, 5311.521963023327, 5315.627906046579, 5318.734063296839, 5267.315249017642, 5270.025045366619, 5281.683099014033, 5339.065663508871, 5342.305500284938, 5193.272941788153, 5288.788448462057, 5303.734813259361, 5313.973430132824, 5325.360956685223, 5609.214709940612, 5657.773689052433, 5675.432456754333, 5679.716014199274, 5796.62321949072, 6240.563160578761, 6299.779507717254, 6318.147050148263, 6331.715072821734, 6367.013112967497, 5437.293151890269, 6360.109584658151, 6362.331955144736, 6370.267419246799, 6391.137196478462, 5749.597528172988, 5771.192033115367, 5777.508911742465, 5887.764489420418, 5904.645721256781, 5366.812161574326, 6257.217847769029, 6324.114623952651, 6326.019466982625, 6331.778387756499, 6225.564210505221, 6245.75016999324, 6248.593841400295, 6251.874962500725, 6256.0, 6198.163247961467, 6298.938056623745, 6323.841903952438, 6346.873062538723, 6347.238331400262, 6014.127951447016, 6117.583823141572, 6122.642214636352, 6185.226846644169, 6235.469985051322, 6271.372862713783, 6314.936850631435, 6315.5894866833505, 6322.936770632326, 6342.4926005919415, 4895.534924182197, 4897.755112244374, 4932.950670493321, 4949.604031677457, 4982.77577509013, 4395.956040439554, 4401.22978478765, 4409.0, 4476.910461790746, 4479.417675702138, 5788.0449725795615, 5836.007878660638, 5836.270466191726, 5878.147668588031, 5899.203607513016, 6327.303996560375, 6357.141785858942, 6361.777337793155, 6364.777232796922, 6395.872082558323, 5798.565107616945, 5838.416158384212, 5854.4730974212525, 5854.930271203495, 5893.2044174035955, 5333.839984800462, 5378.381486129145, 5378.596605254622, 5412.107002344569, 5417.485338892799, 6342.6194428335375, 6352.015437607179, 6366.140571023038, 6373.5857169283845, 6384.680765961776, 6371.55399122057, 6374.490040796818, 6378.234611846423, 6389.840253993687, 6393.968030159819, 5218.55642270396, 6296.6851657417865, 6322.683865806599, 6335.2714437838395, 6385.361463853763, 6182.443580077815, 6196.1015652731, 6219.657918814509, 6251.68741562911, 6291.0, 6348.809535713936, 6354.841128971812, 6363.5863668861375, 6375.840603984938, 6382.0, 6012.3386427493815, 6144.56988010835, 6222.657753823583, 6229.5327850410495, 6233.2208473940755, 6054.122152287981, 6107.431569637723, 6120.9347721082095, 6127.372786728296, 6136.73353236607, 6003.189569408074, 6045.123457098608, 6050.788222412194, 6088.429087384993, 6116.981396139352, 6180.8763824722355, 6228.719707613078, 6243.531735119794, 6255.71849266775, 6257.186565746606, 4885.9022819544125, 6010.519158467225, 6013.579049466495, 6032.547558933185, 6064.939350606437], "value": 5738.025667584555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.53290978652836, 450.4144612004394, 475.40811689446645, 483.8282409744538, 484.1261522951073, 30839.0, 38454.84635460937, 41874.37188442168, 42031.36952945704, 44253.55746442534, 43357.78321108398, 43953.34069988953, 44000.55999440005, 44002.0, 44071.89820254495, 9841.852372214405, 10004.59981600735, 10034.247431442634, 10040.09639132478, 10047.145992590602, 8853.557322133867, 9047.638094476213, 9821.410715357102, 12303.815442768366, 12617.242965422058, 12352.567660131852, 12373.752524949496, 12380.195287306342, 12383.0, 12412.93793531031, 12333.198342107735, 12395.504179832886, 12395.690107747288, 12409.0, 12419.0, 8747.343949203836, 8979.236764874993, 10219.437930913797, 10442.47787610624, 12220.388980551026, 41257.0, 41638.58361416377, 41650.583494164974, 41732.79133604343, 41780.164396711894, 3335.983320083384, 3424.109731469811, 3709.2952339055764, 3951.7036222283446, 4066.0444795473336, 30133.0, 30195.943141989927, 30991.22521936947, 31367.686323136706, 32319.353612927844, 3190.872365105393, 3216.437123503401, 3233.7413006959387, 3283.5238890360765, 3289.1283809790425, 519185.0, 524401.0, 525755.0, 527861.0, 530141.3492932549, 61123.0, 61436.0, 61557.69221153955, 61595.0, 61646.38353616496, 64324.35675643184, 64510.35489645044, 64526.677366612865, 64622.67688661621, 64639.67680161569, 16839.905406148562, 17417.65164696699, 17419.912900435418, 17426.564335891704, 17433.389831355842, 12123.454444550016, 13365.46538138483, 13442.865571344357, 13447.26040067786, 13465.798013029616, 14353.712925741427, 14764.335604897806, 14767.556973290819, 14785.778213326808, 14816.851831481763, 5612.5229355504425, 6430.549861509649, 6463.935360646334, 6474.320196379406, 6510.348965103546, 758.836850077236, 909.417972497602, 929.702495201529, 931.0549791961165, 973.6489504242937, 25236.24291271228, 25759.484810304064, 25919.74080259211, 26235.475290494083, 26290.948362065687, 905.9184673379295, 996.9651062212932, 999.8500224966314, 1033.4419413516616, 1080.4543705428707, 13301.600951971457, 13725.901927845749, 13893.0, 16508.0, 16589.004659720456, 680685.0, 685817.0, 688267.0, 688889.0, 709534.0, 47305.0, 50395.74802125966, 58279.0, 59367.10949335763, 59547.0, 1365.6858922447893, 1381.896357773171, 1425.7219842130685, 1426.992865035689, 1428.0, 29541.85229073841, 30457.54313685252, 30505.694943050286, 30558.541621876135, 31139.37721245608, 51236.0, 51580.74209628928, 51848.222276665125, 51879.48120518746, 51955.0, 605136.0, 608982.0, 609304.0, 609380.0, 609905.0, 25769.0, 26107.608385873846, 26184.738152618993, 26185.476290474464, 26249.475010500064, 44803.775981119885, 45033.0, 45710.77144614256, 46515.6045318641, 46984.0, 30874.0, 37719.0, 38108.42837357497, 38115.42826857655, 38626.2274754509, 37271.695490657694, 37510.6248937518, 37718.86843394703, 37905.0, 38057.238855223295, 36656.63343366532, 38040.0, 38085.61914380821, 38254.0, 38284.0, 32787.83606081954, 33307.66692333046, 34001.65998339985, 34045.829770850985, 34079.65920340864, 24674.629880551445, 24777.87611061933, 24817.751822481543, 25376.74623253818, 25470.61794073053], "value": 20112.80674885624, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.5432259030881, 355.06971734056776, 380.9866654667087, 381.93888977763544, 404.93502089504597, 14207.644808879782, 15067.095974241553, 15867.444639437608, 20283.985800709943, 20747.273845415413, 19751.111199996034, 20239.696404553943, 20898.477538061557, 20974.265900693477, 21168.364949051516, 5593.909187708398, 5846.269216347957, 6095.908561371561, 6118.541109416789, 6125.632462052269, 5668.121441176624, 6054.848628784293, 6122.908156377658, 6130.570860039799, 6132.325444201134, 5764.9423505765035, 5933.436323549277, 5972.283326000886, 6053.969730151343, 6065.757369705207, 5942.465178133967, 5993.370696076936, 5994.100884867283, 5997.190379298826, 6001.939980600204, 5033.647644664875, 5140.33175687162, 5152.845414637567, 5209.765560549784, 5228.189630607262, 21274.787252127437, 24412.0, 24885.0, 25258.24225273245, 25422.491550168892, 2148.34475484977, 2392.784649381564, 2419.63705444183, 2583.9018417172815, 2768.3632764464287, 8400.537970411626, 9749.561269742879, 10013.39919604826, 10182.28723989321, 10340.586376544928, 1894.810518948108, 1915.348781414326, 1926.094735474339, 1927.7493925789697, 1939.8836069835713, 114084.42957785241, 123598.38200809028, 131013.34493327567, 131119.0, 132469.0, 11138.777224455465, 11463.197576169589, 11522.36626985507, 11543.36511491876, 11664.300141991338, 14101.57695269123, 14506.492272770614, 14542.563723088324, 14562.490312839212, 14581.052231605125, 8395.53824539644, 8640.827183456297, 8667.696630618024, 8805.779855503535, 8822.558872056372, 7735.535867847947, 7842.9215707842195, 8654.697085601974, 8724.040355560883, 8866.77833054166, 4084.3254265751493, 4267.722598031118, 4445.110977804387, 4525.683202175816, 4594.5864872161665, 1857.6934805757169, 1915.7030660247683, 1928.431112821693, 1928.6914093744933, 1934.5937353155714, 368.9483472313878, 381.09109773191136, 421.62054151263493, 861.3238607692931, 937.4890684576922, 11610.187286890006, 11672.416379181177, 11681.707957300965, 11853.88146118545, 12034.759304813855, 427.1521030753951, 430.184799804369, 430.3587654394929, 436.5067473754637, 438.193723548672, 4714.481407045222, 5996.13056106862, 6010.398960104042, 6021.849453763691, 6195.566310358232, 514658.0, 514697.0, 517300.0, 529682.0, 612692.0, 143433.0, 151040.0, 151735.0, 154119.0, 160125.0, 974.4396971741277, 999.2954966748425, 1018.8930162332848, 1019.8674172357546, 1029.5161274201114, 18869.622607548048, 19435.3197638082, 20026.799732002495, 20031.699524506854, 20053.097610607267, 55118.0, 56703.14945275907, 57251.71374143103, 57836.13245801232, 59149.0, 78925.60537197278, 81079.18920810953, 84256.15743842484, 85163.14836851553, 86448.0, 7106.928930710834, 7747.18654541265, 8118.2693557580105, 8244.83510329802, 8481.067082620782, 12582.748345033231, 12813.359332033548, 12826.294553799631, 13192.076554641082, 13351.198928064347, 8848.557572121497, 10766.569337226423, 10925.180611454014, 11080.61217857371, 11443.427828608703, 10998.0, 11010.669679909295, 11061.72345691332, 11433.0, 11480.598179064027, 9749.512524373895, 11008.779824403628, 11047.944760276469, 11114.22200445961, 11391.886081139082, 8022.558759268296, 8242.464239824392, 8278.586070696321, 8339.95830020846, 8373.958130209554, 9964.302498825302, 10829.079528240189, 10922.781544369227, 11048.116150708085, 11122.499487522919], "value": 8967.389907097699, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.645712114851, 1540.2760702469839, 1545.1192820092544, 1738.3394310162137, 1872.2510995601765, 7850.214978502154, 8370.497770133796, 8376.0, 8380.790480237996, 8394.664213431462, 8117.797055073612, 8545.01732300784, 8732.388732788691, 8746.12538746125, 8890.0, 2232.352617740853, 2247.3033359658475, 2389.6773935518745, 2391.545606334791, 2425.4785221177444, 2370.9762902370926, 2413.710354757423, 2424.1757802347197, 2425.551273014489, 2425.927222183337, 2391.0435825669783, 2406.133791834947, 2420.455397535558, 2423.672804171441, 2424.2727181845376, 2376.595978683628, 2387.9970412426737, 2395.233525271922, 2395.856248625088, 2403.3631087761755, 2146.860454070496, 2215.534737705084, 2387.3554140382175, 2390.940226494334, 2391.485830546441, 7689.961550192269, 8889.822203555892, 8922.509261990588, 9006.684766033157, 9033.503157326344, 4759.786254505114, 5027.974860125676, 5030.471800460936, 5177.068127737006, 5181.766820493087, 3617.656322649344, 3711.406175012012, 3715.8699445519546, 3719.6838268747188, 3721.0325315417917, 1068.6099573655638, 1078.7195329214383, 1090.6346373964732, 1090.7055095124351, 1098.6649072033026, 11802.0, 11840.644780656594, 11841.993430558412, 11844.0, 11873.871982161681, 4518.344839998247, 4526.818927242939, 4672.135654903854, 4705.811767529329, 4723.8034314044135, 9227.723168304961, 9263.629454821732, 9263.629454821867, 9277.443353398683, 9279.72160835176, 5319.361676598755, 5323.946760532423, 5325.174597937326, 5330.7068111253475, 5331.920021199685, 4210.961578221092, 4449.844255451044, 4554.271316589396, 4930.7288099154175, 4987.60099192071, 3307.818070006125, 3826.598207188205, 3836.769793812324, 3913.745606535566, 3945.743526670757, 1168.684455197109, 1188.4651906642046, 1189.9821502677466, 1200.7178313096415, 1201.0571701214506, 836.7698882807155, 890.5858775669216, 905.1672461335587, 923.6166990698919, 946.5740416812462, 5844.561657875676, 5937.317208520989, 5998.340182579913, 6136.5721351362345, 6189.566730328834, 434.3571514158999, 454.9772511374418, 455.2261156034754, 455.68102328370276, 456.3041361923094, 3621.8732344367822, 3625.057485053905, 3671.889843304705, 3761.4169803680475, 3769.5288088988877, 10442.843357349646, 10953.56185752561, 10957.50691218897, 10961.958613931823, 10964.725881853017, 10896.727581810519, 10908.509117089592, 10912.454377281263, 10926.945365273281, 10937.234393592373, 8098.109207987117, 8231.05342885564, 8244.670213191404, 8390.119037501097, 8395.62219700115, 5778.595498315078, 5781.653100813965, 5969.283685957713, 5996.0, 6021.0, 10030.749231268985, 10107.595696172071, 10122.089011988663, 10179.643712470028, 10238.641647542301, 9409.811803763749, 9618.759531011781, 9769.80460390774, 10120.342177758423, 10183.236257280585, 6401.263854656774, 7638.388928885787, 7639.236076392539, 7655.808604784702, 7721.806954826175, 8487.618057187317, 8531.189536993976, 8591.6992905248, 8595.52724600153, 8612.569371531523, 7461.962690186514, 7525.586092764732, 7558.773236802905, 7580.8483830324185, 7662.348700360531, 7379.0, 7395.926040739739, 7411.4070874331, 7458.366038886756, 7459.738909138154, 6890.621015844176, 6970.7211711533, 7047.506674532733, 7054.329838665319, 7054.4003759681, 4999.225120106389, 5044.192929131322, 5048.318477005557, 5068.695878247317, 5102.515261050195, 4945.282933974481, 5025.869179434598, 5084.567811735896, 5186.6369354144845, 5272.156454967187], "value": 4482.75462924796, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.3811764353679, 297.15015056937153, 302.833441607116, 307.58476057322616, 310.0759735986758, 5010.699358038516, 5051.040302342552, 5208.296879921209, 5249.317588713471, 5322.547583455411, 4787.49731278216, 5098.719570423626, 5209.843704688856, 5249.346455866409, 5258.290130832336, 4041.8682768824774, 4045.5233839648463, 4059.4722686050845, 4060.9593904061026, 4061.903286112748, 3661.6155303693126, 3809.5999920008417, 4043.3624382125286, 4072.470578824749, 4087.1825634872994, 3333.3333333333335, 4034.8789536313957, 4078.5921407859123, 4081.469408976829, 4097.815598298069, 3136.8274744889136, 3396.7961922284744, 3651.233241019376, 4001.339778936472, 4033.4151548025666, 3523.6828685418436, 3534.5228394166716, 3553.538040054802, 3553.6091029986683, 3557.6975957043683, 4310.849120280806, 4762.595179409755, 4822.228443449067, 4989.027139707759, 5177.042247184283, 4317.827286908519, 4640.76796160194, 4659.324397962277, 4687.437507499122, 4702.623790096784, 4479.4176757021705, 5552.86117847053, 5569.610127291051, 5591.30108736408, 5659.4340565943485, 3636.9272614547826, 3657.140571965586, 3884.3979183226643, 3941.2314598653275, 3944.3689009758587, 5370.087085195487, 5851.502622277111, 5859.941400585983, 5863.094494289373, 5898.793542226002, 3804.847806087781, 3938.094238325144, 3989.8005099744896, 3996.6403023728003, 4011.859584914514, 3877.4796382351697, 4025.6376926076796, 4041.535223449282, 4050.339360862032, 4062.2484840304637, 4635.235186194308, 4646.605038571692, 4649.0, 4666.2067448533835, 4741.478437371955, 5249.950009998016, 5610.663360198401, 5648.265725455747, 5728.369879313273, 5747.885042299131, 1169.6666450061862, 1250.1498980693034, 1281.557862537423, 1363.8227030485973, 1386.3692020130816, 749.4641331447932, 840.6633452809939, 843.7047033538336, 850.4812064640564, 853.846307664614, 3907.628775266345, 4123.670106391482, 4282.443282373271, 4291.592298731615, 4313.633341165973, 4277.636400905895, 4641.936322027445, 4645.512221216791, 4689.554492323224, 4691.413573303337, 3885.7668539887695, 3956.5252169739238, 4018.849915295303, 4256.978715106405, 4308.719933204395, 2223.776922692545, 2247.7639847815744, 2315.664228686831, 2481.478889433239, 2526.13283922749, 4212.136512015029, 4760.523947605212, 4814.903701925942, 4822.373091498082, 4888.413390393175, 4122.814908098712, 4358.4769827620885, 4649.744264065509, 4684.695494792828, 4793.544613261734, 4365.956340436618, 4370.38814565961, 4462.732236065782, 4506.662000349921, 4863.9513604864915, 4732.201763329913, 4750.429948406213, 4765.070146590636, 4813.374261346003, 4827.831025914076, 4137.81379837902, 4548.2476956510345, 4658.277966915133, 4734.928976065293, 4762.880927976828, 4559.680822342404, 4616.306954436504, 4629.8611041667455, 4900.656954013328, 4956.702597844141, 3201.807891526516, 3387.6104248011793, 3396.454613150961, 3414.573178352706, 3420.9486857696656, 4074.2258970795456, 4354.695171337976, 4447.421835161537, 4551.476580193188, 4714.844863008448, 4799.448063472606, 4892.363992680928, 5242.266082748342, 5522.337319521683, 5630.493255607015, 5546.140348246028, 5637.520810731134, 5671.716414179357, 5717.485426311652, 5776.624519406225, 5227.536289838851, 5241.0, 5543.251661025871, 5580.544560393414, 5602.915956260741, 4563.0, 5577.26713910173, 5610.7755689773585, 5629.915551266652, 5711.428857114255, 5224.604007395224, 5517.006938751063, 5546.500814926676, 5581.358143813513, 5590.273264475592], "value": 3829.3122031756984, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.9576425414475, 739.5636574421097, 765.8966039584654, 777.2421888658558, 806.3871457692156, 14881.627959301022, 15421.460248891291, 15438.99646522978, 15487.84512154878, 15498.92250538747, 14662.973591848575, 14825.110493370405, 14841.183734894577, 14841.183734894577, 14848.777268340957, 684.0696652552524, 702.2029995954603, 704.9848218565276, 842.0989541190928, 848.5121055393158, 865.5974971638218, 867.8871746672955, 875.6891303587198, 880.7269746378611, 880.973570792874, 931.7903471718877, 932.1657116880388, 933.7945651956559, 935.8409070458005, 937.9062093790635, 931.1852129386787, 932.3892850183141, 932.8740620016279, 933.7478880702206, 937.0910217089412, 525.1859617592715, 538.9622726409153, 648.2545073165898, 664.1996394344803, 670.8725342185018, 15046.172460514666, 15079.24603769807, 15106.924465377602, 15116.017458865139, 15116.848831511765, 11543.653690389217, 13724.862751372459, 13995.117982099284, 14276.428942842274, 14529.927350363287, 10880.183986200987, 11258.211925165242, 11416.543338266543, 12387.318697471635, 12731.872681273162, 3865.6520913117674, 4568.868980963046, 4577.427821522309, 4604.102200070987, 4740.028294199681, 93108.0, 108779.0, 108813.0, 110749.0, 112234.43882780615, 10639.308444951208, 10678.946605266923, 10755.56977720898, 10908.945455272673, 11180.608678696206, 17490.737638935425, 20415.672981256466, 20787.06458209384, 20901.0, 20916.84957327331, 7702.152763196044, 7744.57404842739, 7802.453828231969, 7899.486533375312, 7967.0, 4257.0, 4352.717073390219, 4431.844885429059, 4514.593686568224, 4621.4223222097235, 3463.9134021649156, 3598.4962105305276, 3600.8199590020395, 3601.2077342984503, 3606.4590311452966, 630.8296759874808, 649.9252585952676, 657.4510283912987, 662.9403353698191, 669.1835960128733, 548.3611592494779, 599.6821684507219, 606.9817905462843, 624.1055811734742, 639.7121295417081, 8477.915220847712, 8543.188397102265, 8770.517621530877, 8973.775655608662, 9045.140711632515, 531.2854211086083, 549.5878091431426, 581.1921429213397, 621.6767281013847, 627.9811605651838, 4405.559444055633, 4464.933026004613, 4466.932996005063, 4483.843065492692, 4545.272756358967, 163306.0, 165004.17497912433, 166562.0, 168784.0, 175218.12390937965, 120873.0, 127140.36429817791, 142660.0, 144826.0, 147771.0, 43992.0, 63290.68354658289, 79667.0, 113619.99999999834, 118156.0, 8351.415400921876, 8439.282660973886, 8452.450590711584, 8513.602953983389, 8633.30933525329, 56159.0, 59118.930837420485, 62320.37679623146, 64688.0, 65357.673211633635, 87216.56391718001, 89096.43614255617, 89779.0, 92778.53610731903, 96862.0, 12848.871511284768, 13070.34648267602, 13121.343932803513, 13200.933995329962, 13341.66645833862, 13795.379207935466, 14533.854661453674, 14787.852121479078, 14857.331420086339, 15083.245837707851, 10850.67447976562, 13352.265625390697, 13358.0, 13610.754225552673, 14497.710045798814, 13477.39351729155, 14005.789913151515, 14039.578812635636, 14044.438222470986, 14162.858371416154, 13427.798583021067, 13477.865221347662, 13651.249181295125, 14150.43398264099, 14478.348474318891, 9137.497437640994, 10909.618163364245, 11337.149713771336, 11421.029212517029, 11863.110266729856, 9168.954155229181, 10363.378197308186, 11602.379771938522, 11771.823422648496, 11848.407579621156], "value": 7722.5335245962215, "unit": "score"}], "name": "dromaeo_css", "value": 7181.734742433813, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 114.0, 113.0, 115.0, 113.0, 114.0, 113.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 106.0, 143.0, 109.0, 109.0, 109.0, 106.0, 137.0, 107.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 183.0, 184.0, 182.0, 184.0, 183.0, 184.0, 183.0, 184.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 87.0, 60.0, 58.0, 58.0, 58.0, 82.0, 73.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 94.0, 69.0, 68.0, 68.0, 92.0, 70.0, 92.0, 124.0], "value": 83.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 90.0, 92.0, 90.0, 87.0, 93.0, 91.0, 89.0, 87.0], "value": 90.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 98.0, 94.0, 94.0, 100.0, 145.0, 105.0], "value": 101.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 87.0, 85.0, 86.0, 86.0, 86.0, 83.0, 140.0], "value": 90.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 52.0, 53.0, 57.0, 57.0, 56.0, 57.0, 57.0, 57.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 69.0, 76.0, 72.0, 69.0, 69.0, 70.0, 70.0, 76.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 82.0, 85.0, 80.0, 84.0, 81.0, 83.0, 83.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 139.0, 151.0, 152.0, 136.0, 149.0, 154.0, 194.0, 139.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 169.0, 167.0, 167.0, 171.0, 164.0, 168.0, 168.0, 184.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 66.0, 66.0, 67.0, 67.0, 69.0, 67.0, 67.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1443.1, "alertThreshold": 2.0}]} 17:15:33 INFO - Return code: 0 17:15:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:15:34 INFO - # TBPL SUCCESS # 17:15:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:15:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:15:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:15:34 INFO - 2016-10-24 17:15:34.021 screenresolution[1660:9757] starting screenresolution argv=screenresolution get 17:15:34 INFO - 2016-10-24 17:15:34.024 screenresolution[1660:9757] Display 0: 1600x1200x32@60 17:15:34 INFO - 2016-10-24 17:15:34.030 screenresolution[1661:9760] starting screenresolution argv=screenresolution list 17:15:34 INFO - Available Modes on Display 0 17:15:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:15:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:15:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:15:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:15:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:15:34 INFO - Intel Iris: 17:15:34 INFO - Chipset Model: Intel Iris 17:15:34 INFO - Type: GPU 17:15:34 INFO - Bus: Built-In 17:15:34 INFO - VRAM (Dynamic, Max): 1536 MB 17:15:34 INFO - Vendor: Intel (0x8086) 17:15:34 INFO - Device ID: 0x0a2e 17:15:34 INFO - Revision ID: 0x0009 17:15:34 INFO - Displays: 17:15:34 INFO - Display: 17:15:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:15:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:15:34 INFO - Display Serial Number: 1600x1200 60 17:15:34 INFO - Main Display: Yes 17:15:34 INFO - Mirror: Off 17:15:34 INFO - Online: Yes 17:15:34 INFO - Rotation: Supported 17:15:34 INFO - Return code: 0 17:15:34 INFO - Running post-action listener: _resource_record_post_action 17:15:34 INFO - [mozharness: 2016-10-25 00:15:34.274802Z] Finished run-tests step (success) 17:15:34 INFO - Running post-run listener: _resource_record_post_run 17:15:34 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 36447232; Write bytes: 659309568; Read time: 239; Write time: 1874 17:15:34 INFO - TinderboxPrint: CPU usage
53.5% 17:15:34 INFO - TinderboxPrint: I/O read bytes / time
36,447,232 / 239 17:15:34 INFO - TinderboxPrint: I/O write bytes / time
659,309,568 / 1,874 17:15:34 INFO - TinderboxPrint: CPU idle
2,245.7 (46.5%) 17:15:34 INFO - TinderboxPrint: CPU system
970.2 (20.1%) 17:15:34 INFO - TinderboxPrint: CPU user
1,617.8 (33.5%) 17:15:34 INFO - TinderboxPrint: Swap in / out
400,146,432 / 0 17:15:34 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 355031552; Write bytes: 356550656; Read time: 27681; Write time: 754 17:15:34 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35484672; Write bytes: 292572160; Read time: 225; Write time: 1090 17:15:34 INFO - Running post-run listener: _upload_blobber_files 17:15:34 INFO - Blob upload gear active. 17:15:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:15:34 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 17:15:34 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'] 17:15:34 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 17:15:35 INFO - (blobuploader) - INFO - Open directory for files ... 17:15:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:15:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:15:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:36 INFO - (blobuploader) - INFO - Done attempting. 17:15:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:15:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:15:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:37 INFO - (blobuploader) - INFO - Done attempting. 17:15:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:15:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:15:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:39 INFO - (blobuploader) - INFO - Done attempting. 17:15:39 INFO - (blobuploader) - INFO - Iteration through files over. 17:15:39 INFO - Return code: 0 17:15:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:15:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:15:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cd81111b31829808821dcfac30a2141c2d66d20e43c05dd1008c2dc10e9d368ce1f0ff90834bf1a5645b2145ea944a8dbe3767aed97fdddc4053fb9525c06c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcda3aee7c997dec738df9d4a766c51886ff74328e6b9c3a336cb7bf76aa5d118a45d9e4a7b856f9df30232e1ced8809f3b336ef65424fe8293ce0010e5f182d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/845c55a9b9fb057b9de6a9c76dca0298f770b63d4221fdd9f9c1c35c00ad887272aea1e7ce02d7eb8f645f8df55ffccb4050686ec07c0936d49f75dd8f1d35ba"} 17:15:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:15:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:15:39 INFO - Contents: 17:15:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cd81111b31829808821dcfac30a2141c2d66d20e43c05dd1008c2dc10e9d368ce1f0ff90834bf1a5645b2145ea944a8dbe3767aed97fdddc4053fb9525c06c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcda3aee7c997dec738df9d4a766c51886ff74328e6b9c3a336cb7bf76aa5d118a45d9e4a7b856f9df30232e1ced8809f3b336ef65424fe8293ce0010e5f182d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/845c55a9b9fb057b9de6a9c76dca0298f770b63d4221fdd9f9c1c35c00ad887272aea1e7ce02d7eb8f645f8df55ffccb4050686ec07c0936d49f75dd8f1d35ba"} 17:15:39 INFO - Running post-run listener: copy_logs_to_upload_dir 17:15:39 INFO - Copying logs to upload dir... 17:15:39 INFO - mkdir: /builds/slave/test/build/upload/logs 17:15:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.799512 ========= master_lag: 3.51 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-24 17:15:43.207809) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-10-24 17:15:43.212050) ========= 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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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/2cd81111b31829808821dcfac30a2141c2d66d20e43c05dd1008c2dc10e9d368ce1f0ff90834bf1a5645b2145ea944a8dbe3767aed97fdddc4053fb9525c06c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcda3aee7c997dec738df9d4a766c51886ff74328e6b9c3a336cb7bf76aa5d118a45d9e4a7b856f9df30232e1ced8809f3b336ef65424fe8293ce0010e5f182d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/845c55a9b9fb057b9de6a9c76dca0298f770b63d4221fdd9f9c1c35c00ad887272aea1e7ce02d7eb8f645f8df55ffccb4050686ec07c0936d49f75dd8f1d35ba"} build_url:https://queue.taskcluster.net/v1/task/WQKYPom2Q3C46E7BNK03Tw/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/WQKYPom2Q3C46E7BNK03Tw/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/2cd81111b31829808821dcfac30a2141c2d66d20e43c05dd1008c2dc10e9d368ce1f0ff90834bf1a5645b2145ea944a8dbe3767aed97fdddc4053fb9525c06c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcda3aee7c997dec738df9d4a766c51886ff74328e6b9c3a336cb7bf76aa5d118a45d9e4a7b856f9df30232e1ced8809f3b336ef65424fe8293ce0010e5f182d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/845c55a9b9fb057b9de6a9c76dca0298f770b63d4221fdd9f9c1c35c00ad887272aea1e7ce02d7eb8f645f8df55ffccb4050686ec07c0936d49f75dd8f1d35ba"}' ========= master_lag: 1.37 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-10-24 17:15:44.590796) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2016-10-24 17:15:44.591202) ========= 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.Lru6FKkVDx/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.FSWuz8DKTX/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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.005094 ========= master_lag: 12.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2016-10-24 17:15:56.742212) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 17:15:56.742602) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 17:15:57.137733) ========= ========= Total master_lag: 17.48 =========