builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0002 starttime: 1479500923.13 results: success (0) buildid: 20161118075229 builduid: 6156f27cae584ebea3ab11db32eb26e9 revision: a103e1713a2eda3b4e88d71df82d140487c8db87 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 12:28:43.127650) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 12:28:43.128243) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 12:28:43.128529) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 12:28:43.153811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:28:43.154244) ========= 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.zXP8bQDOQS/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.asDl2fqlQl/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-18 12:28:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.23M=0.001s 2016-11-18 12:28:43 (9.23 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095182 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:28:43.273121) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:28:43.273543) ========= 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.zXP8bQDOQS/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.asDl2fqlQl/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.027193 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:28:43.322377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 12:28:43.322735) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a103e1713a2eda3b4e88d71df82d140487c8db87 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a103e1713a2eda3b4e88d71df82d140487c8db87 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zXP8bQDOQS/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.asDl2fqlQl/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-18 12:28:43,417 truncating revision to first 12 chars 2016-11-18 12:28:43,417 Setting DEBUG logging. 2016-11-18 12:28:43,417 attempt 1/10 2016-11-18 12:28:43,418 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a103e1713a2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 12:28:44,409 unpacking tar archive at: mozilla-central-a103e1713a2e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.262010 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 12:28:44.607469) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 12:28:44.607796) ========= script_repo_revision: a103e1713a2eda3b4e88d71df82d140487c8db87 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 12:28:44.608247) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 12:28:44.608553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 12:28:44.627749) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-18 12:28:44.628279) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zXP8bQDOQS/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.asDl2fqlQl/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 12:28:44 INFO - MultiFileLogger online at 20161118 12:28:44 in /builds/slave/test 12:28:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:28:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:28:44 INFO - {'append_to_log': False, 12:28:44 INFO - 'base_work_dir': '/builds/slave/test', 12:28:44 INFO - 'blob_upload_branch': 'Firefox', 12:28:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:28:44 INFO - 'branch': 'Firefox', 12:28:44 INFO - 'buildbot_json_path': 'buildprops.json', 12:28:44 INFO - 'config_files': ('talos/mac_config.py',), 12:28:44 INFO - 'default_actions': ('clobber', 12:28:44 INFO - 'read-buildbot-config', 12:28:44 INFO - 'download-and-extract', 12:28:44 INFO - 'populate-webroot', 12:28:44 INFO - 'create-virtualenv', 12:28:44 INFO - 'install', 12:28:44 INFO - 'run-tests'), 12:28:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:28:44 INFO - 'download_minidump_stackwalk': True, 12:28:44 INFO - 'download_symbols': 'ondemand', 12:28:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:28:44 INFO - 'tooltool.py': '/tools/tooltool.py', 12:28:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:28:44 INFO - '/tools/misc-python/virtualenv.py')}, 12:28:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:28:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:28:44 INFO - 'installer_path': 'installer.exe', 12:28:44 INFO - 'log_level': 'info', 12:28:44 INFO - 'log_name': 'talos', 12:28:44 INFO - 'log_to_console': True, 12:28:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:28:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:28:44 INFO - 'opt_config_files': (), 12:28:44 INFO - 'pip_index': False, 12:28:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:28:44 INFO - 'cmd': ('bash', 12:28:44 INFO - '-c', 12:28:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:28:44 INFO - 'enabled': True, 12:28:44 INFO - 'halt_on_failure': False, 12:28:44 INFO - 'name': 'check_screen_resolution'},), 12:28:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:28:44 INFO - 'cmd': ('bash', 12:28:44 INFO - '-c', 12:28:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:28:44 INFO - 'enabled': True, 12:28:44 INFO - 'halt_on_failure': False, 12:28:44 INFO - 'name': 'check_screen_resolution'},), 12:28:44 INFO - 'run_cmd_checks_enabled': True, 12:28:44 INFO - 'sps_profile': False, 12:28:44 INFO - 'sps_profile_interval': 0, 12:28:44 INFO - 'suite': 'dromaeojs', 12:28:44 INFO - 'system_bits': '32', 12:28:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:28:44 INFO - 'title': 't-yosemite-r7-0002', 12:28:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:28:44 INFO - 'use_talos_json': True, 12:28:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:28:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:28:44 INFO - 'work_dir': 'build'} 12:28:44 INFO - [mozharness: 2016-11-18 20:28:44.834223Z] Running clobber step. 12:28:44 INFO - Running pre-action listener: _resource_record_pre_action 12:28:44 INFO - Running main action method: clobber 12:28:44 INFO - rmtree: /builds/slave/test/build 12:28:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:28:47 INFO - Running post-action listener: _resource_record_post_action 12:28:47 INFO - [mozharness: 2016-11-18 20:28:47.226392Z] Finished clobber step (success) 12:28:47 INFO - [mozharness: 2016-11-18 20:28:47.226489Z] Running read-buildbot-config step. 12:28:47 INFO - Running pre-action listener: _resource_record_pre_action 12:28:47 INFO - Running main action method: read_buildbot_config 12:28:47 INFO - Using buildbot properties: 12:28:47 INFO - { 12:28:47 INFO - "project": "", 12:28:47 INFO - "product": "firefox", 12:28:47 INFO - "script_repo_revision": "production", 12:28:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 12:28:47 INFO - "repository": "", 12:28:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 12:28:47 INFO - "buildid": "20161118075229", 12:28:47 INFO - "pgo_build": "False", 12:28:47 INFO - "basedir": "/builds/slave/test", 12:28:47 INFO - "buildnumber": 14, 12:28:47 INFO - "slavename": "t-yosemite-r7-0002", 12:28:47 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 12:28:47 INFO - "platform": "yosemite_r7", 12:28:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:28:47 INFO - "branch": "mozilla-central", 12:28:47 INFO - "repo_path": "mozilla-central", 12:28:47 INFO - "revision": "a103e1713a2eda3b4e88d71df82d140487c8db87", 12:28:47 INFO - "stage_platform": "macosx64", 12:28:47 INFO - "builduid": "6156f27cae584ebea3ab11db32eb26e9", 12:28:47 INFO - "slavebuilddir": "test" 12:28:47 INFO - } 12:28:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 12:28:47 INFO - Running post-action listener: _resource_record_post_action 12:28:47 INFO - [mozharness: 2016-11-18 20:28:47.230053Z] Finished read-buildbot-config step (success) 12:28:47 INFO - [mozharness: 2016-11-18 20:28:47.230190Z] Running download-and-extract step. 12:28:47 INFO - Running pre-action listener: _resource_record_pre_action 12:28:47 INFO - Running main action method: download_and_extract 12:28:47 INFO - mkdir: /builds/slave/test/build/tests 12:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:28:47 INFO - trying https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 12:28:47 INFO - Downloading https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 12:28:48 INFO - Downloaded 1199 bytes. 12:28:48 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:28:48 INFO - Using the following test package requirements: 12:28:48 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:28:48 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:28:48 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 12:28:48 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:28:48 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 12:28:48 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:28:48 INFO - u'jsshell-mac.zip'], 12:28:48 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:28:48 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 12:28:48 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:28:48 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:28:48 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 12:28:48 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:28:48 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 12:28:48 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:28:48 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 12:28:48 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:28:48 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 12:28:48 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:28:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:28:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:28:48 INFO - Fetch https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:28:48 INFO - Http code: 200 12:28:48 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 12:28:48 INFO - x-amz-cf-id: sfVTK8dP0eBMN1ZA20Kr79VWvdDre59jGNVzpoFnTsTM8RtJt0pVgg== 12:28:48 INFO - x-amz-version-id: RUc9GKYjTFNw9.T0hVQu7_6GVJy_1CbL 12:28:49 INFO - Expected file size: 16233422 12:28:49 INFO - Obtained file size: 16233422 12:28:55 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:28:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:28:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:28:55 INFO - Fetch https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:28:56 INFO - Http code: 200 12:28:56 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 12:28:56 INFO - x-amz-cf-id: LyDjywspd7sxwruzswrpNMCFSX1Hl3PXs9NeblVRPOArobozLjZ15g== 12:28:56 INFO - x-amz-version-id: RUc9GKYjTFNw9.T0hVQu7_6GVJy_1CbL 12:28:56 INFO - Expected file size: 16233422 12:28:56 INFO - Obtained file size: 16233422 12:29:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 12:29:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:29:03 INFO - Fetch https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 12:29:04 INFO - Http code: 200 12:29:04 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 12:29:04 INFO - x-amz-cf-id: ZRKIK9p6KkTIYRiN2VYtkJOev_RLdmOvw-fsbDovArq-PwgLXleTpw== 12:29:04 INFO - x-amz-version-id: bO6aCAH2wfanU98QfeOOplkF0MlQfgsy 12:29:04 INFO - Expected file size: 14409392 12:29:04 INFO - Obtained file size: 14409392 12:29:04 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')]} 12:29:04 INFO - trying https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:29:04 INFO - Downloading https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 12:29:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 12:29:07 INFO - Downloaded 107384071 bytes. 12:29:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:29:07 INFO - mkdir: /builds/slave/test/properties 12:29:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:29:07 INFO - Writing to file /builds/slave/test/properties/build_url 12:29:07 INFO - Contents: 12:29:07 INFO - build_url:https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:29:08 INFO - Running post-action listener: _resource_record_post_action 12:29:08 INFO - Running post-action listener: set_extra_try_arguments 12:29:08 INFO - [mozharness: 2016-11-18 20:29:08.279347Z] Finished download-and-extract step (success) 12:29:08 INFO - [mozharness: 2016-11-18 20:29:08.279494Z] Running populate-webroot step. 12:29:08 INFO - Running pre-action listener: _resource_record_pre_action 12:29:08 INFO - Running main action method: populate_webroot 12:29:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:29:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:29:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:29:08 INFO - '--tppagecycles', 12:29:08 INFO - '7'], 12:29:08 INFO - 'tests': ['tsvgm']}}, 12:29:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:29:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:29:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:29:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:29:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:29:08 INFO - 'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:29:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:29:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:29:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:29:08 INFO - 'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['damp', 'tps']}, 12:29:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:29:08 INFO - 'tests': ['damp', 'tps']}, 12:29:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['dromaeo_dom']}, 12:29:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:29:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['basic_compositor_video']}, 12:29:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:29:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['a11yr', 12:29:08 INFO - 'ts_paint', 12:29:08 INFO - 'tpaint', 12:29:08 INFO - 'sessionrestore', 12:29:08 INFO - 'sessionrestore_no_auto_restore', 12:29:08 INFO - 'tabpaint']}, 12:29:08 INFO - 'other-e10s': {'tests': ['a11yr', 12:29:08 INFO - 'ts_paint', 12:29:08 INFO - 'tpaint', 12:29:08 INFO - 'sessionrestore', 12:29:08 INFO - 'sessionrestore_no_auto_restore', 12:29:08 INFO - 'tabpaint']}, 12:29:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:29:08 INFO - 'ts_paint', 12:29:08 INFO - 'tpaint', 12:29:08 INFO - 'sessionrestore', 12:29:08 INFO - 'sessionrestore_no_auto_restore', 12:29:08 INFO - 'tabpaint']}, 12:29:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:29:08 INFO - 'ts_paint', 12:29:08 INFO - 'tpaint', 12:29:08 INFO - 'sessionrestore', 12:29:08 INFO - 'sessionrestore_no_auto_restore', 12:29:08 INFO - 'tabpaint']}, 12:29:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['a11yr', 12:29:08 INFO - 'ts_paint', 12:29:08 INFO - 'tpaint', 12:29:08 INFO - 'sessionrestore', 12:29:08 INFO - 'sessionrestore_no_auto_restore', 12:29:08 INFO - 'tabpaint']}, 12:29:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['a11yr', 12:29:08 INFO - 'ts_paint', 12:29:08 INFO - 'tpaint', 12:29:08 INFO - 'sessionrestore', 12:29:08 INFO - 'sessionrestore_no_auto_restore', 12:29:08 INFO - 'tabpaint']}, 12:29:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['tsvgx', 12:29:08 INFO - 'tsvgr_opacity', 12:29:08 INFO - 'tart', 12:29:08 INFO - 'tscrollx', 12:29:08 INFO - 'cart']}, 12:29:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:29:08 INFO - 'tsvgr_opacity', 12:29:08 INFO - 'tart', 12:29:08 INFO - 'tscrollx', 12:29:08 INFO - 'cart']}, 12:29:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:29:08 INFO - 'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['tp5o']}, 12:29:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:29:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:29:08 INFO - 'talos_options': ['--disable-e10s', 12:29:08 INFO - '--xperf_path', 12:29:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:29:08 INFO - 'tests': ['tp5n']}, 12:29:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:29:08 INFO - 'talos_options': ['--xperf_path', 12:29:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:29:08 INFO - 'tests': ['tp5n']}}, 12:29:08 INFO - 'talos.zip': {'path': '', 12:29:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:29:08 INFO - Running post-action listener: _resource_record_post_action 12:29:08 INFO - [mozharness: 2016-11-18 20:29:08.297508Z] Finished populate-webroot step (success) 12:29:08 INFO - [mozharness: 2016-11-18 20:29:08.297618Z] Running create-virtualenv step. 12:29:08 INFO - Running pre-action listener: _resource_record_pre_action 12:29:08 INFO - Running main action method: create_virtualenv 12:29:08 INFO - Creating virtualenv /builds/slave/test/build/venv 12:29:08 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 12:29:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:29:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:29:08 INFO - Using real prefix '/tools/python27' 12:29:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:29:09 INFO - Installing distribute.............................................................................................................................................................................................done. 12:29:12 INFO - Installing pip.................done. 12:29:12 INFO - Return code: 0 12:29:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:29:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:29:12 INFO - Reading from file tmpfile_stdout 12:29:12 INFO - Output received: 12:29:12 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) 12:29:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:12 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 0x1093e83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff10bdc80b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091fed30>, '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 0x109065db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f6b20>, '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.zXP8bQDOQS/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.asDl2fqlQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 12:29:12 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 12:29:12 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 12:29:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zXP8bQDOQS/Render', 12:29:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:12 INFO - 'HOME': '/Users/cltbld', 12:29:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:12 INFO - 'LOGNAME': 'cltbld', 12:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:12 INFO - 'MOZ_NO_REMOTE': '1', 12:29:12 INFO - 'NO_EM_RESTART': '1', 12:29:12 INFO - 'PAGER': '/bin/cat', 12:29:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:12 INFO - 'PWD': '/builds/slave/test', 12:29:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:12 INFO - 'SHELL': '/bin/bash', 12:29:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asDl2fqlQl/Listeners', 12:29:12 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:29:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:12 INFO - 'USER': 'cltbld', 12:29:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:12 INFO - 'XPC_FLAGS': '0x0', 12:29:12 INFO - 'XPC_SERVICE_NAME': '0', 12:29:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:12 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 12:29:12 INFO - Cleaning up... 12:29:12 INFO - Return code: 0 12:29:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:12 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 0x1093e83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff10bdc80b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091fed30>, '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 0x109065db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f6b20>, '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.zXP8bQDOQS/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.asDl2fqlQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 12:29:12 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 12:29:12 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 12:29:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zXP8bQDOQS/Render', 12:29:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:12 INFO - 'HOME': '/Users/cltbld', 12:29:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:12 INFO - 'LOGNAME': 'cltbld', 12:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:12 INFO - 'MOZ_NO_REMOTE': '1', 12:29:12 INFO - 'NO_EM_RESTART': '1', 12:29:12 INFO - 'PAGER': '/bin/cat', 12:29:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:12 INFO - 'PWD': '/builds/slave/test', 12:29:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:12 INFO - 'SHELL': '/bin/bash', 12:29:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asDl2fqlQl/Listeners', 12:29:12 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:29:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:12 INFO - 'USER': 'cltbld', 12:29:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:12 INFO - 'XPC_FLAGS': '0x0', 12:29:12 INFO - 'XPC_SERVICE_NAME': '0', 12:29:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:12 INFO - Downloading/unpacking psutil>=3.1.1 12:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:29:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:29:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:29:16 INFO - Installing collected packages: psutil 12:29:16 INFO - Running setup.py install for psutil 12:29:16 INFO - building 'psutil._psutil_osx' extension 12:29:16 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 12:29:17 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 12:29:17 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 12:29:17 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 12:29:17 INFO - building 'psutil._psutil_posix' extension 12:29:17 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 12:29:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:29:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:29:17 INFO - ^ 12:29:17 INFO - 1 warning generated. 12:29:17 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 12:29:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:29:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:29:17 INFO - Successfully installed psutil 12:29:17 INFO - Cleaning up... 12:29:17 INFO - Return code: 0 12:29:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:29:17 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')]} 12:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:17 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')]} 12:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:17 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 0x1093e83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff10bdc80b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091fed30>, '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 0x109065db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f6b20>, '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.zXP8bQDOQS/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.asDl2fqlQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 12:29:17 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 12:29:17 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 12:29:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zXP8bQDOQS/Render', 12:29:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:17 INFO - 'HOME': '/Users/cltbld', 12:29:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:17 INFO - 'LOGNAME': 'cltbld', 12:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:17 INFO - 'MOZ_NO_REMOTE': '1', 12:29:17 INFO - 'NO_EM_RESTART': '1', 12:29:17 INFO - 'PAGER': '/bin/cat', 12:29:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:17 INFO - 'PWD': '/builds/slave/test', 12:29:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:17 INFO - 'SHELL': '/bin/bash', 12:29:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asDl2fqlQl/Listeners', 12:29:17 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:29:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:17 INFO - 'USER': 'cltbld', 12:29:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:17 INFO - 'XPC_FLAGS': '0x0', 12:29:17 INFO - 'XPC_SERVICE_NAME': '0', 12:29:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:29:17 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 12:29:17 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 12:29:17 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 12:29:17 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 12:29:17 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 12:29:17 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 12:29:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:29:20 INFO - Installing collected packages: mozsystemmonitor 12:29:20 INFO - Running setup.py install for mozsystemmonitor 12:29:20 INFO - Successfully installed mozsystemmonitor 12:29:20 INFO - Cleaning up... 12:29:20 INFO - Return code: 0 12:29:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:29:20 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')]} 12:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:20 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')]} 12:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:20 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 0x1093e83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff10bdc80b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091fed30>, '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 0x109065db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f6b20>, '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.zXP8bQDOQS/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.asDl2fqlQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 12:29:20 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 12:29:20 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 12:29:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zXP8bQDOQS/Render', 12:29:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:20 INFO - 'HOME': '/Users/cltbld', 12:29:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:20 INFO - 'LOGNAME': 'cltbld', 12:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:20 INFO - 'MOZ_NO_REMOTE': '1', 12:29:20 INFO - 'NO_EM_RESTART': '1', 12:29:20 INFO - 'PAGER': '/bin/cat', 12:29:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:20 INFO - 'PWD': '/builds/slave/test', 12:29:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:20 INFO - 'SHELL': '/bin/bash', 12:29:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asDl2fqlQl/Listeners', 12:29:20 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:29:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:20 INFO - 'USER': 'cltbld', 12:29:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:20 INFO - 'XPC_FLAGS': '0x0', 12:29:20 INFO - 'XPC_SERVICE_NAME': '0', 12:29:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:20 INFO - Downloading/unpacking jsonschema==2.5.1 12:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:29:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:29:23 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 12:29:23 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 12:29:23 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 12:29:23 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 12:29:23 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 12:29:23 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 12:29:23 INFO - Downloading functools32-3.2.3-2.tar.gz 12:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:29:23 INFO - warning: no files found matching '*.txt' 12:29:23 INFO - no previously-included directories found matching 'build' 12:29:23 INFO - no previously-included directories found matching 'dist' 12:29:23 INFO - no previously-included directories found matching '.git*' 12:29:23 INFO - Installing collected packages: jsonschema, functools32 12:29:24 INFO - Running setup.py install for functools32 12:29:24 INFO - warning: no files found matching '*.txt' 12:29:24 INFO - no previously-included directories found matching 'build' 12:29:24 INFO - no previously-included directories found matching 'dist' 12:29:24 INFO - no previously-included directories found matching '.git*' 12:29:24 INFO - Successfully installed jsonschema functools32 12:29:24 INFO - Cleaning up... 12:29:24 INFO - Return code: 0 12:29:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1093e83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff10bdc80b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091fed30>, '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 0x109065db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f6b20>, '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.zXP8bQDOQS/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.asDl2fqlQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 12:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:29:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zXP8bQDOQS/Render', 12:29:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:24 INFO - 'HOME': '/Users/cltbld', 12:29:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:24 INFO - 'LOGNAME': 'cltbld', 12:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:24 INFO - 'MOZ_NO_REMOTE': '1', 12:29:24 INFO - 'NO_EM_RESTART': '1', 12:29:24 INFO - 'PAGER': '/bin/cat', 12:29:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:24 INFO - 'PWD': '/builds/slave/test', 12:29:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:24 INFO - 'SHELL': '/bin/bash', 12:29:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asDl2fqlQl/Listeners', 12:29:24 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:29:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:24 INFO - 'USER': 'cltbld', 12:29:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:24 INFO - 'XPC_FLAGS': '0x0', 12:29:24 INFO - 'XPC_SERVICE_NAME': '0', 12:29:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:29:24 INFO - Cleaning up... 12:29:24 INFO - Return code: 0 12:29:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1093e83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff10bdc80b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091fed30>, '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 0x109065db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f6b20>, '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.zXP8bQDOQS/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.asDl2fqlQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 12:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:29:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zXP8bQDOQS/Render', 12:29:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:24 INFO - 'HOME': '/Users/cltbld', 12:29:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:24 INFO - 'LOGNAME': 'cltbld', 12:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:24 INFO - 'MOZ_NO_REMOTE': '1', 12:29:24 INFO - 'NO_EM_RESTART': '1', 12:29:24 INFO - 'PAGER': '/bin/cat', 12:29:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:24 INFO - 'PWD': '/builds/slave/test', 12:29:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:24 INFO - 'SHELL': '/bin/bash', 12:29:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asDl2fqlQl/Listeners', 12:29:24 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:29:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:24 INFO - 'USER': 'cltbld', 12:29:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:24 INFO - 'XPC_FLAGS': '0x0', 12:29:24 INFO - 'XPC_SERVICE_NAME': '0', 12:29:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:24 INFO - Downloading/unpacking blobuploader==1.2.4 12:29:24 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 12:29:24 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 12:29:24 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 12:29:24 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 12:29:24 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 12:29:24 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 12:29:27 INFO - Downloading blobuploader-1.2.4.tar.gz 12:29:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:29:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:29:27 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 12:29:27 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 12:29:27 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 12:29:27 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 12:29:27 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 12:29:27 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 12:29:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:29:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:28 INFO - Downloading docopt-0.6.1.tar.gz 12:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:29:28 INFO - Installing collected packages: blobuploader, requests, docopt 12:29:28 INFO - Running setup.py install for blobuploader 12:29:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:29:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:29:28 INFO - Running setup.py install for requests 12:29:29 INFO - Running setup.py install for docopt 12:29:29 INFO - Successfully installed blobuploader requests docopt 12:29:29 INFO - Cleaning up... 12:29:29 INFO - Return code: 0 12:29:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:29 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 0x1093e83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff10bdc80b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091fed30>, '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 0x109065db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f6b20>, '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.zXP8bQDOQS/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.asDl2fqlQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 12:29:29 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 12:29:29 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 12:29:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zXP8bQDOQS/Render', 12:29:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:29 INFO - 'HOME': '/Users/cltbld', 12:29:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:29 INFO - 'LOGNAME': 'cltbld', 12:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:29 INFO - 'MOZ_NO_REMOTE': '1', 12:29:29 INFO - 'NO_EM_RESTART': '1', 12:29:29 INFO - 'PAGER': '/bin/cat', 12:29:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:29 INFO - 'PWD': '/builds/slave/test', 12:29:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:29 INFO - 'SHELL': '/bin/bash', 12:29:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asDl2fqlQl/Listeners', 12:29:29 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:29:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:29 INFO - 'USER': 'cltbld', 12:29:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:29 INFO - 'XPC_FLAGS': '0x0', 12:29:29 INFO - 'XPC_SERVICE_NAME': '0', 12:29:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:29:29 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-m27wRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:29:29 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-LGpIY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:29:29 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-3Lj7rL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:29:30 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ARY69g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:29:30 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-dFY8pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:29:30 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-WGgL3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:29:30 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-1ZhZs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:29:30 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-S7rgYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:29:30 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-3Ga81X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:29:30 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-3On7vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:29:30 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-effXoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:29:30 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-3nc_Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:29:30 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-OJocCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:29:31 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-vnCz69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:31 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-oHL5n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:29:31 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-NsGgLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:29:31 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-WCysoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:29:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:29:31 INFO - Running setup.py install for manifestparser 12:29:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:29:31 INFO - Running setup.py install for mozcrash 12:29:31 INFO - Running setup.py install for mozdebug 12:29:31 INFO - Running setup.py install for mozdevice 12:29:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:29:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:29:32 INFO - Running setup.py install for mozfile 12:29:32 INFO - Running setup.py install for mozhttpd 12:29:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:29:32 INFO - Running setup.py install for mozinfo 12:29:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:29:32 INFO - Running setup.py install for mozInstall 12:29:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:29:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:29:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:29:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:29:32 INFO - Running setup.py install for mozleak 12:29:32 INFO - Running setup.py install for mozlog 12:29:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:29:33 INFO - Running setup.py install for moznetwork 12:29:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:29:33 INFO - Running setup.py install for mozprocess 12:29:33 INFO - Running setup.py install for mozprofile 12:29:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:29:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:29:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:29:33 INFO - Running setup.py install for mozrunner 12:29:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:29:33 INFO - Running setup.py install for mozscreenshot 12:29:33 INFO - Running setup.py install for moztest 12:29:33 INFO - Running setup.py install for mozversion 12:29:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:29:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:29:34 INFO - Cleaning up... 12:29:34 INFO - Return code: 0 12:29:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:34 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 0x1093e83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff10bdc80b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091fed30>, '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 0x109065db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f6b20>, '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.zXP8bQDOQS/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.asDl2fqlQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 12:29:34 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 12:29:34 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 12:29:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zXP8bQDOQS/Render', 12:29:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:34 INFO - 'HOME': '/Users/cltbld', 12:29:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:34 INFO - 'LOGNAME': 'cltbld', 12:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:34 INFO - 'MOZ_NO_REMOTE': '1', 12:29:34 INFO - 'NO_EM_RESTART': '1', 12:29:34 INFO - 'PAGER': '/bin/cat', 12:29:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:34 INFO - 'PWD': '/builds/slave/test', 12:29:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:34 INFO - 'SHELL': '/bin/bash', 12:29:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asDl2fqlQl/Listeners', 12:29:34 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:29:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:34 INFO - 'USER': 'cltbld', 12:29:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:34 INFO - 'XPC_FLAGS': '0x0', 12:29:34 INFO - 'XPC_SERVICE_NAME': '0', 12:29:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:29:34 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-dKH2eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:29:34 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)) 12:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:29:34 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-fh5RVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:29:34 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)) 12:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:29:34 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-TsTll5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:29:34 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)) 12:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:29:34 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ZJ2v4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:29:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 12:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:29:34 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-TNVULK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:29:34 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)) 12:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:29:34 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-YwVfTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:29:34 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)) 12:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:29:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ehxO7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:29:35 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)) 12:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:29:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-TcRy8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:29:35 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)) 12:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:29:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-4RudR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:29:35 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)) 12:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:29:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-dorm_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:29:35 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)) 12:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:29:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Twszq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:29:35 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)) 12:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:29:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-rPaPfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:29:35 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)) 12:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:29:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-GeCQNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:29:35 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)) 12:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:29:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-S2idSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:29:35 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)) 12:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ek2Bi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:35 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)) 12:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:29:35 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-TVeUYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:29:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:29:36 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-MlwmCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:29:36 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)) 12:29:36 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)) 12:29:36 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)) 12:29:36 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)) 12:29:36 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:29:36 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:29:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:38 INFO - Downloading blessings-1.6.tar.gz 12:29:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:29:38 INFO - Installing collected packages: blessings 12:29:38 INFO - Running setup.py install for blessings 12:29:38 INFO - Successfully installed blessings 12:29:38 INFO - Cleaning up... 12:29:39 INFO - Return code: 0 12:29:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:29:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:29:39 INFO - Reading from file tmpfile_stdout 12:29:39 INFO - Current package versions: 12:29:39 INFO - blessings == 1.6 12:29:39 INFO - blobuploader == 1.2.4 12:29:39 INFO - docopt == 0.6.1 12:29:39 INFO - functools32 == 3.2.3-2 12:29:39 INFO - jsonschema == 2.5.1 12:29:39 INFO - manifestparser == 1.1 12:29:39 INFO - mozInstall == 1.12 12:29:39 INFO - mozcrash == 1.0 12:29:39 INFO - mozdebug == 0.1 12:29:39 INFO - mozdevice == 0.49 12:29:39 INFO - mozfile == 1.2 12:29:39 INFO - mozhttpd == 0.7 12:29:39 INFO - mozinfo == 0.9 12:29:39 INFO - mozleak == 0.1 12:29:39 INFO - mozlog == 3.4 12:29:39 INFO - moznetwork == 0.27 12:29:39 INFO - mozprocess == 0.23 12:29:39 INFO - mozprofile == 0.28 12:29:39 INFO - mozrunner == 6.13 12:29:39 INFO - mozscreenshot == 0.1 12:29:39 INFO - mozsystemmonitor == 0.3 12:29:39 INFO - moztest == 0.7 12:29:39 INFO - mozversion == 1.4 12:29:39 INFO - psutil == 3.1.1 12:29:39 INFO - requests == 1.2.3 12:29:39 INFO - wsgiref == 0.1.2 12:29:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:29:39 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')]} 12:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:39 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')]} 12:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:40 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 0x1093e83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff10bdc80b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091fed30>, '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 0x109065db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f6b20>, '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.zXP8bQDOQS/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.asDl2fqlQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 12:29:40 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 12:29:40 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 12:29:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zXP8bQDOQS/Render', 12:29:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:40 INFO - 'HOME': '/Users/cltbld', 12:29:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:40 INFO - 'LOGNAME': 'cltbld', 12:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:40 INFO - 'MOZ_NO_REMOTE': '1', 12:29:40 INFO - 'NO_EM_RESTART': '1', 12:29:40 INFO - 'PAGER': '/bin/cat', 12:29:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:40 INFO - 'PWD': '/builds/slave/test', 12:29:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:40 INFO - 'SHELL': '/bin/bash', 12:29:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asDl2fqlQl/Listeners', 12:29:40 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:29:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:40 INFO - 'USER': 'cltbld', 12:29:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:40 INFO - 'XPC_FLAGS': '0x0', 12:29:40 INFO - 'XPC_SERVICE_NAME': '0', 12:29:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:40 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)) 12:29:40 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)) 12:29:40 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)) 12:29:40 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)) 12:29:40 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)) 12:29:40 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)) 12:29:40 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)) 12:29:40 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)) 12:29:40 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)) 12:29:40 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)) 12:29:40 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)) 12:29:40 INFO - Cleaning up... 12:29:40 INFO - Return code: 0 12:29:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:29:40 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')]} 12:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:40 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')]} 12:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:41 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 0x1093e83f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff10bdc80b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091fed30>, '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 0x109065db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f6b20>, '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.zXP8bQDOQS/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.asDl2fqlQl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 12:29:41 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 12:29:41 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 12:29:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zXP8bQDOQS/Render', 12:29:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:41 INFO - 'HOME': '/Users/cltbld', 12:29:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:41 INFO - 'LOGNAME': 'cltbld', 12:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:41 INFO - 'MOZ_NO_REMOTE': '1', 12:29:41 INFO - 'NO_EM_RESTART': '1', 12:29:41 INFO - 'PAGER': '/bin/cat', 12:29:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:41 INFO - 'PWD': '/builds/slave/test', 12:29:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:41 INFO - 'SHELL': '/bin/bash', 12:29:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asDl2fqlQl/Listeners', 12:29:41 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:29:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:41 INFO - 'USER': 'cltbld', 12:29:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:41 INFO - 'XPC_FLAGS': '0x0', 12:29:41 INFO - 'XPC_SERVICE_NAME': '0', 12:29:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:29:41 INFO - Cleaning up... 12:29:41 INFO - Return code: 0 12:29:41 INFO - Running post-action listener: _resource_record_post_action 12:29:41 INFO - Running post-action listener: _start_resource_monitoring 12:29:41 INFO - Starting resource monitoring. 12:29:41 INFO - [mozharness: 2016-11-18 20:29:41.433674Z] Finished create-virtualenv step (success) 12:29:41 INFO - [mozharness: 2016-11-18 20:29:41.434634Z] Running install step. 12:29:41 INFO - Running pre-action listener: _resource_record_pre_action 12:29:41 INFO - Running main action method: install 12:29:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:29:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:29:41 INFO - Reading from file tmpfile_stdout 12:29:41 INFO - Detecting whether we're running mozinstall >=1.0... 12:29:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:29:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:29:41 INFO - Reading from file tmpfile_stdout 12:29:41 INFO - Output received: 12:29:41 INFO - Usage: mozinstall [options] installer 12:29:41 INFO - Options: 12:29:41 INFO - -h, --help show this help message and exit 12:29:41 INFO - -d DEST, --destination=DEST 12:29:41 INFO - Directory to install application into. [default: 12:29:41 INFO - "/builds/slave/test"] 12:29:41 INFO - --app=APP Application being installed. [default: firefox] 12:29:41 INFO - mkdir: /builds/slave/test/build/application 12:29:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:29:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:30:14 INFO - Reading from file tmpfile_stdout 12:30:14 INFO - Output received: 12:30:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:30:14 INFO - Running post-action listener: _resource_record_post_action 12:30:14 INFO - [mozharness: 2016-11-18 20:30:14.394609Z] Finished install step (success) 12:30:14 INFO - [mozharness: 2016-11-18 20:30:14.394783Z] Running run-tests step. 12:30:14 INFO - Running pre-action listener: _resource_record_pre_action 12:30:14 INFO - Running main action method: run_tests 12:30:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:30:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:30:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:30:14 INFO - 2016-11-18 12:30:14.409 screenresolution[1622:7240] starting screenresolution argv=screenresolution get 12:30:14 INFO - 2016-11-18 12:30:14.411 screenresolution[1622:7240] Display 0: 1600x1200x32@60 12:30:14 INFO - 2016-11-18 12:30:14.417 screenresolution[1623:7242] starting screenresolution argv=screenresolution list 12:30:14 INFO - Available Modes on Display 0 12:30:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:30:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:30:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:30:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:30:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:30:14 INFO - Intel Iris: 12:30:14 INFO - Chipset Model: Intel Iris 12:30:14 INFO - Type: GPU 12:30:14 INFO - Bus: Built-In 12:30:14 INFO - VRAM (Dynamic, Max): 1536 MB 12:30:14 INFO - Vendor: Intel (0x8086) 12:30:14 INFO - Device ID: 0x0a2e 12:30:14 INFO - Revision ID: 0x0009 12:30:14 INFO - Displays: 12:30:14 INFO - Display: 12:30:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:30:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:30:14 INFO - Display Serial Number: 1600x1200 60 12:30:14 INFO - Main Display: Yes 12:30:14 INFO - Mirror: Off 12:30:14 INFO - Online: Yes 12:30:14 INFO - Rotation: Supported 12:30:14 INFO - Return code: 0 12:30:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:30:14 INFO - Python 2.7.3 12:30:14 INFO - Return code: 0 12:30:14 INFO - grabbing minidump binary from tooltool 12:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:14 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 0x1091fed30>, '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 0x109065db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:30:14 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 12:30:14 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 12:30:14 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 12:30:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:30:14 INFO - Return code: 0 12:30:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:30:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:30:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:30:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:30:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:30:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 12:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0002 --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 12:30:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zXP8bQDOQS/Render', 12:30:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:30:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:30:14 INFO - 'HOME': '/Users/cltbld', 12:30:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:30:14 INFO - 'LOGNAME': 'cltbld', 12:30:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:30:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:14 INFO - 'MOZ_NO_REMOTE': '1', 12:30:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:30:14 INFO - 'NO_EM_RESTART': '1', 12:30:14 INFO - 'PAGER': '/bin/cat', 12:30:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:14 INFO - 'PWD': '/builds/slave/test', 12:30:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:30:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:30:14 INFO - 'SHELL': '/bin/bash', 12:30:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.asDl2fqlQl/Listeners', 12:30:14 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:30:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:30:14 INFO - 'USER': 'cltbld', 12:30:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:30:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:14 INFO - 'XPC_FLAGS': '0x0', 12:30:14 INFO - 'XPC_SERVICE_NAME': '0', 12:30:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:30:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 12:30:14 INFO - mozversion application_buildid: 20161118075229 12:30:14 INFO - mozversion application_changeset: a103e1713a2eda3b4e88d71df82d140487c8db87 12:30:14 INFO - mozversion application_display_name: Nightly 12:30:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:30:14 INFO - mozversion application_name: Firefox 12:30:14 INFO - mozversion application_remotingname: firefox 12:30:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:30:14 INFO - mozversion application_vendor: Mozilla 12:30:14 INFO - mozversion application_version: 53.0a1 12:30:14 INFO - mozversion platform_buildid: 20161118075229 12:30:14 INFO - mozversion platform_changeset: a103e1713a2eda3b4e88d71df82d140487c8db87 12:30:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:30:14 INFO - mozversion platform_version: 53.0a1 12:30:14 INFO - using testdate: 1479501014 12:30:14 INFO - actual date: 1479501014 12:30:14 INFO - starting webserver on 'localhost:49235' 12:30:14 INFO - SUITE-START | Running 2 tests 12:30:14 INFO - TEST-START | dromaeo_css 12:30:14 INFO - operating with platform_type : mac_ 12:30:14 INFO - Initialising browser for dromaeo_css test... 12:30:15 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp0i0JYJ/profile http://localhost:49235/getInfo.html) 12:30:18 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 12:30:18 INFO - PROCESS | 1633 | colorDepth:24 12:30:18 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 12:30:18 INFO - PROCESS | 1633 | __metrics 12:30:18 INFO - PROCESS | 1633 | 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" 12:30:18 INFO - PROCESS | 1633 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:30:18 INFO - TEST-INFO | 1633: exit 0 12:30:18 INFO - Browser initialized. 12:30:18 INFO - Running cycle 1/1 for dromaeo_css test... 12:30:18 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp0i0JYJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:30:31 INFO - PROCESS | 1635 | RSS: Main: 244404224 12:30:31 INFO - PROCESS | 1635 | 12:31:21 INFO - PROCESS | 1635 | 1479501081929 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:33:35 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 12:33:38 INFO - PROCESS | 1635 | RSS: Main: 410828800 12:33:38 INFO - PROCESS | 1635 | 12:36:41 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 12:36:41 INFO - PROCESS | 1635 | RSS: Main: 369074176 12:36:41 INFO - PROCESS | 1635 | 12:39:44 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 12:39:45 INFO - PROCESS | 1635 | RSS: Main: 335716352 12:39:45 INFO - PROCESS | 1635 | 12:42:47 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 12:42:48 INFO - PROCESS | 1635 | RSS: Main: 346923008 12:42:48 INFO - PROCESS | 1635 | 12:45:51 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 12:45:52 INFO - PROCESS | 1635 | RSS: Main: 331960320 12:45:52 INFO - PROCESS | 1635 | 12:48:55 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 12:48:55 INFO - PROCESS | 1635 | RSS: Main: 380350464 12:48:55 INFO - PROCESS | 1635 | 12:48:55 INFO - PROCESS | 1635 | __start_tp_report 12:48:55 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 12:48:55 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 12:48:55 INFO - PROCESS | 1635 | |i|pagename|runs| 12:48:55 INFO - PROCESS | 1635 | |0;dojo.html;2668.933276668083;3145.9370812583734;3330.8834190803327;3347.380734564105;3389.9152521186966;5566.610337276392;5614.270144881165;5690.374058853523;5713.085906255;5726.198332233485;5641.153826925964;5651.039323315036;5712.285964254468;5737.196792449061;5759.10733836255;5103.617228707862;5106.310648062501;5148.382194136709;5200.401953775327;5238.947610523903;5284.788608455658;5306;5309.0709125903;5313.9734301328635;5337.786488540453;5101.20931255656;5137.33214682089;5196.986587615416;5200.97399513;5255.5795536357;5154.252633368178;5185.818496352647;5187.221916712486;5209.60927930403;5210.01009808139;4332.566743325674;5175.197844334134;5189.1697328427645;5197.766100525486;5205.193195054735;5623.7786074500755;5676.886462270772;5679.432056794329;5681.545476361881;5694.77220911163;6002.339742628307;6104.053871649901;6114.480269177126;6201.813945581594;6207.844803879894;6139.154842350791;6181.412765787243;6188.628682279078;6240.282367527747;6240.937590624127;5673.914891276675;5725.484706376446;5741.425857414309;5744.224529688522;5758.337791154029;6170.629762214281;6183.443490085914;6288.213973253343;6308.558400911984;6315.810525684236;5934.376890426443;6035.245594300713;6043.788467403708;6067.908981365283;6095.908561371583;6126.356732543019;6144.477719393813;6146.078088286793;6148.508119350441;6160.260768707783;6105.755769769248;6119.122507065663;6146.815595532141;6158.322584515699;6163.044728067157;6013;6064.575479716465;6083.7566497340495;6143.662098584621;6206.286277078104;3658.560972683295;4843.75781210938;4874.025194961022;4895.241237608177;4906.411230652345;4376.146651402946;4389.561043895585;4390.517043125254;4401.449818772653;4419.624331931822;5526.253955716007;5612;5687.488126068673;5692.48767610917;5705.885882282331;6146.8935591593945;6163.7842675506145;6189.938100618936;6193.845153871099;6197.4732147767945;5600.719964001783;5654.3497497788285;5655.830325090254;5665.6034077614995;5671.291088613923;5280.313559237275;5332.120200167006;5346.278252435949;5347.893042139135;5350.250964864922;6272.40412160844;6296.118543404019;6305.959516679696;6309.652969086745;6315.810525684236;6025.517958563392;6176.969115154396;6191.380861913773;6203.31763506005;6215.689215539295;6273.560850740404;6308.558400911892;6310.6213627182515;6318.494520438446;6320.905186422299;6101.725422355916;6113.57204995646;6152.046432802923;6172.9074063889975;6180.042093475518;6209.379062093754;6218.284897236876;6230.937690623217;6245.0632405139595;6253.6560489173535;4808.711477311233;5830.067189249869;5859.648421094577;5936.584439089395;6048.969755151196;6020.066889632114;6047.697615119315;6061.121137434959;6076.392360763888;6114.449699527064;5835.854103647443;5871.442212989759;5887.911681324698;5891.410858914074;5894.734736936763;5885.117232415172;5927.110933360031;5944.346121926498;6031.5476339273855;6080.027195648852;5820.185174075717;5833.67914764692;5833.970830145822;5837.591368604157;5859.414058594277 12:48:55 INFO - PROCESS | 1635 | |1;ext.html;463.4022111476196;482.45241650726416;497.56214531212527;503.8513638476649;525.1859617592731;27231.591526127126;30628.92798752044;31462.842685786567;39176.41235381472;40675;37379.439308410394;38087.85736427904;41187.9703007425;41632.37551436731;41643.79178104105;9200.493972831508;9379.437233765995;9383.43699378036;9396.34225604208;9417.905820941805;8431.451955622895;8651.567421628924;9262.907370926272;11026.614068507604;11344.43277836105;11171.66485005451;11226.550937962471;11234.045106165944;11235.775284494306;11256.212065155443;11211.831822522628;11274.774504509905;11304.604338848183;11315.490802913888;11330.60342887995;8374.958125209396;8605.526696031715;10783.299085559493;11108.389038602874;11129.387883666395;38716.61283387158;39078;39091;39092;39280.80359598212;3392.3215356928713;3598.5501812273465;3680.9815950920074;3839.1361943562756;3850.3261929162563;29156.854215728785;29806.55290170649;29971.25071873199;30361.24096897573;30715.846420767753;3218.806871587712;3280.1799550112473;3345.063382252973;3382.120648631349;3382.864685412605;456804;459970;462073.9999999966;462857;464567;58016.70991645099;58392;58405.415945839995;58415;58437;60781;60811;60826.087608685906;60889.69555152285;60975.695121524106;15422.228888555528;15620.531384058497;15662.686746265012;15674.608134796494;15694.979826311253;11070.335779853234;12211.26732396059;12258.570950016885;12266.26402415858;12272.38638068093;14348.784768228485;15882.841171588367;16456.341746330014;16495.010299382076;16780.748288775434;5897.410258974069;6560.9343906560325;6645.401913827779;6653.2681405045405;6686.866262674719;891.9197272245399;958.5399008475971;962.4273557233574;969.6896992962185;988.7676396046924;27954.301142471602;28702.71297287042;28798.280042999093;29440.852795735886;29517;993.3443927008284;999.5601935148511;1012.7771890184148;1045.1220974381556;1088.6135421925103;14848.480303189337;14894.106353618818;15104.351432240244;15179.089254644536;15315.387384504495;595194;598023;599583;599808;600223;48473.51526484761;49542.75228623834;54849.725751371785;55930;56040.43959560434;1295.9676008099873;1330.4345653097396;1348.3325753751956;1349.9190048597115;1354.6884216630033;24550.877245613658;29170.56244156382;29992.550111747903;30175.351200557587;30500.237494062825;49474.25788613246;49907.50092499029;50015.749921250164;50024.74987625039;50125;541210;544376;544386;544873;545380;25205.621915670912;25760.227193184233;25830;37782;38107;38636;44560.77719611381;44745.77627111843;45711.771441142584;45989.62031139071;31298.21754456157;35000.94997150089;37293.06767330838;37431.43852842155;38531.61468385392;31876.043718688477;36736.81631591825;37540.81229593835;37833.243335133695;38730.41904371493;36150.27699446049;36405.45391819178;36881.07797305089;37218.06954826043;37588;32060.038198854072;33374.833125834215;33558.49662255019;33623.663763362056;33779.831100845324;23394.605394605394;23878.494167020697;24307.513849723262;25226;25241.87379063093 12:48:55 INFO - PROCESS | 1635 | |2;jquery.html;350.85614897891867;353.2934131736527;368.123865200822;371.6989238716639;394.9960500394995;14823.703525929475;15066.548003559898;15903.363865445383;19995.60008799823;20516.89741551294;15680.843191568081;17739.55651108723;19394.03029848509;20313.289034883783;20343.389698309038;5586.888262234763;5931.843290558343;5935.198748168985;5945.940540594604;5946.672932988684;4553.931691024621;5770.538356931435;5845.912311315334;5894.263217097863;5992.7303271352675;5966.134910437984;5972.701364931736;5990.430909063632;5991.041433370661;5993.340732519419;5707.14392841073;5846.473817356416;5909.556783241274;5914.881702365971;5922.3485416604135;5574.032459425718;5579.6652200868075;5700.059490184115;5707.429257074301;5711.742971566289;12433.440495177738;12547.309897955609;12624.873751262554;12712.872871271262;12717.554885579053;2234.2068565659283;2285.371522831218;2300.7009088818345;2329.743728189898;2752.2018614601743;9589.136977671973;10066;10192.694219173436;11427.600033998853;15215.771763423558;1755.6400937807718;1792.5429015601069;1835.6420498002894;1858.3960212930851;1896.6680830854684;94063.52968235183;97506.04987900273;104718.95281047244;113598.43200784025;125722;8767.517786521676;10538.73653158662;11111.222214444912;11115.665300409844;11313.660590182308;14110.64723381903;14150.36323365451;14155;14157.433702651984;14165.079269847633;7421.183669796426;7703.614819259014;7709.4603377763015;7794.454388192772;7829.765107046797;7385;7393.445491588152;7521.4734968551675;7529.736459223901;7533.924660753432;4292.313229883266;4370.956290437119;4376.343548467756;4398.956010439919;4441.311596702516;1721.1222276638755;1826.8995205263573;1873.1289950172963;1875.4561177258443;1879.2013394307364;751.3988808952926;754.6906117885464;860.4880096342666;933.6545478173119;979.7207795778169;18805.717914231023;19751.308704195286;19796.90101549483;20222.887741174378;20617.175312987612;943.7451887990204;952.1668540027476;962.4465932089076;981.1562056631292;1001.6844693921537;10279.291857755448;10783.042492749519;10804.163381482944;10923.453827308762;10928.398938058324;450607;466051.68819091166;565626;566335;566686;91546;103004;118673;131280;133918;1011.6155860772859;1019.5463018956641;1032.1123833503182;1086.9239153259196;1094.1520321750706;17844.464666060037;18651.533711657317;18717.438476845717;18752;18757.78074425158;54168.187477188665;55138;55943.440565593824;56447;57151.714241428526;80910.19089809027;80966;81709.59145204235;82094.32773739376;83224.58387708022;7798.220177982156;7891.881621775793;7967.760967170994;8029.357651387758;11387.544498219979;11076.446177690923;11524.308541487537;11550.59572914944;11928;12461.003119750218;10920.672379828618;11246.606368777053;11630.302181869114;11657.358845263592;11704.122190835891;10296.382217067;11072.224944253825;11271;11493.023093037185;11607;10997.395143267197;11259.887401126212;11457;11677.941610291895;11729.941350293195;11670.824937626112;11772;11996.400179990791;12040.03679705604;12159.574414895436;9444.527773611155;11164.385958772345;11531.481083351437;11611.5355385787;11711 12:48:55 INFO - PROCESS | 1635 | |3;mootools.html;1495.760678291473;1521.4294639510183;1699.2353440951567;1824.379710898296;1866.9253229870806;7925.365970722342;8368.49789012659;8372.958135209323;8373.623186956587;8376.706815261467;7313.414926805856;7606;7612.809679757995;7910.96044519778;8115.269625733683;2292.048799748107;2327.1505900346338;2328.9534209315802;2330.3358542815217;2333.708286464192;2320.9651855222187;2355.5406695694346;2362.787349138577;2369.763023697634;2373.596488596943;2296.4258935266184;2308.6421604651223;2333.276684227886;2337.9298621041394;2347.108098922407;2290.461741490765;2303.021215983209;2317.7566355532595;2318.3160967514623;2330.4290448840143;2316.0388438798045;2333.1484008337006;2336.380859072347;2340.4499942513494;2345.788879000881;8011.118776934532;8192.467489613216;8203.794905127359;8204.712835050745;8207.630656620466;4959.82640607577;5133.974330128362;5134.204198349262;5135.794568217267;5137.5633071188995;3223.8065716056876;3356.009977056774;3449.913752156191;3550.8757193498104;3567.9643203567894;993.4089216915924;1041.3387498938152;1070.4326706845384;1083.1443159903667;1088.9509972051276;10530.578776848917;10659.253852230348;10679.83980240297;10682.572697092108;10691.30506517074;4356.215881141362;4486.506484286726;4572.222722137245;4581.770911454414;4633.791479383436;8112.269895709414;8828.85224920769;9128.995810460843;9147.81704365909;9160.908390916005;5085.364329458817;5097.260897169964;5103.97448012765;5104.234364845229;5109.4379618241965;4226.281532139544;4380.123975204971;4442.622377097983;4678.976605116953;4681.81272749093;3047.420990011891;3157.605299337583;3682.907927301785;3745.7190710696805;3784.564775050849;1063.7181146996052;1246.5948566715854;1254.9184303020274;1255.1590434408968;1269.6571925580042;828.3166387730147;828.8881001064779;840.306746933782;844.8310337932315;941.275218082073;5481;5554.472325129106;5564.1931919871395;5660.830175094671;5776.942230577724;428.43446650421146;443.28409618465946;445.24530920090785;446.1500840898094;449.3327408797932;3165.3511030238747;3785.6025117362833;3919.8351007027973;3989.7805620691142;4005.4192142139227;9686.806263874683;10077.193824494023;10091.293609447268;10093.5457904393;10120.291579589506;10029.749256268506;10037.548310326052;10051.849222261671;10053.49732513386;10059.094681478555;7491;7668.65491052904;7685.5004424712215;7738.845223095619;7745.457817952689;5323.6273460857365;5340.893182136258;5664.518515926193;5691.715414229189;5705.543556515386;9179.127982841619;9254.35219534626;9382.48396338208;9394.389364691273;9410.764730881783;8404.915950840414;9380.859287110563;9389.154976052188;9430.292728045286;9433.339666223299;6516.609003459807;6740.460763138839;7011.053507776385;7171.318724721144;7180.210176880643;7472.738454154079;7560.979267798777;7685.346745526469;7812.023497062867;7891.092524359772;6972.1284839395075;7049;7058.11773528309;7133.5719856808755;7233.927660723536;6879.277675843964;6945.305469453015;6948.652567371712;6997.860042799014;7012.474064445289;6469.611823290617;6523.054157147282;6596.076549283008;6620.801375958729;6629.668516574248;4623.745693986729;4708.929366059443;4709.364235828257;4741.146593613183;4861.465238823797;4733.36099626546;4827.444843843003;4846.491118432655;4868.099401610713;4868.683535570177 12:48:55 INFO - PROCESS | 1635 | |4;prototype.html;294.35536175775053;297.8153544802223;306.5554945329273;312.10892900768306;312.28330980399977;4149.813258403372;4199.958000419999;5172.922406163911;5241.8427447176555;5284.044903385753;4295.914081718363;4600.7347979305705;5083.771230294637;5083.872903177423;5099.566536844372;3389.5254664347012;3864.599152745594;3950.7629542227414;3951.996482673175;4022.798860057;3496.9300613987707;3676.963230367702;4028.879133625996;4033.6571391431617;4063.349864021757;3270.6075270967517;3912.7065470089715;3979.542352629441;4031.2945234583976;4042.4138499917494;3834.0223243073115;3840.635139661728;3994.6404823566018;4005.859794907164;4009.939850902239;3131.65551789303;3434.227298857737;3485.5294535237927;3490.7556471046782;3513.877014304487;4487.977560112178;4899.92201715622;5119.539241468248;5149;5226.216067589854;4526.592606665416;4555.74943378114;4581.541845815392;4591.288350305708;4662.696924699883;4736.313234580966;5500.789826238221;5501.927124210781;5504.504594586507;5518.834434966958;3206.599175103112;3845.769353806783;3850.5956874528333;3868.903277418087;3886.863959761423;5361.035013697533;5575.024370735106;5651.434856514356;5816.796412125555;5840.182374467578;3260.3153337799326;3769.6984241260634;3900.7464514806447;3920.843166273317;3925.5878132795647;3362.7309815214726;3579.067303656049;3615.620359862229;3793.785988483659;4012.6388625023887;4346.978265108654;4347.956430498663;4559.635229181657;4567;4612.30815377696;4589.30195827546;5527.50252477279;5529.723513824373;5533.501984821385;5543.0067763408115;1107.7009207513927;1236.4003458322707;1282.8524719657173;1297.5791508298398;1304.2696090189525;691.7544271783445;731.7877815433571;770.4645271536341;862.5514732339149;863.8401895649325;4519.593236608721;4644.047970166108;4891.52977746243;5168.53483186515;5213.973930130401;4758.928616070762;5071.188609822484;5160.354955630546;5309.389615061717;5336.599755018389;3951.0714981979213;4514.88712782183;4678.198893426055;5015.523525265094;5156.303898973665;2207.59372284211;2386.246109109803;2531.354504601315;2647.8411295321957;2676.2907829425217;4532.79602417892;4957.801687932514;5357.812476563302;5570.5516565693215;5599.216109744639;4309.500489715957;5009.874753131128;5123.436421993578;5334.906344199429;5516.07647946589;4539.6368290536675;4567.269236922077;4773.307870358779;5575.776968921279;5576.86057848557;4593.530070377447;5007.349044624176;5074.873128171677;5375.001248838461;5401.891962160814;4949.139671056581;5290.391604965324;5321;5333.040052790535;5339.946600533945;4868.878278043077;5131.536213056098;5577.932137324374;5599.948028324491;5617.775288988558;3144.6698096699515;3244.8539815708823;3448.396530607184;3647.176411794103;3697.8705745298785;4813.3983252093485;5176.696370115413;5336.786528538815;5336.839894803162;5394.9460505394445;4957.380327459067;5121.462246464068;5136;5180.326557547494;5212.582993360598;4511.954880451153;5145.871353216199;5151.381834179922;5176.482351764794;5177.792888284426;4330.610245077958;4944.456109827988;5138.332016837787;5472.972635136799;5488.313960754906;4621.712252435066;5326.828097818474;5404.675854415694;5419.078756611307;5562.638428502134;4334.566543345641;5042.39491261051;5250.606204534752;5331.546818520314;5361.142217245222 12:48:55 INFO - PROCESS | 1635 | |5;yui.html;648.9870202595948;740.5926740292841;770.3336613829036;786.1054857792719;793.357380521777;13857.445702171914;15754.606134846634;16334.509964701077;16591.66816663666;16623.2519536621;15022.474213402533;15288;15455.53633391;15519.224038798071;15720.921395393007;822.3832125905586;843.9789005274887;844.2401838345477;846.0735494633398;846.2975730143996;657.9967100164516;677.1738479055545;799.5003123048095;828.1511450762956;831.1356189562847;722.5953466058997;870.1342164546254;876.0626130040858;876.6099085906774;877.385829919056;871.8822958900562;873.7466134820894;874.0822136756444;874.208840998897;874.8818909447207;502.66070402478545;519.3819354967577;520.4769206947032;647.6891092275687;648.6302807399784;12181.269123852597;12226;13875.028747987644;14422.35099420518;14432.134071955716;13010.966600353826;13208.6697832554;13359.398827052806;13376.799348009788;13542.998127285115;11002;11229.101671866312;11279.436028198557;11332.716682083013;11714.121440891968;3601.0637234319265;3630.6006339302658;3659.8536058557625;3665.9816700916326;3689.2805902848954;69161.92514224531;88483.55758221232;91743.24673004751;92758.53620731921;94348;10061.446620435947;10200.591976321013;10336.779588634316;10481.633142839964;10656.25406221557;19859.503512412306;20129.597408051755;20343;20372.981350932394;20408;7407.111146662435;7417.888731669029;7424.665890034961;7445.7766267012075;7495.850082998419;4167.812448439828;4218.8523401681405;4256.233877901946;4329.458817647794;4403.515613282536;2883.8269703817837;2965.620986241408;2978;2981.3292009297734;2995.326051638364;578.9044807606698;597.4592993341033;606.6269244414653;635.6376865186799;641.355437785023;615.806021103351;631.8199313195718;643.8132941447021;656.7307403964352;664.3489380407228;8726.781830454289;8761.605727742266;8896.196143491516;8955.104489551122;8986.14631610009;536.9946300537023;613.5459759777732;653.8921078022073;667.4560233409755;669.4844969373653;3775.3581891078034;4245.702800803914;4340.978295108567;4375.299952007664;4459.710118842329;79366;86157.13842861491;103253;110747.44626276816;110812.4459377698;66701;85622.71565926516;85786;95364;101025.49487252516;69036.309636904;81836;83032.58483707542;85342.29315413657;87221.06694393427;9418.434893906388;9671;9692.224622030362;9700.75748106303;9709.854352184582;40444.595554044085;48343.5165648339;54358.45641543534;57114.42885571091;57161.85676286534;60526;75587.86618200621;75604;77037.4592508158;79124.20875791168;9949.452780097165;11960.222585531912;12395.256284622952;12795.61613151607;12841.229526228457;13387.933060334635;13631.667825568926;13935.58193254204;14052;14440.277986100864;12967.22196668203;13254.873335766568;13327.333633318489;13335.533256335983;13430.597082087554;10630.787384252426;12937.900278476434;13139.474421023053;13302.268375239068;13399.531016414769;12676.112672113233;12904.41930113166;12952.86248905166;13060.804087938499;13259.403326850123;11057.391843448366;11067.557297708323;11245.493952771982;11374.260673056226;11599.420028998686;11000.834987475035;11256.549738010388;11445.370504622326;11450.37022963745;11483.081353491534 12:48:55 INFO - PROCESS | 1635 | __end_tp_report 12:48:55 INFO - PROCESS | 1635 | __start_cc_report 12:48:55 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,2027 12:48:55 INFO - PROCESS | 1635 | __end_cc_report 12:48:55 INFO - PROCESS | 1635 | __startTimestamp1479502135797__endTimestamp 12:48:55 INFO - PROCESS | 1635 | 12:48:55 INFO - PROCESS | 1635 | ------- Summary: start ------- 12:48:55 INFO - PROCESS | 1635 | Number of tests: 6 12:48:55 INFO - PROCESS | 1635 | 12:48:55 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5673.42 Median:5859.41 stddev:670.71 (11.4%) stddev-sans-first:630.00 12:48:55 INFO - PROCESS | 1635 | Values: 2668.9 3145.9 3330.9 3347.4 3389.9 5566.6 5614.3 5690.4 5713.1 5726.2 5641.2 5651.0 5712.3 5737.2 5759.1 5103.6 5106.3 5148.4 5200.4 5238.9 5284.8 5306.0 5309.1 5314.0 5337.8 5101.2 5137.3 5197.0 5201.0 5255.6 5154.3 5185.8 5187.2 5209.6 5210.0 4332.6 5175.2 5189.2 5197.8 5205.2 5623.8 5676.9 5679.4 5681.5 5694.8 6002.3 6104.1 6114.5 6201.8 6207.8 6139.2 6181.4 6188.6 6240.3 6240.9 5673.9 5725.5 5741.4 5744.2 5758.3 6170.6 6183.4 6288.2 6308.6 6315.8 5934.4 6035.2 6043.8 6067.9 6095.9 6126.4 6144.5 6146.1 6148.5 6160.3 6105.8 6119.1 6146.8 6158.3 6163.0 6013.0 6064.6 6083.8 6143.7 6206.3 3658.6 4843.8 4874.0 4895.2 4906.4 4376.1 4389.6 4390.5 4401.4 4419.6 5526.3 5612.0 5687.5 5692.5 5705.9 6146.9 6163.8 6189.9 6193.8 6197.5 5600.7 5654.3 5655.8 5665.6 5671.3 5280.3 5332.1 5346.3 5347.9 5350.3 6272.4 6296.1 6306.0 6309.7 6315.8 6025.5 6177.0 6191.4 6203.3 6215.7 6273.6 6308.6 6310.6 6318.5 6320.9 6101.7 6113.6 6152.0 6172.9 6180.0 6209.4 6218.3 6230.9 6245.1 6253.7 4808.7 5830.1 5859.6 5936.6 6049.0 6020.1 6047.7 6061.1 6076.4 6114.4 5835.9 5871.4 5887.9 5891.4 5894.7 5885.1 5927.1 5944.3 6031.5 6080.0 5820.2 5833.7 5834.0 5837.6 5859.4 12:48:55 INFO - PROCESS | 1635 | 12:48:55 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:66545.13 Median:37336.25 stddev:143479.50 (384.3%) stddev-sans-first:143796.21 12:48:55 INFO - PROCESS | 1635 | Values: 463.4 482.5 497.6 503.9 525.2 27231.6 30628.9 31462.8 39176.4 40675.0 37379.4 38087.9 41188.0 41632.4 41643.8 9200.5 9379.4 9383.4 9396.3 9417.9 8431.5 8651.6 9262.9 11026.6 11344.4 11171.7 11226.6 11234.0 11235.8 11256.2 11211.8 11274.8 11304.6 11315.5 11330.6 8375.0 8605.5 10783.3 11108.4 11129.4 38716.6 39078.0 39091.0 39092.0 39280.8 3392.3 3598.6 3681.0 3839.1 3850.3 29156.9 29806.6 29971.3 30361.2 30715.8 3218.8 3280.2 3345.1 3382.1 3382.9 456804.0 459970.0 462074.0 462857.0 464567.0 58016.7 58392.0 58405.4 58415.0 58437.0 60781.0 60811.0 60826.1 60889.7 60975.7 15422.2 15620.5 15662.7 15674.6 15695.0 11070.3 12211.3 12258.6 12266.3 12272.4 14348.8 15882.8 16456.3 16495.0 16780.7 5897.4 6560.9 6645.4 6653.3 6686.9 891.9 958.5 962.4 969.7 988.8 27954.3 28702.7 28798.3 29440.9 29517.0 993.3 999.6 1012.8 1045.1 1088.6 14848.5 14894.1 15104.4 15179.1 15315.4 595194.0 598023.0 599583.0 599808.0 600223.0 48473.5 49542.8 54849.7 55930.0 56040.4 1296.0 1330.4 1348.3 1349.9 1354.7 24550.9 29170.6 29992.6 30175.4 30500.2 49474.3 49907.5 50015.7 50024.7 50125.0 541210.0 544376.0 544386.0 544873.0 545380.0 25205.6 25760.2 25830.0 37782.0 38107.0 38636.0 44560.8 44745.8 45711.8 45989.6 31298.2 35000.9 37293.1 37431.4 38531.6 31876.0 36736.8 37540.8 37833.2 38730.4 36150.3 36405.5 36881.1 37218.1 37588.0 32060.0 33374.8 33558.5 33623.7 33779.8 23394.6 23878.5 24307.5 25226.0 25241.9 12:48:55 INFO - PROCESS | 1635 | 12:48:55 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:32007.59 Median:20109.24 stddev:88102.42 (438.1%) stddev-sans-first:88317.51 12:48:55 INFO - PROCESS | 1635 | Values: 350.9 353.3 368.1 371.7 395.0 14823.7 15066.5 15903.4 19995.6 20516.9 15680.8 17739.6 19394.0 20313.3 20343.4 5586.9 5931.8 5935.2 5945.9 5946.7 4553.9 5770.5 5845.9 5894.3 5992.7 5966.1 5972.7 5990.4 5991.0 5993.3 5707.1 5846.5 5909.6 5914.9 5922.3 5574.0 5579.7 5700.1 5707.4 5711.7 12433.4 12547.3 12624.9 12712.9 12717.6 2234.2 2285.4 2300.7 2329.7 2752.2 9589.1 10066.0 10192.7 11427.6 15215.8 1755.6 1792.5 1835.6 1858.4 1896.7 94063.5 97506.0 104719.0 113598.4 125722.0 8767.5 10538.7 11111.2 11115.7 11313.7 14110.6 14150.4 14155.0 14157.4 14165.1 7421.2 7703.6 7709.5 7794.5 7829.8 7385.0 7393.4 7521.5 7529.7 7533.9 4292.3 4371.0 4376.3 4399.0 4441.3 1721.1 1826.9 1873.1 1875.5 1879.2 751.4 754.7 860.5 933.7 979.7 18805.7 19751.3 19796.9 20222.9 20617.2 943.7 952.2 962.4 981.2 1001.7 10279.3 10783.0 10804.2 10923.5 10928.4 450607.0 466051.7 565626.0 566335.0 566686.0 91546.0 103004.0 118673.0 131280.0 133918.0 1011.6 1019.5 1032.1 1086.9 1094.2 17844.5 18651.5 18717.4 18752.0 18757.8 54168.2 55138.0 55943.4 56447.0 57151.7 80910.2 80966.0 81709.6 82094.3 83224.6 7798.2 7891.9 7967.8 8029.4 11387.5 11076.4 11524.3 11550.6 11928.0 12461.0 10920.7 11246.6 11630.3 11657.4 11704.1 10296.4 11072.2 11271.0 11493.0 11607.0 10997.4 11259.9 11457.0 11677.9 11729.9 11670.8 11772.0 11996.4 12040.0 12159.6 9444.5 11164.4 11531.5 11611.5 11711.0 12:48:55 INFO - PROCESS | 1635 | 12:48:55 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5352.04 Median:4864.78 stddev:2938.99 (60.4%) stddev-sans-first:2932.95 12:48:55 INFO - PROCESS | 1635 | Values: 1495.8 1521.4 1699.2 1824.4 1866.9 7925.4 8368.5 8373.0 8373.6 8376.7 7313.4 7606.0 7612.8 7911.0 8115.3 2292.0 2327.2 2329.0 2330.3 2333.7 2321.0 2355.5 2362.8 2369.8 2373.6 2296.4 2308.6 2333.3 2337.9 2347.1 2290.5 2303.0 2317.8 2318.3 2330.4 2316.0 2333.1 2336.4 2340.4 2345.8 8011.1 8192.5 8203.8 8204.7 8207.6 4959.8 5134.0 5134.2 5135.8 5137.6 3223.8 3356.0 3449.9 3550.9 3568.0 993.4 1041.3 1070.4 1083.1 1089.0 10530.6 10659.3 10679.8 10682.6 10691.3 4356.2 4486.5 4572.2 4581.8 4633.8 8112.3 8828.9 9129.0 9147.8 9160.9 5085.4 5097.3 5104.0 5104.2 5109.4 4226.3 4380.1 4442.6 4679.0 4681.8 3047.4 3157.6 3682.9 3745.7 3784.6 1063.7 1246.6 1254.9 1255.2 1269.7 828.3 828.9 840.3 844.8 941.3 5481.0 5554.5 5564.2 5660.8 5776.9 428.4 443.3 445.2 446.2 449.3 3165.4 3785.6 3919.8 3989.8 4005.4 9686.8 10077.2 10091.3 10093.5 10120.3 10029.7 10037.5 10051.8 10053.5 10059.1 7491.0 7668.7 7685.5 7738.8 7745.5 5323.6 5340.9 5664.5 5691.7 5705.5 9179.1 9254.4 9382.5 9394.4 9410.8 8404.9 9380.9 9389.2 9430.3 9433.3 6516.6 6740.5 7011.1 7171.3 7180.2 7472.7 7561.0 7685.3 7812.0 7891.1 6972.1 7049.0 7058.1 7133.6 7233.9 6879.3 6945.3 6948.7 6997.9 7012.5 6469.6 6523.1 6596.1 6620.8 6629.7 4623.7 4708.9 4709.4 4741.1 4861.5 4733.4 4827.4 4846.5 4868.1 4868.7 12:48:55 INFO - PROCESS | 1635 | 12:48:55 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4298.97 Median:4747.62 stddev:1316.56 (27.7%) stddev-sans-first:1285.48 12:48:55 INFO - PROCESS | 1635 | Values: 294.4 297.8 306.6 312.1 312.3 4149.8 4200.0 5172.9 5241.8 5284.0 4295.9 4600.7 5083.8 5083.9 5099.6 3389.5 3864.6 3950.8 3952.0 4022.8 3496.9 3677.0 4028.9 4033.7 4063.3 3270.6 3912.7 3979.5 4031.3 4042.4 3834.0 3840.6 3994.6 4005.9 4009.9 3131.7 3434.2 3485.5 3490.8 3513.9 4488.0 4899.9 5119.5 5149.0 5226.2 4526.6 4555.7 4581.5 4591.3 4662.7 4736.3 5500.8 5501.9 5504.5 5518.8 3206.6 3845.8 3850.6 3868.9 3886.9 5361.0 5575.0 5651.4 5816.8 5840.2 3260.3 3769.7 3900.7 3920.8 3925.6 3362.7 3579.1 3615.6 3793.8 4012.6 4347.0 4348.0 4559.6 4567.0 4612.3 4589.3 5527.5 5529.7 5533.5 5543.0 1107.7 1236.4 1282.9 1297.6 1304.3 691.8 731.8 770.5 862.6 863.8 4519.6 4644.0 4891.5 5168.5 5214.0 4758.9 5071.2 5160.4 5309.4 5336.6 3951.1 4514.9 4678.2 5015.5 5156.3 2207.6 2386.2 2531.4 2647.8 2676.3 4532.8 4957.8 5357.8 5570.6 5599.2 4309.5 5009.9 5123.4 5334.9 5516.1 4539.6 4567.3 4773.3 5575.8 5576.9 4593.5 5007.3 5074.9 5375.0 5401.9 4949.1 5290.4 5321.0 5333.0 5339.9 4868.9 5131.5 5577.9 5599.9 5617.8 3144.7 3244.9 3448.4 3647.2 3697.9 4813.4 5176.7 5336.8 5336.8 5394.9 4957.4 5121.5 5136.0 5180.3 5212.6 4512.0 5145.9 5151.4 5176.5 5177.8 4330.6 4944.5 5138.3 5473.0 5488.3 4621.7 5326.8 5404.7 5419.1 5562.6 4334.6 5042.4 5250.6 5331.5 5361.1 12:48:55 INFO - PROCESS | 1635 | 12:48:55 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:19817.63 Median:4358.14 stddev:28324.52 (649.9%) stddev-sans-first:28367.41 12:48:55 INFO - PROCESS | 1635 | Values: 649.0 740.6 770.3 786.1 793.4 13857.4 15754.6 16334.5 16591.7 16623.3 15022.5 15288.0 15455.5 15519.2 15720.9 822.4 844.0 844.2 846.1 846.3 658.0 677.2 799.5 828.2 831.1 722.6 870.1 876.1 876.6 877.4 871.9 873.7 874.1 874.2 874.9 502.7 519.4 520.5 647.7 648.6 12181.3 12226.0 13875.0 14422.4 14432.1 13011.0 13208.7 13359.4 13376.8 13543.0 11002.0 11229.1 11279.4 11332.7 11714.1 3601.1 3630.6 3659.9 3666.0 3689.3 69161.9 88483.6 91743.2 92758.5 94348.0 10061.4 10200.6 10336.8 10481.6 10656.3 19859.5 20129.6 20343.0 20373.0 20408.0 7407.1 7417.9 7424.7 7445.8 7495.9 4167.8 4218.9 4256.2 4329.5 4403.5 2883.8 2965.6 2978.0 2981.3 2995.3 578.9 597.5 606.6 635.6 641.4 615.8 631.8 643.8 656.7 664.3 8726.8 8761.6 8896.2 8955.1 8986.1 537.0 613.5 653.9 667.5 669.5 3775.4 4245.7 4341.0 4375.3 4459.7 79366.0 86157.1 103253.0 110747.4 110812.4 66701.0 85622.7 85786.0 95364.0 101025.5 69036.3 81836.0 83032.6 85342.3 87221.1 9418.4 9671.0 9692.2 9700.8 9709.9 40444.6 48343.5 54358.5 57114.4 57161.9 60526.0 75587.9 75604.0 77037.5 79124.2 9949.5 11960.2 12395.3 12795.6 12841.2 13387.9 13631.7 13935.6 14052.0 14440.3 12967.2 13254.9 13327.3 13335.5 13430.6 10630.8 12937.9 13139.5 13302.3 13399.5 12676.1 12904.4 12952.9 13060.8 13259.4 11057.4 11067.6 11245.5 11374.3 11599.4 11000.8 11256.5 11445.4 11450.4 11483.1 12:48:55 INFO - PROCESS | 1635 | -------- Summary: end -------- 12:48:55 INFO - PROCESS | 1635 | 12:48:56 INFO - TEST-INFO | 1635: exit 0 12:48:56 INFO - TEST-OK | dromaeo_css | took 1121518ms 12:48:56 INFO - TEST-START | kraken 12:48:56 INFO - operating with platform_type : mac_ 12:48:56 INFO - Initialising browser for kraken test... 12:48:56 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmptR_Czi/profile http://localhost:49235/getInfo.html) 12:48:59 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 12:48:59 INFO - PROCESS | 1645 | colorDepth:24 12:48:59 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 12:48:59 INFO - PROCESS | 1645 | __metrics 12:48:59 INFO - PROCESS | 1645 | 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" 12:48:59 INFO - PROCESS | 1645 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:49:00 INFO - TEST-INFO | 1645: exit 0 12:49:00 INFO - Browser initialized. 12:49:00 INFO - Running cycle 1/1 for kraken test... 12:49:00 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmptR_Czi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:49:12 INFO - PROCESS | 1646 | RSS: Main: 245403648 12:49:12 INFO - PROCESS | 1646 | 12:49:15 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 12:49:16 INFO - PROCESS | 1646 | RSS: Main: 294281216 12:49:16 INFO - PROCESS | 1646 | 12:49:18 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 12:49:19 INFO - PROCESS | 1646 | RSS: Main: 296271872 12:49:19 INFO - PROCESS | 1646 | 12:49:22 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 12:49:23 INFO - PROCESS | 1646 | RSS: Main: 386928640 12:49:23 INFO - PROCESS | 1646 | 12:49:25 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 12:49:26 INFO - PROCESS | 1646 | RSS: Main: 289071104 12:49:26 INFO - PROCESS | 1646 | 12:49:28 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:49:28 INFO - PROCESS | 1646 | RSS: Main: 293462016 12:49:28 INFO - PROCESS | 1646 | 12:49:31 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 12:49:32 INFO - PROCESS | 1646 | RSS: Main: 335437824 12:49:32 INFO - PROCESS | 1646 | 12:49:35 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 12:49:35 INFO - PROCESS | 1646 | RSS: Main: 337895424 12:49:35 INFO - PROCESS | 1646 | 12:49:38 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 12:49:39 INFO - PROCESS | 1646 | RSS: Main: 331886592 12:49:39 INFO - PROCESS | 1646 | 12:49:40 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:49:41 INFO - PROCESS | 1646 | RSS: Main: 310734848 12:49:41 INFO - PROCESS | 1646 | 12:49:43 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:49:43 INFO - PROCESS | 1646 | RSS: Main: 313786368 12:49:43 INFO - PROCESS | 1646 | 12:49:46 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:49:46 INFO - PROCESS | 1646 | RSS: Main: 315617280 12:49:46 INFO - PROCESS | 1646 | 12:49:49 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:49:50 INFO - PROCESS | 1646 | RSS: Main: 334061568 12:49:50 INFO - PROCESS | 1646 | 12:49:53 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:49:53 INFO - PROCESS | 1646 | RSS: Main: 327254016 12:49:53 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 12:49:55 INFO - PROCESS | 1646 | RSS: Main: 371015680 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | __start_tp_report 12:49:55 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 12:49:55 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 12:49:55 INFO - PROCESS | 1646 | |i|pagename|runs| 12:49:55 INFO - PROCESS | 1646 | |0;ai-astar;120;167;155;110;111;111;112;113;111;115 12:49:55 INFO - PROCESS | 1646 | |1;audio-beat-detection;161;113;114;148;111;112;112;111;143;118 12:49:55 INFO - PROCESS | 1646 | |2;audio-dft;184;181;183;183;183;181;181;180;181;182 12:49:55 INFO - PROCESS | 1646 | |3;audio-fft;78;59;59;85;61;58;60;57;82;59 12:49:55 INFO - PROCESS | 1646 | |4;audio-oscillator;89;71;92;69;68;69;91;68;69;93 12:49:55 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;88;86;88;85;87;84;88;86;87;84 12:49:55 INFO - PROCESS | 1646 | |6;imaging-darkroom;93;94;96;94;94;94;118;124;93;93 12:49:55 INFO - PROCESS | 1646 | |7;imaging-desaturate;88;85;86;88;84;87;87;87;86;84 12:49:55 INFO - PROCESS | 1646 | |8;json-parse-financial;54;54;53;54;54;56;55;54;55;55 12:49:55 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;73;67;80;74;73;70;70;72;71;74 12:49:55 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;89;88;88;89;77;90;98;75;97;75 12:49:55 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;152;148;150;150;150;148;149;150;189;152 12:49:55 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;173;175;173;175;174;174;174;175;171;171 12:49:55 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;67;68;69;67;68;68;67;67;67;67 12:49:55 INFO - PROCESS | 1646 | __end_tp_report 12:49:55 INFO - PROCESS | 1646 | __start_cc_report 12:49:55 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,2037 12:49:55 INFO - PROCESS | 1646 | __end_cc_report 12:49:55 INFO - PROCESS | 1646 | __startTimestamp1479502195974__endTimestamp 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | ------- Summary: start ------- 12:49:55 INFO - PROCESS | 1646 | Number of tests: 14 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:122.50 Median:114.00 stddev:20.69 (18.1%) stddev-sans-first:21.92 12:49:55 INFO - PROCESS | 1646 | Values: 120.0 167.0 155.0 110.0 111.0 111.0 112.0 113.0 111.0 115.0 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:116.00 stddev:18.82 (16.2%) stddev-sans-first:14.54 12:49:55 INFO - PROCESS | 1646 | Values: 161.0 113.0 114.0 148.0 111.0 112.0 112.0 111.0 143.0 118.0 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:181.90 Median:182.50 stddev:1.29 (0.7%) stddev-sans-first:1.12 12:49:55 INFO - PROCESS | 1646 | Values: 184.0 181.0 183.0 183.0 183.0 181.0 181.0 180.0 181.0 182.0 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:65.80 Median:60.50 stddev:11.12 (18.4%) stddev-sans-first:10.89 12:49:55 INFO - PROCESS | 1646 | Values: 78.0 59.0 59.0 85.0 61.0 58.0 60.0 57.0 82.0 59.0 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:80.00 stddev:11.56 (14.5%) stddev-sans-first:11.54 12:49:55 INFO - PROCESS | 1646 | Values: 89.0 71.0 92.0 69.0 68.0 69.0 91.0 68.0 69.0 93.0 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:1.57 (1.8%) stddev-sans-first:1.54 12:49:55 INFO - PROCESS | 1646 | Values: 88.0 86.0 88.0 85.0 87.0 84.0 88.0 86.0 87.0 84.0 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:99.30 Median:94.00 stddev:11.56 (12.3%) stddev-sans-first:12.03 12:49:55 INFO - PROCESS | 1646 | Values: 93.0 94.0 96.0 94.0 94.0 94.0 118.0 124.0 93.0 93.0 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:87.00 stddev:1.48 (1.7%) stddev-sans-first:1.41 12:49:55 INFO - PROCESS | 1646 | Values: 88.0 85.0 86.0 88.0 84.0 87.0 87.0 87.0 86.0 84.0 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:0.84 (1.5%) stddev-sans-first:0.88 12:49:55 INFO - PROCESS | 1646 | Values: 54.0 54.0 53.0 54.0 54.0 56.0 55.0 54.0 55.0 55.0 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:73.00 stddev:3.44 (4.7%) stddev-sans-first:3.64 12:49:55 INFO - PROCESS | 1646 | Values: 73.0 67.0 80.0 74.0 73.0 70.0 70.0 72.0 71.0 74.0 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:89.00 stddev:8.34 (9.4%) stddev-sans-first:8.80 12:49:55 INFO - PROCESS | 1646 | Values: 89.0 88.0 88.0 89.0 77.0 90.0 98.0 75.0 97.0 75.0 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:153.80 Median:150.00 stddev:12.44 (8.3%) stddev-sans-first:13.18 12:49:55 INFO - PROCESS | 1646 | Values: 152.0 148.0 150.0 150.0 150.0 148.0 149.0 150.0 189.0 152.0 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:174.00 stddev:1.51 (0.9%) stddev-sans-first:1.59 12:49:55 INFO - PROCESS | 1646 | Values: 173.0 175.0 173.0 175.0 174.0 174.0 174.0 175.0 171.0 171.0 12:49:55 INFO - PROCESS | 1646 | 12:49:55 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 12:49:55 INFO - PROCESS | 1646 | Values: 67.0 68.0 69.0 67.0 68.0 68.0 67.0 67.0 67.0 67.0 12:49:55 INFO - PROCESS | 1646 | -------- Summary: end -------- 12:49:55 INFO - PROCESS | 1646 | 12:49:57 INFO - TEST-INFO | 1646: exit 0 12:49:57 INFO - TEST-OK | kraken | took 60532ms 12:49:57 INFO - SUITE-END | took 1182s 12:49:57 INFO - Completed test suite (00:19:42) 12:49:57 INFO - javascript benchmark 12:49:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2668.933276668083, 3145.9370812583734, 3330.8834190803327, 3347.380734564105, 3389.9152521186966, 5566.610337276392, 5614.270144881165, 5690.374058853523, 5713.085906255, 5726.198332233485, 5641.153826925964, 5651.039323315036, 5712.285964254468, 5737.196792449061, 5759.10733836255, 5103.617228707862, 5106.310648062501, 5148.382194136709, 5200.401953775327, 5238.947610523903, 5284.788608455658, 5306.0, 5309.0709125903, 5313.9734301328635, 5337.786488540453, 5101.20931255656, 5137.33214682089, 5196.986587615416, 5200.97399513, 5255.5795536357, 5154.252633368178, 5185.818496352647, 5187.221916712486, 5209.60927930403, 5210.01009808139, 4332.566743325674, 5175.197844334134, 5189.1697328427645, 5197.766100525486, 5205.193195054735, 5623.7786074500755, 5676.886462270772, 5679.432056794329, 5681.545476361881, 5694.77220911163, 6002.339742628307, 6104.053871649901, 6114.480269177126, 6201.813945581594, 6207.844803879894, 6139.154842350791, 6181.412765787243, 6188.628682279078, 6240.282367527747, 6240.937590624127, 5673.914891276675, 5725.484706376446, 5741.425857414309, 5744.224529688522, 5758.337791154029, 6170.629762214281, 6183.443490085914, 6288.213973253343, 6308.558400911984, 6315.810525684236, 5934.376890426443, 6035.245594300713, 6043.788467403708, 6067.908981365283, 6095.908561371583, 6126.356732543019, 6144.477719393813, 6146.078088286793, 6148.508119350441, 6160.260768707783, 6105.755769769248, 6119.122507065663, 6146.815595532141, 6158.322584515699, 6163.044728067157, 6013.0, 6064.575479716465, 6083.7566497340495, 6143.662098584621, 6206.286277078104, 3658.560972683295, 4843.75781210938, 4874.025194961022, 4895.241237608177, 4906.411230652345, 4376.146651402946, 4389.561043895585, 4390.517043125254, 4401.449818772653, 4419.624331931822, 5526.253955716007, 5612.0, 5687.488126068673, 5692.48767610917, 5705.885882282331, 6146.8935591593945, 6163.7842675506145, 6189.938100618936, 6193.845153871099, 6197.4732147767945, 5600.719964001783, 5654.3497497788285, 5655.830325090254, 5665.6034077614995, 5671.291088613923, 5280.313559237275, 5332.120200167006, 5346.278252435949, 5347.893042139135, 5350.250964864922, 6272.40412160844, 6296.118543404019, 6305.959516679696, 6309.652969086745, 6315.810525684236, 6025.517958563392, 6176.969115154396, 6191.380861913773, 6203.31763506005, 6215.689215539295, 6273.560850740404, 6308.558400911892, 6310.6213627182515, 6318.494520438446, 6320.905186422299, 6101.725422355916, 6113.57204995646, 6152.046432802923, 6172.9074063889975, 6180.042093475518, 6209.379062093754, 6218.284897236876, 6230.937690623217, 6245.0632405139595, 6253.6560489173535, 4808.711477311233, 5830.067189249869, 5859.648421094577, 5936.584439089395, 6048.969755151196, 6020.066889632114, 6047.697615119315, 6061.121137434959, 6076.392360763888, 6114.449699527064, 5835.854103647443, 5871.442212989759, 5887.911681324698, 5891.410858914074, 5894.734736936763, 5885.117232415172, 5927.110933360031, 5944.346121926498, 6031.5476339273855, 6080.027195648852, 5820.185174075717, 5833.67914764692, 5833.970830145822, 5837.591368604157, 5859.414058594277], "value": 5627.740684792084, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.4022111476196, 482.45241650726416, 497.56214531212527, 503.8513638476649, 525.1859617592731, 27231.591526127126, 30628.92798752044, 31462.842685786567, 39176.41235381472, 40675.0, 37379.439308410394, 38087.85736427904, 41187.9703007425, 41632.37551436731, 41643.79178104105, 9200.493972831508, 9379.437233765995, 9383.43699378036, 9396.34225604208, 9417.905820941805, 8431.451955622895, 8651.567421628924, 9262.907370926272, 11026.614068507604, 11344.43277836105, 11171.66485005451, 11226.550937962471, 11234.045106165944, 11235.775284494306, 11256.212065155443, 11211.831822522628, 11274.774504509905, 11304.604338848183, 11315.490802913888, 11330.60342887995, 8374.958125209396, 8605.526696031715, 10783.299085559493, 11108.389038602874, 11129.387883666395, 38716.61283387158, 39078.0, 39091.0, 39092.0, 39280.80359598212, 3392.3215356928713, 3598.5501812273465, 3680.9815950920074, 3839.1361943562756, 3850.3261929162563, 29156.854215728785, 29806.55290170649, 29971.25071873199, 30361.24096897573, 30715.846420767753, 3218.806871587712, 3280.1799550112473, 3345.063382252973, 3382.120648631349, 3382.864685412605, 456804.0, 459970.0, 462073.9999999966, 462857.0, 464567.0, 58016.70991645099, 58392.0, 58405.415945839995, 58415.0, 58437.0, 60781.0, 60811.0, 60826.087608685906, 60889.69555152285, 60975.695121524106, 15422.228888555528, 15620.531384058497, 15662.686746265012, 15674.608134796494, 15694.979826311253, 11070.335779853234, 12211.26732396059, 12258.570950016885, 12266.26402415858, 12272.38638068093, 14348.784768228485, 15882.841171588367, 16456.341746330014, 16495.010299382076, 16780.748288775434, 5897.410258974069, 6560.9343906560325, 6645.401913827779, 6653.2681405045405, 6686.866262674719, 891.9197272245399, 958.5399008475971, 962.4273557233574, 969.6896992962185, 988.7676396046924, 27954.301142471602, 28702.71297287042, 28798.280042999093, 29440.852795735886, 29517.0, 993.3443927008284, 999.5601935148511, 1012.7771890184148, 1045.1220974381556, 1088.6135421925103, 14848.480303189337, 14894.106353618818, 15104.351432240244, 15179.089254644536, 15315.387384504495, 595194.0, 598023.0, 599583.0, 599808.0, 600223.0, 48473.51526484761, 49542.75228623834, 54849.725751371785, 55930.0, 56040.43959560434, 1295.9676008099873, 1330.4345653097396, 1348.3325753751956, 1349.9190048597115, 1354.6884216630033, 24550.877245613658, 29170.56244156382, 29992.550111747903, 30175.351200557587, 30500.237494062825, 49474.25788613246, 49907.50092499029, 50015.749921250164, 50024.74987625039, 50125.0, 541210.0, 544376.0, 544386.0, 544873.0, 545380.0, 25205.621915670912, 25760.227193184233, 25830.0, 37782.0, 38107.0, 38636.0, 44560.77719611381, 44745.77627111843, 45711.771441142584, 45989.62031139071, 31298.21754456157, 35000.94997150089, 37293.06767330838, 37431.43852842155, 38531.61468385392, 31876.043718688477, 36736.81631591825, 37540.81229593835, 37833.243335133695, 38730.41904371493, 36150.27699446049, 36405.45391819178, 36881.07797305089, 37218.06954826043, 37588.0, 32060.038198854072, 33374.833125834215, 33558.49662255019, 33623.663763362056, 33779.831100845324, 23394.605394605394, 23878.494167020697, 24307.513849723262, 25226.0, 25241.87379063093], "value": 19476.176110147135, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.85614897891867, 353.2934131736527, 368.123865200822, 371.6989238716639, 394.9960500394995, 14823.703525929475, 15066.548003559898, 15903.363865445383, 19995.60008799823, 20516.89741551294, 15680.843191568081, 17739.55651108723, 19394.03029848509, 20313.289034883783, 20343.389698309038, 5586.888262234763, 5931.843290558343, 5935.198748168985, 5945.940540594604, 5946.672932988684, 4553.931691024621, 5770.538356931435, 5845.912311315334, 5894.263217097863, 5992.7303271352675, 5966.134910437984, 5972.701364931736, 5990.430909063632, 5991.041433370661, 5993.340732519419, 5707.14392841073, 5846.473817356416, 5909.556783241274, 5914.881702365971, 5922.3485416604135, 5574.032459425718, 5579.6652200868075, 5700.059490184115, 5707.429257074301, 5711.742971566289, 12433.440495177738, 12547.309897955609, 12624.873751262554, 12712.872871271262, 12717.554885579053, 2234.2068565659283, 2285.371522831218, 2300.7009088818345, 2329.743728189898, 2752.2018614601743, 9589.136977671973, 10066.0, 10192.694219173436, 11427.600033998853, 15215.771763423558, 1755.6400937807718, 1792.5429015601069, 1835.6420498002894, 1858.3960212930851, 1896.6680830854684, 94063.52968235183, 97506.04987900273, 104718.95281047244, 113598.43200784025, 125722.0, 8767.517786521676, 10538.73653158662, 11111.222214444912, 11115.665300409844, 11313.660590182308, 14110.64723381903, 14150.36323365451, 14155.0, 14157.433702651984, 14165.079269847633, 7421.183669796426, 7703.614819259014, 7709.4603377763015, 7794.454388192772, 7829.765107046797, 7385.0, 7393.445491588152, 7521.4734968551675, 7529.736459223901, 7533.924660753432, 4292.313229883266, 4370.956290437119, 4376.343548467756, 4398.956010439919, 4441.311596702516, 1721.1222276638755, 1826.8995205263573, 1873.1289950172963, 1875.4561177258443, 1879.2013394307364, 751.3988808952926, 754.6906117885464, 860.4880096342666, 933.6545478173119, 979.7207795778169, 18805.717914231023, 19751.308704195286, 19796.90101549483, 20222.887741174378, 20617.175312987612, 943.7451887990204, 952.1668540027476, 962.4465932089076, 981.1562056631292, 1001.6844693921537, 10279.291857755448, 10783.042492749519, 10804.163381482944, 10923.453827308762, 10928.398938058324, 450607.0, 466051.68819091166, 565626.0, 566335.0, 566686.0, 91546.0, 103004.0, 118673.0, 131280.0, 133918.0, 1011.6155860772859, 1019.5463018956641, 1032.1123833503182, 1086.9239153259196, 1094.1520321750706, 17844.464666060037, 18651.533711657317, 18717.438476845717, 18752.0, 18757.78074425158, 54168.187477188665, 55138.0, 55943.440565593824, 56447.0, 57151.714241428526, 80910.19089809027, 80966.0, 81709.59145204235, 82094.32773739376, 83224.58387708022, 7798.220177982156, 7891.881621775793, 7967.760967170994, 8029.357651387758, 11387.544498219979, 11076.446177690923, 11524.308541487537, 11550.59572914944, 11928.0, 12461.003119750218, 10920.672379828618, 11246.606368777053, 11630.302181869114, 11657.358845263592, 11704.122190835891, 10296.382217067, 11072.224944253825, 11271.0, 11493.023093037185, 11607.0, 10997.395143267197, 11259.887401126212, 11457.0, 11677.941610291895, 11729.941350293195, 11670.824937626112, 11772.0, 11996.400179990791, 12040.03679705604, 12159.574414895436, 9444.527773611155, 11164.385958772345, 11531.481083351437, 11611.5355385787, 11711.0], "value": 9272.10582283706, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.760678291473, 1521.4294639510183, 1699.2353440951567, 1824.379710898296, 1866.9253229870806, 7925.365970722342, 8368.49789012659, 8372.958135209323, 8373.623186956587, 8376.706815261467, 7313.414926805856, 7606.0, 7612.809679757995, 7910.96044519778, 8115.269625733683, 2292.048799748107, 2327.1505900346338, 2328.9534209315802, 2330.3358542815217, 2333.708286464192, 2320.9651855222187, 2355.5406695694346, 2362.787349138577, 2369.763023697634, 2373.596488596943, 2296.4258935266184, 2308.6421604651223, 2333.276684227886, 2337.9298621041394, 2347.108098922407, 2290.461741490765, 2303.021215983209, 2317.7566355532595, 2318.3160967514623, 2330.4290448840143, 2316.0388438798045, 2333.1484008337006, 2336.380859072347, 2340.4499942513494, 2345.788879000881, 8011.118776934532, 8192.467489613216, 8203.794905127359, 8204.712835050745, 8207.630656620466, 4959.82640607577, 5133.974330128362, 5134.204198349262, 5135.794568217267, 5137.5633071188995, 3223.8065716056876, 3356.009977056774, 3449.913752156191, 3550.8757193498104, 3567.9643203567894, 993.4089216915924, 1041.3387498938152, 1070.4326706845384, 1083.1443159903667, 1088.9509972051276, 10530.578776848917, 10659.253852230348, 10679.83980240297, 10682.572697092108, 10691.30506517074, 4356.215881141362, 4486.506484286726, 4572.222722137245, 4581.770911454414, 4633.791479383436, 8112.269895709414, 8828.85224920769, 9128.995810460843, 9147.81704365909, 9160.908390916005, 5085.364329458817, 5097.260897169964, 5103.97448012765, 5104.234364845229, 5109.4379618241965, 4226.281532139544, 4380.123975204971, 4442.622377097983, 4678.976605116953, 4681.81272749093, 3047.420990011891, 3157.605299337583, 3682.907927301785, 3745.7190710696805, 3784.564775050849, 1063.7181146996052, 1246.5948566715854, 1254.9184303020274, 1255.1590434408968, 1269.6571925580042, 828.3166387730147, 828.8881001064779, 840.306746933782, 844.8310337932315, 941.275218082073, 5481.0, 5554.472325129106, 5564.1931919871395, 5660.830175094671, 5776.942230577724, 428.43446650421146, 443.28409618465946, 445.24530920090785, 446.1500840898094, 449.3327408797932, 3165.3511030238747, 3785.6025117362833, 3919.8351007027973, 3989.7805620691142, 4005.4192142139227, 9686.806263874683, 10077.193824494023, 10091.293609447268, 10093.5457904393, 10120.291579589506, 10029.749256268506, 10037.548310326052, 10051.849222261671, 10053.49732513386, 10059.094681478555, 7491.0, 7668.65491052904, 7685.5004424712215, 7738.845223095619, 7745.457817952689, 5323.6273460857365, 5340.893182136258, 5664.518515926193, 5691.715414229189, 5705.543556515386, 9179.127982841619, 9254.35219534626, 9382.48396338208, 9394.389364691273, 9410.764730881783, 8404.915950840414, 9380.859287110563, 9389.154976052188, 9430.292728045286, 9433.339666223299, 6516.609003459807, 6740.460763138839, 7011.053507776385, 7171.318724721144, 7180.210176880643, 7472.738454154079, 7560.979267798777, 7685.346745526469, 7812.023497062867, 7891.092524359772, 6972.1284839395075, 7049.0, 7058.11773528309, 7133.5719856808755, 7233.927660723536, 6879.277675843964, 6945.305469453015, 6948.652567371712, 6997.860042799014, 7012.474064445289, 6469.611823290617, 6523.054157147282, 6596.076549283008, 6620.801375958729, 6629.668516574248, 4623.745693986729, 4708.929366059443, 4709.364235828257, 4741.146593613183, 4861.465238823797, 4733.36099626546, 4827.444843843003, 4846.491118432655, 4868.099401610713, 4868.683535570177], "value": 4279.373327106158, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.35536175775053, 297.8153544802223, 306.5554945329273, 312.10892900768306, 312.28330980399977, 4149.813258403372, 4199.958000419999, 5172.922406163911, 5241.8427447176555, 5284.044903385753, 4295.914081718363, 4600.7347979305705, 5083.771230294637, 5083.872903177423, 5099.566536844372, 3389.5254664347012, 3864.599152745594, 3950.7629542227414, 3951.996482673175, 4022.798860057, 3496.9300613987707, 3676.963230367702, 4028.879133625996, 4033.6571391431617, 4063.349864021757, 3270.6075270967517, 3912.7065470089715, 3979.542352629441, 4031.2945234583976, 4042.4138499917494, 3834.0223243073115, 3840.635139661728, 3994.6404823566018, 4005.859794907164, 4009.939850902239, 3131.65551789303, 3434.227298857737, 3485.5294535237927, 3490.7556471046782, 3513.877014304487, 4487.977560112178, 4899.92201715622, 5119.539241468248, 5149.0, 5226.216067589854, 4526.592606665416, 4555.74943378114, 4581.541845815392, 4591.288350305708, 4662.696924699883, 4736.313234580966, 5500.789826238221, 5501.927124210781, 5504.504594586507, 5518.834434966958, 3206.599175103112, 3845.769353806783, 3850.5956874528333, 3868.903277418087, 3886.863959761423, 5361.035013697533, 5575.024370735106, 5651.434856514356, 5816.796412125555, 5840.182374467578, 3260.3153337799326, 3769.6984241260634, 3900.7464514806447, 3920.843166273317, 3925.5878132795647, 3362.7309815214726, 3579.067303656049, 3615.620359862229, 3793.785988483659, 4012.6388625023887, 4346.978265108654, 4347.956430498663, 4559.635229181657, 4567.0, 4612.30815377696, 4589.30195827546, 5527.50252477279, 5529.723513824373, 5533.501984821385, 5543.0067763408115, 1107.7009207513927, 1236.4003458322707, 1282.8524719657173, 1297.5791508298398, 1304.2696090189525, 691.7544271783445, 731.7877815433571, 770.4645271536341, 862.5514732339149, 863.8401895649325, 4519.593236608721, 4644.047970166108, 4891.52977746243, 5168.53483186515, 5213.973930130401, 4758.928616070762, 5071.188609822484, 5160.354955630546, 5309.389615061717, 5336.599755018389, 3951.0714981979213, 4514.88712782183, 4678.198893426055, 5015.523525265094, 5156.303898973665, 2207.59372284211, 2386.246109109803, 2531.354504601315, 2647.8411295321957, 2676.2907829425217, 4532.79602417892, 4957.801687932514, 5357.812476563302, 5570.5516565693215, 5599.216109744639, 4309.500489715957, 5009.874753131128, 5123.436421993578, 5334.906344199429, 5516.07647946589, 4539.6368290536675, 4567.269236922077, 4773.307870358779, 5575.776968921279, 5576.86057848557, 4593.530070377447, 5007.349044624176, 5074.873128171677, 5375.001248838461, 5401.891962160814, 4949.139671056581, 5290.391604965324, 5321.0, 5333.040052790535, 5339.946600533945, 4868.878278043077, 5131.536213056098, 5577.932137324374, 5599.948028324491, 5617.775288988558, 3144.6698096699515, 3244.8539815708823, 3448.396530607184, 3647.176411794103, 3697.8705745298785, 4813.3983252093485, 5176.696370115413, 5336.786528538815, 5336.839894803162, 5394.9460505394445, 4957.380327459067, 5121.462246464068, 5136.0, 5180.326557547494, 5212.582993360598, 4511.954880451153, 5145.871353216199, 5151.381834179922, 5176.482351764794, 5177.792888284426, 4330.610245077958, 4944.456109827988, 5138.332016837787, 5472.972635136799, 5488.313960754906, 4621.712252435066, 5326.828097818474, 5404.675854415694, 5419.078756611307, 5562.638428502134, 4334.566543345641, 5042.39491261051, 5250.606204534752, 5331.546818520314, 5361.142217245222], "value": 3878.131066546979, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.9870202595948, 740.5926740292841, 770.3336613829036, 786.1054857792719, 793.357380521777, 13857.445702171914, 15754.606134846634, 16334.509964701077, 16591.66816663666, 16623.2519536621, 15022.474213402533, 15288.0, 15455.53633391, 15519.224038798071, 15720.921395393007, 822.3832125905586, 843.9789005274887, 844.2401838345477, 846.0735494633398, 846.2975730143996, 657.9967100164516, 677.1738479055545, 799.5003123048095, 828.1511450762956, 831.1356189562847, 722.5953466058997, 870.1342164546254, 876.0626130040858, 876.6099085906774, 877.385829919056, 871.8822958900562, 873.7466134820894, 874.0822136756444, 874.208840998897, 874.8818909447207, 502.66070402478545, 519.3819354967577, 520.4769206947032, 647.6891092275687, 648.6302807399784, 12181.269123852597, 12226.0, 13875.028747987644, 14422.35099420518, 14432.134071955716, 13010.966600353826, 13208.6697832554, 13359.398827052806, 13376.799348009788, 13542.998127285115, 11002.0, 11229.101671866312, 11279.436028198557, 11332.716682083013, 11714.121440891968, 3601.0637234319265, 3630.6006339302658, 3659.8536058557625, 3665.9816700916326, 3689.2805902848954, 69161.92514224531, 88483.55758221232, 91743.24673004751, 92758.53620731921, 94348.0, 10061.446620435947, 10200.591976321013, 10336.779588634316, 10481.633142839964, 10656.25406221557, 19859.503512412306, 20129.597408051755, 20343.0, 20372.981350932394, 20408.0, 7407.111146662435, 7417.888731669029, 7424.665890034961, 7445.7766267012075, 7495.850082998419, 4167.812448439828, 4218.8523401681405, 4256.233877901946, 4329.458817647794, 4403.515613282536, 2883.8269703817837, 2965.620986241408, 2978.0, 2981.3292009297734, 2995.326051638364, 578.9044807606698, 597.4592993341033, 606.6269244414653, 635.6376865186799, 641.355437785023, 615.806021103351, 631.8199313195718, 643.8132941447021, 656.7307403964352, 664.3489380407228, 8726.781830454289, 8761.605727742266, 8896.196143491516, 8955.104489551122, 8986.14631610009, 536.9946300537023, 613.5459759777732, 653.8921078022073, 667.4560233409755, 669.4844969373653, 3775.3581891078034, 4245.702800803914, 4340.978295108567, 4375.299952007664, 4459.710118842329, 79366.0, 86157.13842861491, 103253.0, 110747.44626276816, 110812.4459377698, 66701.0, 85622.71565926516, 85786.0, 95364.0, 101025.49487252516, 69036.309636904, 81836.0, 83032.58483707542, 85342.29315413657, 87221.06694393427, 9418.434893906388, 9671.0, 9692.224622030362, 9700.75748106303, 9709.854352184582, 40444.595554044085, 48343.5165648339, 54358.45641543534, 57114.42885571091, 57161.85676286534, 60526.0, 75587.86618200621, 75604.0, 77037.4592508158, 79124.20875791168, 9949.452780097165, 11960.222585531912, 12395.256284622952, 12795.61613151607, 12841.229526228457, 13387.933060334635, 13631.667825568926, 13935.58193254204, 14052.0, 14440.277986100864, 12967.22196668203, 13254.873335766568, 13327.333633318489, 13335.533256335983, 13430.597082087554, 10630.787384252426, 12937.900278476434, 13139.474421023053, 13302.268375239068, 13399.531016414769, 12676.112672113233, 12904.41930113166, 12952.86248905166, 13060.804087938499, 13259.403326850123, 11057.391843448366, 11067.557297708323, 11245.493952771982, 11374.260673056226, 11599.420028998686, 11000.834987475035, 11256.549738010388, 11445.370504622326, 11450.37022963745, 11483.081353491534], "value": 7185.481408735271, "unit": "score"}], "name": "dromaeo_css", "value": 7034.837648178065, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 167.0, 155.0, 110.0, 111.0, 111.0, 112.0, 113.0, 111.0, 115.0], "value": 122.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 113.0, 114.0, 148.0, 111.0, 112.0, 112.0, 111.0, 143.0, 118.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 183.0, 183.0, 183.0, 181.0, 181.0, 180.0, 181.0, 182.0], "value": 181.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 59.0, 85.0, 61.0, 58.0, 60.0, 57.0, 82.0, 59.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 92.0, 69.0, 68.0, 69.0, 91.0, 68.0, 69.0, 93.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 85.0, 87.0, 84.0, 88.0, 86.0, 87.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 96.0, 94.0, 94.0, 94.0, 118.0, 124.0, 93.0, 93.0], "value": 99.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 86.0, 88.0, 84.0, 87.0, 87.0, 87.0, 86.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 54.0, 56.0, 55.0, 54.0, 55.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 67.0, 80.0, 74.0, 73.0, 70.0, 70.0, 72.0, 71.0, 74.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 88.0, 89.0, 77.0, 90.0, 98.0, 75.0, 97.0, 75.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 148.0, 150.0, 150.0, 150.0, 148.0, 149.0, 150.0, 189.0, 152.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 173.0, 175.0, 174.0, 174.0, 174.0, 175.0, 171.0, 171.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1452.3999999999999, "alertThreshold": 2.0}]} 12:49:57 INFO - Return code: 0 12:49:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:49:57 INFO - # TBPL SUCCESS # 12:49:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:49:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:49:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:49:57 INFO - 2016-11-18 12:49:57.278 screenresolution[1650:9588] starting screenresolution argv=screenresolution get 12:49:57 INFO - 2016-11-18 12:49:57.281 screenresolution[1650:9588] Display 0: 1600x1200x32@60 12:49:57 INFO - 2016-11-18 12:49:57.287 screenresolution[1651:9591] starting screenresolution argv=screenresolution list 12:49:57 INFO - Available Modes on Display 0 12:49:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:49:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:49:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:49:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:49:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:49:57 INFO - Intel Iris: 12:49:57 INFO - Chipset Model: Intel Iris 12:49:57 INFO - Type: GPU 12:49:57 INFO - Bus: Built-In 12:49:57 INFO - VRAM (Dynamic, Max): 1536 MB 12:49:57 INFO - Vendor: Intel (0x8086) 12:49:57 INFO - Device ID: 0x0a2e 12:49:57 INFO - Revision ID: 0x0009 12:49:57 INFO - Displays: 12:49:57 INFO - Display: 12:49:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:49:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:49:57 INFO - Display Serial Number: 1600x1200 60 12:49:57 INFO - Main Display: Yes 12:49:57 INFO - Mirror: Off 12:49:57 INFO - Online: Yes 12:49:57 INFO - Rotation: Supported 12:49:57 INFO - Return code: 0 12:49:57 INFO - Running post-action listener: _resource_record_post_action 12:49:57 INFO - [mozharness: 2016-11-18 20:49:57.533968Z] Finished run-tests step (success) 12:49:57 INFO - Running post-run listener: _resource_record_post_run 12:49:57 INFO - Total resource usage - Wall time: 1215s; CPU: 53.0%; Read bytes: 38913024; Write bytes: 689524224; Read time: 410; Write time: 1868 12:49:57 INFO - TinderboxPrint: CPU usage
53.4% 12:49:57 INFO - TinderboxPrint: I/O read bytes / time
38,913,024 / 410 12:49:57 INFO - TinderboxPrint: I/O write bytes / time
689,524,224 / 1,868 12:49:57 INFO - TinderboxPrint: CPU idle
2,265.1 (46.6%) 12:49:57 INFO - TinderboxPrint: CPU system
972.1 (20.0%) 12:49:57 INFO - TinderboxPrint: CPU user
1,624.5 (33.4%) 12:49:57 INFO - TinderboxPrint: Swap in / out
422,027,264 / 0 12:49:57 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 364530176; Write bytes: 357815808; Read time: 27346; Write time: 618 12:49:57 INFO - run-tests - Wall time: 1183s; CPU: 53.0%; Read bytes: 37921792; Write bytes: 304429056; Read time: 396; Write time: 1187 12:49:58 INFO - Running post-run listener: _upload_blobber_files 12:49:58 INFO - Blob upload gear active. 12:49:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:49:58 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 12:49:58 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:49:58 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:49:58 INFO - (blobuploader) - INFO - Open directory for files ... 12:49:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:49:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:49:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:49:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:49:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:49:59 INFO - (blobuploader) - INFO - Done attempting. 12:49:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:49:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:49:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:50:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:50:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:50:00 INFO - (blobuploader) - INFO - Done attempting. 12:50:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:50:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:50:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:50:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:50:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:50:02 INFO - (blobuploader) - INFO - Done attempting. 12:50:02 INFO - (blobuploader) - INFO - Iteration through files over. 12:50:03 INFO - Return code: 0 12:50:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:50:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:50:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cad112be05a6816c9a5abf49959ac333264e1929b00fe3d1d6095b7a59278fcb8b6bfd155848eef13a514d74536d636315dabff3b47341c37c68db31705aae0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1cb6d5f78b4436f2101249da7e7d009e5c37ea41591075be10343832f48347deba877ea44e232e7ece0ee17952ae5caed7ffaea26cb070fbc87737065052125", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9a11d472d17a22f2636c0434d2ed2145178645e22ff0a90019d76dfff9eb28def4d98e45c99721f5baeffecb9db50f5d0c6fe9b5e1093ae38feab2ff27fc7ba"} 12:50:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:50:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:50:03 INFO - Contents: 12:50:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cad112be05a6816c9a5abf49959ac333264e1929b00fe3d1d6095b7a59278fcb8b6bfd155848eef13a514d74536d636315dabff3b47341c37c68db31705aae0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1cb6d5f78b4436f2101249da7e7d009e5c37ea41591075be10343832f48347deba877ea44e232e7ece0ee17952ae5caed7ffaea26cb070fbc87737065052125", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9a11d472d17a22f2636c0434d2ed2145178645e22ff0a90019d76dfff9eb28def4d98e45c99721f5baeffecb9db50f5d0c6fe9b5e1093ae38feab2ff27fc7ba"} 12:50:03 INFO - Running post-run listener: copy_logs_to_upload_dir 12:50:03 INFO - Copying logs to upload dir... 12:50:03 INFO - mkdir: /builds/slave/test/build/upload/logs 12:50:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.398950 ========= master_lag: 0.56 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-18 12:50:03.589432) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 12:50:03.593449) ========= 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.zXP8bQDOQS/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.asDl2fqlQl/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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/Firefox/sha512/cad112be05a6816c9a5abf49959ac333264e1929b00fe3d1d6095b7a59278fcb8b6bfd155848eef13a514d74536d636315dabff3b47341c37c68db31705aae0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1cb6d5f78b4436f2101249da7e7d009e5c37ea41591075be10343832f48347deba877ea44e232e7ece0ee17952ae5caed7ffaea26cb070fbc87737065052125", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9a11d472d17a22f2636c0434d2ed2145178645e22ff0a90019d76dfff9eb28def4d98e45c99721f5baeffecb9db50f5d0c6fe9b5e1093ae38feab2ff27fc7ba"} build_url:https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010730 build_url: 'https://queue.taskcluster.net/v1/task/HactYvgcTA2YLBPAt_LRyA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cad112be05a6816c9a5abf49959ac333264e1929b00fe3d1d6095b7a59278fcb8b6bfd155848eef13a514d74536d636315dabff3b47341c37c68db31705aae0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1cb6d5f78b4436f2101249da7e7d009e5c37ea41591075be10343832f48347deba877ea44e232e7ece0ee17952ae5caed7ffaea26cb070fbc87737065052125", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9a11d472d17a22f2636c0434d2ed2145178645e22ff0a90019d76dfff9eb28def4d98e45c99721f5baeffecb9db50f5d0c6fe9b5e1093ae38feab2ff27fc7ba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 12:50:03.625569) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:50:03.625908) ========= 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.zXP8bQDOQS/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.asDl2fqlQl/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.005055 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:50:03.674937) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 12:50:03.675251) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 12:50:03.675575) ========= ========= Total master_lag: 0.70 =========