builder: pine_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0367 starttime: 1492449926.45 results: success (0) buildid: 20170417082108 builduid: fcabfd3f11bc48d68b718b9892105b60 revision: befe7c6050b76a46f5d4bed42e28eca8fa6d31ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 10:25:26.454364) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 10:25:26.454803) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 10:25:26.455084) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 10:25:26.481417) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 10:25:26.481796) ========= 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.s9gcUjqLhx/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.bMTcsRyfen/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 --2017-04-17 10:25:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.1M=0.001s 2017-04-17 10:25:26 (18.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.276930 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 10:25:26.782601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 10:25:26.783091) ========= 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.s9gcUjqLhx/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.bMTcsRyfen/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.027512 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 10:25:26.832435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 10:25:26.832801) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev befe7c6050b76a46f5d4bed42e28eca8fa6d31ca --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev befe7c6050b76a46f5d4bed42e28eca8fa6d31ca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s9gcUjqLhx/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.bMTcsRyfen/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 2017-04-17 10:25:26,905 truncating revision to first 12 chars 2017-04-17 10:25:26,905 Setting DEBUG logging. 2017-04-17 10:25:26,905 attempt 1/10 2017-04-17 10:25:26,905 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/befe7c6050b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-17 10:25:28,576 unpacking tar archive at: pine-befe7c6050b7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.969334 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 10:25:28.823791) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 10:25:28.824131) ========= script_repo_revision: befe7c6050b76a46f5d4bed42e28eca8fa6d31ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 10:25:28.824518) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 10:25:28.824803) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 10:25:28.842699) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-17 10:25:28.843002) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s9gcUjqLhx/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.bMTcsRyfen/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 10:25:29 INFO - MultiFileLogger online at 20170417 10:25:29 in /builds/slave/test 10:25:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 10:25:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:25:29 INFO - {'append_to_log': False, 10:25:29 INFO - 'base_work_dir': '/builds/slave/test', 10:25:29 INFO - 'blob_upload_branch': 'Pine', 10:25:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:25:29 INFO - 'branch': 'Pine', 10:25:29 INFO - 'buildbot_json_path': 'buildprops.json', 10:25:29 INFO - 'config_files': ('talos/mac_config.py',), 10:25:29 INFO - 'default_actions': ('clobber', 10:25:29 INFO - 'read-buildbot-config', 10:25:29 INFO - 'download-and-extract', 10:25:29 INFO - 'populate-webroot', 10:25:29 INFO - 'create-virtualenv', 10:25:29 INFO - 'install', 10:25:29 INFO - 'run-tests'), 10:25:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:25:29 INFO - 'download_minidump_stackwalk': True, 10:25:29 INFO - 'download_symbols': 'ondemand', 10:25:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:25:29 INFO - 'tooltool.py': '/tools/tooltool.py', 10:25:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:25:29 INFO - '/tools/misc-python/virtualenv.py')}, 10:25:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:25:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:25:29 INFO - 'gecko_profile': False, 10:25:29 INFO - 'gecko_profile_interval': 0, 10:25:29 INFO - 'installer_path': 'installer.exe', 10:25:29 INFO - 'log_level': 'info', 10:25:29 INFO - 'log_name': 'talos', 10:25:29 INFO - 'log_to_console': True, 10:25:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:25:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:25:29 INFO - 'opt_config_files': (), 10:25:29 INFO - 'pip_index': False, 10:25:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:25:29 INFO - 'cmd': ('bash', 10:25:29 INFO - '-c', 10:25:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:25:29 INFO - 'enabled': True, 10:25:29 INFO - 'halt_on_failure': False, 10:25:29 INFO - 'name': 'check_screen_resolution'},), 10:25:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:25:29 INFO - 'cmd': ('bash', 10:25:29 INFO - '-c', 10:25:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:25:29 INFO - 'enabled': True, 10:25:29 INFO - 'halt_on_failure': False, 10:25:29 INFO - 'name': 'check_screen_resolution'},), 10:25:29 INFO - 'run_cmd_checks_enabled': True, 10:25:29 INFO - 'suite': 'dromaeojs', 10:25:29 INFO - 'system_bits': '32', 10:25:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:25:29 INFO - 'title': 't-yosemite-r7-0367', 10:25:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:25:29 INFO - 'use_talos_json': True, 10:25:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:25:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:25:29 INFO - 'work_dir': 'build'} 10:25:29 INFO - [mozharness: 2017-04-17 17:25:29.015166Z] Running clobber step. 10:25:29 INFO - Running pre-action listener: _resource_record_pre_action 10:25:29 INFO - Running main action method: clobber 10:25:29 INFO - rmtree: /builds/slave/test/build 10:25:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:25:31 INFO - Running post-action listener: _resource_record_post_action 10:25:31 INFO - [mozharness: 2017-04-17 17:25:31.493709Z] Finished clobber step (success) 10:25:31 INFO - [mozharness: 2017-04-17 17:25:31.493825Z] Running read-buildbot-config step. 10:25:31 INFO - Running pre-action listener: _resource_record_pre_action 10:25:31 INFO - Running main action method: read_buildbot_config 10:25:31 INFO - Using buildbot properties: 10:25:31 INFO - { 10:25:31 INFO - "project": "", 10:25:31 INFO - "product": "firefox", 10:25:31 INFO - "script_repo_revision": "default", 10:25:31 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs", 10:25:31 INFO - "repository": "", 10:25:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs", 10:25:31 INFO - "buildid": "20170417082108", 10:25:31 INFO - "pgo_build": "False", 10:25:31 INFO - "basedir": "/builds/slave/test", 10:25:31 INFO - "buildnumber": 1, 10:25:31 INFO - "slavename": "t-yosemite-r7-0367", 10:25:31 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:25:31 INFO - "platform": "yosemite_r7", 10:25:31 INFO - "scheduler": "tests-pine-macosx64-talos", 10:25:31 INFO - "branch": "pine", 10:25:31 INFO - "repo_path": "projects/pine", 10:25:31 INFO - "revision": "befe7c6050b76a46f5d4bed42e28eca8fa6d31ca", 10:25:31 INFO - "stage_platform": "macosx64", 10:25:31 INFO - "builduid": "fcabfd3f11bc48d68b718b9892105b60", 10:25:31 INFO - "slavebuilddir": "test" 10:25:31 INFO - } 10:25:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:25:31 INFO - Running post-action listener: _resource_record_post_action 10:25:31 INFO - [mozharness: 2017-04-17 17:25:31.497220Z] Finished read-buildbot-config step (success) 10:25:31 INFO - [mozharness: 2017-04-17 17:25:31.497331Z] Running download-and-extract step. 10:25:31 INFO - Running pre-action listener: _resource_record_pre_action 10:25:31 INFO - Running main action method: download_and_extract 10:25:31 INFO - mkdir: /builds/slave/test/build/tests 10:25:31 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')]} 10:25:31 INFO - trying https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:25:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:25:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 10:25:32 INFO - Downloaded 1325 bytes. 10:25:32 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:25:32 INFO - Using the following test package requirements: 10:25:32 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:25:32 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:25:32 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:25:32 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:25:32 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:25:32 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:25:32 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:25:32 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:25:32 INFO - u'jsshell-mac.zip'], 10:25:32 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:25:32 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:25:32 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:25:32 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:25:32 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:25:32 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:25:32 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:25:32 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:25:32 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:25:32 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:25:32 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:25:32 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:25:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:25:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:25:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:25:34 INFO - Expected file size: 52660073 10:25:34 INFO - Obtained file size: 52660073 10:25:50 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:25:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:25:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:25:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:25:52 INFO - Expected file size: 52660073 10:25:52 INFO - Obtained file size: 52660073 10:26:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:26:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:26:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:26:09 INFO - Expected file size: 14408802 10:26:09 INFO - Obtained file size: 14408802 10:26: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')]} 10:26:09 INFO - trying https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:26:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:26:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 10:26:11 INFO - Downloaded 71490717 bytes. 10:26:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:26:11 INFO - mkdir: /builds/slave/test/properties 10:26:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:26:11 INFO - Writing to file /builds/slave/test/properties/build_url 10:26:11 INFO - Contents: 10:26:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:26:12 INFO - Running post-action listener: _resource_record_post_action 10:26:12 INFO - Running post-action listener: set_extra_try_arguments 10:26:12 INFO - [mozharness: 2017-04-17 17:26:12.155541Z] Finished download-and-extract step (success) 10:26:12 INFO - [mozharness: 2017-04-17 17:26:12.155678Z] Running populate-webroot step. 10:26:12 INFO - Running pre-action listener: _resource_record_pre_action 10:26:12 INFO - Running main action method: populate_webroot 10:26:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:26:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:26:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:26:12 INFO - '--tppagecycles', 10:26:12 INFO - '7'], 10:26:12 INFO - 'tests': ['tsvgm']}}, 10:26:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:26:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:26:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:26:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:26:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:26:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:26:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:26:12 INFO - 'talos_options': ['--disable-e10s'], 10:26:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:26:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:26:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:26:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:26:12 INFO - 'talos_options': ['--disable-e10s'], 10:26:12 INFO - 'tests': ['damp', 'tps']}, 10:26:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:26:12 INFO - 'tests': ['damp', 'tps']}, 10:26:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:26:12 INFO - 'tests': ['dromaeo_dom']}, 10:26:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:26:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:26:12 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:26:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:26:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:26:12 INFO - 'tests': ['a11yr', 10:26:12 INFO - 'ts_paint', 10:26:12 INFO - 'tpaint', 10:26:12 INFO - 'sessionrestore', 10:26:12 INFO - 'sessionrestore_no_auto_restore', 10:26:12 INFO - 'tabpaint']}, 10:26:12 INFO - 'other-e10s': {'tests': ['a11yr', 10:26:12 INFO - 'ts_paint', 10:26:12 INFO - 'tpaint', 10:26:12 INFO - 'sessionrestore', 10:26:12 INFO - 'sessionrestore_no_auto_restore', 10:26:12 INFO - 'tabpaint']}, 10:26:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:26:12 INFO - 'ts_paint', 10:26:12 INFO - 'tpaint', 10:26:12 INFO - 'sessionrestore', 10:26:12 INFO - 'sessionrestore_no_auto_restore', 10:26:12 INFO - 'tabpaint']}, 10:26:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:26:12 INFO - 'ts_paint', 10:26:12 INFO - 'tpaint', 10:26:12 INFO - 'sessionrestore', 10:26:12 INFO - 'sessionrestore_no_auto_restore', 10:26:12 INFO - 'tabpaint']}, 10:26:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:26:12 INFO - 'tests': ['a11yr', 10:26:12 INFO - 'ts_paint', 10:26:12 INFO - 'tpaint', 10:26:12 INFO - 'sessionrestore', 10:26:12 INFO - 'sessionrestore_no_auto_restore', 10:26:12 INFO - 'tabpaint']}, 10:26:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:26:12 INFO - 'tests': ['a11yr', 10:26:12 INFO - 'ts_paint', 10:26:12 INFO - 'tpaint', 10:26:12 INFO - 'sessionrestore', 10:26:12 INFO - 'sessionrestore_no_auto_restore', 10:26:12 INFO - 'tabpaint']}, 10:26:12 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:26:12 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:26:12 INFO - 'bloom_basic_ref']}, 10:26:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:26:12 INFO - 'tests': ['tsvgx', 10:26:12 INFO - 'tsvgr_opacity', 10:26:12 INFO - 'tart', 10:26:12 INFO - 'tscrollx', 10:26:12 INFO - 'cart', 10:26:12 INFO - 'tsvg_static']}, 10:26:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:26:12 INFO - 'tsvgr_opacity', 10:26:12 INFO - 'tart', 10:26:12 INFO - 'tscrollx', 10:26:12 INFO - 'cart', 10:26:12 INFO - 'tsvg_static']}, 10:26:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:26:12 INFO - 'talos_options': ['--disable-e10s'], 10:26:12 INFO - 'tests': ['tp5o']}, 10:26:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:26:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:26:12 INFO - 'talos_options': ['--disable-e10s', 10:26:12 INFO - '--xperf_path', 10:26:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:26:12 INFO - 'tests': ['tp5n']}, 10:26:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:26:12 INFO - 'talos_options': ['--xperf_path', 10:26:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:26:12 INFO - 'tests': ['tp5n']}}, 10:26:12 INFO - 'talos.zip': {'path': '', 10:26:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:26:12 INFO - Running post-action listener: _resource_record_post_action 10:26:12 INFO - [mozharness: 2017-04-17 17:26:12.174684Z] Finished populate-webroot step (success) 10:26:12 INFO - [mozharness: 2017-04-17 17:26:12.174798Z] Running create-virtualenv step. 10:26:12 INFO - Running pre-action listener: _resource_record_pre_action 10:26:12 INFO - Running main action method: create_virtualenv 10:26:12 INFO - Creating virtualenv /builds/slave/test/build/venv 10:26:12 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 10:26:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:26:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:26:12 INFO - Using real prefix '/tools/python27' 10:26:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:26:13 INFO - Installing distribute.............................................................................................................................................................................................done. 10:26:15 INFO - Installing pip.................done. 10:26:15 INFO - Return code: 0 10:26:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:26:16 INFO - Reading from file tmpfile_stdout 10:26:16 INFO - Output received: 10:26:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:26:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:26:16 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')]} 10:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:16 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')]} 10:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:16 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 0x10c90db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b3c6dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ebd30>, '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 0x10c611db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e0be8>, '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.s9gcUjqLhx/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.bMTcsRyfen/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 10:26:16 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 10:26:16 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 10:26:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9gcUjqLhx/Render', 10:26:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:16 INFO - 'HOME': '/Users/cltbld', 10:26:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:16 INFO - 'LOGNAME': 'cltbld', 10:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:16 INFO - 'MOZ_NO_REMOTE': '1', 10:26:16 INFO - 'NO_EM_RESTART': '1', 10:26:16 INFO - 'PAGER': '/bin/cat', 10:26:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:16 INFO - 'PWD': '/builds/slave/test', 10:26:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:16 INFO - 'SHELL': '/bin/bash', 10:26:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bMTcsRyfen/Listeners', 10:26:16 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:26:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:16 INFO - 'USER': 'cltbld', 10:26:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:16 INFO - 'XPC_FLAGS': '0x0', 10:26:16 INFO - 'XPC_SERVICE_NAME': '0', 10:26:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:16 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 10:26:16 INFO - Cleaning up... 10:26:16 INFO - Return code: 0 10:26:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:26:16 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')]} 10:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:16 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')]} 10:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:16 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 0x10c90db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b3c6dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ebd30>, '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 0x10c611db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e0be8>, '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.s9gcUjqLhx/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.bMTcsRyfen/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 10:26:16 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 10:26:16 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 10:26:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9gcUjqLhx/Render', 10:26:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:16 INFO - 'HOME': '/Users/cltbld', 10:26:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:16 INFO - 'LOGNAME': 'cltbld', 10:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:16 INFO - 'MOZ_NO_REMOTE': '1', 10:26:16 INFO - 'NO_EM_RESTART': '1', 10:26:16 INFO - 'PAGER': '/bin/cat', 10:26:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:16 INFO - 'PWD': '/builds/slave/test', 10:26:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:16 INFO - 'SHELL': '/bin/bash', 10:26:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bMTcsRyfen/Listeners', 10:26:16 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:26:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:16 INFO - 'USER': 'cltbld', 10:26:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:16 INFO - 'XPC_FLAGS': '0x0', 10:26:16 INFO - 'XPC_SERVICE_NAME': '0', 10:26:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:16 INFO - Downloading/unpacking psutil>=3.1.1 10:26:16 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 10:26:16 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 10:26:16 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 10:26:16 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 10:26:16 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 10:26:16 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 10:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:26:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:26:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:26:20 INFO - Installing collected packages: psutil 10:26:20 INFO - Running setup.py install for psutil 10:26:20 INFO - building 'psutil._psutil_osx' extension 10:26:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:26:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:26:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:26:20 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 10:26:21 INFO - building 'psutil._psutil_posix' extension 10:26:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:26:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:26:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:26:21 INFO - ^ 10:26:21 INFO - 1 warning generated. 10:26:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:26:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:26:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:26:21 INFO - Successfully installed psutil 10:26:21 INFO - Cleaning up... 10:26:21 INFO - Return code: 0 10:26:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c90db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b3c6dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ebd30>, '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 0x10c611db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e0be8>, '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.s9gcUjqLhx/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.bMTcsRyfen/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 10:26:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:26:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9gcUjqLhx/Render', 10:26:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:21 INFO - 'HOME': '/Users/cltbld', 10:26:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:21 INFO - 'LOGNAME': 'cltbld', 10:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:21 INFO - 'MOZ_NO_REMOTE': '1', 10:26:21 INFO - 'NO_EM_RESTART': '1', 10:26:21 INFO - 'PAGER': '/bin/cat', 10:26:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:21 INFO - 'PWD': '/builds/slave/test', 10:26:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:21 INFO - 'SHELL': '/bin/bash', 10:26:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bMTcsRyfen/Listeners', 10:26:21 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:26:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:21 INFO - 'USER': 'cltbld', 10:26:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:21 INFO - 'XPC_FLAGS': '0x0', 10:26:21 INFO - 'XPC_SERVICE_NAME': '0', 10:26:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:26:24 INFO - Installing collected packages: mozsystemmonitor 10:26:24 INFO - Running setup.py install for mozsystemmonitor 10:26:24 INFO - Successfully installed mozsystemmonitor 10:26:24 INFO - Cleaning up... 10:26:24 INFO - Return code: 0 10:26:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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')]} 10:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c90db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b3c6dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ebd30>, '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 0x10c611db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e0be8>, '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.s9gcUjqLhx/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.bMTcsRyfen/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 10:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9gcUjqLhx/Render', 10:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:25 INFO - 'HOME': '/Users/cltbld', 10:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:25 INFO - 'LOGNAME': 'cltbld', 10:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:25 INFO - 'MOZ_NO_REMOTE': '1', 10:26:25 INFO - 'NO_EM_RESTART': '1', 10:26:25 INFO - 'PAGER': '/bin/cat', 10:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:25 INFO - 'PWD': '/builds/slave/test', 10:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:25 INFO - 'SHELL': '/bin/bash', 10:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bMTcsRyfen/Listeners', 10:26:25 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:25 INFO - 'USER': 'cltbld', 10:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:25 INFO - 'XPC_FLAGS': '0x0', 10:26:25 INFO - 'XPC_SERVICE_NAME': '0', 10:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:25 INFO - Downloading/unpacking jsonschema==2.5.1 10:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:26:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:28 INFO - Downloading functools32-3.2.3-2.tar.gz 10:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:26:28 INFO - warning: no files found matching '*.txt' 10:26:28 INFO - no previously-included directories found matching 'build' 10:26:28 INFO - no previously-included directories found matching 'dist' 10:26:28 INFO - no previously-included directories found matching '.git*' 10:26:28 INFO - Installing collected packages: jsonschema, functools32 10:26:28 INFO - Running setup.py install for functools32 10:26:28 INFO - warning: no files found matching '*.txt' 10:26:28 INFO - no previously-included directories found matching 'build' 10:26:28 INFO - no previously-included directories found matching 'dist' 10:26:28 INFO - no previously-included directories found matching '.git*' 10:26:28 INFO - Successfully installed jsonschema functools32 10:26:28 INFO - Cleaning up... 10:26:28 INFO - Return code: 0 10:26:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c90db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b3c6dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ebd30>, '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 0x10c611db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e0be8>, '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.s9gcUjqLhx/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.bMTcsRyfen/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 10:26:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:26:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9gcUjqLhx/Render', 10:26:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:28 INFO - 'HOME': '/Users/cltbld', 10:26:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:28 INFO - 'LOGNAME': 'cltbld', 10:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:28 INFO - 'MOZ_NO_REMOTE': '1', 10:26:28 INFO - 'NO_EM_RESTART': '1', 10:26:28 INFO - 'PAGER': '/bin/cat', 10:26:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:28 INFO - 'PWD': '/builds/slave/test', 10:26:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:28 INFO - 'SHELL': '/bin/bash', 10:26:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bMTcsRyfen/Listeners', 10:26:28 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:26:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:28 INFO - 'USER': 'cltbld', 10:26:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:28 INFO - 'XPC_FLAGS': '0x0', 10:26:28 INFO - 'XPC_SERVICE_NAME': '0', 10:26:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:26:29 INFO - Cleaning up... 10:26:29 INFO - Return code: 0 10:26:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:29 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 0x10c90db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b3c6dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ebd30>, '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 0x10c611db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e0be8>, '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.s9gcUjqLhx/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.bMTcsRyfen/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 10:26:29 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 10:26:29 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 10:26:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9gcUjqLhx/Render', 10:26:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:29 INFO - 'HOME': '/Users/cltbld', 10:26:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:29 INFO - 'LOGNAME': 'cltbld', 10:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:29 INFO - 'MOZ_NO_REMOTE': '1', 10:26:29 INFO - 'NO_EM_RESTART': '1', 10:26:29 INFO - 'PAGER': '/bin/cat', 10:26:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:29 INFO - 'PWD': '/builds/slave/test', 10:26:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:29 INFO - 'SHELL': '/bin/bash', 10:26:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bMTcsRyfen/Listeners', 10:26:29 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:26:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:29 INFO - 'USER': 'cltbld', 10:26:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:29 INFO - 'XPC_FLAGS': '0x0', 10:26:29 INFO - 'XPC_SERVICE_NAME': '0', 10:26:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:29 INFO - Downloading/unpacking blobuploader==1.2.4 10:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:31 INFO - Downloading blobuploader-1.2.4.tar.gz 10:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:26:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:26:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:33 INFO - Downloading docopt-0.6.1.tar.gz 10:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:26:33 INFO - Installing collected packages: blobuploader, requests, docopt 10:26:33 INFO - Running setup.py install for blobuploader 10:26:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:26:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:26:33 INFO - Running setup.py install for requests 10:26:34 INFO - Running setup.py install for docopt 10:26:34 INFO - Successfully installed blobuploader requests docopt 10:26:34 INFO - Cleaning up... 10:26:34 INFO - Return code: 0 10:26:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:34 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')]} 10:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:34 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')]} 10:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:34 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 0x10c90db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b3c6dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ebd30>, '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 0x10c611db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e0be8>, '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.s9gcUjqLhx/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.bMTcsRyfen/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 10:26:34 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 10:26:34 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 10:26:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9gcUjqLhx/Render', 10:26:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:34 INFO - 'HOME': '/Users/cltbld', 10:26:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:34 INFO - 'LOGNAME': 'cltbld', 10:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:34 INFO - 'MOZ_NO_REMOTE': '1', 10:26:34 INFO - 'NO_EM_RESTART': '1', 10:26:34 INFO - 'PAGER': '/bin/cat', 10:26:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:34 INFO - 'PWD': '/builds/slave/test', 10:26:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:34 INFO - 'SHELL': '/bin/bash', 10:26:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bMTcsRyfen/Listeners', 10:26:34 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:26:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:34 INFO - 'USER': 'cltbld', 10:26:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:34 INFO - 'XPC_FLAGS': '0x0', 10:26:34 INFO - 'XPC_SERVICE_NAME': '0', 10:26:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:26:34 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-b3Vc85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:26:34 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Nwi1NY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:26:34 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ZoaRBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:26:34 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-4gGB1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:26:34 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-URvcWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:26:35 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-jyRo9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:26:35 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Uo_LaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:26:35 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-yAtRIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:26:35 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ycvrQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:26:35 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-XQXfbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:26:35 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-RsNxS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:26:35 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-DRu5mQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:26:35 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-5MzXJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:26:35 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-c2etXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:35 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-PFoBhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:26:36 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-mhRT6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:26:36 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-MOZvbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:26:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:26:36 INFO - Running setup.py install for manifestparser 10:26:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:26:36 INFO - Running setup.py install for mozcrash 10:26:36 INFO - Running setup.py install for mozdebug 10:26:36 INFO - Running setup.py install for mozdevice 10:26:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:26:36 INFO - Running setup.py install for mozfile 10:26:37 INFO - Running setup.py install for mozhttpd 10:26:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:26:37 INFO - Running setup.py install for mozinfo 10:26:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:26:37 INFO - Running setup.py install for mozInstall 10:26:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:26:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:26:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:26:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:26:37 INFO - Running setup.py install for mozleak 10:26:37 INFO - Running setup.py install for mozlog 10:26:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:26:37 INFO - Running setup.py install for moznetwork 10:26:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:26:37 INFO - Running setup.py install for mozprocess 10:26:38 INFO - Running setup.py install for mozprofile 10:26:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:26:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:26:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:26:38 INFO - Running setup.py install for mozrunner 10:26:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:26:38 INFO - Running setup.py install for mozscreenshot 10:26:38 INFO - Running setup.py install for moztest 10:26:38 INFO - Running setup.py install for mozversion 10:26:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:26:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:26:38 INFO - Cleaning up... 10:26:38 INFO - Return code: 0 10:26:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c90db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b3c6dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ebd30>, '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 0x10c611db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e0be8>, '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.s9gcUjqLhx/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.bMTcsRyfen/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 10:26:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:26:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9gcUjqLhx/Render', 10:26:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:38 INFO - 'HOME': '/Users/cltbld', 10:26:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:38 INFO - 'LOGNAME': 'cltbld', 10:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:38 INFO - 'MOZ_NO_REMOTE': '1', 10:26:38 INFO - 'NO_EM_RESTART': '1', 10:26:38 INFO - 'PAGER': '/bin/cat', 10:26:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:38 INFO - 'PWD': '/builds/slave/test', 10:26:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:38 INFO - 'SHELL': '/bin/bash', 10:26:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bMTcsRyfen/Listeners', 10:26:38 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:26:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:38 INFO - 'USER': 'cltbld', 10:26:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:38 INFO - 'XPC_FLAGS': '0x0', 10:26:38 INFO - 'XPC_SERVICE_NAME': '0', 10:26:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:26:39 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-yTkbPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:26:39 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)) 10:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:26:39 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-oihTRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:26:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 10:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:26:39 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-y6tCEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:26:39 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)) 10:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:26:39 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-y_dw9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:26:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 10:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:26:39 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-WxAbG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:26:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:26:39 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-nCJL2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:26:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:26:39 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-tqSWjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:26:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:26:39 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-060J9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:26:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:26:39 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-GfclvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:26:40 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)) 10:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:26:40 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Tu1Wbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:26:40 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)) 10:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:26:40 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-pNdNRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:26:40 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)) 10:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:26:40 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-AfxRri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 10:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:26:40 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ciRO0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:26:40 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-3O54zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 10:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:40 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ize2fV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:26:40 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-fCMstW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 10:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:26:40 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-1Jh_px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:26:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:43 INFO - Downloading blessings-1.6.tar.gz 10:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:26:43 INFO - Installing collected packages: blessings 10:26:43 INFO - Running setup.py install for blessings 10:26:43 INFO - Successfully installed blessings 10:26:43 INFO - Cleaning up... 10:26:43 INFO - Return code: 0 10:26:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:26:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:26:44 INFO - Reading from file tmpfile_stdout 10:26:44 INFO - Current package versions: 10:26:44 INFO - blessings == 1.6 10:26:44 INFO - blobuploader == 1.2.4 10:26:44 INFO - docopt == 0.6.1 10:26:44 INFO - functools32 == 3.2.3-2 10:26:44 INFO - jsonschema == 2.5.1 10:26:44 INFO - manifestparser == 1.1 10:26:44 INFO - mozInstall == 1.12 10:26:44 INFO - mozcrash == 1.0 10:26:44 INFO - mozdebug == 0.1 10:26:44 INFO - mozdevice == 0.50 10:26:44 INFO - mozfile == 1.2 10:26:44 INFO - mozhttpd == 0.7 10:26:44 INFO - mozinfo == 0.9 10:26:44 INFO - mozleak == 0.1 10:26:44 INFO - mozlog == 3.4 10:26:44 INFO - moznetwork == 0.27 10:26:44 INFO - mozprocess == 0.25 10:26:44 INFO - mozprofile == 0.28 10:26:44 INFO - mozrunner == 6.13 10:26:44 INFO - mozscreenshot == 0.1 10:26:44 INFO - mozsystemmonitor == 0.3 10:26:44 INFO - moztest == 0.8 10:26:44 INFO - mozversion == 1.4 10:26:44 INFO - psutil == 3.1.1 10:26:44 INFO - requests == 1.2.3 10:26:44 INFO - wsgiref == 0.1.2 10:26:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:44 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')]} 10:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:44 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')]} 10:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:44 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 0x10c90db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b3c6dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ebd30>, '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 0x10c611db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e0be8>, '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.s9gcUjqLhx/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.bMTcsRyfen/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 10:26:44 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 10:26:44 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 10:26:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9gcUjqLhx/Render', 10:26:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:44 INFO - 'HOME': '/Users/cltbld', 10:26:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:44 INFO - 'LOGNAME': 'cltbld', 10:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:44 INFO - 'MOZ_NO_REMOTE': '1', 10:26:44 INFO - 'NO_EM_RESTART': '1', 10:26:44 INFO - 'PAGER': '/bin/cat', 10:26:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:44 INFO - 'PWD': '/builds/slave/test', 10:26:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:44 INFO - 'SHELL': '/bin/bash', 10:26:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bMTcsRyfen/Listeners', 10:26:44 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:26:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:44 INFO - 'USER': 'cltbld', 10:26:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:44 INFO - 'XPC_FLAGS': '0x0', 10:26:44 INFO - 'XPC_SERVICE_NAME': '0', 10:26:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:44 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)) 10:26:44 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)) 10:26:44 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)) 10:26:44 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)) 10:26:44 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)) 10:26:44 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)) 10:26:44 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)) 10:26:44 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)) 10:26:44 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)) 10:26:44 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)) 10:26:44 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)) 10:26:44 INFO - Cleaning up... 10:26:44 INFO - Return code: 0 10:26:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:26:44 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')]} 10:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:44 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')]} 10:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:44 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 0x10c90db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b3c6dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ebd30>, '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 0x10c611db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e0be8>, '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.s9gcUjqLhx/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.bMTcsRyfen/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 10:26:44 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 10:26:44 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 10:26:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9gcUjqLhx/Render', 10:26:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:44 INFO - 'HOME': '/Users/cltbld', 10:26:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:44 INFO - 'LOGNAME': 'cltbld', 10:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:44 INFO - 'MOZ_NO_REMOTE': '1', 10:26:44 INFO - 'NO_EM_RESTART': '1', 10:26:44 INFO - 'PAGER': '/bin/cat', 10:26:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:44 INFO - 'PWD': '/builds/slave/test', 10:26:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:44 INFO - 'SHELL': '/bin/bash', 10:26:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bMTcsRyfen/Listeners', 10:26:44 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:26:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:44 INFO - 'USER': 'cltbld', 10:26:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:44 INFO - 'XPC_FLAGS': '0x0', 10:26:44 INFO - 'XPC_SERVICE_NAME': '0', 10:26:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:26:44 INFO - Cleaning up... 10:26:44 INFO - Return code: 0 10:26:44 INFO - Running post-action listener: _resource_record_post_action 10:26:44 INFO - Running post-action listener: _start_resource_monitoring 10:26:44 INFO - Starting resource monitoring. 10:26:44 INFO - [mozharness: 2017-04-17 17:26:44.809539Z] Finished create-virtualenv step (success) 10:26:44 INFO - [mozharness: 2017-04-17 17:26:44.810479Z] Running install step. 10:26:44 INFO - Running pre-action listener: _resource_record_pre_action 10:26:44 INFO - Running main action method: install 10:26:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:26:45 INFO - Reading from file tmpfile_stdout 10:26:45 INFO - Detecting whether we're running mozinstall >=1.0... 10:26:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:26:45 INFO - Reading from file tmpfile_stdout 10:26:45 INFO - Output received: 10:26:45 INFO - Usage: mozinstall [options] installer 10:26:45 INFO - Options: 10:26:45 INFO - -h, --help show this help message and exit 10:26:45 INFO - -d DEST, --destination=DEST 10:26:45 INFO - Directory to install application into. [default: 10:26:45 INFO - "/builds/slave/test"] 10:26:45 INFO - --app=APP Application being installed. [default: firefox] 10:26:45 INFO - mkdir: /builds/slave/test/build/application 10:26:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:27:04 INFO - Reading from file tmpfile_stdout 10:27:04 INFO - Output received: 10:27:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:27:04 INFO - Running post-action listener: _resource_record_post_action 10:27:04 INFO - [mozharness: 2017-04-17 17:27:04.971605Z] Finished install step (success) 10:27:04 INFO - [mozharness: 2017-04-17 17:27:04.971765Z] Running run-tests step. 10:27:04 INFO - Running pre-action listener: _resource_record_pre_action 10:27:04 INFO - Running main action method: run_tests 10:27:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:27:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:27:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:27:04 INFO - 2017-04-17 10:27:04.986 screenresolution[1622:7336] starting screenresolution argv=screenresolution get 10:27:04 INFO - 2017-04-17 10:27:04.989 screenresolution[1622:7336] Display 0: 1600x1200x32@60 10:27:04 INFO - 2017-04-17 10:27:04.995 screenresolution[1623:7339] starting screenresolution argv=screenresolution list 10:27:04 INFO - Available Modes on Display 0 10:27:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:27:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:27:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:27:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:27:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:27:05 INFO - Intel Iris: 10:27:05 INFO - Chipset Model: Intel Iris 10:27:05 INFO - Type: GPU 10:27:05 INFO - Bus: Built-In 10:27:05 INFO - VRAM (Dynamic, Max): 1536 MB 10:27:05 INFO - Vendor: Intel (0x8086) 10:27:05 INFO - Device ID: 0x0a2e 10:27:05 INFO - Revision ID: 0x0009 10:27:05 INFO - Displays: 10:27:05 INFO - Display: 10:27:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:27:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:27:05 INFO - Display Serial Number: 1600x1200 60 10:27:05 INFO - Main Display: Yes 10:27:05 INFO - Mirror: Off 10:27:05 INFO - Online: Yes 10:27:05 INFO - Rotation: Supported 10:27:05 INFO - Return code: 0 10:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:27:05 INFO - Python 2.7.3 10:27:05 INFO - Return code: 0 10:27:05 INFO - grabbing minidump binary from tooltool 10:27: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')]} 10:27:05 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 0x10c6ebd30>, '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 0x10c611db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:27:05 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 10:27:05 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 10:27:05 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 10:27:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:27:05 INFO - Return code: 0 10:27:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:27:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:27:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:27:05 INFO - ENV: RUST_BACKTRACE is now 1 10:27:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:27:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--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 10:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0367 --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 10:27:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9gcUjqLhx/Render', 10:27:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:05 INFO - 'HOME': '/Users/cltbld', 10:27:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:05 INFO - 'LOGNAME': 'cltbld', 10:27:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:27:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:05 INFO - 'MOZ_NO_REMOTE': '1', 10:27:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:27:05 INFO - 'NO_EM_RESTART': '1', 10:27:05 INFO - 'PAGER': '/bin/cat', 10:27:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:05 INFO - 'PWD': '/builds/slave/test', 10:27:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:27:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:05 INFO - 'RUST_BACKTRACE': '1', 10:27:05 INFO - 'SHELL': '/bin/bash', 10:27:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bMTcsRyfen/Listeners', 10:27:05 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 10:27:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:05 INFO - 'USER': 'cltbld', 10:27:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:05 INFO - 'XPC_FLAGS': '0x0', 10:27:05 INFO - 'XPC_SERVICE_NAME': '0', 10:27:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--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 10:27:05 INFO - mozversion application_buildid: 20170417082108 10:27:05 INFO - mozversion application_changeset: befe7c6050b76a46f5d4bed42e28eca8fa6d31ca 10:27:05 INFO - mozversion application_display_name: Nightly 10:27:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:27:05 INFO - mozversion application_name: Firefox 10:27:05 INFO - mozversion application_remotingname: firefox 10:27:05 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 10:27:05 INFO - mozversion application_vendor: Mozilla 10:27:05 INFO - mozversion application_version: 55.0a1 10:27:05 INFO - mozversion platform_buildid: 20170417082108 10:27:05 INFO - mozversion platform_changeset: befe7c6050b76a46f5d4bed42e28eca8fa6d31ca 10:27:05 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 10:27:05 INFO - mozversion platform_version: 55.0a1 10:27:05 INFO - using testdate: 1492450025 10:27:05 INFO - actual date: 1492450025 10:27:05 INFO - starting webserver on 'localhost:49242' 10:27:05 INFO - SUITE-START | Running 2 tests 10:27:05 INFO - TEST-START | dromaeo_css 10:27:05 INFO - operating with platform_type : mac_ 10:27:05 INFO - Initialising browser for dromaeo_css test... 10:27:05 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpUAAV6z/profile http://localhost:49242/getInfo.html) 10:27:08 INFO - PID 1633 | __metrics Screen width/height:1600/1200 10:27:08 INFO - PID 1633 | colorDepth:24 10:27:08 INFO - PID 1633 | Browser inner width/height: 1024/689 10:27:08 INFO - PID 1633 | __metrics 10:27:08 INFO - PID 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:27:08 INFO - PID 1633 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:27:09 INFO - TEST-INFO | 1633: exit 0 10:27:09 INFO - Browser initialized. 10:27:09 INFO - Running cycle 1/1 for dromaeo_css test... 10:27:09 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpUAAV6z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:21 INFO - PID 1635 | RSS: Main: 243273728 10:27:21 INFO - PID 1635 | 10:30:26 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 10:30:28 INFO - PID 1635 | RSS: Main: 443953152 10:30:28 INFO - PID 1635 | 10:32:11 INFO - PID 1635 | ************************* 10:32:11 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 10:32:11 INFO - PID 1635 | 10:32:11 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:32:11 INFO - PID 1635 | Full stack: 10:32:11 INFO - PID 1635 | ************************* 10:32:11 INFO - PID 1635 | ************************* 10:32:11 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 10:32:11 INFO - PID 1635 | 10:32:11 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:32:11 INFO - PID 1635 | Full stack: 10:32:11 INFO - PID 1635 | ************************* 10:32:11 INFO - PID 1635 | ************************* 10:32:11 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 10:32:11 INFO - PID 1635 | 10:32:11 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:32:11 INFO - PID 1635 | Full stack: 10:32:11 INFO - PID 1635 | ************************* 10:32:11 INFO - PID 1635 | ************************* 10:32:11 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 10:32:11 INFO - PID 1635 | 10:32:11 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:32:11 INFO - PID 1635 | Full stack: 10:32:11 INFO - PID 1635 | ************************* 10:33:31 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 10:33:31 INFO - PID 1635 | RSS: Main: 369123328 10:33:31 INFO - PID 1635 | 10:36:33 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 10:36:34 INFO - PID 1635 | RSS: Main: 357535744 10:36:34 INFO - PID 1635 | 10:39:36 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 10:39:37 INFO - PID 1635 | RSS: Main: 330584064 10:39:37 INFO - PID 1635 | 10:42:41 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 10:42:41 INFO - PID 1635 | RSS: Main: 331370496 10:42:41 INFO - PID 1635 | 10:45:44 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 10:45:44 INFO - PID 1635 | RSS: Main: 379965440 10:45:44 INFO - PID 1635 | 10:45:44 INFO - PID 1635 | __start_tp_report 10:45:44 INFO - PID 1635 | _x_x_mozilla_page_load 10:45:44 INFO - PID 1635 | _x_x_mozilla_page_load_details 10:45:44 INFO - PID 1635 | |i|pagename|runs| 10:45:44 INFO - PID 1635 | |0;dojo.html;3471.1842716961523;3485.895423137305;3497.178163131664;3518.173229291117;3578.767380120292;5958.553108516868;6026.548008899328;6118.449339559439;6123.785667501627;6168.784092556756;5962.284525856903;6087.7260523276445;6110.923300256529;6119.106526814658;6126.884121540787;5194.688318700871;5286.127788914824;5314;5356.089464790975;5404.4595540445835;5205.973970130144;5334.573234141279;5386.353637563498;5396.10964190908;5405.027095122877;5276.815311464119;5287.973560132194;5291.1798671206025;5296.232046353296;5300.310959575269;5251.264822924793;5268.209768534713;5282.498162674539;5288;5288.127458969266;5188.6367954243215;5231.869203269949;5238.73806309683;5254.369475662907;5256.342957130359;5875.001249787546;5908.97045514774;5915.231019967419;5938.910916336258;5939;6383.808485745435;6384.968075159594;6390.808275751735;6402.391772781578;6413.3266007069515;6437.2918978912285;6550.4104630583;6553.246376666697;6563;6579.967100164468;6183.227096612924;6183.907241391383;6185.752569897199;6192.597481163755;6204.255489341218;6444.935550644527;6514.57655252407;6712.563683360566;6712.630805305657;6732.057511948331;6298.905516417258;6350.5554611177695;6382.425581697669;6393.424591786761;6412.35876412355;5415.48552887475;6506.739730410731;6532.8366790830605;6538.346165383424;6554.115194448784;6282.842928926813;6441.420272175526;6458.870822583522;6461.450776683941;6470.838229044218;6300;6300.21247344082;6314.873702525923;6319.9368006320265;6325.240971083499;5204.4014938281825;5214.556762675139;5236.136037553837;5237.869053273698;5279.762410691528;4599.770011499411;4606.930896036562;4611.700239484423;4624.583787459145;4666.789994450258;5960.314563825129;6052.939470605237;6067.878642427127;6165.660888651078;6170.475509581646;6503;6514.609123452608;6586.407223349922;6601.2738598754095;6607.108040414482;6163.291221509494;6173;6173.660448675276;6183.659898705614;6184.412480814315;5576.442355764391;5649.435056494318;5744.052231381859;5774.249347584787;5775.826725198251;6502.252240992347;6524.641144737085;6528.445082168069;6533.738650453929;6536.150300460909;6388.4569811566535;6396.48828093742;6463.450606698295;6565.80302590923;6582.243042050034;6685.732570697118;6703.698333574904;6710.429613482908;6749.3925546699065;6751.966240168964;5355;6470.094186813756;6476.352364763675;6480.967595161994;6481.870362592627;5783.785405064984;6294.559380843297;6386.904196436964;6548.508861835287;6589.27517973013;5529;6239.469645080219;6249.718762655601;6274.278457977391;6337.081123237197;6319.3364696706185;6328.367163283635;6344.143540622142;6390.744370225325;6390.808275751735;6222.782202622887;6225.657588832658;6230.096635987666;6239.06414037898;6255.906161407492;6172.814815555541;6241.438270555672;6347.333529979285;6362.618242905255;6365.61806291624;6145.170401995852;6194.628322300677;6213.627182369072;6242.344553821965;6270.059491076193 10:45:44 INFO - PID 1635 | |1;ext.html;800.6797281087565;820.9630566624502;1015.6039144733551;1122.5846436818379;1150.585789115918;34333.82833085834;36637.63362366376;36728;36823.63176368236;36850.631493685054;38265.42601860967;38569.22861542767;38582.8070859646;38698.41952370717;38904.80547597265;6072.089186621998;7975.441719079667;8140;8562.486250824939;8661.437006594582;6140.815775526719;8345.41582089254;8535.146485351477;8535.615897284637;8537.18896704812;8558.358123140759;8566.229039386453;8599.527026013568;8607.569621518898;8610.87083693745;8524.957375213115;8563.10087440819;8593.742187734379;8598.312135029182;8600.053994060649;8387.203215694499;8443.029051659016;8450.19723126302;8458.915410845935;8463.576821158917;36678.449823252675;36719.449208261896;36836.89489315325;36854.44718329227;36989.815050924844;3585.4442561403025;3620.004498762835;3624.311380837659;3624.7281453891064;3627.093226693327;24745.752542474704;27744.02895898634;29961.850190749126;30033.249168770737;30140.54789178164;3015.577819105327;3052.2827135623334;3059.7552195824505;3080.368524452482;3096.5974423325047;222462;277887;277982;278065.6096719524;278194;37205.627943720756;38101;47741.283880741816;47975.56073317806;48010.75994620004;40277.79861100676;49170.508294916595;50009.24986125211;50016;50088.24867626988;14056.508022219174;14175.432982680784;14202.076865003743;14227.715445691028;14228.359723812453;11555.826662600068;11559.537618495166;11570.958613724804;11584.942075289739;11616.709582260512;12005.09961752872;12052.578159764365;12061.336626485452;12068.155229134052;12192.695182620328;4503.617192538605;5430.647007944471;5433.402325744165;5438.592105592017;5459.672419654833;1007.1388962437157;1020.1226944827442;1020.8417695257247;1031.9380837149795;1057.5188289328337;16916.830831691772;22389.55220895573;23580.528389432457;23623.7637623625;23665.88167059188;949.845937186322;1116.4585176189541;1153.81538953767;1157.3808012713157;1168.7720894425674;12011.639650810315;12140.575079872162;12165.20926139798;12200.694982625328;12229.510819567296;305498;305560;307863;308064.4596777002;308489;52736.47263527392;52801.735991319794;52820.47179528233;52940.67648308823;52952.73523632357;1305.8628843971437;1548.5199588127716;1562.82027566829;1564.3429759501037;1575.9606009849845;20497.282595109697;20898.58202835965;23440.531189375775;23506.88246558756;23524.764752352257;37262.81368593248;37264.813675931444;37293.4405983905;37311.626883730816;37397.81301093586;279103;279838;279898;280023;280568.7914681241;27688.446231075668;28171.873125074766;28247.71752282533;32986.83506582452;33089;41178.38232426456;42707;42888.14223715446;43123;43519;29503.9386204584;29704;30146.54780178255;30205.285900112678;30635;27548.58677119885;29404.558931615615;29427.411451771273;30004.949826755957;30239.244018899702;33542;36314.8184259077;36347.63652363548;36420.90737277886;36424.63575364318;22984.770152298264;29471.85264073666;29612;30168.69831301659;30364;21163.47091322729;23169.304920852403;23239;23496.530069398174;23864.403389914696 10:45:44 INFO - PID 1635 | |2;jquery.html;431.61346396965865;433.49930829891446;433.6704104880291;438.55924795580444;457.4971219543799;20348.287809926638;21756.12975480981;22362;22594.88702556487;22597.983090760914;22142.667859982113;22755.77244227557;23467.647985280193;23613.881930590323;23653.881730591365;5961.165436838846;6032.396760323976;6249.2813326467585;6252.812415627538;6257.749690012394;5329.387120481136;5947.375525569818;6038.788642397517;6118.051701986199;6152.138700581922;5800.622959507639;5972.25346831646;6081.087836824468;6083.48290395317;6090.33006369299;6064.4541991220785;6126.0504621783475;6137.202163718733;6137.785177518787;6140.0789881517685;5336.092864213054;5384.246205531229;5445.210444485528;5446.7276636168035;5454.781808727646;26966.865165674244;26991.730082699316;27020.324491887663;27189.562087582366;27307.45385092307;2195.242641288753;2267.7618850020676;2270.318904328711;2271.3867255840833;2271.9204827831113;17704.557386065324;17796.733049004277;17832.55418614532;18049.7292540612;18264.269429222815;2103.4215590712524;2121.671140973136;2169.7287839020123;2171.5114099327525;2184.049938276839;141853;141867;142915;143820;143991.99999999895;10125;12380.566680166152;12390.132690711744;12439.894834704706;12491.250524968349;16533;16549;16561.25474353657;16594.253258603392;16617.584560385847;8706.651733930572;8923.107689231025;8948.68679596211;9023.864642030374;9055.411398259092;7538.811529711691;8255.25702686761;8559.786005349792;8708.564571771387;8781.956090219635;6192.8761424771255;6331.335209802996;7676.385889128856;7681.385489160965;7686.346660533805;1849.6115815678588;2145.753238377575;2180.356794745554;2180.7710190430093;2191.8465707400646;991.9752006199902;996.7657600463886;1000.9249306302056;1040.438163391775;1040.78143589847;20405.183792648128;21324.360269191948;21358.466038349165;21390.679139812913;21390.78609213888;905.6151135767273;987.244757760314;1026.9281150319555;1060.8779990301214;1069.7004838645191;10946.945265273782;11125.499352529156;11159.609413670483;11207.271527350696;11221.80178649081;540075;547830;549175;555164;565373;85661.57169214114;105457;132864;134948.6505134936;141828;1185.9229150105216;1222.3155033181447;1224.675461002835;1241.1622155045488;1247.4324182496941;22111;22394.552108958054;23217.76782232156;23223.767762322837;23284.65073023872;51971.74014129905;54790;55773.721131394086;56079.43920560742;56215.59461013507;72282.63858680673;73841.52316953738;73982.26017739753;74118.62940685262;76196.61901690456;8504.022037465771;8670.913290867264;8857.33569982241;8967;9164.770880728036;13757.862421375658;14089.365978530786;14461.710765784415;14772.852271477148;14918.776218356516;11519.366434846164;11818.645440636794;12174.39128043612;12232.87767122353;12309.13836031505;11572.942135289606;11690.240134391237;11818.527258909548;11858;12022.579209727617;9943.701688949342;10511.421871797125;10534.57861685524;12320.383980801103;12566.434510446868;8837.558122093998;8837.602307896032;9006.234470070118;9177.54112294396;9245.399049061789;11845.940770296093;11872.584459543874;12158.513659453876;12179.451924663234;12216.38918054076 10:45:44 INFO - PID 1635 | |3;mootools.html;1278.801785723213;1355.2072037857854;1430.921299328537;1446.573260888038;1447.6815100677848;11321.320720756761;11828;11848.644540663772;11854;11867.703307417309;11371.886281137186;11426.542938282459;11680.415979201049;11718.824217636742;11821.7635647287;2483.1557270528015;2522.3441905104714;2524.8232623716253;2529.038965193224;2530.7975361971;2292.747797742247;2432.3189506938083;2444.9266522004277;2496.0015993602524;2500.0749722602663;2404.1224952892157;2503.2740505253455;2509.3224829296078;2509.4604659998095;2512.5979843225086;2451.252368027751;2486.490269494749;2488.950220995579;2502.3744063984004;2514.6479492871013;2472.876356182184;2476.108600903673;2498.537770512461;2503.699556053285;2505.6742623459018;11784.292942423483;11856.347900865449;11860.347680877549;11860.466279017464;11899;6443.355664433566;6699.531032827704;6708.597484150967;6709.899351509731;6718.05947167397;3788.886333410002;3972.8609498667406;4033.233685599727;4296.312589985588;4314.503832059322;1106.4025426269804;1226.1600803449664;1248.956286529976;1304.5760127958451;1304.7064410507655;15054.924725376302;15593.532194034084;16240.269187886573;16379.262933168036;16381.180940952905;5039.596832253411;5500.642458240201;5683.062294721325;5710.143478478261;5714.171445140431;12167.209131406431;12174.939125304494;12176.878231217752;12182;12190.2076365036;5690.601657883908;5743.4256574342235;6529.053287273414;6529.575577587441;6538.117354157223;5726.226959360516;5995.760169593254;6186.1648677427975;6190.288116866528;6196.008638617799;4347.543507931685;4458.420405347284;4494.483134439516;4516.503184649686;4520.864374068783;1307.3332600373878;1307.7253776706998;1312.6718320419895;1327.4955516903515;1331.7536255792709;799.8920145780362;800.8998875140608;817.6933649881295;821.8931538899905;840.4369072721291;6124.081387791778;6133.141360209485;6341.4609758170145;6396.552241343062;6478.935210647834;500.2671086857771;557.4704031170404;575.8502789274735;579.956503262257;582.979595714148;3979.243943650697;4345.348197770297;4357.411749413788;4456.554344565518;4467.374567560544;14350.425982960773;15047.548573542812;15053.021553598981;15055.473058442902;15075.623109422353;14485.78271325931;15180.013299135742;15188.544343669708;15192.46826361072;15201.467948621745;8402.243798058204;8558.700445484503;8567.100454452317;8578.270846978077;8578.828423431496;5959.642421454727;6794.456443484411;7023.613701246481;7227.457940654367;7233.529820561646;13310;13336.19982801035;13618.455261789417;13624.65938351549;13641.113327633671;10748;12148.453319600463;13338.93288536934;13791.448342066606;14121.43514259418;9517.762055948657;9547;9637.518124093907;9743.902560974582;9758.9024109758;10608.628697995533;10654.254202205771;10760.946195268974;10769;10782.299150555189;9232.261419086322;9242.815143697222;9316.95341523315;9329.72010839676;9480.762980925532;8982;8995.145461181177;9097.727068187965;9116.635334586808;9176.08239176077;8067.1529489402765;8106.270435660819;8254.83490330202;8263.9586802068;8269.627866746132;4648.465426475998;5373.623846330719;5385.138377859524;5441.5374693151525;6060.515263649478;6071.089336599545;6152.323244443018;6274.278457977209;6279.277883043325;6325.4939604832425 10:45:44 INFO - PID 1635 | |4;prototype.html;373.4845912640557;377.0648790998324;390.7518725609239;396.2708616146292;397.03718482679494;5270.812612765707;5974.7012649367525;6047.5766696331275;6047.87904241916;6085.7565697372165;5323.733813309329;5613.747381367838;5771.50942169916;5803.448672376128;5843.18195452637;3383.5601371821754;3725.2735716535285;4346.739195648255;4356.281213599752;4358.825646974117;3580.820958952042;4317.978410107945;4337.197618440583;4339.893327201575;4369.694121411502;4188.434561334227;4275.209086319025;4281.571842815709;4301.419308393358;4325.913481730364;3701.8519259229597;4296.763677997709;4307.612314891643;4309.612134907873;4322.675799315049;3695.0023493656563;3720.8325625346924;3726.087108658396;3733.2346868891814;3735.5143831301757;5446.945530544723;5632.239647647556;5743.195952566644;5744.156642461966;5776.711164441761;5050.292958985745;5051.823186188466;5085.389753229636;5094.108531007059;5123.38519377677;6204.317525072239;6211.25464944205;6211.565190436671;6214.533909956726;6223.813285601439;4084.8570300039355;4152.8131234094535;4155.667546596295;4201.68487363449;4207.190907909598;6293.874122517524;6430.64631445275;6444.421116826407;6535.57518761279;6612.93387066128;3819.975413031098;4185.372194170899;4250.149970005949;4258.233517966796;4290.528041915387;3952.4268980998168;4096.5903409658795;4298.613124818781;4337.349397590387;4344.457717510301;4340.782960851945;4677.742724150136;4864.732439715779;4951.628627852925;5012.724300163526;5361.356637203483;6212.316645169028;6265.30347095216;6266.342034086447;6275.278342990523;1277.9840027178416;1416.7945647881;1469.4342678068806;1469.926503674812;1481.8888583356077;822.3051521464353;825.9132791056973;979.5689896445541;988.7344199424748;988.9950550247347;5894.557908156819;5902.4097590240635;5916.349201587822;5935.198748168942;5944.405559444021;6250.499960003189;6286.402791734778;6424.967875160594;6426.678666066678;6453.774117905851;5035.647504674711;5660.433956604306;5926.170336152942;5943.465088142088;5946.762129514857;2731.565927887835;3069.739072178845;3297.9010629681147;3341.2649217172184;3363.899083027513;6042.425969532887;6280.811575652738;6485.805425837232;6565.343465653492;6589.86820263592;6513.557415969011;6569.901451478232;6578.3092775258865;6599.505037122235;6659.966700166565;6328.398802113792;6348.984162533972;6530.934690653033;6590.90113648286;6613.768518101843;5153.381594208569;5329.200619907045;6220.284667263322;6480.416762491398;6484.438646734608;6125.663088530174;6329.715162817776;6330.651814150266;6346.90479642815;6411.134496842867;5392.487713667196;5649.519790817662;6433.774817881352;6487.416132548094;6505.51208659343;4110.109349699172;4120.196561670446;4125.339945608688;4595.149897269016;4669.976650116863;5293.835356221625;6152.630842149306;6439.967800160969;6465.709043092978;6477.838054048687;6220.595661282002;6237.845998490294;6262.185915830913;6270.655113968775;6322.620642761449;5527.638190954767;6289.308176100534;6315.5263355247625;6339.746410143727;6340.397662222082;5086.415062267739;5890.558208134321;6042.456178943916;6082.5438092142385;6144.78493252734;5466.808661696821;5530.391656917816;5711.771969026513;6267.529935254783;6281.340459251713;4541.72749635023;5195.3113289564835;5368.8389348319615;5691.943080569141;6160.291566469913 10:45:44 INFO - PID 1635 | |5;yui.html;719.4244604316546;866.9470226690222;872.794893200098;884.8363052835226;895.7984453497962;13256.33718314084;13612.727745445085;17846.732299015508;18245.996470194168;18348.908255458737;17254.137293135325;17358.305667773275;17839.286428542877;18056.368027119053;18076.819231807713;976.5215044628117;1016.3800081950004;1018.0023576894648;1018.124413004819;1020.0258752891008;676.9627670478121;688.1501345837886;1015.984015984016;1016.3901659004575;1016.7458135466134;1006.7181189267017;1042.7393151712072;1050.2123407444417;1052.1109662335314;1053.3521884041336;1039.433508737736;1039.7920415916772;1042.2235434601196;1042.8696412948382;1043.4886905416367;775.3913178155121;776.4254451705754;776.7048521561827;776.755322073545;778.521209456186;16128.516144515683;16409.343626255053;16593.41923032688;16689.24898379576;16889.83110168895;14456.421743130262;16591.91704041472;16687.83312166875;16796.076215808127;17022.48932532026;13609.251491167981;13834.584962451143;13942.024058315921;13990.440382384793;14130.15219086858;3369.679880411357;3400.5579274694132;3401.7958922464486;3403.23427228874;3404.3361544498835;112862;113947.43026284898;114749;121939.39030304791;126067.3696631511;12579.308138052495;13778.931105344409;13850.099743516841;13858.445662173603;13877.930610346884;19917.900410497856;20498.795012049988;24263.150789722276;24967.250982470556;25261.115860944778;7803.985481887318;7924.960375198087;7942.126366099725;7990.20097990208;8025.197480252044;3963.623455771697;4035.757854528738;4043.5956404359918;4051.6961227908023;4060.918781624351;4075.2664520386616;4328.199283132631;4372.781360931941;4412.470503539532;4446.577575130357;950.8858936927475;961.9807603848024;969.1713584884963;970.4807927758616;972.0328273368044;525.6005435868691;541.3963430774658;553.1177771454524;553.5294999250685;559.158466507903;9876;11318.886811131948;11464.713382165513;11508.079353651689;11974.461149248305;522.9006488767122;531.6172355903743;540.6837000354758;551.0136855029452;552.4309960740444;5581.804636837773;6032.638041717511;6108.7861924833305;6112.602680825732;6199.28708198563;94818.05181948231;97887;102580;103078;105794;89290.55354723315;89844.10155898357;89985.55007224921;90616;92871.53564232135;61869.69065154735;79643;80915.7862632061;81576;81737;11070.833937491105;11535;12197.817032744339;12431.564895228623;12615.180013299107;40198.79900600478;40214.798926006355;40647.39028914628;40811.59188408078;40842.38736419015;50127.74936125296;51411.65824221414;51682.74158629183;51705;52268.47731522636;15158.848411515744;15303.540893773205;15403.229838507805;15590.532284031497;15600.219989000732;18145.818541814413;18193.727094093334;18265.726014110063;18547.72178417298;18557.979311138017;16663.91668041652;16681.833181668513;16772.832271677617;16994.66010679804;17079.914600426917;16562.751558726388;16620.916895415445;16735.33058677688;16851;16881.831181688027;16067.276972536498;16344.591385215464;16384.344626214817;16384.83615163833;16566.006039637177;11629.302241865515;11711.76576468483;12103.619914015708;12250.509979600716;12347.876521234673;12443.688907777378;12861.164024338388;12955.870441295467;12994.545190918272;13170.275634840176 10:45:44 INFO - PID 1635 | __end_tp_report 10:45:44 INFO - PID 1635 | __start_cc_report 10:45:44 INFO - PID 1635 | _x_x_mozilla_cycle_collect,2036 10:45:44 INFO - PID 1635 | __end_cc_report 10:45:44 INFO - PID 1635 | __startTimestamp1492451144359__endTimestamp 10:45:44 INFO - PID 1635 | 10:45:44 INFO - PID 1635 | ------- Summary: start ------- 10:45:44 INFO - PID 1635 | Number of tests: 6 10:45:44 INFO - PID 1635 | 10:45:44 INFO - PID 1635 | [#0] dojo.html Cycles:165 Average:5972.94 Median:6213.63 stddev:680.54 (11.0%) stddev-sans-first:653.72 10:45:44 INFO - PID 1635 | Values: 3471.2 3485.9 3497.2 3518.2 3578.8 5958.6 6026.5 6118.4 6123.8 6168.8 5962.3 6087.7 6110.9 6119.1 6126.9 5194.7 5286.1 5314.0 5356.1 5404.5 5206.0 5334.6 5386.4 5396.1 5405.0 5276.8 5288.0 5291.2 5296.2 5300.3 5251.3 5268.2 5282.5 5288.0 5288.1 5188.6 5231.9 5238.7 5254.4 5256.3 5875.0 5909.0 5915.2 5938.9 5939.0 6383.8 6385.0 6390.8 6402.4 6413.3 6437.3 6550.4 6553.2 6563.0 6580.0 6183.2 6183.9 6185.8 6192.6 6204.3 6444.9 6514.6 6712.6 6712.6 6732.1 6298.9 6350.6 6382.4 6393.4 6412.4 5415.5 6506.7 6532.8 6538.3 6554.1 6282.8 6441.4 6458.9 6461.5 6470.8 6300.0 6300.2 6314.9 6319.9 6325.2 5204.4 5214.6 5236.1 5237.9 5279.8 4599.8 4606.9 4611.7 4624.6 4666.8 5960.3 6052.9 6067.9 6165.7 6170.5 6503.0 6514.6 6586.4 6601.3 6607.1 6163.3 6173.0 6173.7 6183.7 6184.4 5576.4 5649.4 5744.1 5774.2 5775.8 6502.3 6524.6 6528.4 6533.7 6536.2 6388.5 6396.5 6463.5 6565.8 6582.2 6685.7 6703.7 6710.4 6749.4 6752.0 5355.0 6470.1 6476.4 6481.0 6481.9 5783.8 6294.6 6386.9 6548.5 6589.3 5529.0 6239.5 6249.7 6274.3 6337.1 6319.3 6328.4 6344.1 6390.7 6390.8 6222.8 6225.7 6230.1 6239.1 6255.9 6172.8 6241.4 6347.3 6362.6 6365.6 6145.2 6194.6 6213.6 6242.3 6270.1 10:45:44 INFO - PID 1635 | 10:45:44 INFO - PID 1635 | [#1] ext.html Cycles:180 Average:42995.90 Median:155471.68 stddev:74819.65 (48.1%) stddev-sans-first:74962.46 10:45:44 INFO - PID 1635 | Values: 800.7 821.0 1015.6 1122.6 1150.6 34333.8 36637.6 36728.0 36823.6 36850.6 38265.4 38569.2 38582.8 38698.4 38904.8 6072.1 7975.4 8140.0 8562.5 8661.4 6140.8 8345.4 8535.1 8535.6 8537.2 8558.4 8566.2 8599.5 8607.6 8610.9 8525.0 8563.1 8593.7 8598.3 8600.1 8387.2 8443.0 8450.2 8458.9 8463.6 36678.4 36719.4 36836.9 36854.4 36989.8 3585.4 3620.0 3624.3 3624.7 3627.1 24745.8 27744.0 29961.9 30033.2 30140.5 3015.6 3052.3 3059.8 3080.4 3096.6 222462.0 277887.0 277982.0 278065.6 278194.0 37205.6 38101.0 47741.3 47975.6 48010.8 40277.8 49170.5 50009.2 50016.0 50088.2 14056.5 14175.4 14202.1 14227.7 14228.4 11555.8 11559.5 11571.0 11584.9 11616.7 12005.1 12052.6 12061.3 12068.2 12192.7 4503.6 5430.6 5433.4 5438.6 5459.7 1007.1 1020.1 1020.8 1031.9 1057.5 16916.8 22389.6 23580.5 23623.8 23665.9 949.8 1116.5 1153.8 1157.4 1168.8 12011.6 12140.6 12165.2 12200.7 12229.5 305498.0 305560.0 307863.0 308064.5 308489.0 52736.5 52801.7 52820.5 52940.7 52952.7 1305.9 1548.5 1562.8 1564.3 1576.0 20497.3 20898.6 23440.5 23506.9 23524.8 37262.8 37264.8 37293.4 37311.6 37397.8 279103.0 279838.0 279898.0 280023.0 280568.8 27688.4 28171.9 28247.7 32986.8 33089.0 41178.4 42707.0 42888.1 43123.0 43519.0 29503.9 29704.0 30146.5 30205.3 30635.0 27548.6 29404.6 29427.4 30004.9 30239.2 33542.0 36314.8 36347.6 36420.9 36424.6 22984.8 29471.9 29612.0 30168.7 30364.0 21163.5 23169.3 23239.0 23496.5 23864.4 10:45:44 INFO - PID 1635 | 10:45:44 INFO - PID 1635 | [#2] jquery.html Cycles:180 Average:35024.97 Median:2271.65 stddev:92875.89 (4088.5%) stddev-sans-first:93100.11 10:45:44 INFO - PID 1635 | Values: 431.6 433.5 433.7 438.6 457.5 20348.3 21756.1 22362.0 22594.9 22598.0 22142.7 22755.8 23467.6 23613.9 23653.9 5961.2 6032.4 6249.3 6252.8 6257.7 5329.4 5947.4 6038.8 6118.1 6152.1 5800.6 5972.3 6081.1 6083.5 6090.3 6064.5 6126.1 6137.2 6137.8 6140.1 5336.1 5384.2 5445.2 5446.7 5454.8 26966.9 26991.7 27020.3 27189.6 27307.5 2195.2 2267.8 2270.3 2271.4 2271.9 17704.6 17796.7 17832.6 18049.7 18264.3 2103.4 2121.7 2169.7 2171.5 2184.0 141853.0 141867.0 142915.0 143820.0 143992.0 10125.0 12380.6 12390.1 12439.9 12491.3 16533.0 16549.0 16561.3 16594.3 16617.6 8706.7 8923.1 8948.7 9023.9 9055.4 7538.8 8255.3 8559.8 8708.6 8782.0 6192.9 6331.3 7676.4 7681.4 7686.3 1849.6 2145.8 2180.4 2180.8 2191.8 992.0 996.8 1000.9 1040.4 1040.8 20405.2 21324.4 21358.5 21390.7 21390.8 905.6 987.2 1026.9 1060.9 1069.7 10946.9 11125.5 11159.6 11207.3 11221.8 540075.0 547830.0 549175.0 555164.0 565373.0 85661.6 105457.0 132864.0 134948.7 141828.0 1185.9 1222.3 1224.7 1241.2 1247.4 22111.0 22394.6 23217.8 23223.8 23284.7 51971.7 54790.0 55773.7 56079.4 56215.6 72282.6 73841.5 73982.3 74118.6 76196.6 8504.0 8670.9 8857.3 8967.0 9164.8 13757.9 14089.4 14461.7 14772.9 14918.8 11519.4 11818.6 12174.4 12232.9 12309.1 11572.9 11690.2 11818.5 11858.0 12022.6 9943.7 10511.4 10534.6 12320.4 12566.4 8837.6 8837.6 9006.2 9177.5 9245.4 11845.9 11872.6 12158.5 12179.5 12216.4 10:45:44 INFO - PID 1635 | 10:45:44 INFO - PID 1635 | [#3] mootools.html Cycles:180 Average:7080.46 Median:3880.87 stddev:4493.37 (115.8%) stddev-sans-first:4484.82 10:45:44 INFO - PID 1635 | Values: 1278.8 1355.2 1430.9 1446.6 1447.7 11321.3 11828.0 11848.6 11854.0 11867.7 11371.9 11426.5 11680.4 11718.8 11821.8 2483.2 2522.3 2524.8 2529.0 2530.8 2292.7 2432.3 2444.9 2496.0 2500.1 2404.1 2503.3 2509.3 2509.5 2512.6 2451.3 2486.5 2489.0 2502.4 2514.6 2472.9 2476.1 2498.5 2503.7 2505.7 11784.3 11856.3 11860.3 11860.5 11899.0 6443.4 6699.5 6708.6 6709.9 6718.1 3788.9 3972.9 4033.2 4296.3 4314.5 1106.4 1226.2 1249.0 1304.6 1304.7 15054.9 15593.5 16240.3 16379.3 16381.2 5039.6 5500.6 5683.1 5710.1 5714.2 12167.2 12174.9 12176.9 12182.0 12190.2 5690.6 5743.4 6529.1 6529.6 6538.1 5726.2 5995.8 6186.2 6190.3 6196.0 4347.5 4458.4 4494.5 4516.5 4520.9 1307.3 1307.7 1312.7 1327.5 1331.8 799.9 800.9 817.7 821.9 840.4 6124.1 6133.1 6341.5 6396.6 6478.9 500.3 557.5 575.9 580.0 583.0 3979.2 4345.3 4357.4 4456.6 4467.4 14350.4 15047.5 15053.0 15055.5 15075.6 14485.8 15180.0 15188.5 15192.5 15201.5 8402.2 8558.7 8567.1 8578.3 8578.8 5959.6 6794.5 7023.6 7227.5 7233.5 13310.0 13336.2 13618.5 13624.7 13641.1 10748.0 12148.5 13338.9 13791.4 14121.4 9517.8 9547.0 9637.5 9743.9 9758.9 10608.6 10654.3 10760.9 10769.0 10782.3 9232.3 9242.8 9317.0 9329.7 9480.8 8982.0 8995.1 9097.7 9116.6 9176.1 8067.2 8106.3 8254.8 8264.0 8269.6 4648.5 5373.6 5385.1 5441.5 6060.5 6071.1 6152.3 6274.3 6279.3 6325.5 10:45:44 INFO - PID 1635 | 10:45:44 INFO - PID 1635 | [#4] prototype.html Cycles:180 Average:5012.46 Median:5701.86 stddev:1581.45 (27.7%) stddev-sans-first:1547.08 10:45:44 INFO - PID 1635 | Values: 373.5 377.1 390.8 396.3 397.0 5270.8 5974.7 6047.6 6047.9 6085.8 5323.7 5613.7 5771.5 5803.4 5843.2 3383.6 3725.3 4346.7 4356.3 4358.8 3580.8 4318.0 4337.2 4339.9 4369.7 4188.4 4275.2 4281.6 4301.4 4325.9 3701.9 4296.8 4307.6 4309.6 4322.7 3695.0 3720.8 3726.1 3733.2 3735.5 5446.9 5632.2 5743.2 5744.2 5776.7 5050.3 5051.8 5085.4 5094.1 5123.4 6204.3 6211.3 6211.6 6214.5 6223.8 4084.9 4152.8 4155.7 4201.7 4207.2 6293.9 6430.6 6444.4 6535.6 6612.9 3820.0 4185.4 4250.1 4258.2 4290.5 3952.4 4096.6 4298.6 4337.3 4344.5 4340.8 4677.7 4864.7 4951.6 5012.7 5361.4 6212.3 6265.3 6266.3 6275.3 1278.0 1416.8 1469.4 1469.9 1481.9 822.3 825.9 979.6 988.7 989.0 5894.6 5902.4 5916.3 5935.2 5944.4 6250.5 6286.4 6425.0 6426.7 6453.8 5035.6 5660.4 5926.2 5943.5 5946.8 2731.6 3069.7 3297.9 3341.3 3363.9 6042.4 6280.8 6485.8 6565.3 6589.9 6513.6 6569.9 6578.3 6599.5 6660.0 6328.4 6349.0 6530.9 6590.9 6613.8 5153.4 5329.2 6220.3 6480.4 6484.4 6125.7 6329.7 6330.7 6346.9 6411.1 5392.5 5649.5 6433.8 6487.4 6505.5 4110.1 4120.2 4125.3 4595.1 4670.0 5293.8 6152.6 6440.0 6465.7 6477.8 6220.6 6237.8 6262.2 6270.7 6322.6 5527.6 6289.3 6315.5 6339.7 6340.4 5086.4 5890.6 6042.5 6082.5 6144.8 5466.8 5530.4 5711.8 6267.5 6281.3 4541.7 5195.3 5368.8 5691.9 6160.3 10:45:44 INFO - PID 1635 | 10:45:44 INFO - PID 1635 | [#5] yui.html Cycles:180 Average:21133.73 Median:18066.59 stddev:29286.05 (162.1%) stddev-sans-first:29328.09 10:45:44 INFO - PID 1635 | Values: 719.4 866.9 872.8 884.8 895.8 13256.3 13612.7 17846.7 18246.0 18348.9 17254.1 17358.3 17839.3 18056.4 18076.8 976.5 1016.4 1018.0 1018.1 1020.0 677.0 688.2 1016.0 1016.4 1016.7 1006.7 1042.7 1050.2 1052.1 1053.4 1039.4 1039.8 1042.2 1042.9 1043.5 775.4 776.4 776.7 776.8 778.5 16128.5 16409.3 16593.4 16689.2 16889.8 14456.4 16591.9 16687.8 16796.1 17022.5 13609.3 13834.6 13942.0 13990.4 14130.2 3369.7 3400.6 3401.8 3403.2 3404.3 112862.0 113947.4 114749.0 121939.4 126067.4 12579.3 13778.9 13850.1 13858.4 13877.9 19917.9 20498.8 24263.2 24967.3 25261.1 7804.0 7925.0 7942.1 7990.2 8025.2 3963.6 4035.8 4043.6 4051.7 4060.9 4075.3 4328.2 4372.8 4412.5 4446.6 950.9 962.0 969.2 970.5 972.0 525.6 541.4 553.1 553.5 559.2 9876.0 11318.9 11464.7 11508.1 11974.5 522.9 531.6 540.7 551.0 552.4 5581.8 6032.6 6108.8 6112.6 6199.3 94818.1 97887.0 102580.0 103078.0 105794.0 89290.6 89844.1 89985.6 90616.0 92871.5 61869.7 79643.0 80915.8 81576.0 81737.0 11070.8 11535.0 12197.8 12431.6 12615.2 40198.8 40214.8 40647.4 40811.6 40842.4 50127.7 51411.7 51682.7 51705.0 52268.5 15158.8 15303.5 15403.2 15590.5 15600.2 18145.8 18193.7 18265.7 18547.7 18558.0 16663.9 16681.8 16772.8 16994.7 17079.9 16562.8 16620.9 16735.3 16851.0 16881.8 16067.3 16344.6 16384.3 16384.8 16566.0 11629.3 11711.8 12103.6 12250.5 12347.9 12443.7 12861.2 12955.9 12994.5 13170.3 10:45:44 INFO - PID 1635 | -------- Summary: end -------- 10:45:44 INFO - PID 1635 | 10:45:45 INFO - TEST-INFO | 1635: exit 0 10:45:45 INFO - TEST-OK | dromaeo_css | took 1119662ms 10:45:45 INFO - TEST-START | kraken 10:45:45 INFO - operating with platform_type : mac_ 10:45:45 INFO - Initialising browser for kraken test... 10:45:45 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpuWmqqo/profile http://localhost:49242/getInfo.html) 10:45:47 INFO - PID 1646 | __metrics Screen width/height:1600/1200 10:45:47 INFO - PID 1646 | colorDepth:24 10:45:47 INFO - PID 1646 | Browser inner width/height: 1024/689 10:45:47 INFO - PID 1646 | __metrics 10:45:47 INFO - PID 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:45:47 INFO - PID 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:45:48 INFO - TEST-INFO | 1646: exit 0 10:45:48 INFO - Browser initialized. 10:45:48 INFO - Running cycle 1/1 for kraken test... 10:45:48 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpuWmqqo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:46:01 INFO - PID 1647 | RSS: Main: 242405376 10:46:01 INFO - PID 1647 | 10:46:03 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 10:46:04 INFO - PID 1647 | RSS: Main: 312373248 10:46:04 INFO - PID 1647 | 10:46:07 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 10:46:08 INFO - PID 1647 | RSS: Main: 293658624 10:46:08 INFO - PID 1647 | 10:46:11 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 10:46:12 INFO - PID 1647 | RSS: Main: 386695168 10:46:12 INFO - PID 1647 | 10:46:14 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 10:46:14 INFO - PID 1647 | RSS: Main: 290021376 10:46:14 INFO - PID 1647 | 10:46:16 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:46:17 INFO - PID 1647 | RSS: Main: 291737600 10:46:17 INFO - PID 1647 | 10:46:20 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 10:46:21 INFO - PID 1647 | RSS: Main: 354451456 10:46:21 INFO - PID 1647 | 10:46:23 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 10:46:24 INFO - PID 1647 | RSS: Main: 372940800 10:46:24 INFO - PID 1647 | 10:46:27 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 10:46:28 INFO - PID 1647 | RSS: Main: 381149184 10:46:28 INFO - PID 1647 | 10:46:29 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:46:30 INFO - PID 1647 | RSS: Main: 332599296 10:46:30 INFO - PID 1647 | 10:46:31 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:46:32 INFO - PID 1647 | RSS: Main: 330596352 10:46:32 INFO - PID 1647 | 10:46:34 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:46:35 INFO - PID 1647 | RSS: Main: 314830848 10:46:35 INFO - PID 1647 | 10:46:38 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:46:39 INFO - PID 1647 | RSS: Main: 334901248 10:46:39 INFO - PID 1647 | 10:46:42 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:46:42 INFO - PID 1647 | RSS: Main: 344801280 10:46:42 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 10:46:44 INFO - PID 1647 | RSS: Main: 387969024 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | __start_tp_report 10:46:44 INFO - PID 1647 | _x_x_mozilla_page_load 10:46:44 INFO - PID 1647 | _x_x_mozilla_page_load_details 10:46:44 INFO - PID 1647 | |i|pagename|runs| 10:46:44 INFO - PID 1647 | |0;ai-astar;110;110;111;111;110;110;111;110;110;110 10:46:44 INFO - PID 1647 | |1;audio-beat-detection;144;110;114;180;107;114;132;95;148;138 10:46:44 INFO - PID 1647 | |2;audio-dft;186;185;188;187;183;186;182;184;181;183 10:46:44 INFO - PID 1647 | |3;audio-fft;80;59;58;88;61;59;60;58;81;59 10:46:44 INFO - PID 1647 | |4;audio-oscillator;92;68;84;70;68;69;91;69;77;110 10:46:44 INFO - PID 1647 | |5;imaging-gaussian-blur;89;88;87;127;135;83;125;135;89;88 10:46:44 INFO - PID 1647 | |6;imaging-darkroom;95;95;95;94;95;95;96;95;94;94 10:46:44 INFO - PID 1647 | |7;imaging-desaturate;85;86;86;87;84;83;86;85;89;86 10:46:44 INFO - PID 1647 | |8;json-parse-financial;48;48;49;49;50;49;50;51;49;51 10:46:44 INFO - PID 1647 | |9;json-stringify-tinderbox;54;53;61;61;62;65;60;57;58;58 10:46:44 INFO - PID 1647 | |10;stanford-crypto-aes;82;83;83;80;83;81;82;81;82;82 10:46:44 INFO - PID 1647 | |11;stanford-crypto-ccm;137;136;140;147;149;146;137;135;178;172 10:46:44 INFO - PID 1647 | |12;stanford-crypto-pbkdf2;187;186;183;190;186;182;183;187;187;186 10:46:44 INFO - PID 1647 | |13;stanford-crypto-sha256-iterative;67;67;67;68;68;66;66;69;67;57 10:46:44 INFO - PID 1647 | __end_tp_report 10:46:44 INFO - PID 1647 | __start_cc_report 10:46:44 INFO - PID 1647 | _x_x_mozilla_cycle_collect,2174 10:46:44 INFO - PID 1647 | __end_cc_report 10:46:44 INFO - PID 1647 | __startTimestamp1492451204760__endTimestamp 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | ------- Summary: start ------- 10:46:44 INFO - PID 1647 | Number of tests: 14 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:46:44 INFO - PID 1647 | Values: 110.0 110.0 111.0 111.0 110.0 110.0 111.0 110.0 110.0 110.0 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:141.00 stddev:25.21 (17.9%) stddev-sans-first:26.09 10:46:44 INFO - PID 1647 | Values: 144.0 110.0 114.0 180.0 107.0 114.0 132.0 95.0 148.0 138.0 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.50 stddev:2.27 (1.2%) stddev-sans-first:2.35 10:46:44 INFO - PID 1647 | Values: 186.0 185.0 188.0 187.0 183.0 186.0 182.0 184.0 181.0 183.0 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | [#3] audio-fft Cycles:10 Average:66.30 Median:60.50 stddev:11.74 (19.4%) stddev-sans-first:11.36 10:46:44 INFO - PID 1647 | Values: 80.0 59.0 58.0 88.0 61.0 59.0 60.0 58.0 81.0 59.0 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:73.50 stddev:14.22 (19.3%) stddev-sans-first:14.38 10:46:44 INFO - PID 1647 | Values: 92.0 68.0 84.0 70.0 68.0 69.0 91.0 69.0 77.0 110.0 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:104.60 Median:87.50 stddev:22.56 (25.8%) stddev-sans-first:23.21 10:46:44 INFO - PID 1647 | Values: 89.0 88.0 87.0 127.0 135.0 83.0 125.0 135.0 89.0 88.0 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 10:46:44 INFO - PID 1647 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 96.0 95.0 94.0 94.0 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:1.64 (1.9%) stddev-sans-first:1.72 10:46:44 INFO - PID 1647 | Values: 85.0 86.0 86.0 87.0 84.0 83.0 86.0 85.0 89.0 86.0 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:49.50 stddev:1.07 (2.2%) stddev-sans-first:1.01 10:46:44 INFO - PID 1647 | Values: 48.0 48.0 49.0 49.0 50.0 49.0 50.0 51.0 49.0 51.0 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:60.50 stddev:3.67 (6.1%) stddev-sans-first:3.43 10:46:44 INFO - PID 1647 | Values: 54.0 53.0 61.0 61.0 62.0 65.0 60.0 57.0 58.0 58.0 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 10:46:44 INFO - PID 1647 | Values: 82.0 83.0 83.0 80.0 83.0 81.0 82.0 81.0 82.0 82.0 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:146.50 stddev:15.28 (10.4%) stddev-sans-first:15.70 10:46:44 INFO - PID 1647 | Values: 137.0 136.0 140.0 147.0 149.0 146.0 137.0 135.0 178.0 172.0 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.70 Median:186.50 stddev:2.41 (1.3%) stddev-sans-first:2.51 10:46:44 INFO - PID 1647 | Values: 187.0 186.0 183.0 190.0 186.0 182.0 183.0 187.0 187.0 186.0 10:46:44 INFO - PID 1647 | 10:46:44 INFO - PID 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:3.36 (5.0%) stddev-sans-first:3.55 10:46:44 INFO - PID 1647 | Values: 67.0 67.0 67.0 68.0 68.0 66.0 66.0 69.0 67.0 57.0 10:46:44 INFO - PID 1647 | -------- Summary: end -------- 10:46:44 INFO - PID 1647 | 10:46:46 INFO - TEST-INFO | 1647: exit 0 10:46:46 INFO - TEST-OK | kraken | took 60807ms 10:46:46 INFO - SUITE-END | took 1180s 10:46:46 INFO - Completed test suite (00:19:40) 10:46:46 INFO - javascript benchmark 10:46:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7684.512513558331, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3471.1842716961523, 3485.895423137305, 3497.178163131664, 3518.173229291117, 3578.767380120292, 5958.553108516868, 6026.548008899328, 6118.449339559439, 6123.785667501627, 6168.784092556756, 5962.284525856903, 6087.7260523276445, 6110.923300256529, 6119.106526814658, 6126.884121540787, 5194.688318700871, 5286.127788914824, 5314.0, 5356.089464790975, 5404.4595540445835, 5205.973970130144, 5334.573234141279, 5386.353637563498, 5396.10964190908, 5405.027095122877, 5276.815311464119, 5287.973560132194, 5291.1798671206025, 5296.232046353296, 5300.310959575269, 5251.264822924793, 5268.209768534713, 5282.498162674539, 5288.0, 5288.127458969266, 5188.6367954243215, 5231.869203269949, 5238.73806309683, 5254.369475662907, 5256.342957130359, 5875.001249787546, 5908.97045514774, 5915.231019967419, 5938.910916336258, 5939.0, 6383.808485745435, 6384.968075159594, 6390.808275751735, 6402.391772781578, 6413.3266007069515, 6437.2918978912285, 6550.4104630583, 6553.246376666697, 6563.0, 6579.967100164468, 6183.227096612924, 6183.907241391383, 6185.752569897199, 6192.597481163755, 6204.255489341218, 6444.935550644527, 6514.57655252407, 6712.563683360566, 6712.630805305657, 6732.057511948331, 6298.905516417258, 6350.5554611177695, 6382.425581697669, 6393.424591786761, 6412.35876412355, 5415.48552887475, 6506.739730410731, 6532.8366790830605, 6538.346165383424, 6554.115194448784, 6282.842928926813, 6441.420272175526, 6458.870822583522, 6461.450776683941, 6470.838229044218, 6300.0, 6300.21247344082, 6314.873702525923, 6319.9368006320265, 6325.240971083499, 5204.4014938281825, 5214.556762675139, 5236.136037553837, 5237.869053273698, 5279.762410691528, 4599.770011499411, 4606.930896036562, 4611.700239484423, 4624.583787459145, 4666.789994450258, 5960.314563825129, 6052.939470605237, 6067.878642427127, 6165.660888651078, 6170.475509581646, 6503.0, 6514.609123452608, 6586.407223349922, 6601.2738598754095, 6607.108040414482, 6163.291221509494, 6173.0, 6173.660448675276, 6183.659898705614, 6184.412480814315, 5576.442355764391, 5649.435056494318, 5744.052231381859, 5774.249347584787, 5775.826725198251, 6502.252240992347, 6524.641144737085, 6528.445082168069, 6533.738650453929, 6536.150300460909, 6388.4569811566535, 6396.48828093742, 6463.450606698295, 6565.80302590923, 6582.243042050034, 6685.732570697118, 6703.698333574904, 6710.429613482908, 6749.3925546699065, 6751.966240168964, 5355.0, 6470.094186813756, 6476.352364763675, 6480.967595161994, 6481.870362592627, 5783.785405064984, 6294.559380843297, 6386.904196436964, 6548.508861835287, 6589.27517973013, 5529.0, 6239.469645080219, 6249.718762655601, 6274.278457977391, 6337.081123237197, 6319.3364696706185, 6328.367163283635, 6344.143540622142, 6390.744370225325, 6390.808275751735, 6222.782202622887, 6225.657588832658, 6230.096635987666, 6239.06414037898, 6255.906161407492, 6172.814815555541, 6241.438270555672, 6347.333529979285, 6362.618242905255, 6365.61806291624, 6145.170401995852, 6194.628322300677, 6213.627182369072, 6242.344553821965, 6270.059491076193], "value": 5929.0630992898305, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.6797281087565, 820.9630566624502, 1015.6039144733551, 1122.5846436818379, 1150.585789115918, 34333.82833085834, 36637.63362366376, 36728.0, 36823.63176368236, 36850.631493685054, 38265.42601860967, 38569.22861542767, 38582.8070859646, 38698.41952370717, 38904.80547597265, 6072.089186621998, 7975.441719079667, 8140.0, 8562.486250824939, 8661.437006594582, 6140.815775526719, 8345.41582089254, 8535.146485351477, 8535.615897284637, 8537.18896704812, 8558.358123140759, 8566.229039386453, 8599.527026013568, 8607.569621518898, 8610.87083693745, 8524.957375213115, 8563.10087440819, 8593.742187734379, 8598.312135029182, 8600.053994060649, 8387.203215694499, 8443.029051659016, 8450.19723126302, 8458.915410845935, 8463.576821158917, 36678.449823252675, 36719.449208261896, 36836.89489315325, 36854.44718329227, 36989.815050924844, 3585.4442561403025, 3620.004498762835, 3624.311380837659, 3624.7281453891064, 3627.093226693327, 24745.752542474704, 27744.02895898634, 29961.850190749126, 30033.249168770737, 30140.54789178164, 3015.577819105327, 3052.2827135623334, 3059.7552195824505, 3080.368524452482, 3096.5974423325047, 222462.0, 277887.0, 277982.0, 278065.6096719524, 278194.0, 37205.627943720756, 38101.0, 47741.283880741816, 47975.56073317806, 48010.75994620004, 40277.79861100676, 49170.508294916595, 50009.24986125211, 50016.0, 50088.24867626988, 14056.508022219174, 14175.432982680784, 14202.076865003743, 14227.715445691028, 14228.359723812453, 11555.826662600068, 11559.537618495166, 11570.958613724804, 11584.942075289739, 11616.709582260512, 12005.09961752872, 12052.578159764365, 12061.336626485452, 12068.155229134052, 12192.695182620328, 4503.617192538605, 5430.647007944471, 5433.402325744165, 5438.592105592017, 5459.672419654833, 1007.1388962437157, 1020.1226944827442, 1020.8417695257247, 1031.9380837149795, 1057.5188289328337, 16916.830831691772, 22389.55220895573, 23580.528389432457, 23623.7637623625, 23665.88167059188, 949.845937186322, 1116.4585176189541, 1153.81538953767, 1157.3808012713157, 1168.7720894425674, 12011.639650810315, 12140.575079872162, 12165.20926139798, 12200.694982625328, 12229.510819567296, 305498.0, 305560.0, 307863.0, 308064.4596777002, 308489.0, 52736.47263527392, 52801.735991319794, 52820.47179528233, 52940.67648308823, 52952.73523632357, 1305.8628843971437, 1548.5199588127716, 1562.82027566829, 1564.3429759501037, 1575.9606009849845, 20497.282595109697, 20898.58202835965, 23440.531189375775, 23506.88246558756, 23524.764752352257, 37262.81368593248, 37264.813675931444, 37293.4405983905, 37311.626883730816, 37397.81301093586, 279103.0, 279838.0, 279898.0, 280023.0, 280568.7914681241, 27688.446231075668, 28171.873125074766, 28247.71752282533, 32986.83506582452, 33089.0, 41178.38232426456, 42707.0, 42888.14223715446, 43123.0, 43519.0, 29503.9386204584, 29704.0, 30146.54780178255, 30205.285900112678, 30635.0, 27548.58677119885, 29404.558931615615, 29427.411451771273, 30004.949826755957, 30239.244018899702, 33542.0, 36314.8184259077, 36347.63652363548, 36420.90737277886, 36424.63575364318, 22984.770152298264, 29471.85264073666, 29612.0, 30168.69831301659, 30364.0, 21163.47091322729, 23169.304920852403, 23239.0, 23496.530069398174, 23864.403389914696], "value": 16930.203295266172, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.61346396965865, 433.49930829891446, 433.6704104880291, 438.55924795580444, 457.4971219543799, 20348.287809926638, 21756.12975480981, 22362.0, 22594.88702556487, 22597.983090760914, 22142.667859982113, 22755.77244227557, 23467.647985280193, 23613.881930590323, 23653.881730591365, 5961.165436838846, 6032.396760323976, 6249.2813326467585, 6252.812415627538, 6257.749690012394, 5329.387120481136, 5947.375525569818, 6038.788642397517, 6118.051701986199, 6152.138700581922, 5800.622959507639, 5972.25346831646, 6081.087836824468, 6083.48290395317, 6090.33006369299, 6064.4541991220785, 6126.0504621783475, 6137.202163718733, 6137.785177518787, 6140.0789881517685, 5336.092864213054, 5384.246205531229, 5445.210444485528, 5446.7276636168035, 5454.781808727646, 26966.865165674244, 26991.730082699316, 27020.324491887663, 27189.562087582366, 27307.45385092307, 2195.242641288753, 2267.7618850020676, 2270.318904328711, 2271.3867255840833, 2271.9204827831113, 17704.557386065324, 17796.733049004277, 17832.55418614532, 18049.7292540612, 18264.269429222815, 2103.4215590712524, 2121.671140973136, 2169.7287839020123, 2171.5114099327525, 2184.049938276839, 141853.0, 141867.0, 142915.0, 143820.0, 143991.99999999895, 10125.0, 12380.566680166152, 12390.132690711744, 12439.894834704706, 12491.250524968349, 16533.0, 16549.0, 16561.25474353657, 16594.253258603392, 16617.584560385847, 8706.651733930572, 8923.107689231025, 8948.68679596211, 9023.864642030374, 9055.411398259092, 7538.811529711691, 8255.25702686761, 8559.786005349792, 8708.564571771387, 8781.956090219635, 6192.8761424771255, 6331.335209802996, 7676.385889128856, 7681.385489160965, 7686.346660533805, 1849.6115815678588, 2145.753238377575, 2180.356794745554, 2180.7710190430093, 2191.8465707400646, 991.9752006199902, 996.7657600463886, 1000.9249306302056, 1040.438163391775, 1040.78143589847, 20405.183792648128, 21324.360269191948, 21358.466038349165, 21390.679139812913, 21390.78609213888, 905.6151135767273, 987.244757760314, 1026.9281150319555, 1060.8779990301214, 1069.7004838645191, 10946.945265273782, 11125.499352529156, 11159.609413670483, 11207.271527350696, 11221.80178649081, 540075.0, 547830.0, 549175.0, 555164.0, 565373.0, 85661.57169214114, 105457.0, 132864.0, 134948.6505134936, 141828.0, 1185.9229150105216, 1222.3155033181447, 1224.675461002835, 1241.1622155045488, 1247.4324182496941, 22111.0, 22394.552108958054, 23217.76782232156, 23223.767762322837, 23284.65073023872, 51971.74014129905, 54790.0, 55773.721131394086, 56079.43920560742, 56215.59461013507, 72282.63858680673, 73841.52316953738, 73982.26017739753, 74118.62940685262, 76196.61901690456, 8504.022037465771, 8670.913290867264, 8857.33569982241, 8967.0, 9164.770880728036, 13757.862421375658, 14089.365978530786, 14461.710765784415, 14772.852271477148, 14918.776218356516, 11519.366434846164, 11818.645440636794, 12174.39128043612, 12232.87767122353, 12309.13836031505, 11572.942135289606, 11690.240134391237, 11818.527258909548, 11858.0, 12022.579209727617, 9943.701688949342, 10511.421871797125, 10534.57861685524, 12320.383980801103, 12566.434510446868, 8837.558122093998, 8837.602307896032, 9006.234470070118, 9177.54112294396, 9245.399049061789, 11845.940770296093, 11872.584459543874, 12158.513659453876, 12179.451924663234, 12216.38918054076], "value": 10447.963458391763, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.801785723213, 1355.2072037857854, 1430.921299328537, 1446.573260888038, 1447.6815100677848, 11321.320720756761, 11828.0, 11848.644540663772, 11854.0, 11867.703307417309, 11371.886281137186, 11426.542938282459, 11680.415979201049, 11718.824217636742, 11821.7635647287, 2483.1557270528015, 2522.3441905104714, 2524.8232623716253, 2529.038965193224, 2530.7975361971, 2292.747797742247, 2432.3189506938083, 2444.9266522004277, 2496.0015993602524, 2500.0749722602663, 2404.1224952892157, 2503.2740505253455, 2509.3224829296078, 2509.4604659998095, 2512.5979843225086, 2451.252368027751, 2486.490269494749, 2488.950220995579, 2502.3744063984004, 2514.6479492871013, 2472.876356182184, 2476.108600903673, 2498.537770512461, 2503.699556053285, 2505.6742623459018, 11784.292942423483, 11856.347900865449, 11860.347680877549, 11860.466279017464, 11899.0, 6443.355664433566, 6699.531032827704, 6708.597484150967, 6709.899351509731, 6718.05947167397, 3788.886333410002, 3972.8609498667406, 4033.233685599727, 4296.312589985588, 4314.503832059322, 1106.4025426269804, 1226.1600803449664, 1248.956286529976, 1304.5760127958451, 1304.7064410507655, 15054.924725376302, 15593.532194034084, 16240.269187886573, 16379.262933168036, 16381.180940952905, 5039.596832253411, 5500.642458240201, 5683.062294721325, 5710.143478478261, 5714.171445140431, 12167.209131406431, 12174.939125304494, 12176.878231217752, 12182.0, 12190.2076365036, 5690.601657883908, 5743.4256574342235, 6529.053287273414, 6529.575577587441, 6538.117354157223, 5726.226959360516, 5995.760169593254, 6186.1648677427975, 6190.288116866528, 6196.008638617799, 4347.543507931685, 4458.420405347284, 4494.483134439516, 4516.503184649686, 4520.864374068783, 1307.3332600373878, 1307.7253776706998, 1312.6718320419895, 1327.4955516903515, 1331.7536255792709, 799.8920145780362, 800.8998875140608, 817.6933649881295, 821.8931538899905, 840.4369072721291, 6124.081387791778, 6133.141360209485, 6341.4609758170145, 6396.552241343062, 6478.935210647834, 500.2671086857771, 557.4704031170404, 575.8502789274735, 579.956503262257, 582.979595714148, 3979.243943650697, 4345.348197770297, 4357.411749413788, 4456.554344565518, 4467.374567560544, 14350.425982960773, 15047.548573542812, 15053.021553598981, 15055.473058442902, 15075.623109422353, 14485.78271325931, 15180.013299135742, 15188.544343669708, 15192.46826361072, 15201.467948621745, 8402.243798058204, 8558.700445484503, 8567.100454452317, 8578.270846978077, 8578.828423431496, 5959.642421454727, 6794.456443484411, 7023.613701246481, 7227.457940654367, 7233.529820561646, 13310.0, 13336.19982801035, 13618.455261789417, 13624.65938351549, 13641.113327633671, 10748.0, 12148.453319600463, 13338.93288536934, 13791.448342066606, 14121.43514259418, 9517.762055948657, 9547.0, 9637.518124093907, 9743.902560974582, 9758.9024109758, 10608.628697995533, 10654.254202205771, 10760.946195268974, 10769.0, 10782.299150555189, 9232.261419086322, 9242.815143697222, 9316.95341523315, 9329.72010839676, 9480.762980925532, 8982.0, 8995.145461181177, 9097.727068187965, 9116.635334586808, 9176.08239176077, 8067.1529489402765, 8106.270435660819, 8254.83490330202, 8263.9586802068, 8269.627866746132, 4648.465426475998, 5373.623846330719, 5385.138377859524, 5441.5374693151525, 6060.515263649478, 6071.089336599545, 6152.323244443018, 6274.278457977209, 6279.277883043325, 6325.4939604832425], "value": 5295.786998123342, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.4845912640557, 377.0648790998324, 390.7518725609239, 396.2708616146292, 397.03718482679494, 5270.812612765707, 5974.7012649367525, 6047.5766696331275, 6047.87904241916, 6085.7565697372165, 5323.733813309329, 5613.747381367838, 5771.50942169916, 5803.448672376128, 5843.18195452637, 3383.5601371821754, 3725.2735716535285, 4346.739195648255, 4356.281213599752, 4358.825646974117, 3580.820958952042, 4317.978410107945, 4337.197618440583, 4339.893327201575, 4369.694121411502, 4188.434561334227, 4275.209086319025, 4281.571842815709, 4301.419308393358, 4325.913481730364, 3701.8519259229597, 4296.763677997709, 4307.612314891643, 4309.612134907873, 4322.675799315049, 3695.0023493656563, 3720.8325625346924, 3726.087108658396, 3733.2346868891814, 3735.5143831301757, 5446.945530544723, 5632.239647647556, 5743.195952566644, 5744.156642461966, 5776.711164441761, 5050.292958985745, 5051.823186188466, 5085.389753229636, 5094.108531007059, 5123.38519377677, 6204.317525072239, 6211.25464944205, 6211.565190436671, 6214.533909956726, 6223.813285601439, 4084.8570300039355, 4152.8131234094535, 4155.667546596295, 4201.68487363449, 4207.190907909598, 6293.874122517524, 6430.64631445275, 6444.421116826407, 6535.57518761279, 6612.93387066128, 3819.975413031098, 4185.372194170899, 4250.149970005949, 4258.233517966796, 4290.528041915387, 3952.4268980998168, 4096.5903409658795, 4298.613124818781, 4337.349397590387, 4344.457717510301, 4340.782960851945, 4677.742724150136, 4864.732439715779, 4951.628627852925, 5012.724300163526, 5361.356637203483, 6212.316645169028, 6265.30347095216, 6266.342034086447, 6275.278342990523, 1277.9840027178416, 1416.7945647881, 1469.4342678068806, 1469.926503674812, 1481.8888583356077, 822.3051521464353, 825.9132791056973, 979.5689896445541, 988.7344199424748, 988.9950550247347, 5894.557908156819, 5902.4097590240635, 5916.349201587822, 5935.198748168942, 5944.405559444021, 6250.499960003189, 6286.402791734778, 6424.967875160594, 6426.678666066678, 6453.774117905851, 5035.647504674711, 5660.433956604306, 5926.170336152942, 5943.465088142088, 5946.762129514857, 2731.565927887835, 3069.739072178845, 3297.9010629681147, 3341.2649217172184, 3363.899083027513, 6042.425969532887, 6280.811575652738, 6485.805425837232, 6565.343465653492, 6589.86820263592, 6513.557415969011, 6569.901451478232, 6578.3092775258865, 6599.505037122235, 6659.966700166565, 6328.398802113792, 6348.984162533972, 6530.934690653033, 6590.90113648286, 6613.768518101843, 5153.381594208569, 5329.200619907045, 6220.284667263322, 6480.416762491398, 6484.438646734608, 6125.663088530174, 6329.715162817776, 6330.651814150266, 6346.90479642815, 6411.134496842867, 5392.487713667196, 5649.519790817662, 6433.774817881352, 6487.416132548094, 6505.51208659343, 4110.109349699172, 4120.196561670446, 4125.339945608688, 4595.149897269016, 4669.976650116863, 5293.835356221625, 6152.630842149306, 6439.967800160969, 6465.709043092978, 6477.838054048687, 6220.595661282002, 6237.845998490294, 6262.185915830913, 6270.655113968775, 6322.620642761449, 5527.638190954767, 6289.308176100534, 6315.5263355247625, 6339.746410143727, 6340.397662222082, 5086.415062267739, 5890.558208134321, 6042.456178943916, 6082.5438092142385, 6144.78493252734, 5466.808661696821, 5530.391656917816, 5711.771969026513, 6267.529935254783, 6281.340459251713, 4541.72749635023, 5195.3113289564835, 5368.8389348319615, 5691.943080569141, 6160.291566469913], "value": 4516.71157118279, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.4244604316546, 866.9470226690222, 872.794893200098, 884.8363052835226, 895.7984453497962, 13256.33718314084, 13612.727745445085, 17846.732299015508, 18245.996470194168, 18348.908255458737, 17254.137293135325, 17358.305667773275, 17839.286428542877, 18056.368027119053, 18076.819231807713, 976.5215044628117, 1016.3800081950004, 1018.0023576894648, 1018.124413004819, 1020.0258752891008, 676.9627670478121, 688.1501345837886, 1015.984015984016, 1016.3901659004575, 1016.7458135466134, 1006.7181189267017, 1042.7393151712072, 1050.2123407444417, 1052.1109662335314, 1053.3521884041336, 1039.433508737736, 1039.7920415916772, 1042.2235434601196, 1042.8696412948382, 1043.4886905416367, 775.3913178155121, 776.4254451705754, 776.7048521561827, 776.755322073545, 778.521209456186, 16128.516144515683, 16409.343626255053, 16593.41923032688, 16689.24898379576, 16889.83110168895, 14456.421743130262, 16591.91704041472, 16687.83312166875, 16796.076215808127, 17022.48932532026, 13609.251491167981, 13834.584962451143, 13942.024058315921, 13990.440382384793, 14130.15219086858, 3369.679880411357, 3400.5579274694132, 3401.7958922464486, 3403.23427228874, 3404.3361544498835, 112862.0, 113947.43026284898, 114749.0, 121939.39030304791, 126067.3696631511, 12579.308138052495, 13778.931105344409, 13850.099743516841, 13858.445662173603, 13877.930610346884, 19917.900410497856, 20498.795012049988, 24263.150789722276, 24967.250982470556, 25261.115860944778, 7803.985481887318, 7924.960375198087, 7942.126366099725, 7990.20097990208, 8025.197480252044, 3963.623455771697, 4035.757854528738, 4043.5956404359918, 4051.6961227908023, 4060.918781624351, 4075.2664520386616, 4328.199283132631, 4372.781360931941, 4412.470503539532, 4446.577575130357, 950.8858936927475, 961.9807603848024, 969.1713584884963, 970.4807927758616, 972.0328273368044, 525.6005435868691, 541.3963430774658, 553.1177771454524, 553.5294999250685, 559.158466507903, 9876.0, 11318.886811131948, 11464.713382165513, 11508.079353651689, 11974.461149248305, 522.9006488767122, 531.6172355903743, 540.6837000354758, 551.0136855029452, 552.4309960740444, 5581.804636837773, 6032.638041717511, 6108.7861924833305, 6112.602680825732, 6199.28708198563, 94818.05181948231, 97887.0, 102580.0, 103078.0, 105794.0, 89290.55354723315, 89844.10155898357, 89985.55007224921, 90616.0, 92871.53564232135, 61869.69065154735, 79643.0, 80915.7862632061, 81576.0, 81737.0, 11070.833937491105, 11535.0, 12197.817032744339, 12431.564895228623, 12615.180013299107, 40198.79900600478, 40214.798926006355, 40647.39028914628, 40811.59188408078, 40842.38736419015, 50127.74936125296, 51411.65824221414, 51682.74158629183, 51705.0, 52268.47731522636, 15158.848411515744, 15303.540893773205, 15403.229838507805, 15590.532284031497, 15600.219989000732, 18145.818541814413, 18193.727094093334, 18265.726014110063, 18547.72178417298, 18557.979311138017, 16663.91668041652, 16681.833181668513, 16772.832271677617, 16994.66010679804, 17079.914600426917, 16562.751558726388, 16620.916895415445, 16735.33058677688, 16851.0, 16881.831181688027, 16067.276972536498, 16344.591385215464, 16384.344626214817, 16384.83615163833, 16566.006039637177, 11629.302241865515, 11711.76576468483, 12103.619914015708, 12250.509979600716, 12347.876521234673, 12443.688907777378, 12861.164024338388, 12955.870441295467, 12994.545190918272, 13170.275634840176], "value": 8207.912861979577, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1444.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 114.0, 180.0, 107.0, 114.0, 132.0, 95.0, 148.0, 138.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 188.0, 187.0, 183.0, 186.0, 182.0, 184.0, 181.0, 183.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 88.0, 61.0, 59.0, 60.0, 58.0, 81.0, 59.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 68.0, 84.0, 70.0, 68.0, 69.0, 91.0, 69.0, 77.0, 110.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 87.0, 127.0, 135.0, 83.0, 125.0, 135.0, 89.0, 88.0], "value": 104.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 87.0, 84.0, 83.0, 86.0, 85.0, 89.0, 86.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 49.0, 49.0, 50.0, 49.0, 50.0, 51.0, 49.0, 51.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 61.0, 61.0, 62.0, 65.0, 60.0, 57.0, 58.0, 58.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 80.0, 83.0, 81.0, 82.0, 81.0, 82.0, 82.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 140.0, 147.0, 149.0, 146.0, 137.0, 135.0, 178.0, 172.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 183.0, 190.0, 186.0, 182.0, 183.0, 187.0, 187.0, 186.0], "value": 185.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 68.0, 68.0, 66.0, 66.0, 69.0, 67.0, 57.0], "value": 66.2, "unit": "score"}]}]} 10:46:46 INFO - Return code: 0 10:46:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:46:46 ERROR - # TBPL SUCCESS # 10:46:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:46:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:46:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:46:46 INFO - 2017-04-17 10:46:46.604 screenresolution[1652:9718] starting screenresolution argv=screenresolution get 10:46:46 INFO - 2017-04-17 10:46:46.606 screenresolution[1652:9718] Display 0: 1600x1200x32@60 10:46:46 INFO - 2017-04-17 10:46:46.612 screenresolution[1653:9721] starting screenresolution argv=screenresolution list 10:46:46 INFO - Available Modes on Display 0 10:46:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:46:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:46:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:46:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:46:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:46:46 INFO - Intel Iris: 10:46:46 INFO - Chipset Model: Intel Iris 10:46:46 INFO - Type: GPU 10:46:46 INFO - Bus: Built-In 10:46:46 INFO - VRAM (Dynamic, Max): 1536 MB 10:46:46 INFO - Vendor: Intel (0x8086) 10:46:46 INFO - Device ID: 0x0a2e 10:46:46 INFO - Revision ID: 0x0009 10:46:46 INFO - Displays: 10:46:46 INFO - Display: 10:46:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:46:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:46:46 INFO - Display Serial Number: 1600x1200 60 10:46:46 INFO - Main Display: Yes 10:46:46 INFO - Mirror: Off 10:46:46 INFO - Online: Yes 10:46:46 INFO - Rotation: Supported 10:46:46 INFO - Return code: 0 10:46:46 INFO - Running post-action listener: _resource_record_post_action 10:46:46 INFO - [mozharness: 2017-04-17 17:46:46.855415Z] Finished run-tests step (success) 10:46:46 INFO - Running post-run listener: _resource_record_post_run 10:46:46 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 38274560; Write bytes: 515983872; Read time: 242; Write time: 1552 10:46:46 INFO - TinderboxPrint: CPU usage
53.3% 10:46:46 INFO - TinderboxPrint: I/O read bytes / time
38,274,560 / 242 10:46:46 INFO - TinderboxPrint: I/O write bytes / time
515,983,872 / 1,552 10:46:46 INFO - TinderboxPrint: CPU idle
2,246.5 (46.7%) 10:46:46 INFO - TinderboxPrint: CPU system
954.0 (19.9%) 10:46:46 INFO - TinderboxPrint: CPU user
1,605.2 (33.4%) 10:46:46 INFO - TinderboxPrint: Swap in / out
246,730,752 / 0 10:46:46 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208065024; Write bytes: 206542848; Read time: 16319; Write time: 421 10:46:46 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 34252288; Write bytes: 302211584; Read time: 216; Write time: 1104 10:46:47 INFO - Running post-run listener: _upload_blobber_files 10:46:47 INFO - Blob upload gear active. 10:46:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:46:47 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 10:46:47 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:46:47 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:46:47 INFO - (blobuploader) - INFO - Open directory for files ... 10:46:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:46:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:46:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:48 INFO - (blobuploader) - INFO - Done attempting. 10:46:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:46:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:46:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:49 INFO - (blobuploader) - INFO - Done attempting. 10:46:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:46:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:46:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:50 INFO - (blobuploader) - INFO - Done attempting. 10:46:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:46:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:46:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:52 INFO - (blobuploader) - INFO - Done attempting. 10:46:52 INFO - (blobuploader) - INFO - Iteration through files over. 10:46:52 INFO - Return code: 0 10:46:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:46:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:46:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ae4b6a91131ccc8ff42c263147ce790ab43279bb86ec547cb854615f2c83533b8dee72436306eefd53cdaec0273c4a4786d557ad90c4ce233d3e8a9e950f61f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/9f99bc039da31c0fa16dab33993175ac84e641e9855b71de72e04c6271e8698330920cc3e6940492010c1257cdb9dafc4d6e7e89cbc3b61347a72bc6614d1b6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e251a04f0b0bf4bcbd49d9b4afca2d5922fcc82d8f5fb30d0b9c7d8b968902dc4322d643ca419c0371896c0bfc984e96c3d0919a80a7e8477ff22a27cd1167d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8a093aef9ba477e654d3f761411d738c30a0276b259f6d7b0169e1ad930461c6eceea9f5b94d6396c802680d5c17f9c8ae9f6a371f1bf7ce6587aeaaa408921e"} 10:46:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:46:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:46:52 INFO - Contents: 10:46:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ae4b6a91131ccc8ff42c263147ce790ab43279bb86ec547cb854615f2c83533b8dee72436306eefd53cdaec0273c4a4786d557ad90c4ce233d3e8a9e950f61f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/9f99bc039da31c0fa16dab33993175ac84e641e9855b71de72e04c6271e8698330920cc3e6940492010c1257cdb9dafc4d6e7e89cbc3b61347a72bc6614d1b6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e251a04f0b0bf4bcbd49d9b4afca2d5922fcc82d8f5fb30d0b9c7d8b968902dc4322d643ca419c0371896c0bfc984e96c3d0919a80a7e8477ff22a27cd1167d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8a093aef9ba477e654d3f761411d738c30a0276b259f6d7b0169e1ad930461c6eceea9f5b94d6396c802680d5c17f9c8ae9f6a371f1bf7ce6587aeaaa408921e"} 10:46:52 INFO - Running post-run listener: copy_logs_to_upload_dir 10:46:52 INFO - Copying logs to upload dir... 10:46:52 INFO - mkdir: /builds/slave/test/build/upload/logs 10:46:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.827076 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-17 10:46:52.716624) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 10:46:52.720177) ========= 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.s9gcUjqLhx/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.bMTcsRyfen/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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/Pine/sha512/ae4b6a91131ccc8ff42c263147ce790ab43279bb86ec547cb854615f2c83533b8dee72436306eefd53cdaec0273c4a4786d557ad90c4ce233d3e8a9e950f61f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/9f99bc039da31c0fa16dab33993175ac84e641e9855b71de72e04c6271e8698330920cc3e6940492010c1257cdb9dafc4d6e7e89cbc3b61347a72bc6614d1b6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e251a04f0b0bf4bcbd49d9b4afca2d5922fcc82d8f5fb30d0b9c7d8b968902dc4322d643ca419c0371896c0bfc984e96c3d0919a80a7e8477ff22a27cd1167d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8a093aef9ba477e654d3f761411d738c30a0276b259f6d7b0169e1ad930461c6eceea9f5b94d6396c802680d5c17f9c8ae9f6a371f1bf7ce6587aeaaa408921e"} build_url:https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/Qz7uu5y3RZq_OzCRpQSrmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ae4b6a91131ccc8ff42c263147ce790ab43279bb86ec547cb854615f2c83533b8dee72436306eefd53cdaec0273c4a4786d557ad90c4ce233d3e8a9e950f61f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/9f99bc039da31c0fa16dab33993175ac84e641e9855b71de72e04c6271e8698330920cc3e6940492010c1257cdb9dafc4d6e7e89cbc3b61347a72bc6614d1b6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e251a04f0b0bf4bcbd49d9b4afca2d5922fcc82d8f5fb30d0b9c7d8b968902dc4322d643ca419c0371896c0bfc984e96c3d0919a80a7e8477ff22a27cd1167d8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8a093aef9ba477e654d3f761411d738c30a0276b259f6d7b0169e1ad930461c6eceea9f5b94d6396c802680d5c17f9c8ae9f6a371f1bf7ce6587aeaaa408921e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 10:46:52.755235) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 10:46:52.755589) ========= 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.s9gcUjqLhx/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.bMTcsRyfen/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.005300 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 10:46:52.804768) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 10:46:52.805120) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 10:46:52.805489) ========= ========= Total master_lag: 0.18 =========