builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0131 starttime: 1485222593.84 results: success (0) buildid: 20170123152243 builduid: 8e48e7fd79f748ad9ecb7354120e0f37 revision: d738f701dd5d71d25ea8b502f15ca049c5dec52b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 17:49:53.838954) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 17:49:53.839321) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 17:49:53.839587) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 17:49:54.037473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 17:49:54.037724) ========= 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.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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-01-23 17:49:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.3M=0.001s 2017-01-23 17:49:54 (14.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.603595 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 17:49:54.684053) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 17:49:54.684343) ========= 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.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.025993 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 17:49:54.732527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 17:49:54.732947) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d738f701dd5d71d25ea8b502f15ca049c5dec52b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d738f701dd5d71d25ea8b502f15ca049c5dec52b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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-01-23 17:49:54,838 truncating revision to first 12 chars 2017-01-23 17:49:54,838 Setting DEBUG logging. 2017-01-23 17:49:54,839 attempt 1/10 2017-01-23 17:49:54,839 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d738f701dd5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 17:49:55,970 unpacking tar archive at: mozilla-beta-d738f701dd5d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.402085 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 17:49:56.158996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 17:49:56.159307) ========= script_repo_revision: d738f701dd5d71d25ea8b502f15ca049c5dec52b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 17:49:56.159724) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 17:49:56.160003) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 17:49:56.183952) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-01-23 17:49:56.184358) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 17:49:56 INFO - MultiFileLogger online at 20170123 17:49:56 in /builds/slave/test 17:49:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:49:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:49:56 INFO - {'append_to_log': False, 17:49:56 INFO - 'base_work_dir': '/builds/slave/test', 17:49:56 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:49:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:49:56 INFO - 'branch': 'Mozilla-Beta', 17:49:56 INFO - 'buildbot_json_path': 'buildprops.json', 17:49:56 INFO - 'config_files': ('talos/mac_config.py',), 17:49:56 INFO - 'default_actions': ('clobber', 17:49:56 INFO - 'read-buildbot-config', 17:49:56 INFO - 'download-and-extract', 17:49:56 INFO - 'populate-webroot', 17:49:56 INFO - 'create-virtualenv', 17:49:56 INFO - 'install', 17:49:56 INFO - 'run-tests'), 17:49:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:49:56 INFO - 'download_minidump_stackwalk': True, 17:49:56 INFO - 'download_symbols': 'ondemand', 17:49:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:49:56 INFO - 'tooltool.py': '/tools/tooltool.py', 17:49:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:49:56 INFO - '/tools/misc-python/virtualenv.py')}, 17:49:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:49:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:49:56 INFO - 'installer_path': 'installer.exe', 17:49:56 INFO - 'log_level': 'info', 17:49:56 INFO - 'log_name': 'talos', 17:49:56 INFO - 'log_to_console': True, 17:49:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:49:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:49:56 INFO - 'opt_config_files': (), 17:49:56 INFO - 'pip_index': False, 17:49:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:49:56 INFO - 'cmd': ('bash', 17:49:56 INFO - '-c', 17:49:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:49:56 INFO - 'enabled': True, 17:49:56 INFO - 'halt_on_failure': False, 17:49:56 INFO - 'name': 'check_screen_resolution'},), 17:49:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:49:56 INFO - 'cmd': ('bash', 17:49:56 INFO - '-c', 17:49:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:49:56 INFO - 'enabled': True, 17:49:56 INFO - 'halt_on_failure': False, 17:49:56 INFO - 'name': 'check_screen_resolution'},), 17:49:56 INFO - 'run_cmd_checks_enabled': True, 17:49:56 INFO - 'sps_profile': False, 17:49:56 INFO - 'sps_profile_interval': 0, 17:49:56 INFO - 'suite': 'dromaeojs', 17:49:56 INFO - 'system_bits': '32', 17:49:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:49:56 INFO - 'title': 't-yosemite-r7-0131', 17:49:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:49:56 INFO - 'use_talos_json': True, 17:49:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:49:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:49:56 INFO - 'work_dir': 'build'} 17:49:56 INFO - [mozharness: 2017-01-24 01:49:56.402768Z] Running clobber step. 17:49:56 INFO - Running pre-action listener: _resource_record_pre_action 17:49:56 INFO - Running main action method: clobber 17:49:56 INFO - rmtree: /builds/slave/test/build 17:49:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:49:58 INFO - Running post-action listener: _resource_record_post_action 17:49:58 INFO - [mozharness: 2017-01-24 01:49:58.986421Z] Finished clobber step (success) 17:49:58 INFO - [mozharness: 2017-01-24 01:49:58.986547Z] Running read-buildbot-config step. 17:49:58 INFO - Running pre-action listener: _resource_record_pre_action 17:49:58 INFO - Running main action method: read_buildbot_config 17:49:58 INFO - Using buildbot properties: 17:49:58 INFO - { 17:49:58 INFO - "project": "", 17:49:58 INFO - "product": "firefox", 17:49:58 INFO - "script_repo_revision": "production", 17:49:58 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 17:49:58 INFO - "repository": "", 17:49:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 17:49:58 INFO - "buildid": "20170123152243", 17:49:58 INFO - "pgo_build": "False", 17:49:58 INFO - "basedir": "/builds/slave/test", 17:49:58 INFO - "buildnumber": 6, 17:49:58 INFO - "slavename": "t-yosemite-r7-0131", 17:49:58 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 17:49:58 INFO - "platform": "yosemite_r7", 17:49:58 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:49:58 INFO - "branch": "mozilla-beta", 17:49:58 INFO - "repo_path": "releases/mozilla-beta", 17:49:58 INFO - "revision": "d738f701dd5d71d25ea8b502f15ca049c5dec52b", 17:49:58 INFO - "stage_platform": "macosx64", 17:49:58 INFO - "builduid": "8e48e7fd79f748ad9ecb7354120e0f37", 17:49:58 INFO - "slavebuilddir": "test" 17:49:58 INFO - } 17:49:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 17:49:58 INFO - Running post-action listener: _resource_record_post_action 17:49:58 INFO - [mozharness: 2017-01-24 01:49:58.989969Z] Finished read-buildbot-config step (success) 17:49:58 INFO - [mozharness: 2017-01-24 01:49:58.990078Z] Running download-and-extract step. 17:49:58 INFO - Running pre-action listener: _resource_record_pre_action 17:49:58 INFO - Running main action method: download_and_extract 17:49:58 INFO - mkdir: /builds/slave/test/build/tests 17:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:58 INFO - trying https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 17:49:58 INFO - Downloading https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 17:49:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 17:50:00 INFO - Downloaded 1165 bytes. 17:50:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 17:50:00 INFO - Using the following test package requirements: 17:50:00 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 17:50:00 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:50:00 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 17:50:00 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:50:00 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 17:50:00 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:50:00 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:50:00 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 17:50:00 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 17:50:00 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:50:00 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 17:50:00 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:50:00 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 17:50:00 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:50:00 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 17:50:00 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 17:50:00 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 17:50:00 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 17:50:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 17:50:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 17:50:00 INFO - Fetch https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 17:50:01 INFO - Http code: 200 17:50:01 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 17:50:01 INFO - x-amz-cf-id: RpBAl4nhyrlDGYMW1_DVjrcq2fkevcRIoopnaEweubX2SkTb5HUpvA== 17:50:01 INFO - x-amz-version-id: tvpgiBMmEbbwNxB7diWyVCCnZ1UuaBxT 17:50:05 INFO - Expected file size: 16086069 17:50:05 INFO - Obtained file size: 16086069 17:50:12 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 17:50:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 17:50:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 17:50:12 INFO - Fetch https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 17:50:13 INFO - Http code: 200 17:50:13 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 17:50:13 INFO - x-amz-cf-id: z2fKnh5zXQ57pxaw5kSA1yrOEyaLpt0bdJwSwv7BYKCtV3GXHcDjBQ== 17:50:13 INFO - x-amz-version-id: tvpgiBMmEbbwNxB7diWyVCCnZ1UuaBxT 17:50:14 INFO - Expected file size: 16086069 17:50:14 INFO - Obtained file size: 16086069 17:50:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 17:50:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 17:50:21 INFO - Fetch https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 17:50:22 INFO - Http code: 200 17:50:22 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 17:50:22 INFO - x-amz-cf-id: iax1lJsPw-LseXhCeW4Daulkwa6jipRI9FQ167fDmV9DeO8VpCNCxA== 17:50:22 INFO - x-amz-version-id: r92VDuwHJ1Hc3Vb4SVjLGJW2IFl4ziGu 17:50:28 INFO - Expected file size: 14402992 17:50:28 INFO - Obtained file size: 14402992 17:50: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')]} 17:50:28 INFO - trying https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 17:50:28 INFO - Downloading https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 17:50:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 17:50:40 INFO - Downloaded 82107959 bytes. 17:50:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 17:50:40 INFO - mkdir: /builds/slave/test/properties 17:50:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:50:40 INFO - Writing to file /builds/slave/test/properties/build_url 17:50:40 INFO - Contents: 17:50:40 INFO - build_url:https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 17:50:41 INFO - Running post-action listener: _resource_record_post_action 17:50:41 INFO - Running post-action listener: set_extra_try_arguments 17:50:41 INFO - [mozharness: 2017-01-24 01:50:41.336810Z] Finished download-and-extract step (success) 17:50:41 INFO - [mozharness: 2017-01-24 01:50:41.336951Z] Running populate-webroot step. 17:50:41 INFO - Running pre-action listener: _resource_record_pre_action 17:50:41 INFO - Running main action method: populate_webroot 17:50:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:50:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:50:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:50:41 INFO - '--tppagecycles', 17:50:41 INFO - '7'], 17:50:41 INFO - 'tests': ['tsvgm']}}, 17:50:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:50:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:50:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:50:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:50:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:50:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:50:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:41 INFO - 'talos_options': ['--disable-e10s'], 17:50:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:41 INFO - 'talos_options': ['--disable-e10s'], 17:50:41 INFO - 'tests': ['damp', 'tps']}, 17:50:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:41 INFO - 'tests': ['damp', 'tps']}, 17:50:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:50:41 INFO - 'tests': ['dromaeo_dom']}, 17:50:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:50:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:50:41 INFO - 'tests': ['basic_compositor_video']}, 17:50:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:50:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:50:41 INFO - 'tests': ['a11yr', 17:50:41 INFO - 'ts_paint', 17:50:41 INFO - 'tpaint', 17:50:41 INFO - 'sessionrestore', 17:50:41 INFO - 'sessionrestore_no_auto_restore', 17:50:41 INFO - 'tabpaint']}, 17:50:41 INFO - 'other-e10s': {'tests': ['a11yr', 17:50:41 INFO - 'ts_paint', 17:50:41 INFO - 'tpaint', 17:50:41 INFO - 'sessionrestore', 17:50:41 INFO - 'sessionrestore_no_auto_restore', 17:50:41 INFO - 'tabpaint']}, 17:50:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:50:41 INFO - 'ts_paint', 17:50:41 INFO - 'tpaint', 17:50:41 INFO - 'sessionrestore', 17:50:41 INFO - 'sessionrestore_no_auto_restore', 17:50:41 INFO - 'tabpaint']}, 17:50:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:50:41 INFO - 'ts_paint', 17:50:41 INFO - 'tpaint', 17:50:41 INFO - 'sessionrestore', 17:50:41 INFO - 'sessionrestore_no_auto_restore', 17:50:41 INFO - 'tabpaint']}, 17:50:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:50:41 INFO - 'tests': ['a11yr', 17:50:41 INFO - 'ts_paint', 17:50:41 INFO - 'tpaint', 17:50:41 INFO - 'sessionrestore', 17:50:41 INFO - 'sessionrestore_no_auto_restore', 17:50:41 INFO - 'tabpaint']}, 17:50:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:50:41 INFO - 'tests': ['a11yr', 17:50:41 INFO - 'ts_paint', 17:50:41 INFO - 'tpaint', 17:50:41 INFO - 'sessionrestore', 17:50:41 INFO - 'sessionrestore_no_auto_restore', 17:50:41 INFO - 'tabpaint']}, 17:50:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:50:41 INFO - 'tests': ['tsvgx', 17:50:41 INFO - 'tsvgr_opacity', 17:50:41 INFO - 'tart', 17:50:41 INFO - 'tscrollx', 17:50:41 INFO - 'cart']}, 17:50:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:50:41 INFO - 'tsvgr_opacity', 17:50:41 INFO - 'tart', 17:50:41 INFO - 'tscrollx', 17:50:41 INFO - 'cart']}, 17:50:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:41 INFO - 'talos_options': ['--disable-e10s'], 17:50:41 INFO - 'tests': ['tp5o']}, 17:50:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:41 INFO - 'tests': ['tp5o']}, 17:50:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:41 INFO - 'talos_options': ['--disable-e10s', 17:50:41 INFO - '--xperf_path', 17:50:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:41 INFO - 'tests': ['tp5n']}, 17:50:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:41 INFO - 'talos_options': ['--xperf_path', 17:50:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:41 INFO - 'tests': ['tp5n']}}, 17:50:41 INFO - 'talos.zip': {'path': '', 17:50:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:50:41 INFO - Running post-action listener: _resource_record_post_action 17:50:41 INFO - [mozharness: 2017-01-24 01:50:41.355767Z] Finished populate-webroot step (success) 17:50:41 INFO - [mozharness: 2017-01-24 01:50:41.355876Z] Running create-virtualenv step. 17:50:41 INFO - Running pre-action listener: _resource_record_pre_action 17:50:41 INFO - Running main action method: create_virtualenv 17:50:41 INFO - Creating virtualenv /builds/slave/test/build/venv 17:50:41 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 17:50:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:50:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:50:41 INFO - Using real prefix '/tools/python27' 17:50:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:50:42 INFO - Installing distribute.............................................................................................................................................................................................done. 17:50:45 INFO - Installing pip.................done. 17:50:45 INFO - Return code: 0 17:50:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:50:45 INFO - Reading from file tmpfile_stdout 17:50:45 INFO - Output received: 17:50:45 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) 17:50:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d84bc370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa26d30>, '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 0x10a88cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1eb20>, '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.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 17:50:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:50:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ndhhmod9ml/Render', 17:50:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:45 INFO - 'HOME': '/Users/cltbld', 17:50:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:45 INFO - 'LOGNAME': 'cltbld', 17:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:45 INFO - 'MOZ_NO_REMOTE': '1', 17:50:45 INFO - 'NO_EM_RESTART': '1', 17:50:45 INFO - 'PAGER': '/bin/cat', 17:50:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:45 INFO - 'PWD': '/builds/slave/test', 17:50:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:45 INFO - 'SHELL': '/bin/bash', 17:50:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZpTWlAdgGe/Listeners', 17:50:45 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 17:50:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:45 INFO - 'USER': 'cltbld', 17:50:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:45 INFO - 'XPC_FLAGS': '0x0', 17:50:45 INFO - 'XPC_SERVICE_NAME': '0', 17:50:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:45 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 17:50:45 INFO - Cleaning up... 17:50:45 INFO - Return code: 0 17:50:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ac12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d84bc370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa26d30>, '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 0x10a88cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1eb20>, '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.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 17:50:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:50:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ndhhmod9ml/Render', 17:50:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:45 INFO - 'HOME': '/Users/cltbld', 17:50:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:45 INFO - 'LOGNAME': 'cltbld', 17:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:45 INFO - 'MOZ_NO_REMOTE': '1', 17:50:45 INFO - 'NO_EM_RESTART': '1', 17:50:45 INFO - 'PAGER': '/bin/cat', 17:50:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:45 INFO - 'PWD': '/builds/slave/test', 17:50:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:45 INFO - 'SHELL': '/bin/bash', 17:50:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZpTWlAdgGe/Listeners', 17:50:45 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 17:50:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:45 INFO - 'USER': 'cltbld', 17:50:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:45 INFO - 'XPC_FLAGS': '0x0', 17:50:45 INFO - 'XPC_SERVICE_NAME': '0', 17:50:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:45 INFO - Downloading/unpacking psutil>=3.1.1 17:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:50:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:50:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:50:49 INFO - Installing collected packages: psutil 17:50:49 INFO - Running setup.py install for psutil 17:50:49 INFO - building 'psutil._psutil_osx' extension 17:50:49 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 17:50:50 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 17:50:50 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 17:50:50 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 17:50:50 INFO - building 'psutil._psutil_posix' extension 17:50:50 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 17:50:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:50:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:50:50 INFO - ^ 17:50:50 INFO - 1 warning generated. 17:50:50 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 17:50:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:50:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:50:50 INFO - Successfully installed psutil 17:50:50 INFO - Cleaning up... 17:50:51 INFO - Return code: 0 17:50:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:51 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 0x10ac12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d84bc370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa26d30>, '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 0x10a88cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1eb20>, '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.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 17:50:51 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 17:50:51 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 17:50:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ndhhmod9ml/Render', 17:50:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:51 INFO - 'HOME': '/Users/cltbld', 17:50:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:51 INFO - 'LOGNAME': 'cltbld', 17:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:51 INFO - 'MOZ_NO_REMOTE': '1', 17:50:51 INFO - 'NO_EM_RESTART': '1', 17:50:51 INFO - 'PAGER': '/bin/cat', 17:50:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:51 INFO - 'PWD': '/builds/slave/test', 17:50:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:51 INFO - 'SHELL': '/bin/bash', 17:50:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZpTWlAdgGe/Listeners', 17:50:51 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 17:50:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:51 INFO - 'USER': 'cltbld', 17:50:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:51 INFO - 'XPC_FLAGS': '0x0', 17:50:51 INFO - 'XPC_SERVICE_NAME': '0', 17:50:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:50:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:50:54 INFO - Installing collected packages: mozsystemmonitor 17:50:54 INFO - Running setup.py install for mozsystemmonitor 17:50:54 INFO - Successfully installed mozsystemmonitor 17:50:54 INFO - Cleaning up... 17:50:54 INFO - Return code: 0 17:50:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:50:54 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')]} 17:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:54 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')]} 17:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:54 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 0x10ac12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d84bc370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa26d30>, '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 0x10a88cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1eb20>, '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.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 17:50:54 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 17:50:54 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 17:50:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ndhhmod9ml/Render', 17:50:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:54 INFO - 'HOME': '/Users/cltbld', 17:50:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:54 INFO - 'LOGNAME': 'cltbld', 17:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:54 INFO - 'MOZ_NO_REMOTE': '1', 17:50:54 INFO - 'NO_EM_RESTART': '1', 17:50:54 INFO - 'PAGER': '/bin/cat', 17:50:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:54 INFO - 'PWD': '/builds/slave/test', 17:50:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:54 INFO - 'SHELL': '/bin/bash', 17:50:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZpTWlAdgGe/Listeners', 17:50:54 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 17:50:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:54 INFO - 'USER': 'cltbld', 17:50:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:54 INFO - 'XPC_FLAGS': '0x0', 17:50:54 INFO - 'XPC_SERVICE_NAME': '0', 17:50:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:54 INFO - Downloading/unpacking jsonschema==2.5.1 17:50:54 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 17:50:54 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 17:50:54 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 17:50:54 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 17:50:54 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 17:50:54 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 17:50:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:50:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:50:57 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 17:50:57 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 17:50:57 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 17:50:57 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 17:50:57 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 17:50:57 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 17:50:57 INFO - Downloading functools32-3.2.3-2.tar.gz 17:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:50:57 INFO - warning: no files found matching '*.txt' 17:50:57 INFO - no previously-included directories found matching 'build' 17:50:57 INFO - no previously-included directories found matching 'dist' 17:50:57 INFO - no previously-included directories found matching '.git*' 17:50:57 INFO - Installing collected packages: jsonschema, functools32 17:50:57 INFO - Running setup.py install for functools32 17:50:57 INFO - warning: no files found matching '*.txt' 17:50:57 INFO - no previously-included directories found matching 'build' 17:50:57 INFO - no previously-included directories found matching 'dist' 17:50:57 INFO - no previously-included directories found matching '.git*' 17:50:57 INFO - Successfully installed jsonschema functools32 17:50:57 INFO - Cleaning up... 17:50:57 INFO - Return code: 0 17:50:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:58 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 0x10ac12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d84bc370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa26d30>, '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 0x10a88cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1eb20>, '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.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 17:50:58 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 17:50:58 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 17:50:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ndhhmod9ml/Render', 17:50:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:58 INFO - 'HOME': '/Users/cltbld', 17:50:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:58 INFO - 'LOGNAME': 'cltbld', 17:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:58 INFO - 'MOZ_NO_REMOTE': '1', 17:50:58 INFO - 'NO_EM_RESTART': '1', 17:50:58 INFO - 'PAGER': '/bin/cat', 17:50:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:58 INFO - 'PWD': '/builds/slave/test', 17:50:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:58 INFO - 'SHELL': '/bin/bash', 17:50:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZpTWlAdgGe/Listeners', 17:50:58 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 17:50:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:58 INFO - 'USER': 'cltbld', 17:50:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:58 INFO - 'XPC_FLAGS': '0x0', 17:50:58 INFO - 'XPC_SERVICE_NAME': '0', 17:50:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:50:58 INFO - Cleaning up... 17:50:58 INFO - Return code: 0 17:50:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:58 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 0x10ac12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d84bc370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa26d30>, '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 0x10a88cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1eb20>, '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.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 17:50:58 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 17:50:58 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 17:50:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ndhhmod9ml/Render', 17:50:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:58 INFO - 'HOME': '/Users/cltbld', 17:50:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:58 INFO - 'LOGNAME': 'cltbld', 17:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:58 INFO - 'MOZ_NO_REMOTE': '1', 17:50:58 INFO - 'NO_EM_RESTART': '1', 17:50:58 INFO - 'PAGER': '/bin/cat', 17:50:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:58 INFO - 'PWD': '/builds/slave/test', 17:50:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:58 INFO - 'SHELL': '/bin/bash', 17:50:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZpTWlAdgGe/Listeners', 17:50:58 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 17:50:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:58 INFO - 'USER': 'cltbld', 17:50:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:58 INFO - 'XPC_FLAGS': '0x0', 17:50:58 INFO - 'XPC_SERVICE_NAME': '0', 17:50:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:58 INFO - Downloading/unpacking blobuploader==1.2.4 17:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:01 INFO - Downloading blobuploader-1.2.4.tar.gz 17:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:51:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:51:01 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 17:51:01 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 17:51:01 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 17:51:01 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 17:51:01 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 17:51:01 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 17:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:51:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:51:01 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 17:51:01 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 17:51:01 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 17:51:01 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 17:51:01 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 17:51:01 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 17:51:02 INFO - Downloading docopt-0.6.1.tar.gz 17:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:51:02 INFO - Installing collected packages: blobuploader, requests, docopt 17:51:02 INFO - Running setup.py install for blobuploader 17:51:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:51:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:51:02 INFO - Running setup.py install for requests 17:51:03 INFO - Running setup.py install for docopt 17:51:03 INFO - Successfully installed blobuploader requests docopt 17:51:03 INFO - Cleaning up... 17:51:03 INFO - Return code: 0 17:51:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:03 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 0x10ac12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d84bc370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa26d30>, '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 0x10a88cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1eb20>, '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.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 17:51:03 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 17:51:03 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 17:51:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ndhhmod9ml/Render', 17:51:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:51:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:51:03 INFO - 'HOME': '/Users/cltbld', 17:51:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:51:03 INFO - 'LOGNAME': 'cltbld', 17:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:03 INFO - 'MOZ_NO_REMOTE': '1', 17:51:03 INFO - 'NO_EM_RESTART': '1', 17:51:03 INFO - 'PAGER': '/bin/cat', 17:51:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:03 INFO - 'PWD': '/builds/slave/test', 17:51:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:51:03 INFO - 'SHELL': '/bin/bash', 17:51:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZpTWlAdgGe/Listeners', 17:51:03 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 17:51:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:51:03 INFO - 'USER': 'cltbld', 17:51:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:51:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:03 INFO - 'XPC_FLAGS': '0x0', 17:51:03 INFO - 'XPC_SERVICE_NAME': '0', 17:51:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:51:03 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-tKvVWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:51:03 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-TFHXVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:51:03 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-mvma27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:51:03 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-lQhhpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:51:04 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-524jO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:51:04 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ec7tpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:51:04 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-g_YpWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:51:04 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-XTI7oE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:51:04 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-rao30x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:51:04 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-wsoeYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:51:04 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-8F72pH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:51:04 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-94Vgtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:51:04 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-84xpUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:51:04 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Xq8dtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:05 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-zbqxYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:51:05 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-wWRlrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:51:05 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-M031nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:51:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:51:05 INFO - Running setup.py install for manifestparser 17:51:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Running setup.py install for mozcrash 17:51:05 INFO - Running setup.py install for mozdebug 17:51:05 INFO - Running setup.py install for mozdevice 17:51:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Running setup.py install for mozfile 17:51:06 INFO - Running setup.py install for mozhttpd 17:51:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Running setup.py install for mozinfo 17:51:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Running setup.py install for mozInstall 17:51:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Running setup.py install for mozleak 17:51:06 INFO - Running setup.py install for mozlog 17:51:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Running setup.py install for moznetwork 17:51:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Running setup.py install for mozprocess 17:51:07 INFO - Running setup.py install for mozprofile 17:51:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:51:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:51:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:51:07 INFO - Running setup.py install for mozrunner 17:51:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:51:07 INFO - Running setup.py install for mozscreenshot 17:51:07 INFO - Running setup.py install for moztest 17:51:07 INFO - Running setup.py install for mozversion 17:51:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:51:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:51:07 INFO - Cleaning up... 17:51:07 INFO - Return code: 0 17:51:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51:07 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')]} 17:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:07 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')]} 17:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:07 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 0x10ac12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d84bc370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa26d30>, '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 0x10a88cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1eb20>, '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.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 17:51:07 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 17:51:07 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 17:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ndhhmod9ml/Render', 17:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:51:07 INFO - 'HOME': '/Users/cltbld', 17:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:51:07 INFO - 'LOGNAME': 'cltbld', 17:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:07 INFO - 'MOZ_NO_REMOTE': '1', 17:51:07 INFO - 'NO_EM_RESTART': '1', 17:51:07 INFO - 'PAGER': '/bin/cat', 17:51:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:07 INFO - 'PWD': '/builds/slave/test', 17:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:51:07 INFO - 'SHELL': '/bin/bash', 17:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZpTWlAdgGe/Listeners', 17:51:07 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 17:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:51:07 INFO - 'USER': 'cltbld', 17:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:07 INFO - 'XPC_FLAGS': '0x0', 17:51:07 INFO - 'XPC_SERVICE_NAME': '0', 17:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:51:08 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-LacUpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:51:08 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-4VnH29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:51:08 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-_ZeluT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:51:08 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-v2MWFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:51:08 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-JyAIVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:51:08 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-YEVg6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:51:08 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-JgPfA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:51:08 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)) 17:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:51:08 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-hGyQRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:51:09 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)) 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:51:09 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-onj1WC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:51:09 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)) 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:51:09 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-TZF9_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:51:09 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)) 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:51:09 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-7Rkor8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:51:09 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)) 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:51:09 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-PGcjaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:51:09 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-kV8sJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:51:09 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)) 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:51:09 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-zuW6Tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:51:09 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)) 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:09 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-hSs5hV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:09 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)) 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:51:09 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-zBoBeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:51:09 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)) 17:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:51:09 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-UyCKI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:51:09 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)) 17:51:10 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)) 17:51:10 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)) 17:51:10 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)) 17:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:51:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:51:10 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 17:51:10 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 17:51:10 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 17:51:10 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 17:51:10 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 17:51:10 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 17:51:12 INFO - Downloading blessings-1.6.tar.gz 17:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:51:12 INFO - Installing collected packages: blessings 17:51:12 INFO - Running setup.py install for blessings 17:51:12 INFO - Successfully installed blessings 17:51:12 INFO - Cleaning up... 17:51:12 INFO - Return code: 0 17:51:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:51:13 INFO - Reading from file tmpfile_stdout 17:51:13 INFO - Current package versions: 17:51:13 INFO - blessings == 1.6 17:51:13 INFO - blobuploader == 1.2.4 17:51:13 INFO - docopt == 0.6.1 17:51:13 INFO - functools32 == 3.2.3-2 17:51:13 INFO - jsonschema == 2.5.1 17:51:13 INFO - manifestparser == 1.1 17:51:13 INFO - mozInstall == 1.12 17:51:13 INFO - mozcrash == 1.0 17:51:13 INFO - mozdebug == 0.1 17:51:13 INFO - mozdevice == 0.48 17:51:13 INFO - mozfile == 1.2 17:51:13 INFO - mozhttpd == 0.7 17:51:13 INFO - mozinfo == 0.9 17:51:13 INFO - mozleak == 0.1 17:51:13 INFO - mozlog == 3.4 17:51:13 INFO - moznetwork == 0.27 17:51:13 INFO - mozprocess == 0.23 17:51:13 INFO - mozprofile == 0.28 17:51:13 INFO - mozrunner == 6.13 17:51:13 INFO - mozscreenshot == 0.1 17:51:13 INFO - mozsystemmonitor == 0.3 17:51:13 INFO - moztest == 0.8 17:51:13 INFO - mozversion == 1.4 17:51:13 INFO - psutil == 3.1.1 17:51:13 INFO - requests == 1.2.3 17:51:13 INFO - wsgiref == 0.1.2 17:51:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:13 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 0x10ac12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d84bc370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa26d30>, '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 0x10a88cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1eb20>, '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.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 17:51:13 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 17:51:13 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 17:51:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ndhhmod9ml/Render', 17:51:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:51:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:51:13 INFO - 'HOME': '/Users/cltbld', 17:51:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:51:13 INFO - 'LOGNAME': 'cltbld', 17:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:13 INFO - 'MOZ_NO_REMOTE': '1', 17:51:13 INFO - 'NO_EM_RESTART': '1', 17:51:13 INFO - 'PAGER': '/bin/cat', 17:51:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:13 INFO - 'PWD': '/builds/slave/test', 17:51:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:51:13 INFO - 'SHELL': '/bin/bash', 17:51:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZpTWlAdgGe/Listeners', 17:51:13 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 17:51:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:51:13 INFO - 'USER': 'cltbld', 17:51:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:51:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:13 INFO - 'XPC_FLAGS': '0x0', 17:51:13 INFO - 'XPC_SERVICE_NAME': '0', 17:51:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:13 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)) 17:51:13 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)) 17:51:13 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)) 17:51:13 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)) 17:51:13 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)) 17:51:13 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)) 17:51:13 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)) 17:51:13 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)) 17:51:13 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)) 17:51:13 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)) 17:51:13 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)) 17:51:13 INFO - Cleaning up... 17:51:13 INFO - Return code: 0 17:51:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:51:13 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 0x10ac12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab88570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8d84bc370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa26d30>, '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 0x10a88cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1eb20>, '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.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 17:51:13 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 17:51:13 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 17:51:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ndhhmod9ml/Render', 17:51:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:51:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:51:13 INFO - 'HOME': '/Users/cltbld', 17:51:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:51:13 INFO - 'LOGNAME': 'cltbld', 17:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:13 INFO - 'MOZ_NO_REMOTE': '1', 17:51:13 INFO - 'NO_EM_RESTART': '1', 17:51:13 INFO - 'PAGER': '/bin/cat', 17:51:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:13 INFO - 'PWD': '/builds/slave/test', 17:51:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:51:13 INFO - 'SHELL': '/bin/bash', 17:51:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZpTWlAdgGe/Listeners', 17:51:13 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 17:51:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:51:13 INFO - 'USER': 'cltbld', 17:51:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:51:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:13 INFO - 'XPC_FLAGS': '0x0', 17:51:13 INFO - 'XPC_SERVICE_NAME': '0', 17:51:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:51:13 INFO - Cleaning up... 17:51:13 INFO - Return code: 0 17:51:13 INFO - Running post-action listener: _resource_record_post_action 17:51:13 INFO - Running post-action listener: _start_resource_monitoring 17:51:13 INFO - Starting resource monitoring. 17:51:13 INFO - [mozharness: 2017-01-24 01:51:13.792367Z] Finished create-virtualenv step (success) 17:51:13 INFO - [mozharness: 2017-01-24 01:51:13.793340Z] Running install step. 17:51:13 INFO - Running pre-action listener: _resource_record_pre_action 17:51:13 INFO - Running main action method: install 17:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:51:14 INFO - Reading from file tmpfile_stdout 17:51:14 INFO - Detecting whether we're running mozinstall >=1.0... 17:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:51:14 INFO - Reading from file tmpfile_stdout 17:51:14 INFO - Output received: 17:51:14 INFO - Usage: mozinstall [options] installer 17:51:14 INFO - Options: 17:51:14 INFO - -h, --help show this help message and exit 17:51:14 INFO - -d DEST, --destination=DEST 17:51:14 INFO - Directory to install application into. [default: 17:51:14 INFO - "/builds/slave/test"] 17:51:14 INFO - --app=APP Application being installed. [default: firefox] 17:51:14 INFO - mkdir: /builds/slave/test/build/application 17:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 17:51:35 INFO - Reading from file tmpfile_stdout 17:51:35 INFO - Output received: 17:51:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:51:35 INFO - Running post-action listener: _resource_record_post_action 17:51:35 INFO - [mozharness: 2017-01-24 01:51:35.427640Z] Finished install step (success) 17:51:35 INFO - [mozharness: 2017-01-24 01:51:35.427773Z] Running run-tests step. 17:51:35 INFO - Running pre-action listener: _resource_record_pre_action 17:51:35 INFO - Running main action method: run_tests 17:51:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:51:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:51:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:51:35 INFO - 2017-01-23 17:51:35.440 screenresolution[1628:7917] starting screenresolution argv=screenresolution get 17:51:35 INFO - 2017-01-23 17:51:35.442 screenresolution[1628:7917] Display 0: 1600x1200x32@60 17:51:35 INFO - 2017-01-23 17:51:35.447 screenresolution[1629:7919] starting screenresolution argv=screenresolution list 17:51:35 INFO - Available Modes on Display 0 17:51:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:51:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:51:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:51:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:51:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:51:35 INFO - Intel Iris: 17:51:35 INFO - Chipset Model: Intel Iris 17:51:35 INFO - Type: GPU 17:51:35 INFO - Bus: Built-In 17:51:35 INFO - VRAM (Dynamic, Max): 1536 MB 17:51:35 INFO - Vendor: Intel (0x8086) 17:51:35 INFO - Device ID: 0x0a2e 17:51:35 INFO - Revision ID: 0x0009 17:51:35 INFO - Displays: 17:51:35 INFO - Display: 17:51:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:51:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:51:35 INFO - Display Serial Number: 1600x1200 60 17:51:35 INFO - Main Display: Yes 17:51:35 INFO - Mirror: Off 17:51:35 INFO - Online: Yes 17:51:35 INFO - Rotation: Supported 17:51:35 INFO - Return code: 0 17:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:51:35 INFO - Python 2.7.3 17:51:35 INFO - Return code: 0 17:51:35 INFO - grabbing minidump binary from tooltool 17:51:35 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')]} 17:51:35 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 0x10aa26d30>, '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 0x10a88cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:51:35 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 17:51:35 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 17:51:35 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 17:51:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:51:35 INFO - Return code: 0 17:51:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:51:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:51:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:51:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:51:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--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 17:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0131 --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 17:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ndhhmod9ml/Render', 17:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:51:35 INFO - 'HOME': '/Users/cltbld', 17:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:51:35 INFO - 'LOGNAME': 'cltbld', 17:51:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:51:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:35 INFO - 'MOZ_NO_REMOTE': '1', 17:51:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:51:35 INFO - 'NO_EM_RESTART': '1', 17:51:35 INFO - 'PAGER': '/bin/cat', 17:51:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:35 INFO - 'PWD': '/builds/slave/test', 17:51:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:51:35 INFO - 'SHELL': '/bin/bash', 17:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZpTWlAdgGe/Listeners', 17:51:35 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 17:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:51:35 INFO - 'USER': 'cltbld', 17:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:35 INFO - 'XPC_FLAGS': '0x0', 17:51:35 INFO - 'XPC_SERVICE_NAME': '0', 17:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:51:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--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 17:51:36 INFO - mozversion application_buildid: 20170123152243 17:51:36 INFO - mozversion application_changeset: d738f701dd5d71d25ea8b502f15ca049c5dec52b 17:51:36 INFO - mozversion application_display_name: Firefox 17:51:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:51:36 INFO - mozversion application_name: Firefox 17:51:36 INFO - mozversion application_remotingname: firefox 17:51:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:51:36 INFO - mozversion application_vendor: Mozilla 17:51:36 INFO - mozversion application_version: 52.0 17:51:36 INFO - mozversion platform_buildid: 20170123152243 17:51:36 INFO - mozversion platform_changeset: d738f701dd5d71d25ea8b502f15ca049c5dec52b 17:51:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:51:36 INFO - mozversion platform_version: 52.0 17:51:36 INFO - using testdate: 1485222696 17:51:36 INFO - actual date: 1485222696 17:51:36 INFO - starting webserver on 'localhost:49241' 17:51:36 INFO - SUITE-START | Running 2 tests 17:51:36 INFO - TEST-START | dromaeo_css 17:51:36 INFO - operating with platform_type : mac_ 17:51:36 INFO - Initialising browser for dromaeo_css test... 17:51:36 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpFw2tGA/profile http://localhost:49241/getInfo.html) 17:51:38 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 17:51:38 INFO - PROCESS | 1639 | colorDepth:24 17:51:38 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 17:51:38 INFO - PROCESS | 1639 | __metrics 17:51:38 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:51:38 INFO - PROCESS | 1639 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:51:39 INFO - TEST-INFO | 1639: exit 0 17:51:39 INFO - Browser initialized. 17:51:39 INFO - Running cycle 1/1 for dromaeo_css test... 17:51:39 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpFw2tGA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:51:51 INFO - PROCESS | 1643 | RSS: Main: 167419904 17:51:51 INFO - PROCESS | 1643 | 17:54:55 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 17:54:57 INFO - PROCESS | 1643 | RSS: Main: 274309120 17:54:57 INFO - PROCESS | 1643 | 17:57:59 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 17:58:00 INFO - PROCESS | 1643 | RSS: Main: 304050176 17:58:00 INFO - PROCESS | 1643 | 18:01:02 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 18:01:03 INFO - PROCESS | 1643 | RSS: Main: 276033536 18:01:03 INFO - PROCESS | 1643 | 18:04:05 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 18:04:05 INFO - PROCESS | 1643 | RSS: Main: 292425728 18:04:05 INFO - PROCESS | 1643 | 18:07:09 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 18:07:09 INFO - PROCESS | 1643 | RSS: Main: 262189056 18:07:09 INFO - PROCESS | 1643 | 18:10:12 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 18:10:12 INFO - PROCESS | 1643 | RSS: Main: 363704320 18:10:12 INFO - PROCESS | 1643 | 18:10:12 INFO - PROCESS | 1643 | __start_tp_report 18:10:12 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 18:10:12 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 18:10:12 INFO - PROCESS | 1643 | |i|pagename|runs| 18:10:12 INFO - PROCESS | 1643 | |0;dojo.html;3016.698330166982;3519.859205631775;3545;3560.1989552350724;3582.1760994971173;4786.736729479877;5929.2292002039785;6001.069834175699;6006.669633170174;6022.247219097608;5922.555808314372;6017.398260173981;6036.4265394787535;6039.1243269725865;6050.969745151268;4417.889552761175;5319.468053194688;5339.679619222839;5371.221172929922;5474.534664553517;5309.123994540896;5318.149096144618;5351.678899266037;5448.509634132927;5450.073487507133;4311.956880431187;5314.335708036496;5361.544268737162;5401.945980540184;5420.349558053039;5402.783888644469;5437;5440.219047761807;5456.809011684572;5503.669779813224;5254.92117618236;5297.966896455193;5308.628396012281;5391.78432862685;5398.6220964532495;4874.5856602188505;5889.587728858982;5918.378570250148;5920.703964801743;5959.314678811948;6266.122742816009;6270.3416141305415;6309.3690630937;6310.958691815845;6312.053192021188;6206.162168107338;6388.488920886318;6392.264889537716;6396.3283855194995;6407.8398040048905;5968.31364393096;6062.454379105901;6066.059760737093;6084.330723620398;6160.414760597736;6476.935230647728;6518.674066296666;6524.706388212542;6527.8694426111215;6537.869242615121;6312.589681670676;6312.589681670768;6330.272018717907;6340;6343.524235682342;5294;6262.624242545462;6265.780697675559;6272.498200143978;6303.401176888188;6285.182926219562;6306.65313407767;6313.715882785285;6317.336679648571;6319.684015799192;6249.9062514062325;6286.05709143623;6297.653629050446;6315.273743519554;6331.2085989251345;5054.898902021939;5109.105906466353;5113.309703190096;5116.437191908887;5129.281900533928;4577.313402989578;4629.976850115795;4632.814687412466;4649.814007439732;4668.883277918079;6029.879402411927;6133.84665383369;6152.969235153795;6167.753289868355;6189.566730328834;6173.074038894202;6283.874322513616;6364.299927008025;6385.712642931079;6407.839804004937;6077.908831367533;6111.98679349419;6137.048757442603;6144.446999770043;6162.691865406712;5648.971755141198;5694.686792226385;5705.087186050212;5709.314882214161;5719.914201286984;6258.186435763321;6596.637184954681;6598.7030583623855;6619.602823830585;6634.834129146713;6155.292141403616;6235.844103897439;6265.310815810166;6307.30619631831;6406.487481001602;6572.474202063728;6583.407493325623;6590.9670451647435;6594.604323740591;6611.603303801788;6289.874202515833;6292;6325.304216536269;6342.714577843916;6345.93654063472;6077.939220607915;6213.254409470893;6230.190075290183;6281.12064311006;6372.235331760218;6326.145970293951;6340.809775706736;6346.587471814318;6357.554971151975;6359.745610175726;6170.7155498868815;6282.277538083179;6289.339619339903;6295.024271237966;6313.494920406265;6124.877502449837;6162.168107305636;6169.475594574332;6206.565540412128;6216.906746398718;6264.530160238091;6276.905846412216;6280.309165991646;6291.842703932438;6296.307406185408;6130.386961303834;6281.7173227203975;6299.275583307978;6303.936960630518;6308.968455157695 18:10:12 INFO - PROCESS | 1643 | |1;ext.html;489.3442786665867;531.1501597444089;533.463868811844;560.3723829311172;562.1595714406963;30338.848305758467;40769.980750481256;42099.99999999992;42125.78937105318;43961;42601.786991065004;43007;43043.92390190247;43060.78469607647;43186;8650.48097114172;9296.674616388427;9505.334626576143;9691.98234185411;9711.514424278794;9160.129787670161;9230.769230769218;9574.712758617217;9691;9697.75755606112;9633.807323853518;9670.419774813534;9687.41875487473;9688.370255933378;9725;9644.276679249084;9666.565004574812;9677.564509597085;9683;9683.806323873554;9564.665236716752;9646.614135434575;9660.75848103796;9667.564959576835;9694.03059694032;40690.79654601708;41122.38316425256;41173.794131029455;41192.1761564767;41237;3347.129746265988;3349.7487688423466;3355.0941245863723;3438.8796392126405;3817;30020.699793002226;30483.542746858813;31081;31450.21374465634;31637.20906977344;2836.4610723962383;3305.603327600679;3362.663733626642;3367.6463971282906;3377.290768938526;496989;500988;501124;501587;502715.4864225692;34464.310713786086;62446;62564.748705025646;62923.68538157371;63026.369736302964;35135.29729405398;36115.458268126;36180.81909590435;36181.91454256376;36218.27563448769;15132.470363537444;15281.694366112615;15293.464728734441;15303.770443443358;15305.540833775005;12855.292958887165;12962.935185324013;12983;13002;13015.958723302114;7957.3634109271115;8040.517568945882;8060.355171586259;8105.31104856082;8138.511689298661;3346.8995930122137;3369.0566641340465;3376.7636265461183;3377.3751855906735;3409.5908490980746;892.6117139044406;961.6297725375781;962.5860879821744;1021.0810270756378;1119.7067387167833;29732.10803675893;30004;30108.946186883353;30562.388752225277;30813.22966925845;891.8573028315568;1080;1089.493385575711;1120.6806060272784;1204.4941124727636;11896.76206475883;15563;15608.921955390377;15669.29488173035;15837.841621583637;663468;666622;668405;671372.643136791;671861;58133.70933145307;58504.41495585075;58726.11910821341;58786.82426351449;58824.41175588189;1258.025030601273;1298.2859427314938;1396.0716123777574;1400.824896887889;1432.842387337392;29569.112926612237;30716.692833072277;33596.83201583976;33695;33715;59886.50283742941;63905.04142437774;63995;64003.679981599795;64255.67872160609;606145;612230;614025;614646;658331;37940.86177414682;46761.53238467572;47103.05793884172;47517;47947.76026119847;50443;50566.24150637817;50677.98644027025;50801.74599126981;51249.487505124474;41259;41760.16479670451;42610.78694606507;42915.57084429241;43950.34074488821;41731.1653766929;41753;41915.1616967665;43118.35322470228;43554.78222608867;33854.322913542084;41114.588854111076;41988.37017444802;42037.36943945782;42185.789071054445;34020.48969265413;36552.63447365492;37114;37387.252254954205;37441.4383784238;22777.772222277566;26710.465790683687;27003.59494607543;27006.729932700422;27055.86472067627 18:10:12 INFO - PROCESS | 1643 | |2;jquery.html;341.24244177925;382.5352197080547;385.2699135138912;398.2135282816437;410.5976143379488;16713.832861671395;18940;20090.799092009074;20320.796792032073;20853.27013554526;19804.801951980477;19971.900140499278;20364;20536.281230156947;20627.38117856467;5768.336641286253;5857.297124345085;5905.557083218754;5935.49548288396;6060.060690592965;5776.942230577703;5950.672713000783;5963.8210853674245;5968.5523585731025;5974.551908606872;5771.989901767195;5820.417958204188;5890.410958904096;5905.881882362351;5916.88166236675;5855.209546711182;5891.587588868781;5936.821895343147;5943.9108413373615;5961.314448838374;4441.244988351988;5120.871978200575;5160.277561141444;5182.041322355339;5183.740812959375;25683.486330273478;25746.742532574808;25746.871265643553;25864.094756683615;26063.218103456926;2134.1996751218294;2243.1924507177405;2348.4481146930457;2405.1362579260167;3059.2198989257818;10320.38077715332;10796.622118225825;10825;10846.29499082557;13347.932165426742;1930.6814375628005;1943.1061711612674;1974.8815071095637;1975.2790231565375;2017.8284845788125;118801;121211;124147;124193.37903310516;126792.99999999908;11209.775804483865;11541.249818761753;11627.360495172677;11631.59289424866;11820.940895295469;14966.02720823143;15024.924875375553;15026.924865375822;15035.09789412617;15052.172130532927;8290.590599598083;8560.272376848037;8768.912310876936;8844.646214151362;8885;8690.739277821676;8692.130786921383;8760.956195218983;8911.55442227886;8963.372563920462;4530.320451932236;4602.493725690171;4632.351470794091;4634.328022436728;4777.665563410597;1907.7710674719121;1967.2426115945464;1972.6252012117652;1973.8716983396034;1975.3086419752972;721.8664547058811;723.3381455967731;730.3499885102264;757.9086115992952;883.5758835758871;19905.905175215503;20706.618738844925;21020.684689729667;21294.78705212959;21401;947.2611363136764;948.8956214816365;966.9419834809934;984.8522721591819;1001.1740314240781;10461.42462164573;11029;11068.612598559012;11091.72270693239;11130.888691113147;599411;608504;609182;610486;615138;118499;118644;118743.812561875;129818.35090824486;131463;930.5114814722325;1015.1016350529834;1060.575769692114;1061.6072053340313;1068.8770791359093;14834.925825370805;18220.45338639843;19123.76682059188;19512.121954512364;19634.153047808275;42960;46313;50473.73815654638;53208.73395632997;54924.45075549353;63284;74780.87828682465;75993;78134;84719.5764021176;5459.535939445032;7471.729805932896;8170.387220958333;8182.7545173644885;8364.665413383396;11281.887181128084;12919.677008074874;12944.935275323563;13351.265680387283;13361.331933403486;10961;11224.270422422516;11335.886641133813;11459.942700286445;11664.183507154417;10978.176636752116;10983.835242471529;11070.059044981266;11531.250468719507;11549.769004619693;11440;11461.828072578752;11657.76684466289;11808.350540720343;11896.167268291136;6762.222344430256;7727.6136193188995;8149.307308878811;8163.714270000759;8365.497525132749;8319.417640765088;10397.32417392867;11100.333979961228;11353.943230283796;11556.88443115558 18:10:12 INFO - PROCESS | 1643 | |3;mootools.html;1498.5054931872482;1536.208852440993;1593.5617705131087;1674.539501637049;1721.3630956546065;8120.106788253295;8508.91491085089;8524.786880327994;8548.316134709225;8562.828743425136;7457.328840404362;7753.961230193855;8103.554304513249;8271.296939760112;8293.087760346358;2367.9763202368013;2395.7484464131276;2397.7122745270503;2398.9520209595885;2399.5560821248123;2395.796357309631;2411.867347295898;2433.634954756783;2439.9390015249674;2440.707115146176;2371.051579368258;2374.4063984004;2401.5317013182434;2403.4472071423584;2405.0740464921046;2361.622140457527;2364.2552595932225;2382.940426489334;2384.1297926256966;2386.1409892438796;2376.66726658268;2382.463945612241;2398.8680622565753;2402.3994001499627;2402.6155815069505;8221.712240071629;8421.452605580678;8425.747227583182;8430.957845210796;8445.451045682012;5106.872328191787;5255.159174532095;5258.92111618326;5269;5271.815486457994;2861.756750676195;3404.927447853943;3537.964620353815;3575.6781889629797;3578.874739384109;1066.637343303273;1066.983995240072;1092.071739021833;1102.1072930925975;1102.922795404322;10785.62250321235;10792.946035269773;10857.239993200557;10862.891371086267;10879.83680244797;4266.104118135165;4412.448443944507;4509.233430316854;4510.323451482304;4518.096380723802;8617.052124266325;8631.007434145027;8647.610857511427;8657.653693852175;8675.73972780805;5129.153689641167;5130.640855140105;5133.640645154804;5140.640155189176;5140.974295128501;4369.60673539383;4532.456105267389;4699.295105734167;4799.448063472745;4830.372051633335;3665;3710.888673339804;3762.9435558466644;3795.468634391132;3799.0122568132483;989.8317286061387;1174.1370092981651;1174.9941250293693;1176.4411904345368;1183.7159081820473;781.0393216343929;863.3266052479077;910.1717437132178;931.0317270039219;943.4527973775193;5789.478946894799;5919.141724449931;5957.046872500379;5963.522918166623;6209.472194863397;946.7869729310987;959.2182371367453;962.4898803633945;971.7570607348163;1010.3079390617451;3700.9814950925074;3901.6293452122004;3940.6650434712797;3944.7041471889725;4028.4561584186345;9707.320487565943;10124.392536447689;10181.389116653025;10200;10200.591976320864;9557;9994.000599940093;10031.347962382422;10060.748481288027;10065.446400448045;6231.470325022333;7854.371650268079;7857.214278572212;7866.842663146705;7892.684292628345;4456.5766252205985;5611.971940140274;5707.8858422832145;5803.535717142534;5871.383504732113;8956.731298061068;9155.450672959378;9406.153446189875;9406.858897116686;9416.340856140005;7374.594397308199;9485.525723713648;9486.146296702407;9590.90409095928;9631.518424078908;5617.5505959522325;6478.319776423407;7143.964280178566;7168.24733403006;7301.488895777457;7942.166072562298;8012.679492820455;8024.2376974187355;8032.919670803451;8033.959830201045;7139.964300178466;7258.419326453976;7259.637018148966;7312.268773122858;7386.372158366599;6978.79063628092;7040.718371265092;7075.5047146699235;7157.785266442015;7182.676779545038;6716.462682985447;6726.831829204309;6788.117544719353;6791.694373753094;6808.62552559614;4767.189577771718;4785.234362501983;4799.352087468147;4817.590504807131;4838.806447742051;4759.286107083965;4802.135615589227;4908.361912951294;4924.064427758714;5020.698758074527 18:10:12 INFO - PROCESS | 1643 | |4;prototype.html;310.58691939720177;317.6489978573675;321.87446895710667;327.99344013119736;330.8858443836875;4399.6260317872975;4418.646508279338;4991.326170966919;5425.674459532426;5517.668939863601;3935.7048221383366;4108.863920099875;5071.137906555885;5239.449857764937;5383.81156659517;3819.2170605025904;4011.8997025074386;4125.628693417591;4135.627793498585;4166.7708276044805;3379.9493007604906;3556.608773034964;4127.814248358816;4139.710220284566;4154.8130334134885;3982.780947047911;4047.4738284023038;4098.139390727951;4107.712460127792;4120.443740095079;3579.7673151245085;4088.5298190708154;4110.916812390707;4111.835526578933;4114.724435425012;3004.4291584598855;3172.666869978642;3606.3688854450365;3610.2598967211657;3617.94573081404;5139.254808052849;5258.8709717718275;5274.3670759509105;5284.0977248191;5305.65513241638;4488.551144885485;4729.952700472985;4745.335653008581;4750.904981900378;4766.666333356667;5090.5237481130425;5175.223716442526;5656.886862262772;5693.146028095777;5696.316442026983;3337.747020761001;3599.4420864766003;3750.868719594801;3986.4618276532588;3999.320115580358;5741.445056949659;5874.765009399662;5879.235699359098;5896.852578685524;5984.521238300926;3359.0853213668465;4052.7163098582814;4055.614716601918;4057.5536690963972;4065.796710164539;3476.3568739783223;4096.692748043909;4146;4166.229247589205;4168.812403441852;4314.892127696833;4526.253168227271;4613.5847773700525;4787.893326936137;4799.28010798383;4697.718136911728;4806.927896081562;5492.725363731797;5663.745131469093;5678.716064196774;1158;1190.8627260965757;1221.908356873238;1318.7296604196117;1357.8933169466852;739.8002539314355;860.8407444622765;907.5689047702289;937.4656445825814;938.5265133739963;4743.857684269477;5047.697138171721;5083.72039537829;5095.235714642759;5110.897782044338;4523.796429160696;5228.843134705965;5464.808731694372;5514;5550.833474995757;4112.676337869154;4295.4201182839915;4917.360743103445;4961;4970.527799859007;2549.3754030262703;2775.834149657149;2868;2878.424315136981;2900.448914706199;5569.192467092249;5610.625396777734;5640.379558248589;5662.688552129673;5685.276144125604;5071.841090305914;5317.962997215506;5699.914501282484;6134.141220229171;6135.754569817157;4869.951300487091;5914.284857391308;6179.598326108879;6180.351063138306;6186.350433204539;5499.752511136929;5685.374608793112;5700.230468886647;5906.468417842415;5928.636413624977;4860.635452341018;4885.606053033916;5511.421300763523;5752.884942301047;5876.70904293597;5080.923786143285;5652.5020869470445;5706.914396283976;6155.753769849156;6199.535034872312;3387.322535492862;3801.6159105034185;3806.7144964128356;3999.3800960851113;4051.54144507971;5586.692731899784;5926.999275489114;5943.91084133747;5962.016267316018;5964.731587078505;5056.028149021958;5580.35379563038;5609.962157000968;5803.7388317524965;5816.883662326645;4890.584300334369;5650.830475085754;5702.600817942704;5725.599208055396;5736.225609542658;5246.895062098813;5635.577331700221;5635.971820141037;5641.661500309994;5654.886902262014;5238.2404551340605;5473.0695781718;5629.8592535186945;5750.856228594319;5773.797917072882;4830.8792280193275;5108.923366149436;5499.3675727291875;5598;5606.103023516218 18:10:12 INFO - PROCESS | 1643 | |5;yui.html;709.8722229998601;745.6979923131132;753.2317036622645;832.7252006837742;852.1733918099442;13974.161550306975;15716.685666286667;15885.444009459672;15901.045937243773;15906.284217210225;14076;14250.2162381069;14259.287035648202;14273.78589321161;14284.07153535022;697.0763738047108;719.1226703421817;883.4787475389519;887.6671248281895;909.6088681866795;907.0068275238604;912.1608120529129;915.7847905742145;919.2554031234688;919.9816003679922;950.8621249918758;951.1819834941945;952.3238500664537;952.8618350339196;956.2302346610975;936.7236665183788;937.1799675284126;943.0098396683524;943.5235206220849;945.924326053914;707.1902671441222;708.6350529477323;710.1159056974049;710.4245561095478;710.722818100941;14640;14664.70670586593;14697.485588004476;14816.555503334917;15423.228838558027;13768.65578360549;14498.130112193197;14644;14712.779308310384;14787.482438114614;11654.533818647244;11904.16670833042;12043.93978030113;12639.431225594779;12870.099093063489;3873.061846146158;3920.2943470175355;4018.3168861293652;4045.1707399982934;4091.652209562191;72230.63884680596;89904.99999999935;99156.50421747845;101138;102147;10609;10989.175811814146;11188.832167517494;11496.482658280398;11526.193166478266;22250.109995599996;22388.664170037464;22427.878606069957;22455.214067507557;22532;7832.412569057344;7963.800904977422;8110.716124935599;8234.629441675139;8370.372222083368;4147.52303485103;4170.291050521419;4190.329547272483;4356.259435895905;4417.337399390053;3470.4794280858073;3587.2287458196615;3597.640235976434;3602.7297952653657;3611.8555257789394;650.8568115014689;651.8761435327273;660.4980215036607;663.2405895249912;672.579637726421;540.5648452995298;627.419636835925;659.5383231737803;660.6399512265826;700.7722490190708;8503.957480212559;9278.814423711488;9280.443173409618;9435.782591091089;9768.27129991224;608.7321578505532;676.7529851604228;681.3288910423229;716.7670507085218;722.385971923871;4258.382534532476;4574.565416285448;4591.931121033187;4652.185867473247;4706.552877476634;61178;78659.8201026985;97653.51173244088;99444;102452.48773756083;84552;85561.14438855657;86520.56739716261;105698.47150764197;107549;58692.23923282223;77958.22041779623;83358;83451.16548834555;83594;9116.453012818987;9505.524723763645;9642.035796420301;9684.75788105303;9691.757706057122;43208.35187472127;44069.559304406546;49868.750656246484;53901;58342;60759;62656.37343626688;77372.2262777365;80127.59936200282;80487;12523.812142818048;12822.743545128858;12924.030697697899;12991;13159.276239806903;14261.215633140277;14516.854831451972;14518.564443066725;14912;15092.773608396103;13219.867801321863;13329.800052999019;13564.321783910962;13609.387577558835;13754.587362379145;13638.045336826326;13724.245166515937;13732.901367890745;13922;13995.580132596038;11118.944405277922;11723.769004254431;11788.410579470821;12938.482460701467;13578.524751633646;11208.607698730506;11259.718507037389;11632.287040321426;11776.587819426279;12047.457864395948;11485.885141148481;11530.94234528822;11562;11779.587714429954;11792.587259445878 18:10:12 INFO - PROCESS | 1643 | __end_tp_report 18:10:12 INFO - PROCESS | 1643 | __start_cc_report 18:10:12 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1242 18:10:12 INFO - PROCESS | 1643 | __end_cc_report 18:10:12 INFO - PROCESS | 1643 | __startTimestamp1485223812918__endTimestamp 18:10:12 INFO - PROCESS | 1643 | 18:10:12 INFO - PROCESS | 1643 | ------- Summary: start ------- 18:10:12 INFO - PROCESS | 1643 | Number of tests: 6 18:10:12 INFO - PROCESS | 1643 | 18:10:12 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5908.66 Median:6173.07 stddev:673.27 (10.9%) stddev-sans-first:635.96 18:10:12 INFO - PROCESS | 1643 | Values: 3016.7 3519.9 3545.0 3560.2 3582.2 4786.7 5929.2 6001.1 6006.7 6022.2 5922.6 6017.4 6036.4 6039.1 6051.0 4417.9 5319.5 5339.7 5371.2 5474.5 5309.1 5318.1 5351.7 5448.5 5450.1 4312.0 5314.3 5361.5 5401.9 5420.3 5402.8 5437.0 5440.2 5456.8 5503.7 5254.9 5298.0 5308.6 5391.8 5398.6 4874.6 5889.6 5918.4 5920.7 5959.3 6266.1 6270.3 6309.4 6311.0 6312.1 6206.2 6388.5 6392.3 6396.3 6407.8 5968.3 6062.5 6066.1 6084.3 6160.4 6476.9 6518.7 6524.7 6527.9 6537.9 6312.6 6312.6 6330.3 6340.0 6343.5 5294.0 6262.6 6265.8 6272.5 6303.4 6285.2 6306.7 6313.7 6317.3 6319.7 6249.9 6286.1 6297.7 6315.3 6331.2 5054.9 5109.1 5113.3 5116.4 5129.3 4577.3 4630.0 4632.8 4649.8 4668.9 6029.9 6133.8 6153.0 6167.8 6189.6 6173.1 6283.9 6364.3 6385.7 6407.8 6077.9 6112.0 6137.0 6144.4 6162.7 5649.0 5694.7 5705.1 5709.3 5719.9 6258.2 6596.6 6598.7 6619.6 6634.8 6155.3 6235.8 6265.3 6307.3 6406.5 6572.5 6583.4 6591.0 6594.6 6611.6 6289.9 6292.0 6325.3 6342.7 6345.9 6077.9 6213.3 6230.2 6281.1 6372.2 6326.1 6340.8 6346.6 6357.6 6359.7 6170.7 6282.3 6289.3 6295.0 6313.5 6124.9 6162.2 6169.5 6206.6 6216.9 6264.5 6276.9 6280.3 6291.8 6296.3 6130.4 6281.7 6299.3 6303.9 6309.0 18:10:12 INFO - PROCESS | 1643 | 18:10:12 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:72760.41 Median:42155.79 stddev:160842.54 (381.5%) stddev-sans-first:161202.21 18:10:12 INFO - PROCESS | 1643 | Values: 489.3 531.2 533.5 560.4 562.2 30338.8 40770.0 42100.0 42125.8 43961.0 42601.8 43007.0 43043.9 43060.8 43186.0 8650.5 9296.7 9505.3 9692.0 9711.5 9160.1 9230.8 9574.7 9691.0 9697.8 9633.8 9670.4 9687.4 9688.4 9725.0 9644.3 9666.6 9677.6 9683.0 9683.8 9564.7 9646.6 9660.8 9667.6 9694.0 40690.8 41122.4 41173.8 41192.2 41237.0 3347.1 3349.7 3355.1 3438.9 3817.0 30020.7 30483.5 31081.0 31450.2 31637.2 2836.5 3305.6 3362.7 3367.6 3377.3 496989.0 500988.0 501124.0 501587.0 502715.5 34464.3 62446.0 62564.7 62923.7 63026.4 35135.3 36115.5 36180.8 36181.9 36218.3 15132.5 15281.7 15293.5 15303.8 15305.5 12855.3 12962.9 12983.0 13002.0 13016.0 7957.4 8040.5 8060.4 8105.3 8138.5 3346.9 3369.1 3376.8 3377.4 3409.6 892.6 961.6 962.6 1021.1 1119.7 29732.1 30004.0 30108.9 30562.4 30813.2 891.9 1080.0 1089.5 1120.7 1204.5 11896.8 15563.0 15608.9 15669.3 15837.8 663468.0 666622.0 668405.0 671372.6 671861.0 58133.7 58504.4 58726.1 58786.8 58824.4 1258.0 1298.3 1396.1 1400.8 1432.8 29569.1 30716.7 33596.8 33695.0 33715.0 59886.5 63905.0 63995.0 64003.7 64255.7 606145.0 612230.0 614025.0 614646.0 658331.0 37940.9 46761.5 47103.1 47517.0 47947.8 50443.0 50566.2 50678.0 50801.7 51249.5 41259.0 41760.2 42610.8 42915.6 43950.3 41731.2 41753.0 41915.2 43118.4 43554.8 33854.3 41114.6 41988.4 42037.4 42185.8 34020.5 36552.6 37114.0 37387.3 37441.4 22777.8 26710.5 27003.6 27006.7 27055.9 18:10:12 INFO - PROCESS | 1643 | 18:10:12 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:35179.60 Median:2295.82 stddev:101441.71 (4418.5%) stddev-sans-first:101692.55 18:10:12 INFO - PROCESS | 1643 | Values: 341.2 382.5 385.3 398.2 410.6 16713.8 18940.0 20090.8 20320.8 20853.3 19804.8 19971.9 20364.0 20536.3 20627.4 5768.3 5857.3 5905.6 5935.5 6060.1 5776.9 5950.7 5963.8 5968.6 5974.6 5772.0 5820.4 5890.4 5905.9 5916.9 5855.2 5891.6 5936.8 5943.9 5961.3 4441.2 5120.9 5160.3 5182.0 5183.7 25683.5 25746.7 25746.9 25864.1 26063.2 2134.2 2243.2 2348.4 2405.1 3059.2 10320.4 10796.6 10825.0 10846.3 13347.9 1930.7 1943.1 1974.9 1975.3 2017.8 118801.0 121211.0 124147.0 124193.4 126793.0 11209.8 11541.2 11627.4 11631.6 11820.9 14966.0 15024.9 15026.9 15035.1 15052.2 8290.6 8560.3 8768.9 8844.6 8885.0 8690.7 8692.1 8761.0 8911.6 8963.4 4530.3 4602.5 4632.4 4634.3 4777.7 1907.8 1967.2 1972.6 1973.9 1975.3 721.9 723.3 730.3 757.9 883.6 19905.9 20706.6 21020.7 21294.8 21401.0 947.3 948.9 966.9 984.9 1001.2 10461.4 11029.0 11068.6 11091.7 11130.9 599411.0 608504.0 609182.0 610486.0 615138.0 118499.0 118644.0 118743.8 129818.4 131463.0 930.5 1015.1 1060.6 1061.6 1068.9 14834.9 18220.5 19123.8 19512.1 19634.2 42960.0 46313.0 50473.7 53208.7 54924.5 63284.0 74780.9 75993.0 78134.0 84719.6 5459.5 7471.7 8170.4 8182.8 8364.7 11281.9 12919.7 12944.9 13351.3 13361.3 10961.0 11224.3 11335.9 11459.9 11664.2 10978.2 10983.8 11070.1 11531.3 11549.8 11440.0 11461.8 11657.8 11808.4 11896.2 6762.2 7727.6 8149.3 8163.7 8365.5 8319.4 10397.3 11100.3 11353.9 11556.9 18:10:12 INFO - PROCESS | 1643 | 18:10:12 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5428.50 Median:5132.14 stddev:2932.27 (57.1%) stddev-sans-first:2925.62 18:10:12 INFO - PROCESS | 1643 | Values: 1498.5 1536.2 1593.6 1674.5 1721.4 8120.1 8508.9 8524.8 8548.3 8562.8 7457.3 7754.0 8103.6 8271.3 8293.1 2368.0 2395.7 2397.7 2399.0 2399.6 2395.8 2411.9 2433.6 2439.9 2440.7 2371.1 2374.4 2401.5 2403.4 2405.1 2361.6 2364.3 2382.9 2384.1 2386.1 2376.7 2382.5 2398.9 2402.4 2402.6 8221.7 8421.5 8425.7 8431.0 8445.5 5106.9 5255.2 5258.9 5269.0 5271.8 2861.8 3404.9 3538.0 3575.7 3578.9 1066.6 1067.0 1092.1 1102.1 1102.9 10785.6 10792.9 10857.2 10862.9 10879.8 4266.1 4412.4 4509.2 4510.3 4518.1 8617.1 8631.0 8647.6 8657.7 8675.7 5129.2 5130.6 5133.6 5140.6 5141.0 4369.6 4532.5 4699.3 4799.4 4830.4 3665.0 3710.9 3762.9 3795.5 3799.0 989.8 1174.1 1175.0 1176.4 1183.7 781.0 863.3 910.2 931.0 943.5 5789.5 5919.1 5957.0 5963.5 6209.5 946.8 959.2 962.5 971.8 1010.3 3701.0 3901.6 3940.7 3944.7 4028.5 9707.3 10124.4 10181.4 10200.0 10200.6 9557.0 9994.0 10031.3 10060.7 10065.4 6231.5 7854.4 7857.2 7866.8 7892.7 4456.6 5612.0 5707.9 5803.5 5871.4 8956.7 9155.5 9406.2 9406.9 9416.3 7374.6 9485.5 9486.1 9590.9 9631.5 5617.6 6478.3 7144.0 7168.2 7301.5 7942.2 8012.7 8024.2 8032.9 8034.0 7140.0 7258.4 7259.6 7312.3 7386.4 6978.8 7040.7 7075.5 7157.8 7182.7 6716.5 6726.8 6788.1 6791.7 6808.6 4767.2 4785.2 4799.4 4817.6 4838.8 4759.3 4802.1 4908.4 4924.1 5020.7 18:10:12 INFO - PROCESS | 1643 | 18:10:12 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4539.11 Median:5063.58 stddev:1413.01 (27.9%) stddev-sans-first:1380.87 18:10:12 INFO - PROCESS | 1643 | Values: 310.6 317.6 321.9 328.0 330.9 4399.6 4418.6 4991.3 5425.7 5517.7 3935.7 4108.9 5071.1 5239.4 5383.8 3819.2 4011.9 4125.6 4135.6 4166.8 3379.9 3556.6 4127.8 4139.7 4154.8 3982.8 4047.5 4098.1 4107.7 4120.4 3579.8 4088.5 4110.9 4111.8 4114.7 3004.4 3172.7 3606.4 3610.3 3617.9 5139.3 5258.9 5274.4 5284.1 5305.7 4488.6 4730.0 4745.3 4750.9 4766.7 5090.5 5175.2 5656.9 5693.1 5696.3 3337.7 3599.4 3750.9 3986.5 3999.3 5741.4 5874.8 5879.2 5896.9 5984.5 3359.1 4052.7 4055.6 4057.6 4065.8 3476.4 4096.7 4146.0 4166.2 4168.8 4314.9 4526.3 4613.6 4787.9 4799.3 4697.7 4806.9 5492.7 5663.7 5678.7 1158.0 1190.9 1221.9 1318.7 1357.9 739.8 860.8 907.6 937.5 938.5 4743.9 5047.7 5083.7 5095.2 5110.9 4523.8 5228.8 5464.8 5514.0 5550.8 4112.7 4295.4 4917.4 4961.0 4970.5 2549.4 2775.8 2868.0 2878.4 2900.4 5569.2 5610.6 5640.4 5662.7 5685.3 5071.8 5318.0 5699.9 6134.1 6135.8 4870.0 5914.3 6179.6 6180.4 6186.4 5499.8 5685.4 5700.2 5906.5 5928.6 4860.6 4885.6 5511.4 5752.9 5876.7 5080.9 5652.5 5706.9 6155.8 6199.5 3387.3 3801.6 3806.7 3999.4 4051.5 5586.7 5927.0 5943.9 5962.0 5964.7 5056.0 5580.4 5610.0 5803.7 5816.9 4890.6 5650.8 5702.6 5725.6 5736.2 5246.9 5635.6 5636.0 5641.7 5654.9 5238.2 5473.1 5629.9 5750.9 5773.8 4830.9 5108.9 5499.4 5598.0 5606.1 18:10:12 INFO - PROCESS | 1643 | 18:10:12 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:19994.80 Median:24212.91 stddev:28126.22 (116.2%) stddev-sans-first:28167.85 18:10:12 INFO - PROCESS | 1643 | Values: 709.9 745.7 753.2 832.7 852.2 13974.2 15716.7 15885.4 15901.0 15906.3 14076.0 14250.2 14259.3 14273.8 14284.1 697.1 719.1 883.5 887.7 909.6 907.0 912.2 915.8 919.3 920.0 950.9 951.2 952.3 952.9 956.2 936.7 937.2 943.0 943.5 945.9 707.2 708.6 710.1 710.4 710.7 14640.0 14664.7 14697.5 14816.6 15423.2 13768.7 14498.1 14644.0 14712.8 14787.5 11654.5 11904.2 12043.9 12639.4 12870.1 3873.1 3920.3 4018.3 4045.2 4091.7 72230.6 89905.0 99156.5 101138.0 102147.0 10609.0 10989.2 11188.8 11496.5 11526.2 22250.1 22388.7 22427.9 22455.2 22532.0 7832.4 7963.8 8110.7 8234.6 8370.4 4147.5 4170.3 4190.3 4356.3 4417.3 3470.5 3587.2 3597.6 3602.7 3611.9 650.9 651.9 660.5 663.2 672.6 540.6 627.4 659.5 660.6 700.8 8504.0 9278.8 9280.4 9435.8 9768.3 608.7 676.8 681.3 716.8 722.4 4258.4 4574.6 4591.9 4652.2 4706.6 61178.0 78659.8 97653.5 99444.0 102452.5 84552.0 85561.1 86520.6 105698.5 107549.0 58692.2 77958.2 83358.0 83451.2 83594.0 9116.5 9505.5 9642.0 9684.8 9691.8 43208.4 44069.6 49868.8 53901.0 58342.0 60759.0 62656.4 77372.2 80127.6 80487.0 12523.8 12822.7 12924.0 12991.0 13159.3 14261.2 14516.9 14518.6 14912.0 15092.8 13219.9 13329.8 13564.3 13609.4 13754.6 13638.0 13724.2 13732.9 13922.0 13995.6 11118.9 11723.8 11788.4 12938.5 13578.5 11208.6 11259.7 11632.3 11776.6 12047.5 11485.9 11530.9 11562.0 11779.6 11792.6 18:10:12 INFO - PROCESS | 1643 | -------- Summary: end -------- 18:10:12 INFO - PROCESS | 1643 | 18:10:13 INFO - TEST-INFO | 1643: exit 0 18:10:13 INFO - TEST-OK | dromaeo_css | took 1117509ms 18:10:13 INFO - TEST-START | kraken 18:10:13 INFO - operating with platform_type : mac_ 18:10:13 INFO - Initialising browser for kraken test... 18:10:13 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmp_oSplI/profile http://localhost:49241/getInfo.html) 18:10:16 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 18:10:16 INFO - PROCESS | 1649 | colorDepth:24 18:10:16 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 18:10:16 INFO - PROCESS | 1649 | __metrics 18:10:16 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:10:16 INFO - PROCESS | 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:10:16 INFO - TEST-INFO | 1649: exit 0 18:10:16 INFO - Browser initialized. 18:10:16 INFO - Running cycle 1/1 for kraken test... 18:10:16 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmp_oSplI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:10:29 INFO - PROCESS | 1651 | RSS: Main: 171712512 18:10:29 INFO - PROCESS | 1651 | 18:10:31 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 18:10:32 INFO - PROCESS | 1651 | RSS: Main: 221507584 18:10:32 INFO - PROCESS | 1651 | 18:10:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 18:10:35 INFO - PROCESS | 1651 | RSS: Main: 233357312 18:10:35 INFO - PROCESS | 1651 | 18:10:38 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 18:10:39 INFO - PROCESS | 1651 | RSS: Main: 330801152 18:10:39 INFO - PROCESS | 1651 | 18:10:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 18:10:42 INFO - PROCESS | 1651 | RSS: Main: 233500672 18:10:42 INFO - PROCESS | 1651 | 18:10:44 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:10:44 INFO - PROCESS | 1651 | RSS: Main: 234733568 18:10:44 INFO - PROCESS | 1651 | 18:10:47 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 18:10:48 INFO - PROCESS | 1651 | RSS: Main: 274399232 18:10:48 INFO - PROCESS | 1651 | 18:10:51 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 18:10:51 INFO - PROCESS | 1651 | RSS: Main: 275984384 18:10:51 INFO - PROCESS | 1651 | 18:10:54 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 18:10:54 INFO - PROCESS | 1651 | RSS: Main: 272187392 18:10:54 INFO - PROCESS | 1651 | 18:10:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:10:57 INFO - PROCESS | 1651 | RSS: Main: 248274944 18:10:57 INFO - PROCESS | 1651 | 18:10:59 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:10:59 INFO - PROCESS | 1651 | RSS: Main: 250683392 18:10:59 INFO - PROCESS | 1651 | 18:11:01 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:11:02 INFO - PROCESS | 1651 | RSS: Main: 252678144 18:11:02 INFO - PROCESS | 1651 | 18:11:05 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:11:05 INFO - PROCESS | 1651 | RSS: Main: 272334848 18:11:05 INFO - PROCESS | 1651 | 18:11:08 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:11:09 INFO - PROCESS | 1651 | RSS: Main: 266764288 18:11:09 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 18:11:11 INFO - PROCESS | 1651 | RSS: Main: 311025664 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | __start_tp_report 18:11:11 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 18:11:11 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 18:11:11 INFO - PROCESS | 1651 | |i|pagename|runs| 18:11:11 INFO - PROCESS | 1651 | |0;ai-astar;117;114;113;114;115;112;113;114;113;112 18:11:11 INFO - PROCESS | 1651 | |1;audio-beat-detection;143;111;112;136;108;108;106;111;137;107 18:11:11 INFO - PROCESS | 1651 | |2;audio-dft;191;188;255;184;183;182;180;183;181;183 18:11:11 INFO - PROCESS | 1651 | |3;audio-fft;80;58;57;89;60;58;57;58;81;66 18:11:11 INFO - PROCESS | 1651 | |4;audio-oscillator;85;69;91;102;100;103;97;67;69;91 18:11:11 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;87;84;87;84;92;82;88;84;79;130 18:11:11 INFO - PROCESS | 1651 | |6;imaging-darkroom;95;96;96;96;95;95;96;96;96;95 18:11:11 INFO - PROCESS | 1651 | |7;imaging-desaturate;84;84;78;80;83;81;84;86;83;80 18:11:11 INFO - PROCESS | 1651 | |8;json-parse-financial;54;55;55;51;54;58;57;56;55;55 18:11:11 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;64;73;63;80;108;57;71;92;103;100 18:11:11 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;84;83;82;82;82;80;81;82;83;80 18:11:11 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;138;136;134;136;140;140;139;134;176;133 18:11:11 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;160;159;208;229;161;159;161;160;160;161 18:11:11 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;65;65;68;65;65;66;64;65;64;65 18:11:11 INFO - PROCESS | 1651 | __end_tp_report 18:11:11 INFO - PROCESS | 1651 | __start_cc_report 18:11:11 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1855 18:11:11 INFO - PROCESS | 1651 | __end_cc_report 18:11:11 INFO - PROCESS | 1651 | __startTimestamp1485223871314__endTimestamp 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | ------- Summary: start ------- 18:11:11 INFO - PROCESS | 1651 | Number of tests: 14 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.49 (1.3%) stddev-sans-first:1.00 18:11:11 INFO - PROCESS | 1651 | Values: 117.0 114.0 113.0 114.0 115.0 112.0 113.0 114.0 113.0 112.0 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:117.90 Median:111.50 stddev:14.56 (13.1%) stddev-sans-first:12.29 18:11:11 INFO - PROCESS | 1651 | Values: 143.0 111.0 112.0 136.0 108.0 108.0 106.0 111.0 137.0 107.0 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:191.00 Median:183.50 stddev:22.73 (12.4%) stddev-sans-first:24.10 18:11:11 INFO - PROCESS | 1651 | Values: 191.0 188.0 255.0 184.0 183.0 182.0 180.0 183.0 181.0 183.0 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:66.40 Median:63.00 stddev:12.19 (19.4%) stddev-sans-first:11.90 18:11:11 INFO - PROCESS | 1651 | Values: 80.0 58.0 57.0 89.0 60.0 58.0 57.0 58.0 81.0 66.0 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:77.00 stddev:14.27 (18.5%) stddev-sans-first:15.11 18:11:11 INFO - PROCESS | 1651 | Values: 85.0 69.0 91.0 102.0 100.0 103.0 97.0 67.0 69.0 91.0 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:89.70 Median:85.50 stddev:14.60 (17.1%) stddev-sans-first:15.45 18:11:11 INFO - PROCESS | 1651 | Values: 87.0 84.0 87.0 84.0 92.0 82.0 88.0 84.0 79.0 130.0 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 18:11:11 INFO - PROCESS | 1651 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:82.30 Median:83.50 stddev:2.45 (2.9%) stddev-sans-first:2.52 18:11:11 INFO - PROCESS | 1651 | Values: 84.0 84.0 78.0 80.0 83.0 81.0 84.0 86.0 83.0 80.0 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.89 (3.4%) stddev-sans-first:1.96 18:11:11 INFO - PROCESS | 1651 | Values: 54.0 55.0 55.0 51.0 54.0 58.0 57.0 56.0 55.0 55.0 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:81.10 Median:67.50 stddev:18.41 (27.3%) stddev-sans-first:18.45 18:11:11 INFO - PROCESS | 1651 | Values: 64.0 73.0 63.0 80.0 108.0 57.0 71.0 92.0 103.0 100.0 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:1.29 (1.6%) stddev-sans-first:1.12 18:11:11 INFO - PROCESS | 1651 | Values: 84.0 83.0 82.0 82.0 82.0 80.0 81.0 82.0 83.0 80.0 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:138.50 stddev:12.69 (9.2%) stddev-sans-first:13.43 18:11:11 INFO - PROCESS | 1651 | Values: 138.0 136.0 134.0 136.0 140.0 140.0 139.0 134.0 176.0 133.0 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:161.00 stddev:25.12 (15.6%) stddev-sans-first:26.27 18:11:11 INFO - PROCESS | 1651 | Values: 160.0 159.0 208.0 229.0 161.0 159.0 161.0 160.0 160.0 161.0 18:11:11 INFO - PROCESS | 1651 | 18:11:11 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 18:11:11 INFO - PROCESS | 1651 | Values: 65.0 65.0 68.0 65.0 65.0 66.0 64.0 65.0 64.0 65.0 18:11:11 INFO - PROCESS | 1651 | -------- Summary: end -------- 18:11:11 INFO - PROCESS | 1651 | 18:11:12 INFO - TEST-INFO | 1651: exit 0 18:11:12 INFO - TEST-OK | kraken | took 58789ms 18:11:12 INFO - SUITE-END | took 1176s 18:11:12 INFO - Completed test suite (00:19:36) 18:11:12 INFO - javascript benchmark 18:11:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3016.698330166982, 3519.859205631775, 3545.0, 3560.1989552350724, 3582.1760994971173, 4786.736729479877, 5929.2292002039785, 6001.069834175699, 6006.669633170174, 6022.247219097608, 5922.555808314372, 6017.398260173981, 6036.4265394787535, 6039.1243269725865, 6050.969745151268, 4417.889552761175, 5319.468053194688, 5339.679619222839, 5371.221172929922, 5474.534664553517, 5309.123994540896, 5318.149096144618, 5351.678899266037, 5448.509634132927, 5450.073487507133, 4311.956880431187, 5314.335708036496, 5361.544268737162, 5401.945980540184, 5420.349558053039, 5402.783888644469, 5437.0, 5440.219047761807, 5456.809011684572, 5503.669779813224, 5254.92117618236, 5297.966896455193, 5308.628396012281, 5391.78432862685, 5398.6220964532495, 4874.5856602188505, 5889.587728858982, 5918.378570250148, 5920.703964801743, 5959.314678811948, 6266.122742816009, 6270.3416141305415, 6309.3690630937, 6310.958691815845, 6312.053192021188, 6206.162168107338, 6388.488920886318, 6392.264889537716, 6396.3283855194995, 6407.8398040048905, 5968.31364393096, 6062.454379105901, 6066.059760737093, 6084.330723620398, 6160.414760597736, 6476.935230647728, 6518.674066296666, 6524.706388212542, 6527.8694426111215, 6537.869242615121, 6312.589681670676, 6312.589681670768, 6330.272018717907, 6340.0, 6343.524235682342, 5294.0, 6262.624242545462, 6265.780697675559, 6272.498200143978, 6303.401176888188, 6285.182926219562, 6306.65313407767, 6313.715882785285, 6317.336679648571, 6319.684015799192, 6249.9062514062325, 6286.05709143623, 6297.653629050446, 6315.273743519554, 6331.2085989251345, 5054.898902021939, 5109.105906466353, 5113.309703190096, 5116.437191908887, 5129.281900533928, 4577.313402989578, 4629.976850115795, 4632.814687412466, 4649.814007439732, 4668.883277918079, 6029.879402411927, 6133.84665383369, 6152.969235153795, 6167.753289868355, 6189.566730328834, 6173.074038894202, 6283.874322513616, 6364.299927008025, 6385.712642931079, 6407.839804004937, 6077.908831367533, 6111.98679349419, 6137.048757442603, 6144.446999770043, 6162.691865406712, 5648.971755141198, 5694.686792226385, 5705.087186050212, 5709.314882214161, 5719.914201286984, 6258.186435763321, 6596.637184954681, 6598.7030583623855, 6619.602823830585, 6634.834129146713, 6155.292141403616, 6235.844103897439, 6265.310815810166, 6307.30619631831, 6406.487481001602, 6572.474202063728, 6583.407493325623, 6590.9670451647435, 6594.604323740591, 6611.603303801788, 6289.874202515833, 6292.0, 6325.304216536269, 6342.714577843916, 6345.93654063472, 6077.939220607915, 6213.254409470893, 6230.190075290183, 6281.12064311006, 6372.235331760218, 6326.145970293951, 6340.809775706736, 6346.587471814318, 6357.554971151975, 6359.745610175726, 6170.7155498868815, 6282.277538083179, 6289.339619339903, 6295.024271237966, 6313.494920406265, 6124.877502449837, 6162.168107305636, 6169.475594574332, 6206.565540412128, 6216.906746398718, 6264.530160238091, 6276.905846412216, 6280.309165991646, 6291.842703932438, 6296.307406185408, 6130.386961303834, 6281.7173227203975, 6299.275583307978, 6303.936960630518, 6308.968455157695], "value": 5866.105309549596, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.3442786665867, 531.1501597444089, 533.463868811844, 560.3723829311172, 562.1595714406963, 30338.848305758467, 40769.980750481256, 42099.99999999992, 42125.78937105318, 43961.0, 42601.786991065004, 43007.0, 43043.92390190247, 43060.78469607647, 43186.0, 8650.48097114172, 9296.674616388427, 9505.334626576143, 9691.98234185411, 9711.514424278794, 9160.129787670161, 9230.769230769218, 9574.712758617217, 9691.0, 9697.75755606112, 9633.807323853518, 9670.419774813534, 9687.41875487473, 9688.370255933378, 9725.0, 9644.276679249084, 9666.565004574812, 9677.564509597085, 9683.0, 9683.806323873554, 9564.665236716752, 9646.614135434575, 9660.75848103796, 9667.564959576835, 9694.03059694032, 40690.79654601708, 41122.38316425256, 41173.794131029455, 41192.1761564767, 41237.0, 3347.129746265988, 3349.7487688423466, 3355.0941245863723, 3438.8796392126405, 3817.0, 30020.699793002226, 30483.542746858813, 31081.0, 31450.21374465634, 31637.20906977344, 2836.4610723962383, 3305.603327600679, 3362.663733626642, 3367.6463971282906, 3377.290768938526, 496989.0, 500988.0, 501124.0, 501587.0, 502715.4864225692, 34464.310713786086, 62446.0, 62564.748705025646, 62923.68538157371, 63026.369736302964, 35135.29729405398, 36115.458268126, 36180.81909590435, 36181.91454256376, 36218.27563448769, 15132.470363537444, 15281.694366112615, 15293.464728734441, 15303.770443443358, 15305.540833775005, 12855.292958887165, 12962.935185324013, 12983.0, 13002.0, 13015.958723302114, 7957.3634109271115, 8040.517568945882, 8060.355171586259, 8105.31104856082, 8138.511689298661, 3346.8995930122137, 3369.0566641340465, 3376.7636265461183, 3377.3751855906735, 3409.5908490980746, 892.6117139044406, 961.6297725375781, 962.5860879821744, 1021.0810270756378, 1119.7067387167833, 29732.10803675893, 30004.0, 30108.946186883353, 30562.388752225277, 30813.22966925845, 891.8573028315568, 1080.0, 1089.493385575711, 1120.6806060272784, 1204.4941124727636, 11896.76206475883, 15563.0, 15608.921955390377, 15669.29488173035, 15837.841621583637, 663468.0, 666622.0, 668405.0, 671372.643136791, 671861.0, 58133.70933145307, 58504.41495585075, 58726.11910821341, 58786.82426351449, 58824.41175588189, 1258.025030601273, 1298.2859427314938, 1396.0716123777574, 1400.824896887889, 1432.842387337392, 29569.112926612237, 30716.692833072277, 33596.83201583976, 33695.0, 33715.0, 59886.50283742941, 63905.04142437774, 63995.0, 64003.679981599795, 64255.67872160609, 606145.0, 612230.0, 614025.0, 614646.0, 658331.0, 37940.86177414682, 46761.53238467572, 47103.05793884172, 47517.0, 47947.76026119847, 50443.0, 50566.24150637817, 50677.98644027025, 50801.74599126981, 51249.487505124474, 41259.0, 41760.16479670451, 42610.78694606507, 42915.57084429241, 43950.34074488821, 41731.1653766929, 41753.0, 41915.1616967665, 43118.35322470228, 43554.78222608867, 33854.322913542084, 41114.588854111076, 41988.37017444802, 42037.36943945782, 42185.789071054445, 34020.48969265413, 36552.63447365492, 37114.0, 37387.252254954205, 37441.4383784238, 22777.772222277566, 26710.465790683687, 27003.59494607543, 27006.729932700422, 27055.86472067627], "value": 19548.992929579876, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.24244177925, 382.5352197080547, 385.2699135138912, 398.2135282816437, 410.5976143379488, 16713.832861671395, 18940.0, 20090.799092009074, 20320.796792032073, 20853.27013554526, 19804.801951980477, 19971.900140499278, 20364.0, 20536.281230156947, 20627.38117856467, 5768.336641286253, 5857.297124345085, 5905.557083218754, 5935.49548288396, 6060.060690592965, 5776.942230577703, 5950.672713000783, 5963.8210853674245, 5968.5523585731025, 5974.551908606872, 5771.989901767195, 5820.417958204188, 5890.410958904096, 5905.881882362351, 5916.88166236675, 5855.209546711182, 5891.587588868781, 5936.821895343147, 5943.9108413373615, 5961.314448838374, 4441.244988351988, 5120.871978200575, 5160.277561141444, 5182.041322355339, 5183.740812959375, 25683.486330273478, 25746.742532574808, 25746.871265643553, 25864.094756683615, 26063.218103456926, 2134.1996751218294, 2243.1924507177405, 2348.4481146930457, 2405.1362579260167, 3059.2198989257818, 10320.38077715332, 10796.622118225825, 10825.0, 10846.29499082557, 13347.932165426742, 1930.6814375628005, 1943.1061711612674, 1974.8815071095637, 1975.2790231565375, 2017.8284845788125, 118801.0, 121211.0, 124147.0, 124193.37903310516, 126792.99999999908, 11209.775804483865, 11541.249818761753, 11627.360495172677, 11631.59289424866, 11820.940895295469, 14966.02720823143, 15024.924875375553, 15026.924865375822, 15035.09789412617, 15052.172130532927, 8290.590599598083, 8560.272376848037, 8768.912310876936, 8844.646214151362, 8885.0, 8690.739277821676, 8692.130786921383, 8760.956195218983, 8911.55442227886, 8963.372563920462, 4530.320451932236, 4602.493725690171, 4632.351470794091, 4634.328022436728, 4777.665563410597, 1907.7710674719121, 1967.2426115945464, 1972.6252012117652, 1973.8716983396034, 1975.3086419752972, 721.8664547058811, 723.3381455967731, 730.3499885102264, 757.9086115992952, 883.5758835758871, 19905.905175215503, 20706.618738844925, 21020.684689729667, 21294.78705212959, 21401.0, 947.2611363136764, 948.8956214816365, 966.9419834809934, 984.8522721591819, 1001.1740314240781, 10461.42462164573, 11029.0, 11068.612598559012, 11091.72270693239, 11130.888691113147, 599411.0, 608504.0, 609182.0, 610486.0, 615138.0, 118499.0, 118644.0, 118743.812561875, 129818.35090824486, 131463.0, 930.5114814722325, 1015.1016350529834, 1060.575769692114, 1061.6072053340313, 1068.8770791359093, 14834.925825370805, 18220.45338639843, 19123.76682059188, 19512.121954512364, 19634.153047808275, 42960.0, 46313.0, 50473.73815654638, 53208.73395632997, 54924.45075549353, 63284.0, 74780.87828682465, 75993.0, 78134.0, 84719.5764021176, 5459.535939445032, 7471.729805932896, 8170.387220958333, 8182.7545173644885, 8364.665413383396, 11281.887181128084, 12919.677008074874, 12944.935275323563, 13351.265680387283, 13361.331933403486, 10961.0, 11224.270422422516, 11335.886641133813, 11459.942700286445, 11664.183507154417, 10978.176636752116, 10983.835242471529, 11070.059044981266, 11531.250468719507, 11549.769004619693, 11440.0, 11461.828072578752, 11657.76684466289, 11808.350540720343, 11896.167268291136, 6762.222344430256, 7727.6136193188995, 8149.307308878811, 8163.714270000759, 8365.497525132749, 8319.417640765088, 10397.32417392867, 11100.333979961228, 11353.943230283796, 11556.88443115558], "value": 9562.438447762337, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.5054931872482, 1536.208852440993, 1593.5617705131087, 1674.539501637049, 1721.3630956546065, 8120.106788253295, 8508.91491085089, 8524.786880327994, 8548.316134709225, 8562.828743425136, 7457.328840404362, 7753.961230193855, 8103.554304513249, 8271.296939760112, 8293.087760346358, 2367.9763202368013, 2395.7484464131276, 2397.7122745270503, 2398.9520209595885, 2399.5560821248123, 2395.796357309631, 2411.867347295898, 2433.634954756783, 2439.9390015249674, 2440.707115146176, 2371.051579368258, 2374.4063984004, 2401.5317013182434, 2403.4472071423584, 2405.0740464921046, 2361.622140457527, 2364.2552595932225, 2382.940426489334, 2384.1297926256966, 2386.1409892438796, 2376.66726658268, 2382.463945612241, 2398.8680622565753, 2402.3994001499627, 2402.6155815069505, 8221.712240071629, 8421.452605580678, 8425.747227583182, 8430.957845210796, 8445.451045682012, 5106.872328191787, 5255.159174532095, 5258.92111618326, 5269.0, 5271.815486457994, 2861.756750676195, 3404.927447853943, 3537.964620353815, 3575.6781889629797, 3578.874739384109, 1066.637343303273, 1066.983995240072, 1092.071739021833, 1102.1072930925975, 1102.922795404322, 10785.62250321235, 10792.946035269773, 10857.239993200557, 10862.891371086267, 10879.83680244797, 4266.104118135165, 4412.448443944507, 4509.233430316854, 4510.323451482304, 4518.096380723802, 8617.052124266325, 8631.007434145027, 8647.610857511427, 8657.653693852175, 8675.73972780805, 5129.153689641167, 5130.640855140105, 5133.640645154804, 5140.640155189176, 5140.974295128501, 4369.60673539383, 4532.456105267389, 4699.295105734167, 4799.448063472745, 4830.372051633335, 3665.0, 3710.888673339804, 3762.9435558466644, 3795.468634391132, 3799.0122568132483, 989.8317286061387, 1174.1370092981651, 1174.9941250293693, 1176.4411904345368, 1183.7159081820473, 781.0393216343929, 863.3266052479077, 910.1717437132178, 931.0317270039219, 943.4527973775193, 5789.478946894799, 5919.141724449931, 5957.046872500379, 5963.522918166623, 6209.472194863397, 946.7869729310987, 959.2182371367453, 962.4898803633945, 971.7570607348163, 1010.3079390617451, 3700.9814950925074, 3901.6293452122004, 3940.6650434712797, 3944.7041471889725, 4028.4561584186345, 9707.320487565943, 10124.392536447689, 10181.389116653025, 10200.0, 10200.591976320864, 9557.0, 9994.000599940093, 10031.347962382422, 10060.748481288027, 10065.446400448045, 6231.470325022333, 7854.371650268079, 7857.214278572212, 7866.842663146705, 7892.684292628345, 4456.5766252205985, 5611.971940140274, 5707.8858422832145, 5803.535717142534, 5871.383504732113, 8956.731298061068, 9155.450672959378, 9406.153446189875, 9406.858897116686, 9416.340856140005, 7374.594397308199, 9485.525723713648, 9486.146296702407, 9590.90409095928, 9631.518424078908, 5617.5505959522325, 6478.319776423407, 7143.964280178566, 7168.24733403006, 7301.488895777457, 7942.166072562298, 8012.679492820455, 8024.2376974187355, 8032.919670803451, 8033.959830201045, 7139.964300178466, 7258.419326453976, 7259.637018148966, 7312.268773122858, 7386.372158366599, 6978.79063628092, 7040.718371265092, 7075.5047146699235, 7157.785266442015, 7182.676779545038, 6716.462682985447, 6726.831829204309, 6788.117544719353, 6791.694373753094, 6808.62552559614, 4767.189577771718, 4785.234362501983, 4799.352087468147, 4817.590504807131, 4838.806447742051, 4759.286107083965, 4802.135615589227, 4908.361912951294, 4924.064427758714, 5020.698758074527], "value": 4426.814896907353, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.58691939720177, 317.6489978573675, 321.87446895710667, 327.99344013119736, 330.8858443836875, 4399.6260317872975, 4418.646508279338, 4991.326170966919, 5425.674459532426, 5517.668939863601, 3935.7048221383366, 4108.863920099875, 5071.137906555885, 5239.449857764937, 5383.81156659517, 3819.2170605025904, 4011.8997025074386, 4125.628693417591, 4135.627793498585, 4166.7708276044805, 3379.9493007604906, 3556.608773034964, 4127.814248358816, 4139.710220284566, 4154.8130334134885, 3982.780947047911, 4047.4738284023038, 4098.139390727951, 4107.712460127792, 4120.443740095079, 3579.7673151245085, 4088.5298190708154, 4110.916812390707, 4111.835526578933, 4114.724435425012, 3004.4291584598855, 3172.666869978642, 3606.3688854450365, 3610.2598967211657, 3617.94573081404, 5139.254808052849, 5258.8709717718275, 5274.3670759509105, 5284.0977248191, 5305.65513241638, 4488.551144885485, 4729.952700472985, 4745.335653008581, 4750.904981900378, 4766.666333356667, 5090.5237481130425, 5175.223716442526, 5656.886862262772, 5693.146028095777, 5696.316442026983, 3337.747020761001, 3599.4420864766003, 3750.868719594801, 3986.4618276532588, 3999.320115580358, 5741.445056949659, 5874.765009399662, 5879.235699359098, 5896.852578685524, 5984.521238300926, 3359.0853213668465, 4052.7163098582814, 4055.614716601918, 4057.5536690963972, 4065.796710164539, 3476.3568739783223, 4096.692748043909, 4146.0, 4166.229247589205, 4168.812403441852, 4314.892127696833, 4526.253168227271, 4613.5847773700525, 4787.893326936137, 4799.28010798383, 4697.718136911728, 4806.927896081562, 5492.725363731797, 5663.745131469093, 5678.716064196774, 1158.0, 1190.8627260965757, 1221.908356873238, 1318.7296604196117, 1357.8933169466852, 739.8002539314355, 860.8407444622765, 907.5689047702289, 937.4656445825814, 938.5265133739963, 4743.857684269477, 5047.697138171721, 5083.72039537829, 5095.235714642759, 5110.897782044338, 4523.796429160696, 5228.843134705965, 5464.808731694372, 5514.0, 5550.833474995757, 4112.676337869154, 4295.4201182839915, 4917.360743103445, 4961.0, 4970.527799859007, 2549.3754030262703, 2775.834149657149, 2868.0, 2878.424315136981, 2900.448914706199, 5569.192467092249, 5610.625396777734, 5640.379558248589, 5662.688552129673, 5685.276144125604, 5071.841090305914, 5317.962997215506, 5699.914501282484, 6134.141220229171, 6135.754569817157, 4869.951300487091, 5914.284857391308, 6179.598326108879, 6180.351063138306, 6186.350433204539, 5499.752511136929, 5685.374608793112, 5700.230468886647, 5906.468417842415, 5928.636413624977, 4860.635452341018, 4885.606053033916, 5511.421300763523, 5752.884942301047, 5876.70904293597, 5080.923786143285, 5652.5020869470445, 5706.914396283976, 6155.753769849156, 6199.535034872312, 3387.322535492862, 3801.6159105034185, 3806.7144964128356, 3999.3800960851113, 4051.54144507971, 5586.692731899784, 5926.999275489114, 5943.91084133747, 5962.016267316018, 5964.731587078505, 5056.028149021958, 5580.35379563038, 5609.962157000968, 5803.7388317524965, 5816.883662326645, 4890.584300334369, 5650.830475085754, 5702.600817942704, 5725.599208055396, 5736.225609542658, 5246.895062098813, 5635.577331700221, 5635.971820141037, 5641.661500309994, 5654.886902262014, 5238.2404551340605, 5473.0695781718, 5629.8592535186945, 5750.856228594319, 5773.797917072882, 4830.8792280193275, 5108.923366149436, 5499.3675727291875, 5598.0, 5606.103023516218], "value": 4091.3162630454017, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.8722229998601, 745.6979923131132, 753.2317036622645, 832.7252006837742, 852.1733918099442, 13974.161550306975, 15716.685666286667, 15885.444009459672, 15901.045937243773, 15906.284217210225, 14076.0, 14250.2162381069, 14259.287035648202, 14273.78589321161, 14284.07153535022, 697.0763738047108, 719.1226703421817, 883.4787475389519, 887.6671248281895, 909.6088681866795, 907.0068275238604, 912.1608120529129, 915.7847905742145, 919.2554031234688, 919.9816003679922, 950.8621249918758, 951.1819834941945, 952.3238500664537, 952.8618350339196, 956.2302346610975, 936.7236665183788, 937.1799675284126, 943.0098396683524, 943.5235206220849, 945.924326053914, 707.1902671441222, 708.6350529477323, 710.1159056974049, 710.4245561095478, 710.722818100941, 14640.0, 14664.70670586593, 14697.485588004476, 14816.555503334917, 15423.228838558027, 13768.65578360549, 14498.130112193197, 14644.0, 14712.779308310384, 14787.482438114614, 11654.533818647244, 11904.16670833042, 12043.93978030113, 12639.431225594779, 12870.099093063489, 3873.061846146158, 3920.2943470175355, 4018.3168861293652, 4045.1707399982934, 4091.652209562191, 72230.63884680596, 89904.99999999935, 99156.50421747845, 101138.0, 102147.0, 10609.0, 10989.175811814146, 11188.832167517494, 11496.482658280398, 11526.193166478266, 22250.109995599996, 22388.664170037464, 22427.878606069957, 22455.214067507557, 22532.0, 7832.412569057344, 7963.800904977422, 8110.716124935599, 8234.629441675139, 8370.372222083368, 4147.52303485103, 4170.291050521419, 4190.329547272483, 4356.259435895905, 4417.337399390053, 3470.4794280858073, 3587.2287458196615, 3597.640235976434, 3602.7297952653657, 3611.8555257789394, 650.8568115014689, 651.8761435327273, 660.4980215036607, 663.2405895249912, 672.579637726421, 540.5648452995298, 627.419636835925, 659.5383231737803, 660.6399512265826, 700.7722490190708, 8503.957480212559, 9278.814423711488, 9280.443173409618, 9435.782591091089, 9768.27129991224, 608.7321578505532, 676.7529851604228, 681.3288910423229, 716.7670507085218, 722.385971923871, 4258.382534532476, 4574.565416285448, 4591.931121033187, 4652.185867473247, 4706.552877476634, 61178.0, 78659.8201026985, 97653.51173244088, 99444.0, 102452.48773756083, 84552.0, 85561.14438855657, 86520.56739716261, 105698.47150764197, 107549.0, 58692.23923282223, 77958.22041779623, 83358.0, 83451.16548834555, 83594.0, 9116.453012818987, 9505.524723763645, 9642.035796420301, 9684.75788105303, 9691.757706057122, 43208.35187472127, 44069.559304406546, 49868.750656246484, 53901.0, 58342.0, 60759.0, 62656.37343626688, 77372.2262777365, 80127.59936200282, 80487.0, 12523.812142818048, 12822.743545128858, 12924.030697697899, 12991.0, 13159.276239806903, 14261.215633140277, 14516.854831451972, 14518.564443066725, 14912.0, 15092.773608396103, 13219.867801321863, 13329.800052999019, 13564.321783910962, 13609.387577558835, 13754.587362379145, 13638.045336826326, 13724.245166515937, 13732.901367890745, 13922.0, 13995.580132596038, 11118.944405277922, 11723.769004254431, 11788.410579470821, 12938.482460701467, 13578.524751633646, 11208.607698730506, 11259.718507037389, 11632.287040321426, 11776.587819426279, 12047.457864395948, 11485.885141148481, 11530.94234528822, 11562.0, 11779.587714429954, 11792.587259445878], "value": 7538.176972211511, "unit": "score"}], "name": "dromaeo_css", "value": 7287.047423744702, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 113.0, 114.0, 115.0, 112.0, 113.0, 114.0, 113.0, 112.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 112.0, 136.0, 108.0, 108.0, 106.0, 111.0, 137.0, 107.0], "value": 117.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 188.0, 255.0, 184.0, 183.0, 182.0, 180.0, 183.0, 181.0, 183.0], "value": 191.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 57.0, 89.0, 60.0, 58.0, 57.0, 58.0, 81.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 91.0, 102.0, 100.0, 103.0, 97.0, 67.0, 69.0, 91.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 92.0, 82.0, 88.0, 84.0, 79.0, 130.0], "value": 89.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 78.0, 80.0, 83.0, 81.0, 84.0, 86.0, 83.0, 80.0], "value": 82.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 51.0, 54.0, 58.0, 57.0, 56.0, 55.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 63.0, 80.0, 108.0, 57.0, 71.0, 92.0, 103.0, 100.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 82.0, 82.0, 80.0, 81.0, 82.0, 83.0, 80.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 134.0, 136.0, 140.0, 140.0, 139.0, 134.0, 176.0, 133.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 208.0, 229.0, 161.0, 159.0, 161.0, 160.0, 160.0, 161.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 68.0, 65.0, 65.0, 66.0, 64.0, 65.0, 64.0, 65.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1439.6, "alertThreshold": 2.0}]} 18:11:12 INFO - Return code: 0 18:11:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:11:12 INFO - # TBPL SUCCESS # 18:11:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:11:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:11:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:11:12 INFO - 2017-01-23 18:11:12.665 screenresolution[1655:10114] starting screenresolution argv=screenresolution get 18:11:12 INFO - 2017-01-23 18:11:12.668 screenresolution[1655:10114] Display 0: 1600x1200x32@60 18:11:12 INFO - 2017-01-23 18:11:12.674 screenresolution[1656:10117] starting screenresolution argv=screenresolution list 18:11:12 INFO - Available Modes on Display 0 18:11:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:11:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:11:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:11:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:11:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:11:12 INFO - Intel Iris: 18:11:12 INFO - Chipset Model: Intel Iris 18:11:12 INFO - Type: GPU 18:11:12 INFO - Bus: Built-In 18:11:12 INFO - VRAM (Dynamic, Max): 1536 MB 18:11:12 INFO - Vendor: Intel (0x8086) 18:11:12 INFO - Device ID: 0x0a2e 18:11:12 INFO - Revision ID: 0x0009 18:11:12 INFO - Displays: 18:11:12 INFO - Display: 18:11:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:11:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:11:12 INFO - Display Serial Number: 1600x1200 60 18:11:12 INFO - Main Display: Yes 18:11:12 INFO - Mirror: Off 18:11:12 INFO - Online: Yes 18:11:12 INFO - Rotation: Supported 18:11:12 INFO - Return code: 0 18:11:12 INFO - Running post-action listener: _resource_record_post_action 18:11:12 INFO - [mozharness: 2017-01-24 02:11:12.914274Z] Finished run-tests step (success) 18:11:12 INFO - Running post-run listener: _resource_record_post_run 18:11:12 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 33635328; Write bytes: 501557760; Read time: 314; Write time: 1631 18:11:12 INFO - TinderboxPrint: CPU usage
53.5% 18:11:12 INFO - TinderboxPrint: I/O read bytes / time
33,635,328 / 314 18:11:12 INFO - TinderboxPrint: I/O write bytes / time
501,557,760 / 1,631 18:11:12 INFO - TinderboxPrint: CPU idle
2,229.8 (46.5%) 18:11:12 INFO - TinderboxPrint: CPU system
961.1 (20.0%) 18:11:12 INFO - TinderboxPrint: CPU user
1,602.7 (33.4%) 18:11:12 INFO - TinderboxPrint: Swap in / out
221,237,248 / 0 18:11:12 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 186610176; Write bytes: 186056704; Read time: 16916; Write time: 354 18:11:12 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 31845376; Write bytes: 308603392; Read time: 294; Write time: 1251 18:11:13 INFO - Running post-run listener: _upload_blobber_files 18:11:13 INFO - Blob upload gear active. 18:11:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:11:13 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 18:11:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:11:13 INFO - (blobuploader) - INFO - Open directory for files ... 18:11:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:11:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:11:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:14 INFO - (blobuploader) - INFO - Done attempting. 18:11:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:11:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:11:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:15 INFO - (blobuploader) - INFO - Done attempting. 18:11:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:11:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:11:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:18 INFO - (blobuploader) - INFO - Done attempting. 18:11:18 INFO - (blobuploader) - INFO - Iteration through files over. 18:11:18 INFO - Return code: 0 18:11:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:11:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:11:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9727ab65161f03a843dbf7de0e8f74ace4f64a0d17ef39cd1f1bac948932a43abe31d2faf9f9c7b8f10731fa69f84f9dd41cfb6e27208f74dea1456ea483656", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae2d5355605c6c21218ecce8b1e96a8ec35e2486db319472fcbe3643ff86ed86e1bdc5350786a863caf4542c4774dbe8adfec357293c07c0076a41254d0b46ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/091548172428222c771a3abb9a0893c0a2a7a106b4f11de907a997284d9c4fce2696df8b46af2a6c6e64d8f99a533c06eaf591e3ef2b548fa339e42537964ab1"} 18:11:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:11:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:11:18 INFO - Contents: 18:11:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9727ab65161f03a843dbf7de0e8f74ace4f64a0d17ef39cd1f1bac948932a43abe31d2faf9f9c7b8f10731fa69f84f9dd41cfb6e27208f74dea1456ea483656", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae2d5355605c6c21218ecce8b1e96a8ec35e2486db319472fcbe3643ff86ed86e1bdc5350786a863caf4542c4774dbe8adfec357293c07c0076a41254d0b46ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/091548172428222c771a3abb9a0893c0a2a7a106b4f11de907a997284d9c4fce2696df8b46af2a6c6e64d8f99a533c06eaf591e3ef2b548fa339e42537964ab1"} 18:11:18 INFO - Running post-run listener: copy_logs_to_upload_dir 18:11:18 INFO - Copying logs to upload dir... 18:11:18 INFO - mkdir: /builds/slave/test/build/upload/logs 18:11:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.866451 ========= master_lag: 0.66 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-01-23 18:11:18.711669) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 18:11:18.714717) ========= 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.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9727ab65161f03a843dbf7de0e8f74ace4f64a0d17ef39cd1f1bac948932a43abe31d2faf9f9c7b8f10731fa69f84f9dd41cfb6e27208f74dea1456ea483656", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae2d5355605c6c21218ecce8b1e96a8ec35e2486db319472fcbe3643ff86ed86e1bdc5350786a863caf4542c4774dbe8adfec357293c07c0076a41254d0b46ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/091548172428222c771a3abb9a0893c0a2a7a106b4f11de907a997284d9c4fce2696df8b46af2a6c6e64d8f99a533c06eaf591e3ef2b548fa339e42537964ab1"} build_url:https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010666 build_url: 'https://queue.taskcluster.net/v1/task/W9SUuBiaQoCDqlORlgoDdw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9727ab65161f03a843dbf7de0e8f74ace4f64a0d17ef39cd1f1bac948932a43abe31d2faf9f9c7b8f10731fa69f84f9dd41cfb6e27208f74dea1456ea483656", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae2d5355605c6c21218ecce8b1e96a8ec35e2486db319472fcbe3643ff86ed86e1bdc5350786a863caf4542c4774dbe8adfec357293c07c0076a41254d0b46ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/091548172428222c771a3abb9a0893c0a2a7a106b4f11de907a997284d9c4fce2696df8b46af2a6c6e64d8f99a533c06eaf591e3ef2b548fa339e42537964ab1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 18:11:18.748353) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 18:11:18.748677) ========= 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.Ndhhmod9ml/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.ZpTWlAdgGe/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.005165 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 18:11:18.797302) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 18:11:18.797621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 18:11:18.797930) ========= ========= Total master_lag: 0.82 =========