builder: larch_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0357 starttime: 1476229022.02 results: success (0) buildid: 20161011134948 builduid: edc2734193c9474da419c174d0d59e54 revision: 22a929d86e4db43d828efe54430a34c182b2dbc2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 16:37:02.019117) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 16:37:02.019644) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 16:37:02.019960) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 16:37:02.047921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 16:37:02.048482) ========= 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.jfq5dRdIpv/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.bBNcA279JH/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-11 16:37:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2016-10-11 16:37:02 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113297 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 16:37:02.185684) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 16:37:02.186043) ========= 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.jfq5dRdIpv/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.bBNcA279JH/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.026075 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 16:37:02.237208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 16:37:02.238182) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 22a929d86e4db43d828efe54430a34c182b2dbc2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 22a929d86e4db43d828efe54430a34c182b2dbc2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jfq5dRdIpv/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.bBNcA279JH/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-11 16:37:02,326 truncating revision to first 12 chars 2016-10-11 16:37:02,326 Setting DEBUG logging. 2016-10-11 16:37:02,326 attempt 1/10 2016-10-11 16:37:02,326 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/22a929d86e4d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 16:37:03,426 unpacking tar archive at: larch-22a929d86e4d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.378076 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 16:37:03.652080) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 16:37:03.652546) ========= script_repo_revision: 22a929d86e4db43d828efe54430a34c182b2dbc2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 16:37:03.653043) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 16:37:03.653489) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 16:37:03.672438) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-11 16:37:03.672780) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jfq5dRdIpv/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.bBNcA279JH/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:37:03 INFO - MultiFileLogger online at 20161011 16:37:03 in /builds/slave/test 16:37:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 16:37:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:37:03 INFO - {'append_to_log': False, 16:37:03 INFO - 'base_work_dir': '/builds/slave/test', 16:37:03 INFO - 'blob_upload_branch': 'Larch', 16:37:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:37:03 INFO - 'branch': 'Larch', 16:37:03 INFO - 'buildbot_json_path': 'buildprops.json', 16:37:03 INFO - 'config_files': ('talos/mac_config.py',), 16:37:03 INFO - 'default_actions': ('clobber', 16:37:03 INFO - 'read-buildbot-config', 16:37:03 INFO - 'download-and-extract', 16:37:03 INFO - 'populate-webroot', 16:37:03 INFO - 'create-virtualenv', 16:37:03 INFO - 'install', 16:37:03 INFO - 'run-tests'), 16:37:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:37:03 INFO - 'download_minidump_stackwalk': True, 16:37:03 INFO - 'download_symbols': 'ondemand', 16:37:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:37:03 INFO - 'tooltool.py': '/tools/tooltool.py', 16:37:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:37:03 INFO - '/tools/misc-python/virtualenv.py')}, 16:37:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:37:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:37:03 INFO - 'installer_path': 'installer.exe', 16:37:03 INFO - 'log_level': 'info', 16:37:03 INFO - 'log_name': 'talos', 16:37:03 INFO - 'log_to_console': True, 16:37:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:37:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:37:03 INFO - 'opt_config_files': (), 16:37:03 INFO - 'pip_index': False, 16:37:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:37:03 INFO - 'cmd': ('bash', 16:37:03 INFO - '-c', 16:37:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:37:03 INFO - 'enabled': True, 16:37:03 INFO - 'halt_on_failure': False, 16:37:03 INFO - 'name': 'check_screen_resolution'},), 16:37:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:37:03 INFO - 'cmd': ('bash', 16:37:03 INFO - '-c', 16:37:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:37:03 INFO - 'enabled': True, 16:37:03 INFO - 'halt_on_failure': False, 16:37:03 INFO - 'name': 'check_screen_resolution'},), 16:37:03 INFO - 'run_cmd_checks_enabled': True, 16:37:03 INFO - 'sps_profile': False, 16:37:03 INFO - 'sps_profile_interval': 0, 16:37:03 INFO - 'suite': 'dromaeojs', 16:37:03 INFO - 'system_bits': '32', 16:37:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:37:03 INFO - 'title': 't-yosemite-r7-0357', 16:37:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:37:03 INFO - 'use_talos_json': True, 16:37:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:37:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:37:03 INFO - 'work_dir': 'build'} 16:37:03 INFO - [mozharness: 2016-10-11 23:37:03.899641Z] Running clobber step. 16:37:03 INFO - Running pre-action listener: _resource_record_pre_action 16:37:03 INFO - Running main action method: clobber 16:37:03 INFO - rmtree: /builds/slave/test/build 16:37:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:37:05 INFO - Running post-action listener: _resource_record_post_action 16:37:05 INFO - [mozharness: 2016-10-11 23:37:05.984219Z] Finished clobber step (success) 16:37:05 INFO - [mozharness: 2016-10-11 23:37:05.984344Z] Running read-buildbot-config step. 16:37:05 INFO - Running pre-action listener: _resource_record_pre_action 16:37:05 INFO - Running main action method: read_buildbot_config 16:37:05 INFO - Using buildbot properties: 16:37:05 INFO - { 16:37:05 INFO - "project": "", 16:37:05 INFO - "product": "firefox", 16:37:05 INFO - "script_repo_revision": "production", 16:37:05 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs", 16:37:05 INFO - "repository": "", 16:37:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs", 16:37:05 INFO - "buildid": "20161011134948", 16:37:05 INFO - "pgo_build": "False", 16:37:05 INFO - "basedir": "/builds/slave/test", 16:37:05 INFO - "buildnumber": 0, 16:37:05 INFO - "slavename": "t-yosemite-r7-0357", 16:37:05 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:37:05 INFO - "platform": "yosemite_r7", 16:37:05 INFO - "scheduler": "tests-larch-macosx64-talos", 16:37:05 INFO - "branch": "larch", 16:37:05 INFO - "repo_path": "projects/larch", 16:37:05 INFO - "revision": "22a929d86e4db43d828efe54430a34c182b2dbc2", 16:37:05 INFO - "stage_platform": "macosx64", 16:37:05 INFO - "builduid": "edc2734193c9474da419c174d0d59e54", 16:37:05 INFO - "slavebuilddir": "test" 16:37:05 INFO - } 16:37:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 16:37:05 INFO - Running post-action listener: _resource_record_post_action 16:37:05 INFO - [mozharness: 2016-10-11 23:37:05.987663Z] Finished read-buildbot-config step (success) 16:37:05 INFO - [mozharness: 2016-10-11 23:37:05.987782Z] Running download-and-extract step. 16:37:05 INFO - Running pre-action listener: _resource_record_pre_action 16:37:05 INFO - Running main action method: download_and_extract 16:37:05 INFO - mkdir: /builds/slave/test/build/tests 16:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:05 INFO - trying https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 16:37:05 INFO - Downloading https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 16:37:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 16:37:07 INFO - Downloaded 1199 bytes. 16:37:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 16:37:07 INFO - Using the following test package requirements: 16:37:07 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:37:07 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:37:07 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 16:37:07 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:37:07 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 16:37:07 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:37:07 INFO - u'jsshell-mac.zip'], 16:37:07 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:37:07 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 16:37:07 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:37:07 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:37:07 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 16:37:07 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:37:07 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 16:37:07 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:37:07 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 16:37:07 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:37:07 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 16:37:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:37:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:37:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:37:07 INFO - Fetch https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:37:07 INFO - Http code: 200 16:37:07 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 16:37:07 INFO - x-amz-cf-id: _VppCeR-65XHlEXi7q-Axd9Qzem88LQnPt0sZCiLyMugyAKiVge-FA== 16:37:07 INFO - x-amz-version-id: j5M661kXta2fqnPkcRdPt9sSz6cH0usF 16:37:08 INFO - Expected file size: 16508497 16:37:08 INFO - Obtained file size: 16508497 16:37:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:37:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:37:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:37:14 INFO - Fetch https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:37:15 INFO - Http code: 200 16:37:15 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 16:37:15 INFO - x-amz-cf-id: LNFqoeSTJvWxAPNxQiGwPH_eTL3mlasm45tDVDEVfjkDltrgxkhzbA== 16:37:15 INFO - x-amz-version-id: j5M661kXta2fqnPkcRdPt9sSz6cH0usF 16:37:15 INFO - Expected file size: 16508497 16:37:15 INFO - Obtained file size: 16508497 16:37:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 16:37:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:37:22 INFO - Fetch https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 16:37:23 INFO - Http code: 200 16:37:23 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 16:37:23 INFO - x-amz-cf-id: _vYAqn0zEbm--q9koyZMJhjxuaw1lcmvYldHyAY0Qkz-xPrVAISssA== 16:37:23 INFO - x-amz-version-id: wevLGx6pRPLCRQn2tRJGqcr57Hrf4l8m 16:37:23 INFO - Expected file size: 14409006 16:37:23 INFO - Obtained file size: 14409006 16:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:23 INFO - trying https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:37:23 INFO - Downloading https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 16:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 16:37:26 INFO - Downloaded 111697703 bytes. 16:37:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:37:26 INFO - mkdir: /builds/slave/test/properties 16:37:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:37:26 INFO - Writing to file /builds/slave/test/properties/build_url 16:37:26 INFO - Contents: 16:37:26 INFO - build_url:https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:37:27 INFO - Running post-action listener: _resource_record_post_action 16:37:27 INFO - Running post-action listener: set_extra_try_arguments 16:37:27 INFO - [mozharness: 2016-10-11 23:37:27.145489Z] Finished download-and-extract step (success) 16:37:27 INFO - [mozharness: 2016-10-11 23:37:27.145648Z] Running populate-webroot step. 16:37:27 INFO - Running pre-action listener: _resource_record_pre_action 16:37:27 INFO - Running main action method: populate_webroot 16:37:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:37:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:37:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:37:27 INFO - '--tppagecycles', 16:37:27 INFO - '7'], 16:37:27 INFO - 'tests': ['tsvgm']}}, 16:37:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:37:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:37:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:37:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:37:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:37:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:37:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:27 INFO - 'talos_options': ['--disable-e10s'], 16:37:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:27 INFO - 'talos_options': ['--disable-e10s'], 16:37:27 INFO - 'tests': ['damp', 'tps']}, 16:37:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:27 INFO - 'tests': ['damp', 'tps']}, 16:37:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:37:27 INFO - 'tests': ['dromaeo_dom']}, 16:37:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:37:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:37:27 INFO - 'tests': ['basic_compositor_video']}, 16:37:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:37:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:37:27 INFO - 'tests': ['a11yr', 16:37:27 INFO - 'ts_paint', 16:37:27 INFO - 'tpaint', 16:37:27 INFO - 'sessionrestore', 16:37:27 INFO - 'sessionrestore_no_auto_restore', 16:37:27 INFO - 'tabpaint']}, 16:37:27 INFO - 'other-e10s': {'tests': ['a11yr', 16:37:27 INFO - 'ts_paint', 16:37:27 INFO - 'tpaint', 16:37:27 INFO - 'sessionrestore', 16:37:27 INFO - 'sessionrestore_no_auto_restore', 16:37:27 INFO - 'tabpaint']}, 16:37:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:37:27 INFO - 'ts_paint', 16:37:27 INFO - 'tpaint', 16:37:27 INFO - 'sessionrestore', 16:37:27 INFO - 'sessionrestore_no_auto_restore', 16:37:27 INFO - 'tabpaint']}, 16:37:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:37:27 INFO - 'ts_paint', 16:37:27 INFO - 'tpaint', 16:37:27 INFO - 'sessionrestore', 16:37:27 INFO - 'sessionrestore_no_auto_restore', 16:37:27 INFO - 'tabpaint']}, 16:37:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:37:27 INFO - 'tests': ['a11yr', 16:37:27 INFO - 'ts_paint', 16:37:27 INFO - 'tpaint', 16:37:27 INFO - 'sessionrestore', 16:37:27 INFO - 'sessionrestore_no_auto_restore', 16:37:27 INFO - 'tabpaint']}, 16:37:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:37:27 INFO - 'tests': ['a11yr', 16:37:27 INFO - 'ts_paint', 16:37:27 INFO - 'tpaint', 16:37:27 INFO - 'sessionrestore', 16:37:27 INFO - 'sessionrestore_no_auto_restore', 16:37:27 INFO - 'tabpaint']}, 16:37:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:37:27 INFO - 'tests': ['tsvgx', 16:37:27 INFO - 'tsvgr_opacity', 16:37:27 INFO - 'tart', 16:37:27 INFO - 'tscrollx', 16:37:27 INFO - 'cart']}, 16:37:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:37:27 INFO - 'tsvgr_opacity', 16:37:27 INFO - 'tart', 16:37:27 INFO - 'tscrollx', 16:37:27 INFO - 'cart']}, 16:37:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:27 INFO - 'talos_options': ['--disable-e10s'], 16:37:27 INFO - 'tests': ['tp5o']}, 16:37:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:27 INFO - 'tests': ['tp5o']}, 16:37:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:27 INFO - 'talos_options': ['--disable-e10s', 16:37:27 INFO - '--xperf_path', 16:37:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:27 INFO - 'tests': ['tp5n']}, 16:37:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:27 INFO - 'talos_options': ['--xperf_path', 16:37:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:27 INFO - 'tests': ['tp5n']}}, 16:37:27 INFO - 'talos.zip': {'path': '', 16:37:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:37:27 INFO - Running post-action listener: _resource_record_post_action 16:37:27 INFO - [mozharness: 2016-10-11 23:37:27.163802Z] Finished populate-webroot step (success) 16:37:27 INFO - [mozharness: 2016-10-11 23:37:27.163909Z] Running create-virtualenv step. 16:37:27 INFO - Running pre-action listener: _resource_record_pre_action 16:37:27 INFO - Running main action method: create_virtualenv 16:37:27 INFO - Creating virtualenv /builds/slave/test/build/venv 16:37:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:37:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:37:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:37:27 INFO - Using real prefix '/tools/python27' 16:37:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:37:28 INFO - Installing distribute.............................................................................................................................................................................................done. 16:37:30 INFO - Installing pip.................done. 16:37:30 INFO - Return code: 0 16:37:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:37:31 INFO - Reading from file tmpfile_stdout 16:37:31 INFO - Output received: 16:37:31 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) 16:37:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:31 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 0x10adcf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8a58b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe3d30>, '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 0x10aa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abdbb20>, '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.jfq5dRdIpv/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.bBNcA279JH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:37:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfq5dRdIpv/Render', 16:37:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:31 INFO - 'HOME': '/Users/cltbld', 16:37:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:31 INFO - 'LOGNAME': 'cltbld', 16:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:31 INFO - 'MOZ_NO_REMOTE': '1', 16:37:31 INFO - 'NO_EM_RESTART': '1', 16:37:31 INFO - 'PAGER': '/bin/cat', 16:37:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:31 INFO - 'PWD': '/builds/slave/test', 16:37:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:31 INFO - 'SHELL': '/bin/bash', 16:37:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bBNcA279JH/Listeners', 16:37:31 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 16:37:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:31 INFO - 'USER': 'cltbld', 16:37:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:31 INFO - 'XPC_FLAGS': '0x0', 16:37:31 INFO - 'XPC_SERVICE_NAME': '0', 16:37:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:37:31 INFO - Cleaning up... 16:37:31 INFO - Return code: 0 16:37:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:31 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 0x10adcf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8a58b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe3d30>, '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 0x10aa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abdbb20>, '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.jfq5dRdIpv/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.bBNcA279JH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:37:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfq5dRdIpv/Render', 16:37:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:31 INFO - 'HOME': '/Users/cltbld', 16:37:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:31 INFO - 'LOGNAME': 'cltbld', 16:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:31 INFO - 'MOZ_NO_REMOTE': '1', 16:37:31 INFO - 'NO_EM_RESTART': '1', 16:37:31 INFO - 'PAGER': '/bin/cat', 16:37:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:31 INFO - 'PWD': '/builds/slave/test', 16:37:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:31 INFO - 'SHELL': '/bin/bash', 16:37:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bBNcA279JH/Listeners', 16:37:31 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 16:37:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:31 INFO - 'USER': 'cltbld', 16:37:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:31 INFO - 'XPC_FLAGS': '0x0', 16:37:31 INFO - 'XPC_SERVICE_NAME': '0', 16:37:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:31 INFO - Downloading/unpacking psutil>=3.1.1 16:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:37:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:35 INFO - Installing collected packages: psutil 16:37:35 INFO - Running setup.py install for psutil 16:37:35 INFO - building 'psutil._psutil_osx' extension 16:37:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:37:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:37:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:37:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:37:35 INFO - building 'psutil._psutil_posix' extension 16:37:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:37:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:37:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:37:36 INFO - ^ 16:37:36 INFO - 1 warning generated. 16:37:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:37:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:36 INFO - Successfully installed psutil 16:37:36 INFO - Cleaning up... 16:37:36 INFO - Return code: 0 16:37:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:36 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 0x10adcf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8a58b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe3d30>, '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 0x10aa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abdbb20>, '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.jfq5dRdIpv/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.bBNcA279JH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:37:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfq5dRdIpv/Render', 16:37:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:36 INFO - 'HOME': '/Users/cltbld', 16:37:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:36 INFO - 'LOGNAME': 'cltbld', 16:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:36 INFO - 'MOZ_NO_REMOTE': '1', 16:37:36 INFO - 'NO_EM_RESTART': '1', 16:37:36 INFO - 'PAGER': '/bin/cat', 16:37:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:36 INFO - 'PWD': '/builds/slave/test', 16:37:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:36 INFO - 'SHELL': '/bin/bash', 16:37:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bBNcA279JH/Listeners', 16:37:36 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 16:37:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:36 INFO - 'USER': 'cltbld', 16:37:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:36 INFO - 'XPC_FLAGS': '0x0', 16:37:36 INFO - 'XPC_SERVICE_NAME': '0', 16:37:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:37:39 INFO - Installing collected packages: mozsystemmonitor 16:37:39 INFO - Running setup.py install for mozsystemmonitor 16:37:39 INFO - Successfully installed mozsystemmonitor 16:37:39 INFO - Cleaning up... 16:37:39 INFO - Return code: 0 16:37:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:39 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 0x10adcf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8a58b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe3d30>, '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 0x10aa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abdbb20>, '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.jfq5dRdIpv/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.bBNcA279JH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:37:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfq5dRdIpv/Render', 16:37:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:39 INFO - 'HOME': '/Users/cltbld', 16:37:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:39 INFO - 'LOGNAME': 'cltbld', 16:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:39 INFO - 'MOZ_NO_REMOTE': '1', 16:37:39 INFO - 'NO_EM_RESTART': '1', 16:37:39 INFO - 'PAGER': '/bin/cat', 16:37:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:39 INFO - 'PWD': '/builds/slave/test', 16:37:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:39 INFO - 'SHELL': '/bin/bash', 16:37:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bBNcA279JH/Listeners', 16:37:39 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 16:37:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:39 INFO - 'USER': 'cltbld', 16:37:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:39 INFO - 'XPC_FLAGS': '0x0', 16:37:39 INFO - 'XPC_SERVICE_NAME': '0', 16:37:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:39 INFO - Downloading/unpacking jsonschema==2.5.1 16:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:37:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:42 INFO - Downloading functools32-3.2.3-2.tar.gz 16:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:37:42 INFO - warning: no files found matching '*.txt' 16:37:42 INFO - no previously-included directories found matching 'build' 16:37:42 INFO - no previously-included directories found matching 'dist' 16:37:42 INFO - no previously-included directories found matching '.git*' 16:37:42 INFO - Installing collected packages: jsonschema, functools32 16:37:42 INFO - Running setup.py install for functools32 16:37:42 INFO - warning: no files found matching '*.txt' 16:37:42 INFO - no previously-included directories found matching 'build' 16:37:42 INFO - no previously-included directories found matching 'dist' 16:37:42 INFO - no previously-included directories found matching '.git*' 16:37:42 INFO - Successfully installed jsonschema functools32 16:37:42 INFO - Cleaning up... 16:37:42 INFO - Return code: 0 16:37:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:42 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 0x10adcf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8a58b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe3d30>, '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 0x10aa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abdbb20>, '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.jfq5dRdIpv/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.bBNcA279JH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:37:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfq5dRdIpv/Render', 16:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:42 INFO - 'HOME': '/Users/cltbld', 16:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:42 INFO - 'LOGNAME': 'cltbld', 16:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:42 INFO - 'MOZ_NO_REMOTE': '1', 16:37:42 INFO - 'NO_EM_RESTART': '1', 16:37:42 INFO - 'PAGER': '/bin/cat', 16:37:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:42 INFO - 'PWD': '/builds/slave/test', 16:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:42 INFO - 'SHELL': '/bin/bash', 16:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bBNcA279JH/Listeners', 16:37:42 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 16:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:42 INFO - 'USER': 'cltbld', 16:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:42 INFO - 'XPC_FLAGS': '0x0', 16:37:42 INFO - 'XPC_SERVICE_NAME': '0', 16:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:37:43 INFO - Cleaning up... 16:37:43 INFO - Return code: 0 16:37:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:43 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 0x10adcf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8a58b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe3d30>, '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 0x10aa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abdbb20>, '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.jfq5dRdIpv/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.bBNcA279JH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:37:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfq5dRdIpv/Render', 16:37:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:43 INFO - 'HOME': '/Users/cltbld', 16:37:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:43 INFO - 'LOGNAME': 'cltbld', 16:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:43 INFO - 'MOZ_NO_REMOTE': '1', 16:37:43 INFO - 'NO_EM_RESTART': '1', 16:37:43 INFO - 'PAGER': '/bin/cat', 16:37:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:43 INFO - 'PWD': '/builds/slave/test', 16:37:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:43 INFO - 'SHELL': '/bin/bash', 16:37:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bBNcA279JH/Listeners', 16:37:43 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 16:37:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:43 INFO - 'USER': 'cltbld', 16:37:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:43 INFO - 'XPC_FLAGS': '0x0', 16:37:43 INFO - 'XPC_SERVICE_NAME': '0', 16:37:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:43 INFO - Downloading/unpacking blobuploader==1.2.4 16:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:46 INFO - Downloading blobuploader-1.2.4.tar.gz 16:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:37:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:37:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:47 INFO - Downloading docopt-0.6.1.tar.gz 16:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:37:47 INFO - Installing collected packages: blobuploader, requests, docopt 16:37:47 INFO - Running setup.py install for blobuploader 16:37:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:37:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:37:47 INFO - Running setup.py install for requests 16:37:47 INFO - Running setup.py install for docopt 16:37:48 INFO - Successfully installed blobuploader requests docopt 16:37:48 INFO - Cleaning up... 16:37:48 INFO - Return code: 0 16:37:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:48 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 0x10adcf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8a58b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe3d30>, '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 0x10aa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abdbb20>, '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.jfq5dRdIpv/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.bBNcA279JH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:37:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfq5dRdIpv/Render', 16:37:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:48 INFO - 'HOME': '/Users/cltbld', 16:37:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:48 INFO - 'LOGNAME': 'cltbld', 16:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:48 INFO - 'MOZ_NO_REMOTE': '1', 16:37:48 INFO - 'NO_EM_RESTART': '1', 16:37:48 INFO - 'PAGER': '/bin/cat', 16:37:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:48 INFO - 'PWD': '/builds/slave/test', 16:37:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:48 INFO - 'SHELL': '/bin/bash', 16:37:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bBNcA279JH/Listeners', 16:37:48 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 16:37:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:48 INFO - 'USER': 'cltbld', 16:37:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:48 INFO - 'XPC_FLAGS': '0x0', 16:37:48 INFO - 'XPC_SERVICE_NAME': '0', 16:37:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:48 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-RitZeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:48 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-dnagca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:48 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Dfwgjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:48 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-CpiGzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:48 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-qrM_GJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-hVGZlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-SXUm4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-dcrqig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-R9oBtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-PbIPZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-ag7SLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-LmM5Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-H53vYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-ab4xN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:49 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Rl3Usf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-GPnuRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:50 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-5AM7MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:37:50 INFO - Running setup.py install for manifestparser 16:37:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:37:50 INFO - Running setup.py install for mozcrash 16:37:50 INFO - Running setup.py install for mozdebug 16:37:50 INFO - Running setup.py install for mozdevice 16:37:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:37:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:37:50 INFO - Running setup.py install for mozfile 16:37:50 INFO - Running setup.py install for mozhttpd 16:37:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:37:51 INFO - Running setup.py install for mozinfo 16:37:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:37:51 INFO - Running setup.py install for mozInstall 16:37:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:37:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:37:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:37:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:37:51 INFO - Running setup.py install for mozleak 16:37:51 INFO - Running setup.py install for mozlog 16:37:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:37:51 INFO - Running setup.py install for moznetwork 16:37:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:37:51 INFO - Running setup.py install for mozprocess 16:37:52 INFO - Running setup.py install for mozprofile 16:37:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:37:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:37:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:37:52 INFO - Running setup.py install for mozrunner 16:37:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:37:52 INFO - Running setup.py install for mozscreenshot 16:37:52 INFO - Running setup.py install for moztest 16:37:52 INFO - Running setup.py install for mozversion 16:37:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:37:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:37:52 INFO - Cleaning up... 16:37:52 INFO - Return code: 0 16:37:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:52 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 0x10adcf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8a58b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe3d30>, '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 0x10aa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abdbb20>, '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.jfq5dRdIpv/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.bBNcA279JH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:37:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfq5dRdIpv/Render', 16:37:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:52 INFO - 'HOME': '/Users/cltbld', 16:37:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:52 INFO - 'LOGNAME': 'cltbld', 16:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:52 INFO - 'MOZ_NO_REMOTE': '1', 16:37:52 INFO - 'NO_EM_RESTART': '1', 16:37:52 INFO - 'PAGER': '/bin/cat', 16:37:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:52 INFO - 'PWD': '/builds/slave/test', 16:37:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:52 INFO - 'SHELL': '/bin/bash', 16:37:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bBNcA279JH/Listeners', 16:37:52 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 16:37:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:52 INFO - 'USER': 'cltbld', 16:37:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:52 INFO - 'XPC_FLAGS': '0x0', 16:37:52 INFO - 'XPC_SERVICE_NAME': '0', 16:37:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-QUah7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-gEvED1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-N14VvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-nUe2vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-LtRJrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-IX2IGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-eu5hfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-62XqnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Ctly_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-x_9mus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-IeUPR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-ewLjTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-atfxu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-mj97W0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-LMI8JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-q6aYcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-coUUp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:57 INFO - Downloading blessings-1.6.tar.gz 16:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:37:57 INFO - Installing collected packages: blessings 16:37:57 INFO - Running setup.py install for blessings 16:37:58 INFO - Successfully installed blessings 16:37:58 INFO - Cleaning up... 16:37:58 INFO - Return code: 0 16:37:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:37:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:58 INFO - Reading from file tmpfile_stdout 16:37:58 INFO - Current package versions: 16:37:58 INFO - blessings == 1.6 16:37:58 INFO - blobuploader == 1.2.4 16:37:58 INFO - docopt == 0.6.1 16:37:58 INFO - functools32 == 3.2.3-2 16:37:58 INFO - jsonschema == 2.5.1 16:37:58 INFO - manifestparser == 1.1 16:37:58 INFO - mozInstall == 1.12 16:37:58 INFO - mozcrash == 0.17 16:37:58 INFO - mozdebug == 0.1 16:37:58 INFO - mozdevice == 0.48 16:37:58 INFO - mozfile == 1.2 16:37:58 INFO - mozhttpd == 0.7 16:37:58 INFO - mozinfo == 0.9 16:37:58 INFO - mozleak == 0.1 16:37:58 INFO - mozlog == 3.4 16:37:58 INFO - moznetwork == 0.27 16:37:58 INFO - mozprocess == 0.23 16:37:58 INFO - mozprofile == 0.28 16:37:58 INFO - mozrunner == 6.12 16:37:58 INFO - mozscreenshot == 0.1 16:37:58 INFO - mozsystemmonitor == 0.3 16:37:58 INFO - moztest == 0.7 16:37:58 INFO - mozversion == 1.4 16:37:58 INFO - psutil == 3.1.1 16:37:58 INFO - requests == 1.2.3 16:37:58 INFO - wsgiref == 0.1.2 16:37:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:58 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 0x10adcf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8a58b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe3d30>, '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 0x10aa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abdbb20>, '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.jfq5dRdIpv/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.bBNcA279JH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:37:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfq5dRdIpv/Render', 16:37:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:58 INFO - 'HOME': '/Users/cltbld', 16:37:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:58 INFO - 'LOGNAME': 'cltbld', 16:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:58 INFO - 'MOZ_NO_REMOTE': '1', 16:37:58 INFO - 'NO_EM_RESTART': '1', 16:37:58 INFO - 'PAGER': '/bin/cat', 16:37:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:58 INFO - 'PWD': '/builds/slave/test', 16:37:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:58 INFO - 'SHELL': '/bin/bash', 16:37:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bBNcA279JH/Listeners', 16:37:58 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 16:37:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:58 INFO - 'USER': 'cltbld', 16:37:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:58 INFO - 'XPC_FLAGS': '0x0', 16:37:58 INFO - 'XPC_SERVICE_NAME': '0', 16:37:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:37:59 INFO - Cleaning up... 16:37:59 INFO - Return code: 0 16:37:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:59 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 0x10adcf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f8a58b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe3d30>, '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 0x10aa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abdbb20>, '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.jfq5dRdIpv/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.bBNcA279JH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:37:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfq5dRdIpv/Render', 16:37:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:59 INFO - 'HOME': '/Users/cltbld', 16:37:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:59 INFO - 'LOGNAME': 'cltbld', 16:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:59 INFO - 'MOZ_NO_REMOTE': '1', 16:37:59 INFO - 'NO_EM_RESTART': '1', 16:37:59 INFO - 'PAGER': '/bin/cat', 16:37:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:59 INFO - 'PWD': '/builds/slave/test', 16:37:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:59 INFO - 'SHELL': '/bin/bash', 16:37:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bBNcA279JH/Listeners', 16:37:59 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 16:37:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:59 INFO - 'USER': 'cltbld', 16:37:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:59 INFO - 'XPC_FLAGS': '0x0', 16:37:59 INFO - 'XPC_SERVICE_NAME': '0', 16:37:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:37:59 INFO - Cleaning up... 16:37:59 INFO - Return code: 0 16:37:59 INFO - Running post-action listener: _resource_record_post_action 16:37:59 INFO - Running post-action listener: _start_resource_monitoring 16:37:59 INFO - Starting resource monitoring. 16:37:59 INFO - [mozharness: 2016-10-11 23:37:59.441310Z] Finished create-virtualenv step (success) 16:37:59 INFO - [mozharness: 2016-10-11 23:37:59.442123Z] Running install step. 16:37:59 INFO - Running pre-action listener: _resource_record_pre_action 16:37:59 INFO - Running main action method: install 16:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:59 INFO - Reading from file tmpfile_stdout 16:37:59 INFO - Detecting whether we're running mozinstall >=1.0... 16:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:37:59 INFO - Reading from file tmpfile_stdout 16:37:59 INFO - Output received: 16:37:59 INFO - Usage: mozinstall [options] installer 16:37:59 INFO - Options: 16:37:59 INFO - -h, --help show this help message and exit 16:37:59 INFO - -d DEST, --destination=DEST 16:37:59 INFO - Directory to install application into. [default: 16:37:59 INFO - "/builds/slave/test"] 16:37:59 INFO - --app=APP Application being installed. [default: firefox] 16:37:59 INFO - mkdir: /builds/slave/test/build/application 16:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:38:34 INFO - Reading from file tmpfile_stdout 16:38:34 INFO - Output received: 16:38:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:38:34 INFO - Running post-action listener: _resource_record_post_action 16:38:34 INFO - [mozharness: 2016-10-11 23:38:34.277502Z] Finished install step (success) 16:38:34 INFO - [mozharness: 2016-10-11 23:38:34.277698Z] Running run-tests step. 16:38:34 INFO - Running pre-action listener: _resource_record_pre_action 16:38:34 INFO - Running main action method: run_tests 16:38:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:38:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:38:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:38:34 INFO - 2016-10-11 16:38:34.292 screenresolution[1659:7615] starting screenresolution argv=screenresolution get 16:38:34 INFO - 2016-10-11 16:38:34.294 screenresolution[1659:7615] Display 0: 1600x1200x32@60 16:38:34 INFO - 2016-10-11 16:38:34.301 screenresolution[1660:7617] starting screenresolution argv=screenresolution list 16:38:34 INFO - Available Modes on Display 0 16:38:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:38:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:38:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:38:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:38:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:38:34 INFO - Intel Iris: 16:38:34 INFO - Chipset Model: Intel Iris 16:38:34 INFO - Type: GPU 16:38:34 INFO - Bus: Built-In 16:38:34 INFO - VRAM (Dynamic, Max): 1536 MB 16:38:34 INFO - Vendor: Intel (0x8086) 16:38:34 INFO - Device ID: 0x0a2e 16:38:34 INFO - Revision ID: 0x0009 16:38:34 INFO - Displays: 16:38:34 INFO - Display: 16:38:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:38:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:38:34 INFO - Display Serial Number: 1600x1200 60 16:38:34 INFO - Main Display: Yes 16:38:34 INFO - Mirror: Off 16:38:34 INFO - Online: Yes 16:38:34 INFO - Rotation: Supported 16:38:34 INFO - Return code: 0 16:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:38:34 INFO - Python 2.7.3 16:38:34 INFO - Return code: 0 16:38:34 INFO - grabbing minidump binary from tooltool 16:38: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')]} 16:38:34 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 0x10abe3d30>, '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 0x10aa09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abdbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:38:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:38:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:38:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:38:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:38:34 INFO - Return code: 0 16:38:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:38:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:38:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:38:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:38:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0357 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:38:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfq5dRdIpv/Render', 16:38:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:34 INFO - 'HOME': '/Users/cltbld', 16:38:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:34 INFO - 'LOGNAME': 'cltbld', 16:38:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:38:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:34 INFO - 'MOZ_NO_REMOTE': '1', 16:38:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:38:34 INFO - 'NO_EM_RESTART': '1', 16:38:34 INFO - 'PAGER': '/bin/cat', 16:38:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:34 INFO - 'PWD': '/builds/slave/test', 16:38:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:38:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:34 INFO - 'SHELL': '/bin/bash', 16:38:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bBNcA279JH/Listeners', 16:38:34 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 16:38:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:34 INFO - 'USER': 'cltbld', 16:38:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:34 INFO - 'XPC_FLAGS': '0x0', 16:38:34 INFO - 'XPC_SERVICE_NAME': '0', 16:38:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:38:34 INFO - mozversion application_buildid: 20161011134948 16:38:34 INFO - mozversion application_changeset: 22a929d86e4db43d828efe54430a34c182b2dbc2 16:38:34 INFO - mozversion application_display_name: Nightly 16:38:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:38:34 INFO - mozversion application_name: Firefox 16:38:34 INFO - mozversion application_remotingname: firefox 16:38:34 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 16:38:34 INFO - mozversion application_vendor: Mozilla 16:38:34 INFO - mozversion application_version: 52.0a1 16:38:34 INFO - mozversion platform_buildid: 20161011134948 16:38:34 INFO - mozversion platform_changeset: 22a929d86e4db43d828efe54430a34c182b2dbc2 16:38:34 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 16:38:34 INFO - mozversion platform_version: 52.0a1 16:38:34 INFO - using testdate: 1476229114 16:38:34 INFO - actual date: 1476229114 16:38:34 INFO - starting webserver on 'localhost:49267' 16:38:34 INFO - SUITE-START | Running 2 tests 16:38:34 INFO - TEST-START | dromaeo_css 16:38:34 INFO - operating with platform_type : mac_ 16:38:34 INFO - Initialising browser for dromaeo_css test... 16:38:34 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpsJOxRG/profile http://localhost:49267/getInfo.html) 16:38:37 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 16:38:37 INFO - PROCESS | 1670 | colorDepth:24 16:38:37 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 16:38:37 INFO - PROCESS | 1670 | __metrics 16:38:37 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:38:37 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:38:38 INFO - TEST-INFO | 1670: exit 0 16:38:38 INFO - Browser initialized. 16:38:38 INFO - Running cycle 1/1 for dromaeo_css test... 16:38:38 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpsJOxRG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:50 INFO - PROCESS | 1672 | RSS: Main: 245608448 16:38:50 INFO - PROCESS | 1672 | 16:39:41 INFO - PROCESS | 1672 | 1476229181810 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:41:54 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 16:41:56 INFO - PROCESS | 1672 | RSS: Main: 394620928 16:41:56 INFO - PROCESS | 1672 | 16:44:59 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 16:45:00 INFO - PROCESS | 1672 | RSS: Main: 373895168 16:45:00 INFO - PROCESS | 1672 | 16:48:02 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 16:48:03 INFO - PROCESS | 1672 | RSS: Main: 338866176 16:48:03 INFO - PROCESS | 1672 | 16:51:05 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 16:51:06 INFO - PROCESS | 1672 | RSS: Main: 339038208 16:51:06 INFO - PROCESS | 1672 | 16:54:09 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 16:54:10 INFO - PROCESS | 1672 | RSS: Main: 330846208 16:54:10 INFO - PROCESS | 1672 | 16:57:13 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 16:57:13 INFO - PROCESS | 1672 | RSS: Main: 498462720 16:57:13 INFO - PROCESS | 1672 | 16:57:13 INFO - PROCESS | 1672 | __start_tp_report 16:57:13 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 16:57:13 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 16:57:13 INFO - PROCESS | 1672 | |i|pagename|runs| 16:57:13 INFO - PROCESS | 1672 | |0;dojo.html;2908.258394109502;3306.801591904485;3336.3160552086824;3353.2287573858025;3377.5814158053613;5529.004779139753;5659.632123911948;5678.43215678432;5735.455131762486;5742.483176514118;5661.66030038198;5711.286089238845;5714.599978001531;5717.742701578439;5726.427357264281;5123.948760512394;5173.637845350827;5177.974110129444;5194.480551944813;5209.921851172236;5181.455947125554;5182.093133701606;5183.50756678115;5186.429492755813;5186.948130518685;5091.159958606825;5126.7436628168625;5130.871728206787;5142.717150556718;5164.586833053347;5201.713905735202;5206.479352064764;5234.6335756497065;5247.68513889164;5249.4488078751565;5080.542751152377;5087.898242035176;5129.820456284012;5154.845354639367;5170.819021334235;5563.638363506359;5623.493885550321;5693.743781529841;5698.373178950312;5704.2299289595785;5289.471052894718;6108.053251745987;6214.720337584819;6219.067139929001;6232.314445411046;6140.846478838065;6252.5101770635265;6288.056791481269;6312.242530896276;6320.431161195468;5620.381758006616;5741.081426971665;5750.734838335559;5790.247267855152;5807.506361959281;6244.438000579969;6251.062340648939;6253.405926436982;6254;6300.369963003663;6054.939450605438;6132.938670613326;6146;6162.568620196633;6177.104319873683;6086.178365920544;6119.929102025404;6131.774283661951;6133.18690095852;6262.1546091278005;6118.251671986824;6214.098955651405;6218.098375735493;6221.688915554204;6225.564210505221;6228.657423841732;6248.50011999039;6253.46845518127;6260.342664020303;6264.404881536247;4336.783160841946;4742.857714268577;4867.221244600847;4900.828471003569;4948.183549714328;4361.869143925687;4417.690761646718;4421.579949904753;4434.600885920283;4460.687751857404;4778.474367819537;5647.322321321468;5705.771769129188;5712.200291959129;5714.685692286881;6202.317745048041;6213.720382582795;6223.533235007302;6233.470155036873;6234.314225435199;5531.308586426697;5669.092945128842;5688.06146985751;5694.316681998187;5749.885002300014;5418.566514678816;5423.294971653739;5427.402985671573;5435.42927992563;5440.3743569489225;6257.906131408033;6263.655498947602;6274.435300822948;6278.968605157128;6289.748410063729;6108;6230.43926046658;6232.844178895564;6282.560220784501;6311.747530098744;6164.229471316085;6202.534809889186;6222.688865556614;6263.4362907338555;6324;6173.32093469709;6175.59858609189;6190.164327815867;6195.783147589993;6221.875562488815;6121.418465245794;6227.782027629192;6250.593711408926;6271.3415091414745;6288.245410550763;5763.682997435014;5781.075027995501;6079.422454866781;6083.726232319467;6098.664573448503;6114.723190878713;6121.239585875057;6123.740204357105;6127.189528148541;6135.875804921915;5917.171595976481;5945.940540594539;5952.285725712942;5969.313528944053;5978.760849565969;5878.147668588116;5956.344802071682;6059.969700151471;6073.878522429615;6106.3588323227195;5893;5939.643621382731;5968.791092311922;6011;6029 16:57:13 INFO - PROCESS | 1672 | |1;ext.html;459.57718898613274;488.07753346175724;501.72405177152535;507.55081752648897;540.211291514389;29507.704922950765;30417.847910760443;31563.21091972699;31564;31573.89491367797;31869.68130318696;32579.837100814464;32593.67406325936;32637.51043734346;41000.58999410005;9184.8622270666;9481.620735170585;9484;9507.714768556954;9542.33203675743;9294.767630809216;9393.859092113624;9401.952990235039;9416.52917354133;9426.81146377072;9377.296702747288;9410.435373877555;9429.151376376125;9455.385399948982;9470.573824177929;9349.626014959393;9405.623775048989;9425.387349822307;9431.528423578862;9450.952745236264;7979;9272.72181834546;9324.580393882292;9333.533323333873;9339.76650583734;39559;39880;39887.20225595472;39888.40167397491;39911.800440997606;3320.7841490303053;3357.9496307555405;3535.699465545432;3542.256126213498;3775.3959366501504;29785.702142978727;30176;30703.925362612426;30735;30739.846300768353;3189.1548739584027;3193.1697758582704;3194.1216165554424;3201.2157021529642;3302.2734998300334;447484;449086;449961;453466.9999999967;458922;55681.72159139178;55848.72075639677;55920.16119758207;55978.44021559814;56090.43909560934;28649.570256445753;33927;34525;58509.70745146247;58540;15490.457833975757;15958.521244362688;16076.356945722275;16077.196140193177;16093.114878681785;12170.269783812999;12250;12257.958073563846;12261.509539618315;12280.877191228152;17997.910010449865;18532.629347413247;18535.814641853678;18544.16551255197;18585.628287434174;7700.3454706350585;7823.843523129505;7845.490043147177;7942.3646108311195;7944.44388892772;855.4952577979022;937.864009718587;966.3960024984385;1005.3967619428284;1045.3988956350129;28885.56671649927;29462.558061629094;29506.852465737535;30053.849730751208;30217.69782302193;1025.0825511167463;1032.396048311731;1050.1651187305956;1066.440118937564;1137.9544818207344;13265.204087754766;14730.852691473163;14736;14853.108813471226;15084.094954302776;646103;685215;685516.5724171348;685977;686531;54024.72987635115;54529;54601.45398545964;54638.907221856134;54675.72662136744;1226.4419689041465;1272.1858010873048;1358.5992132320791;1417.6385021819576;1468.4199741102418;24611.384715382257;29399;30888.691113088582;31624.36751265008;31710.841445792623;50804.745976269885;51788;51846.96306073782;51867.740661296455;51986.48013519968;608034;622990;623647;624972;625265;41486.377704333856;41941.79029104957;42709.5155008732;42966.14067718691;43098.1380372397;46270;46999.765001174776;47352.763236184976;47395;47425.76287118543;36392.636073638925;38620.420693690176;39280;39931;40444.595554044085;32778;38322.80838595789;39192;39280.01799955024;40120;38033;38376.84869453921;38417.42373864338;38467.42298865463;40533.581324653496;32381.676183238807;33993.3910904698;34200.486992694634;34353.312933740686;34576.09831459294;25064;25130.62304065477;25322.987080516574;25414.30966631378;25516.61725074088 16:57:13 INFO - PROCESS | 1672 | |2;jquery.html;347.0594688394451;366.20168033686565;370.1985202037589;377.2078634866779;401.09152768978254;14224.928875355621;15086.3211155498;19363.031848407594;19373.612527749436;20349.18603255868;16959.745603815954;19623.215071397128;20136.69794953073;20224.696629550534;20480.975951202417;5481.780728770845;6038.939610603882;6077.817665470043;6096.116063170837;6108.14485971962;4174.457320548339;4412.580804823537;5937.554683398741;6316.431521163095;6640.6347650879425;6403.1355766971565;6692.498062645297;6696.531242813005;6704.094947182117;6713.2951040140815;5993.700314984233;6649.168853893263;6692.698828552727;6699.263081061079;6706.094677218586;5516.310461192351;5732.5987180897355;5764.106563482667;5775.711214439261;5799.217105690762;20849.8957505213;25016.23976894545;25548.361290967874;25599;26082.608760868603;2219.411855858199;2274.0449011415244;2290.874001929893;2449.64480150379;2973.762099032094;12587.622371328875;14507.419703211859;15532;15634.45279415215;16370.590735231595;1797.6045270040702;1819.5724004858848;1928.3732786844332;1972.2505447929839;1973.4868934077099;118509.40745296305;123028;123291.15063274058;123498;124979;11081.778364432666;11378.487968041458;11532.942335288437;11535.826962595567;11704.239224450383;12928.288944107977;13415.798763018562;13501.392437340342;13501.797473037912;14231.146131232159;8283.50298982063;8407.747767566983;8452.704155354533;8544.829103417896;8572.399932004824;7151.427885769126;8042.879356809653;8258.658030161523;8271.21423464782;8490.405671603052;4429.734215947054;4502.932456013163;4516.3902873112365;4600.97699511507;4615.3077038443835;1850.4818650777804;1891.5743957609427;1893.479293194355;1917.8561607879465;1932.845372370207;794.6463823598559;804.3565147881671;944.3719926248967;957.6169532187181;1023.6928921323573;19910.004499775245;19975.700364494543;21358.466038349165;21524;21683.891580541997;880.2561835249204;902.3052249767774;907.4827348411474;921.949292788903;995.7709726762885;10443.791124177475;10953.83569246462;11067.335959842436;11099.001089901947;11109.83335249972;577349;579724;585461;598652;600729;119831.40084299697;125383.373083134;126215;129547;129826;953.208836665566;998.9001099890098;1035.171862509989;1037.9481025948671;1039.9636012739518;15724.857382215772;19114.617707646048;19462.708059379405;19736.70394944048;19944.800551994293;54651.47546534692;55472;55976;56072;57168.284951451526;70287.59424811577;77164.2283577157;77681;79771.80342294755;79885;7900.170482099526;7950;8229.711960081368;8231.95884020576;8432.283255923316;10953.780924381626;12849.357532123544;12955.352232388532;13055.673608159872;13208.735825283633;11068.501917413574;11149.386783726974;11293.096552275634;11305.208635395444;11388;10975.341479511255;10977.3962432067;11214;11328;11432.371219583003;9153.855768028996;10093.596256149673;11342.773144537228;11537.307761534335;11560.94219528897;8121.8375632488205;8147.266745992889;8223.917760822555;8234.258916697527;8273;9519.381240219363;10237.641682541076;10659.680209593724;11100.056495197998;11208.159388045766 16:57:13 INFO - PROCESS | 1672 | |3;mootools.html;1314.4610709609062;1464.2166440954088;1476.2249818845107;1641.302446460255;1823.2342416185202;7708.498947568404;8177.386695997801;8545;8795.384323097385;8804.603792829323;8635.568221588926;8713.607887645056;8731.126887311282;8735.781605459866;8756.255718263956;2290.8625482471107;2314.456102815837;2317.24689475921;2325.9534809303805;2328.3247858121126;2269.341890851651;2305.020366344297;2323.2217207235594;2325.1513197682893;2329.848559843613;2276.260215429992;2304.412374844412;2312.0289478419104;2317.2237300504353;2322.314917099451;2271.5002699406105;2283.748787633359;2286.1312701173447;2287.874166920819;2290.8625482471107;2274.4541310085624;2281.0305620111385;2285.245868863271;2286.0969916882905;2290.141197051106;8641.222289993932;8660.740177794676;8733.99559050711;8744;8744.956275218583;5056.595472362203;5274.393444753864;5275.393329767087;5297.12597421425;5305.363356397218;3608.891733248007;3631.055925459373;3694.07648087978;3694.685951694082;3700.2257697149025;993.8211121998038;1014.4471263161595;1756.6486702659392;1813.7460755494242;1858.256697321069;10106.64626738068;11237.213395062348;11396.088312934946;11498.080153587693;11509.194356395055;3999.1801680655394;4370.7159034662645;4444.266695995125;4513.954860451354;4524.47968483622;8984.730458086267;8995.145461181177;9006.819863602692;9014.143656352637;9020;5200.193969934666;5208.713520756395;5214.2960700304975;5216.634835561475;5223.3209682741;4052.5339585947404;4370.7159034662645;4537.6143027842345;4866.148424025781;4927.5811556017425;3618.638136186413;3645.799481028516;3720.9627903720616;3740.887773366749;3741.7567858089137;1102.327580176092;1118.0608289037248;1131.5077941095649;1131.8981291683624;1134.2003887259461;835.9164083591713;853.1638993786;898.6630013744846;903.7559858838077;924.8011677489372;5616.887662246814;5623.2408624835125;5749.755308311557;5847.502962248256;5861.9706901465215;403.97576145431367;409.8360655737729;432.82254275746794;444.56876829475357;446.49992008949533;3769.698424126118;3908;3999.9400008999887;4004.819783109767;4009.4386785850006;10360.171186305077;10657.520411581498;10668.89331106679;10775;10796.136309095253;10732.517036733365;10746.355218686904;10746.78506429867;10751.408672523086;10773.299735517166;7653.808654783564;7946.32456241226;8093.1502192270145;8194.67221311141;8258.050324212672;5731.140328950691;5857.707114644166;5932.525397968066;5991.550633702403;6042.882066817653;9735.70792876215;9806.548362909272;9936.006399360296;9995.300328977193;10050.39697618116;9296.349255552046;9605.903940960501;9646.517674116407;9923.603055877684;10022.899771002196;6752.223494298022;6939.722411103499;7375.778726638209;7377.594232317274;7417.072865891763;7894.250046245597;8067.677292908218;8145.266925976691;8169.978752655918;8174.509529428254;7305;7312.96343518279;7336.559806411632;7337.229590892879;7527.548347099191;7110.893336599852;7184.425245980205;7228.385587225145;7237.131544214728;7291.125064992235;5922.526197904243;6830.624315662686;6885.311468853275;6916.273791251846;6925.099737034153;4776.641751868693;4819.108464933998;4884.8290309838985;4939.110960027229;4942.258661200849;4924.556789888928;4925.532074452921;4985.1276026695905;5048.848534543969;5063.1645778446145 16:57:13 INFO - PROCESS | 1672 | |4;prototype.html;299.6838335555988;307.776861775213;309.8745008271649;315.05797664981714;319.5941154733487;4170.145120250349;5192.039472697549;5222.738863056847;5239.816606418776;5265.578753699704;5077.41609714882;5089.974550127245;5090.643654944146;5126.051680439122;5127.641065125443;3468.6531346865363;3686.9631303687024;3731.7312113881276;3748.906277343061;3905.7461265017823;3222.4682927316962;3907.0427745202464;3942.369220924653;3944.842206311744;4011.438398624195;3408.6250512443735;3875.7403843750753;3880.689544836406;3914.3345631242755;3915.23652887687;3267.5425440438357;3646.361886669822;3650.5984341722387;3910.4720862683457;3926.371780515118;2954.2762023304426;3386.9322613547592;3388.7797293175863;3394.575678040245;3399.5750531183603;3809.790461524643;4579.473360563545;4998.425181104183;5028.34631497903;5043.167877300241;3763.7741735495956;4429.468463784334;4434.091011342667;4454.977725111354;4464.531224221442;4206.579342065799;4292.18448494785;4909.337239472661;5382.865428364283;5468.589855760833;3132.8746850125967;3689.3543629864935;3706.0734816295926;3728.5525736911472;3730.198007428416;5624;5638.323401191842;5641.2102305677645;5649.022842005265;5660.726336574237;3165.889193878203;3672.779633221962;3683.650053244937;3728.1984373359314;3911.413288006822;3951.229510245532;3954.7033972451604;3961.0590810502645;3961.267165574378;4011.859584914514;3788.8484460621266;3870.1292209252692;4523.909521809545;4532.592066713945;4535.546445355504;5015.4733752956145;5368.141097424394;5474.562035037187;5475.06923822951;5484.643498172606;1334.7520068735764;1354.537099932071;1361.46902707944;1361.9114757540729;1364.590622813152;728.6575309604477;742.8477162181848;805.7864665863551;833.8749187621905;848.7708318754026;4723.881902952454;4823.831165909176;4976.2286845539;5001.349824522788;5113.51421614946;5325.573954083664;5564.805231816867;5576.605848537865;5612.719364031782;5631.380548139701;4787.4494433140635;5069.969374347403;5096.566791822663;5106.770195341219;5110.948890511122;2711.9050833221136;2857.7570906472765;2937.4859399604984;2943.2641839540115;2975.226441125323;5249.553787927993;5404.675854415615;5746.741396637161;5757.625754325955;5773.066022882382;4658.277966915066;5720.740307578566;5746.971265143731;5751.223584815996;5790.36306006339;5531.861703457445;5805.593608447368;5816.651000939957;5832.80427512359;5838.095095260242;4954.950450495449;5450.937067271844;5629.648884267828;5634.32388113429;5663.7451314690115;4891.902161956812;5308.920366194433;5488.780448782004;5628.662280263197;5669.31968163823;4960.578350840219;5205.323307969939;5681.318241811009;5827.4172582741385;5889.94110058894;3256.8132986542805;3543;3758.9436158457097;3780.6389699708634;3813.550850676725;4882.316475693335;5203.869903252449;5617.5505959522325;5622.297212848394;5759.7408116634015;4862.489438608895;5442.673439593637;5457.918131227955;5513.58648101386;5551.417101204315;4605.4933957264;5302.443243459536;5488.780448782004;5517.586181036519;5597.468240517144;4392.912141757083;4545.863624091283;5365.651232669864;5366;5386.353637563518;5137.768800403916;5267.7094111942815;5354.196870469461;5411.458854114557;5475.904819036288;5305.469453054664;5316.468353164652;5323.2547443358735;5334.813281535127;5357.437304192824 16:57:13 INFO - PROCESS | 1672 | |5;yui.html;700.7127077898061;709.4537206351107;757.2314101187296;786.4180506425247;792.6036981509244;15536.456224032161;15792.131432771193;15816.44642437515;15816.920915395407;16149.596260093504;14139.36372863221;14221.502247421342;14241.71516569668;14243.287835608204;14268.357923893424;665.5274754923986;678.7726111752556;689.0766373060098;691.5159388428095;813.3574476163824;839.039300001498;839.2027573804879;845.0957475501216;848.855694531931;849.1932663969224;899.1817446124029;902.7246689759621;904.8733177355142;905.3481493324796;905.4160066756938;893.9553022348856;894.7181637784078;895.9462432254086;897.1611543207122;898.883145191121;527.8996990571779;545.1849485019881;649.6004956951488;661.851083506212;664.833791552112;14611.561653150422;14652.926735366362;14677.045992010591;14682.119072855556;14714.33785479656;11608;13074;13300.3349832508;13438.46246150153;13486.662833429145;12077.214981026205;12207.145499815017;12224.511019559208;12258.387080645933;12348.135630505869;4312.374705667692;4328.740275583444;4353.151135528573;4372.234858899712;4476.932365954326;114893;117092;118180;118546.40726796396;121460.78539214672;10498;10559.736006599744;10602.25784195099;10613.310134841366;11021.559137634566;20712.58574828525;20764.480887977923;20793.272235471686;20820.37538873836;20834.1666333348;7452.180260171377;7570.16728159902;7616;7721.575313357707;7816.296533312029;4151.1075118848985;4168.43726096973;4189.958100419018;4234.2801723706425;4335.6965012449455;3329.933401332008;3434.6565343465454;3439.6044454887506;3441.535392722001;3444.156181735441;636.2905360522983;637.7990932856136;641.2657507154282;648.8961766117399;662.2979641579941;528.5744975294848;546.3416583017455;573.827851644505;598.530153829242;608.1971797227706;8915.063918288615;9012.684556040507;9032.8645070324;9043.276537876955;9140.63437462494;488.0994812086681;509.3454910440067;534.1027074514852;603.5382932056892;626.8746250749869;4109.794510274474;4215.473065866767;4351.956480435155;4410.977945110254;4437.467503899553;93965;108669.61286194171;132752.33623832013;163791.181044094;171732.14133929252;91390.54304728567;137560;145147;145398;148874;116716.83283167229;118235.27058917547;121451;121601;124372;8382.748517544484;8470.207260319421;8485.872711909204;8516.61675224604;8678.78303042429;63970.3602963983;64732;65319.34680653133;66489.35372432039;67531.32468675447;96198;99229.50385248028;99570.5021474917;106284.9371506275;107939.46030269799;9871;11137.498812553617;11222.270552414067;11358.76532577018;11552.364619945647;11927.582534611247;11977.820332695192;11986.160968732454;12156.149069565046;12265.57070502528;9487.20884503762;11466.541338346373;11505.884941150482;11669.88330116688;11723;9844.704658860246;13306.600801975956;13709.794353084912;13863.237521935987;14175.716485670435;13824.170549766644;13837.930810345884;14250.287485625884;14309.356078976263;14399.640008999859;9365.250779937453;11488.253263537843;11502.769944600894;11562.76874462523;11666;9650.855237171307;9791.559379827782;11318.120858904895;11395;11706.590269340531 16:57:13 INFO - PROCESS | 1672 | __end_tp_report 16:57:13 INFO - PROCESS | 1672 | __start_cc_report 16:57:13 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1854 16:57:13 INFO - PROCESS | 1672 | __end_cc_report 16:57:13 INFO - PROCESS | 1672 | __startTimestamp1476230233802__endTimestamp 16:57:13 INFO - PROCESS | 1672 | 16:57:13 INFO - PROCESS | 1672 | ------- Summary: start ------- 16:57:13 INFO - PROCESS | 1672 | Number of tests: 6 16:57:13 INFO - PROCESS | 1672 | 16:57:13 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5707.16 Median:5945.94 stddev:660.42 (11.1%) stddev-sans-first:624.88 16:57:13 INFO - PROCESS | 1672 | Values: 2908.3 3306.8 3336.3 3353.2 3377.6 5529.0 5659.6 5678.4 5735.5 5742.5 5661.7 5711.3 5714.6 5717.7 5726.4 5123.9 5173.6 5178.0 5194.5 5209.9 5181.5 5182.1 5183.5 5186.4 5186.9 5091.2 5126.7 5130.9 5142.7 5164.6 5201.7 5206.5 5234.6 5247.7 5249.4 5080.5 5087.9 5129.8 5154.8 5170.8 5563.6 5623.5 5693.7 5698.4 5704.2 5289.5 6108.1 6214.7 6219.1 6232.3 6140.8 6252.5 6288.1 6312.2 6320.4 5620.4 5741.1 5750.7 5790.2 5807.5 6244.4 6251.1 6253.4 6254.0 6300.4 6054.9 6132.9 6146.0 6162.6 6177.1 6086.2 6119.9 6131.8 6133.2 6262.2 6118.3 6214.1 6218.1 6221.7 6225.6 6228.7 6248.5 6253.5 6260.3 6264.4 4336.8 4742.9 4867.2 4900.8 4948.2 4361.9 4417.7 4421.6 4434.6 4460.7 4778.5 5647.3 5705.8 5712.2 5714.7 6202.3 6213.7 6223.5 6233.5 6234.3 5531.3 5669.1 5688.1 5694.3 5749.9 5418.6 5423.3 5427.4 5435.4 5440.4 6257.9 6263.7 6274.4 6279.0 6289.7 6108.0 6230.4 6232.8 6282.6 6311.7 6164.2 6202.5 6222.7 6263.4 6324.0 6173.3 6175.6 6190.2 6195.8 6221.9 6121.4 6227.8 6250.6 6271.3 6288.2 5763.7 5781.1 6079.4 6083.7 6098.7 6114.7 6121.2 6123.7 6127.2 6135.9 5917.2 5945.9 5952.3 5969.3 5978.8 5878.1 5956.3 6060.0 6073.9 6106.4 5893.0 5939.6 5968.8 6011.0 6029.0 16:57:13 INFO - PROCESS | 1672 | 16:57:13 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:70577.40 Median:39719.50 stddev:158480.59 (399.0%) stddev-sans-first:158837.73 16:57:13 INFO - PROCESS | 1672 | Values: 459.6 488.1 501.7 507.6 540.2 29507.7 30417.8 31563.2 31564.0 31573.9 31869.7 32579.8 32593.7 32637.5 41000.6 9184.9 9481.6 9484.0 9507.7 9542.3 9294.8 9393.9 9402.0 9416.5 9426.8 9377.3 9410.4 9429.2 9455.4 9470.6 9349.6 9405.6 9425.4 9431.5 9451.0 7979.0 9272.7 9324.6 9333.5 9339.8 39559.0 39880.0 39887.2 39888.4 39911.8 3320.8 3357.9 3535.7 3542.3 3775.4 29785.7 30176.0 30703.9 30735.0 30739.8 3189.2 3193.2 3194.1 3201.2 3302.3 447484.0 449086.0 449961.0 453467.0 458922.0 55681.7 55848.7 55920.2 55978.4 56090.4 28649.6 33927.0 34525.0 58509.7 58540.0 15490.5 15958.5 16076.4 16077.2 16093.1 12170.3 12250.0 12258.0 12261.5 12280.9 17997.9 18532.6 18535.8 18544.2 18585.6 7700.3 7823.8 7845.5 7942.4 7944.4 855.5 937.9 966.4 1005.4 1045.4 28885.6 29462.6 29506.9 30053.8 30217.7 1025.1 1032.4 1050.2 1066.4 1138.0 13265.2 14730.9 14736.0 14853.1 15084.1 646103.0 685215.0 685516.6 685977.0 686531.0 54024.7 54529.0 54601.5 54638.9 54675.7 1226.4 1272.2 1358.6 1417.6 1468.4 24611.4 29399.0 30888.7 31624.4 31710.8 50804.7 51788.0 51847.0 51867.7 51986.5 608034.0 622990.0 623647.0 624972.0 625265.0 41486.4 41941.8 42709.5 42966.1 43098.1 46270.0 46999.8 47352.8 47395.0 47425.8 36392.6 38620.4 39280.0 39931.0 40444.6 32778.0 38322.8 39192.0 39280.0 40120.0 38033.0 38376.8 38417.4 38467.4 40533.6 32381.7 33993.4 34200.5 34353.3 34576.1 25064.0 25130.6 25323.0 25414.3 25516.6 16:57:13 INFO - PROCESS | 1672 | 16:57:13 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:34884.14 Median:2370.26 stddev:98367.76 (4150.1%) stddev-sans-first:98609.52 16:57:13 INFO - PROCESS | 1672 | Values: 347.1 366.2 370.2 377.2 401.1 14224.9 15086.3 19363.0 19373.6 20349.2 16959.7 19623.2 20136.7 20224.7 20481.0 5481.8 6038.9 6077.8 6096.1 6108.1 4174.5 4412.6 5937.6 6316.4 6640.6 6403.1 6692.5 6696.5 6704.1 6713.3 5993.7 6649.2 6692.7 6699.3 6706.1 5516.3 5732.6 5764.1 5775.7 5799.2 20849.9 25016.2 25548.4 25599.0 26082.6 2219.4 2274.0 2290.9 2449.6 2973.8 12587.6 14507.4 15532.0 15634.5 16370.6 1797.6 1819.6 1928.4 1972.3 1973.5 118509.4 123028.0 123291.2 123498.0 124979.0 11081.8 11378.5 11532.9 11535.8 11704.2 12928.3 13415.8 13501.4 13501.8 14231.1 8283.5 8407.7 8452.7 8544.8 8572.4 7151.4 8042.9 8258.7 8271.2 8490.4 4429.7 4502.9 4516.4 4601.0 4615.3 1850.5 1891.6 1893.5 1917.9 1932.8 794.6 804.4 944.4 957.6 1023.7 19910.0 19975.7 21358.5 21524.0 21683.9 880.3 902.3 907.5 921.9 995.8 10443.8 10953.8 11067.3 11099.0 11109.8 577349.0 579724.0 585461.0 598652.0 600729.0 119831.4 125383.4 126215.0 129547.0 129826.0 953.2 998.9 1035.2 1037.9 1040.0 15724.9 19114.6 19462.7 19736.7 19944.8 54651.5 55472.0 55976.0 56072.0 57168.3 70287.6 77164.2 77681.0 79771.8 79885.0 7900.2 7950.0 8229.7 8232.0 8432.3 10953.8 12849.4 12955.4 13055.7 13208.7 11068.5 11149.4 11293.1 11305.2 11388.0 10975.3 10977.4 11214.0 11328.0 11432.4 9153.9 10093.6 11342.8 11537.3 11560.9 8121.8 8147.3 8223.9 8234.3 8273.0 9519.4 10237.6 10659.7 11100.1 11208.2 16:57:13 INFO - PROCESS | 1672 | 16:57:13 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:5574.97 Median:4933.35 stddev:3129.32 (63.4%) stddev-sans-first:3121.72 16:57:13 INFO - PROCESS | 1672 | Values: 1314.5 1464.2 1476.2 1641.3 1823.2 7708.5 8177.4 8545.0 8795.4 8804.6 8635.6 8713.6 8731.1 8735.8 8756.3 2290.9 2314.5 2317.2 2326.0 2328.3 2269.3 2305.0 2323.2 2325.2 2329.8 2276.3 2304.4 2312.0 2317.2 2322.3 2271.5 2283.7 2286.1 2287.9 2290.9 2274.5 2281.0 2285.2 2286.1 2290.1 8641.2 8660.7 8734.0 8744.0 8745.0 5056.6 5274.4 5275.4 5297.1 5305.4 3608.9 3631.1 3694.1 3694.7 3700.2 993.8 1014.4 1756.6 1813.7 1858.3 10106.6 11237.2 11396.1 11498.1 11509.2 3999.2 4370.7 4444.3 4514.0 4524.5 8984.7 8995.1 9006.8 9014.1 9020.0 5200.2 5208.7 5214.3 5216.6 5223.3 4052.5 4370.7 4537.6 4866.1 4927.6 3618.6 3645.8 3721.0 3740.9 3741.8 1102.3 1118.1 1131.5 1131.9 1134.2 835.9 853.2 898.7 903.8 924.8 5616.9 5623.2 5749.8 5847.5 5862.0 404.0 409.8 432.8 444.6 446.5 3769.7 3908.0 3999.9 4004.8 4009.4 10360.2 10657.5 10668.9 10775.0 10796.1 10732.5 10746.4 10746.8 10751.4 10773.3 7653.8 7946.3 8093.2 8194.7 8258.1 5731.1 5857.7 5932.5 5991.6 6042.9 9735.7 9806.5 9936.0 9995.3 10050.4 9296.3 9605.9 9646.5 9923.6 10022.9 6752.2 6939.7 7375.8 7377.6 7417.1 7894.3 8067.7 8145.3 8170.0 8174.5 7305.0 7313.0 7336.6 7337.2 7527.5 7110.9 7184.4 7228.4 7237.1 7291.1 5922.5 6830.6 6885.3 6916.3 6925.1 4776.6 4819.1 4884.8 4939.1 4942.3 4924.6 4925.5 4985.1 5048.8 5063.2 16:57:13 INFO - PROCESS | 1672 | 16:57:13 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:4394.97 Median:5008.41 stddev:1369.05 (27.3%) stddev-sans-first:1337.94 16:57:13 INFO - PROCESS | 1672 | Values: 299.7 307.8 309.9 315.1 319.6 4170.1 5192.0 5222.7 5239.8 5265.6 5077.4 5090.0 5090.6 5126.1 5127.6 3468.7 3687.0 3731.7 3748.9 3905.7 3222.5 3907.0 3942.4 3944.8 4011.4 3408.6 3875.7 3880.7 3914.3 3915.2 3267.5 3646.4 3650.6 3910.5 3926.4 2954.3 3386.9 3388.8 3394.6 3399.6 3809.8 4579.5 4998.4 5028.3 5043.2 3763.8 4429.5 4434.1 4455.0 4464.5 4206.6 4292.2 4909.3 5382.9 5468.6 3132.9 3689.4 3706.1 3728.6 3730.2 5624.0 5638.3 5641.2 5649.0 5660.7 3165.9 3672.8 3683.7 3728.2 3911.4 3951.2 3954.7 3961.1 3961.3 4011.9 3788.8 3870.1 4523.9 4532.6 4535.5 5015.5 5368.1 5474.6 5475.1 5484.6 1334.8 1354.5 1361.5 1361.9 1364.6 728.7 742.8 805.8 833.9 848.8 4723.9 4823.8 4976.2 5001.3 5113.5 5325.6 5564.8 5576.6 5612.7 5631.4 4787.4 5070.0 5096.6 5106.8 5110.9 2711.9 2857.8 2937.5 2943.3 2975.2 5249.6 5404.7 5746.7 5757.6 5773.1 4658.3 5720.7 5747.0 5751.2 5790.4 5531.9 5805.6 5816.7 5832.8 5838.1 4955.0 5450.9 5629.6 5634.3 5663.7 4891.9 5308.9 5488.8 5628.7 5669.3 4960.6 5205.3 5681.3 5827.4 5889.9 3256.8 3543.0 3758.9 3780.6 3813.6 4882.3 5203.9 5617.6 5622.3 5759.7 4862.5 5442.7 5457.9 5513.6 5551.4 4605.5 5302.4 5488.8 5517.6 5597.5 4392.9 4545.9 5365.7 5366.0 5386.4 5137.8 5267.7 5354.2 5411.5 5475.9 5305.5 5316.5 5323.3 5334.8 5357.4 16:57:13 INFO - PROCESS | 1672 | 16:57:13 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:25177.59 Median:4159.77 stddev:41075.74 (987.5%) stddev-sans-first:41149.85 16:57:13 INFO - PROCESS | 1672 | Values: 700.7 709.5 757.2 786.4 792.6 15536.5 15792.1 15816.4 15816.9 16149.6 14139.4 14221.5 14241.7 14243.3 14268.4 665.5 678.8 689.1 691.5 813.4 839.0 839.2 845.1 848.9 849.2 899.2 902.7 904.9 905.3 905.4 894.0 894.7 895.9 897.2 898.9 527.9 545.2 649.6 661.9 664.8 14611.6 14652.9 14677.0 14682.1 14714.3 11608.0 13074.0 13300.3 13438.5 13486.7 12077.2 12207.1 12224.5 12258.4 12348.1 4312.4 4328.7 4353.2 4372.2 4476.9 114893.0 117092.0 118180.0 118546.4 121460.8 10498.0 10559.7 10602.3 10613.3 11021.6 20712.6 20764.5 20793.3 20820.4 20834.2 7452.2 7570.2 7616.0 7721.6 7816.3 4151.1 4168.4 4190.0 4234.3 4335.7 3329.9 3434.7 3439.6 3441.5 3444.2 636.3 637.8 641.3 648.9 662.3 528.6 546.3 573.8 598.5 608.2 8915.1 9012.7 9032.9 9043.3 9140.6 488.1 509.3 534.1 603.5 626.9 4109.8 4215.5 4352.0 4411.0 4437.5 93965.0 108669.6 132752.3 163791.2 171732.1 91390.5 137560.0 145147.0 145398.0 148874.0 116716.8 118235.3 121451.0 121601.0 124372.0 8382.7 8470.2 8485.9 8516.6 8678.8 63970.4 64732.0 65319.3 66489.4 67531.3 96198.0 99229.5 99570.5 106284.9 107939.5 9871.0 11137.5 11222.3 11358.8 11552.4 11927.6 11977.8 11986.2 12156.1 12265.6 9487.2 11466.5 11505.9 11669.9 11723.0 9844.7 13306.6 13709.8 13863.2 14175.7 13824.2 13837.9 14250.3 14309.4 14399.6 9365.3 11488.3 11502.8 11562.8 11666.0 9650.9 9791.6 11318.1 11395.0 11706.6 16:57:13 INFO - PROCESS | 1672 | -------- Summary: end -------- 16:57:13 INFO - PROCESS | 1672 | 16:57:14 INFO - TEST-INFO | 1672: exit 0 16:57:14 INFO - TEST-OK | dromaeo_css | took 1119633ms 16:57:14 INFO - TEST-START | kraken 16:57:14 INFO - operating with platform_type : mac_ 16:57:14 INFO - Initialising browser for kraken test... 16:57:14 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpJjsIjj/profile http://localhost:49267/getInfo.html) 16:57:16 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 16:57:16 INFO - PROCESS | 1679 | colorDepth:24 16:57:16 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 16:57:16 INFO - PROCESS | 1679 | __metrics 16:57:16 INFO - PROCESS | 1679 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:57:16 INFO - PROCESS | 1679 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:57:17 INFO - TEST-INFO | 1679: exit 0 16:57:17 INFO - Browser initialized. 16:57:17 INFO - Running cycle 1/1 for kraken test... 16:57:17 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpJjsIjj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:29 INFO - PROCESS | 1680 | RSS: Main: 246194176 16:57:29 INFO - PROCESS | 1680 | 16:57:32 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 16:57:33 INFO - PROCESS | 1680 | RSS: Main: 296452096 16:57:33 INFO - PROCESS | 1680 | 16:57:36 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 16:57:36 INFO - PROCESS | 1680 | RSS: Main: 297369600 16:57:36 INFO - PROCESS | 1680 | 16:57:40 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 16:57:41 INFO - PROCESS | 1680 | RSS: Main: 386080768 16:57:41 INFO - PROCESS | 1680 | 16:57:43 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 16:57:43 INFO - PROCESS | 1680 | RSS: Main: 288321536 16:57:43 INFO - PROCESS | 1680 | 16:57:45 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:57:46 INFO - PROCESS | 1680 | RSS: Main: 292589568 16:57:46 INFO - PROCESS | 1680 | 16:57:49 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 16:57:49 INFO - PROCESS | 1680 | RSS: Main: 330850304 16:57:49 INFO - PROCESS | 1680 | 16:57:52 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 16:57:53 INFO - PROCESS | 1680 | RSS: Main: 331120640 16:57:53 INFO - PROCESS | 1680 | 16:57:55 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 16:57:56 INFO - PROCESS | 1680 | RSS: Main: 329043968 16:57:56 INFO - PROCESS | 1680 | 16:57:57 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:57:58 INFO - PROCESS | 1680 | RSS: Main: 301670400 16:57:58 INFO - PROCESS | 1680 | 16:58:00 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:58:01 INFO - PROCESS | 1680 | RSS: Main: 304353280 16:58:01 INFO - PROCESS | 1680 | 16:58:03 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:58:04 INFO - PROCESS | 1680 | RSS: Main: 307863552 16:58:04 INFO - PROCESS | 1680 | 16:58:07 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:58:07 INFO - PROCESS | 1680 | RSS: Main: 321183744 16:58:07 INFO - PROCESS | 1680 | 16:58:10 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:58:11 INFO - PROCESS | 1680 | RSS: Main: 321081344 16:58:11 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 16:58:13 INFO - PROCESS | 1680 | RSS: Main: 365584384 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | __start_tp_report 16:58:13 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 16:58:13 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 16:58:13 INFO - PROCESS | 1680 | |i|pagename|runs| 16:58:13 INFO - PROCESS | 1680 | |0;ai-astar;111;111;112;110;112;113;118;160;160;110 16:58:13 INFO - PROCESS | 1680 | |1;audio-beat-detection;151;111;116;148;119;113;112;112;143;112 16:58:13 INFO - PROCESS | 1680 | |2;audio-dft;182;181;199;268;212;183;182;182;182;255 16:58:13 INFO - PROCESS | 1680 | |3;audio-fft;79;59;59;85;60;59;60;57;82;57 16:58:13 INFO - PROCESS | 1680 | |4;audio-oscillator;87;71;90;69;67;69;93;68;75;124 16:58:13 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;86;83;86;83;86;83;86;83;86;83 16:58:13 INFO - PROCESS | 1680 | |6;imaging-darkroom;94;95;94;95;94;95;94;95;93;94 16:58:13 INFO - PROCESS | 1680 | |7;imaging-desaturate;86;86;85;84;83;83;86;85;85;84 16:58:13 INFO - PROCESS | 1680 | |8;json-parse-financial;55;52;52;51;52;53;55;53;54;53 16:58:13 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;69;68;65;77;71;70;68;70;69;71 16:58:13 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;87;87;85;97;108;85;85;89;88;78 16:58:13 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;154;157;154;140;145;144;147;145;180;146 16:58:13 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;175;172;172;173;173;175;172;174;171;173 16:58:13 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;69;69;70;70;69;70;69;68;70;67 16:58:13 INFO - PROCESS | 1680 | __end_tp_report 16:58:13 INFO - PROCESS | 1680 | __start_cc_report 16:58:13 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,2017 16:58:13 INFO - PROCESS | 1680 | __end_cc_report 16:58:13 INFO - PROCESS | 1680 | __startTimestamp1476230293300__endTimestamp 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | ------- Summary: start ------- 16:58:13 INFO - PROCESS | 1680 | Number of tests: 14 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:121.70 Median:112.50 stddev:20.31 (18.1%) stddev-sans-first:21.17 16:58:13 INFO - PROCESS | 1680 | Values: 111.0 111.0 112.0 110.0 112.0 113.0 118.0 160.0 160.0 110.0 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:123.70 Median:117.50 stddev:16.59 (14.1%) stddev-sans-first:14.35 16:58:13 INFO - PROCESS | 1680 | Values: 151.0 111.0 116.0 148.0 119.0 113.0 112.0 112.0 143.0 112.0 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:202.60 Median:191.00 stddev:32.78 (17.2%) stddev-sans-first:33.91 16:58:13 INFO - PROCESS | 1680 | Values: 182.0 181.0 199.0 268.0 212.0 183.0 182.0 182.0 182.0 255.0 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:65.70 Median:60.00 stddev:11.38 (19.0%) stddev-sans-first:11.01 16:58:13 INFO - PROCESS | 1680 | Values: 79.0 59.0 59.0 85.0 60.0 59.0 60.0 57.0 82.0 57.0 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:73.00 stddev:17.94 (24.6%) stddev-sans-first:18.91 16:58:13 INFO - PROCESS | 1680 | Values: 87.0 71.0 90.0 69.0 67.0 69.0 93.0 68.0 75.0 124.0 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:84.50 Median:86.00 stddev:1.58 (1.8%) stddev-sans-first:1.58 16:58:13 INFO - PROCESS | 1680 | Values: 86.0 83.0 86.0 83.0 86.0 83.0 86.0 83.0 86.0 83.0 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 16:58:13 INFO - PROCESS | 1680 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 93.0 94.0 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.16 (1.4%) stddev-sans-first:1.13 16:58:13 INFO - PROCESS | 1680 | Values: 86.0 86.0 85.0 84.0 83.0 83.0 86.0 85.0 85.0 84.0 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:1.33 (2.5%) stddev-sans-first:1.20 16:58:13 INFO - PROCESS | 1680 | Values: 55.0 52.0 52.0 51.0 52.0 53.0 55.0 53.0 54.0 53.0 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:3.08 (4.4%) stddev-sans-first:3.26 16:58:13 INFO - PROCESS | 1680 | Values: 69.0 68.0 65.0 77.0 71.0 70.0 68.0 70.0 69.0 71.0 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:87.00 stddev:8.18 (9.4%) stddev-sans-first:8.65 16:58:13 INFO - PROCESS | 1680 | Values: 87.0 87.0 85.0 97.0 108.0 85.0 85.0 89.0 88.0 78.0 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:151.20 Median:150.50 stddev:11.44 (7.6%) stddev-sans-first:12.09 16:58:13 INFO - PROCESS | 1680 | Values: 154.0 157.0 154.0 140.0 145.0 144.0 147.0 145.0 180.0 146.0 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:173.00 stddev:1.33 (0.8%) stddev-sans-first:1.20 16:58:13 INFO - PROCESS | 1680 | Values: 175.0 172.0 172.0 173.0 173.0 175.0 172.0 174.0 171.0 173.0 16:58:13 INFO - PROCESS | 1680 | 16:58:13 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:0.99 (1.4%) stddev-sans-first:1.05 16:58:13 INFO - PROCESS | 1680 | Values: 69.0 69.0 70.0 70.0 69.0 70.0 69.0 68.0 70.0 67.0 16:58:13 INFO - PROCESS | 1680 | -------- Summary: end -------- 16:58:13 INFO - PROCESS | 1680 | 16:58:14 INFO - TEST-INFO | 1680: exit 0 16:58:14 INFO - TEST-OK | kraken | took 59779ms 16:58:14 INFO - SUITE-END | took 1179s 16:58:14 INFO - Completed test suite (00:19:39) 16:58:14 INFO - javascript benchmark 16:58:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2908.258394109502, 3306.801591904485, 3336.3160552086824, 3353.2287573858025, 3377.5814158053613, 5529.004779139753, 5659.632123911948, 5678.43215678432, 5735.455131762486, 5742.483176514118, 5661.66030038198, 5711.286089238845, 5714.599978001531, 5717.742701578439, 5726.427357264281, 5123.948760512394, 5173.637845350827, 5177.974110129444, 5194.480551944813, 5209.921851172236, 5181.455947125554, 5182.093133701606, 5183.50756678115, 5186.429492755813, 5186.948130518685, 5091.159958606825, 5126.7436628168625, 5130.871728206787, 5142.717150556718, 5164.586833053347, 5201.713905735202, 5206.479352064764, 5234.6335756497065, 5247.68513889164, 5249.4488078751565, 5080.542751152377, 5087.898242035176, 5129.820456284012, 5154.845354639367, 5170.819021334235, 5563.638363506359, 5623.493885550321, 5693.743781529841, 5698.373178950312, 5704.2299289595785, 5289.471052894718, 6108.053251745987, 6214.720337584819, 6219.067139929001, 6232.314445411046, 6140.846478838065, 6252.5101770635265, 6288.056791481269, 6312.242530896276, 6320.431161195468, 5620.381758006616, 5741.081426971665, 5750.734838335559, 5790.247267855152, 5807.506361959281, 6244.438000579969, 6251.062340648939, 6253.405926436982, 6254.0, 6300.369963003663, 6054.939450605438, 6132.938670613326, 6146.0, 6162.568620196633, 6177.104319873683, 6086.178365920544, 6119.929102025404, 6131.774283661951, 6133.18690095852, 6262.1546091278005, 6118.251671986824, 6214.098955651405, 6218.098375735493, 6221.688915554204, 6225.564210505221, 6228.657423841732, 6248.50011999039, 6253.46845518127, 6260.342664020303, 6264.404881536247, 4336.783160841946, 4742.857714268577, 4867.221244600847, 4900.828471003569, 4948.183549714328, 4361.869143925687, 4417.690761646718, 4421.579949904753, 4434.600885920283, 4460.687751857404, 4778.474367819537, 5647.322321321468, 5705.771769129188, 5712.200291959129, 5714.685692286881, 6202.317745048041, 6213.720382582795, 6223.533235007302, 6233.470155036873, 6234.314225435199, 5531.308586426697, 5669.092945128842, 5688.06146985751, 5694.316681998187, 5749.885002300014, 5418.566514678816, 5423.294971653739, 5427.402985671573, 5435.42927992563, 5440.3743569489225, 6257.906131408033, 6263.655498947602, 6274.435300822948, 6278.968605157128, 6289.748410063729, 6108.0, 6230.43926046658, 6232.844178895564, 6282.560220784501, 6311.747530098744, 6164.229471316085, 6202.534809889186, 6222.688865556614, 6263.4362907338555, 6324.0, 6173.32093469709, 6175.59858609189, 6190.164327815867, 6195.783147589993, 6221.875562488815, 6121.418465245794, 6227.782027629192, 6250.593711408926, 6271.3415091414745, 6288.245410550763, 5763.682997435014, 5781.075027995501, 6079.422454866781, 6083.726232319467, 6098.664573448503, 6114.723190878713, 6121.239585875057, 6123.740204357105, 6127.189528148541, 6135.875804921915, 5917.171595976481, 5945.940540594539, 5952.285725712942, 5969.313528944053, 5978.760849565969, 5878.147668588116, 5956.344802071682, 6059.969700151471, 6073.878522429615, 6106.3588323227195, 5893.0, 5939.643621382731, 5968.791092311922, 6011.0, 6029.0], "value": 5662.833696768895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.57718898613274, 488.07753346175724, 501.72405177152535, 507.55081752648897, 540.211291514389, 29507.704922950765, 30417.847910760443, 31563.21091972699, 31564.0, 31573.89491367797, 31869.68130318696, 32579.837100814464, 32593.67406325936, 32637.51043734346, 41000.58999410005, 9184.8622270666, 9481.620735170585, 9484.0, 9507.714768556954, 9542.33203675743, 9294.767630809216, 9393.859092113624, 9401.952990235039, 9416.52917354133, 9426.81146377072, 9377.296702747288, 9410.435373877555, 9429.151376376125, 9455.385399948982, 9470.573824177929, 9349.626014959393, 9405.623775048989, 9425.387349822307, 9431.528423578862, 9450.952745236264, 7979.0, 9272.72181834546, 9324.580393882292, 9333.533323333873, 9339.76650583734, 39559.0, 39880.0, 39887.20225595472, 39888.40167397491, 39911.800440997606, 3320.7841490303053, 3357.9496307555405, 3535.699465545432, 3542.256126213498, 3775.3959366501504, 29785.702142978727, 30176.0, 30703.925362612426, 30735.0, 30739.846300768353, 3189.1548739584027, 3193.1697758582704, 3194.1216165554424, 3201.2157021529642, 3302.2734998300334, 447484.0, 449086.0, 449961.0, 453466.9999999967, 458922.0, 55681.72159139178, 55848.72075639677, 55920.16119758207, 55978.44021559814, 56090.43909560934, 28649.570256445753, 33927.0, 34525.0, 58509.70745146247, 58540.0, 15490.457833975757, 15958.521244362688, 16076.356945722275, 16077.196140193177, 16093.114878681785, 12170.269783812999, 12250.0, 12257.958073563846, 12261.509539618315, 12280.877191228152, 17997.910010449865, 18532.629347413247, 18535.814641853678, 18544.16551255197, 18585.628287434174, 7700.3454706350585, 7823.843523129505, 7845.490043147177, 7942.3646108311195, 7944.44388892772, 855.4952577979022, 937.864009718587, 966.3960024984385, 1005.3967619428284, 1045.3988956350129, 28885.56671649927, 29462.558061629094, 29506.852465737535, 30053.849730751208, 30217.69782302193, 1025.0825511167463, 1032.396048311731, 1050.1651187305956, 1066.440118937564, 1137.9544818207344, 13265.204087754766, 14730.852691473163, 14736.0, 14853.108813471226, 15084.094954302776, 646103.0, 685215.0, 685516.5724171348, 685977.0, 686531.0, 54024.72987635115, 54529.0, 54601.45398545964, 54638.907221856134, 54675.72662136744, 1226.4419689041465, 1272.1858010873048, 1358.5992132320791, 1417.6385021819576, 1468.4199741102418, 24611.384715382257, 29399.0, 30888.691113088582, 31624.36751265008, 31710.841445792623, 50804.745976269885, 51788.0, 51846.96306073782, 51867.740661296455, 51986.48013519968, 608034.0, 622990.0, 623647.0, 624972.0, 625265.0, 41486.377704333856, 41941.79029104957, 42709.5155008732, 42966.14067718691, 43098.1380372397, 46270.0, 46999.765001174776, 47352.763236184976, 47395.0, 47425.76287118543, 36392.636073638925, 38620.420693690176, 39280.0, 39931.0, 40444.595554044085, 32778.0, 38322.80838595789, 39192.0, 39280.01799955024, 40120.0, 38033.0, 38376.84869453921, 38417.42373864338, 38467.42298865463, 40533.581324653496, 32381.676183238807, 33993.3910904698, 34200.486992694634, 34353.312933740686, 34576.09831459294, 25064.0, 25130.62304065477, 25322.987080516574, 25414.30966631378, 25516.61725074088], "value": 19583.546311608763, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.0594688394451, 366.20168033686565, 370.1985202037589, 377.2078634866779, 401.09152768978254, 14224.928875355621, 15086.3211155498, 19363.031848407594, 19373.612527749436, 20349.18603255868, 16959.745603815954, 19623.215071397128, 20136.69794953073, 20224.696629550534, 20480.975951202417, 5481.780728770845, 6038.939610603882, 6077.817665470043, 6096.116063170837, 6108.14485971962, 4174.457320548339, 4412.580804823537, 5937.554683398741, 6316.431521163095, 6640.6347650879425, 6403.1355766971565, 6692.498062645297, 6696.531242813005, 6704.094947182117, 6713.2951040140815, 5993.700314984233, 6649.168853893263, 6692.698828552727, 6699.263081061079, 6706.094677218586, 5516.310461192351, 5732.5987180897355, 5764.106563482667, 5775.711214439261, 5799.217105690762, 20849.8957505213, 25016.23976894545, 25548.361290967874, 25599.0, 26082.608760868603, 2219.411855858199, 2274.0449011415244, 2290.874001929893, 2449.64480150379, 2973.762099032094, 12587.622371328875, 14507.419703211859, 15532.0, 15634.45279415215, 16370.590735231595, 1797.6045270040702, 1819.5724004858848, 1928.3732786844332, 1972.2505447929839, 1973.4868934077099, 118509.40745296305, 123028.0, 123291.15063274058, 123498.0, 124979.0, 11081.778364432666, 11378.487968041458, 11532.942335288437, 11535.826962595567, 11704.239224450383, 12928.288944107977, 13415.798763018562, 13501.392437340342, 13501.797473037912, 14231.146131232159, 8283.50298982063, 8407.747767566983, 8452.704155354533, 8544.829103417896, 8572.399932004824, 7151.427885769126, 8042.879356809653, 8258.658030161523, 8271.21423464782, 8490.405671603052, 4429.734215947054, 4502.932456013163, 4516.3902873112365, 4600.97699511507, 4615.3077038443835, 1850.4818650777804, 1891.5743957609427, 1893.479293194355, 1917.8561607879465, 1932.845372370207, 794.6463823598559, 804.3565147881671, 944.3719926248967, 957.6169532187181, 1023.6928921323573, 19910.004499775245, 19975.700364494543, 21358.466038349165, 21524.0, 21683.891580541997, 880.2561835249204, 902.3052249767774, 907.4827348411474, 921.949292788903, 995.7709726762885, 10443.791124177475, 10953.83569246462, 11067.335959842436, 11099.001089901947, 11109.83335249972, 577349.0, 579724.0, 585461.0, 598652.0, 600729.0, 119831.40084299697, 125383.373083134, 126215.0, 129547.0, 129826.0, 953.208836665566, 998.9001099890098, 1035.171862509989, 1037.9481025948671, 1039.9636012739518, 15724.857382215772, 19114.617707646048, 19462.708059379405, 19736.70394944048, 19944.800551994293, 54651.47546534692, 55472.0, 55976.0, 56072.0, 57168.284951451526, 70287.59424811577, 77164.2283577157, 77681.0, 79771.80342294755, 79885.0, 7900.170482099526, 7950.0, 8229.711960081368, 8231.95884020576, 8432.283255923316, 10953.780924381626, 12849.357532123544, 12955.352232388532, 13055.673608159872, 13208.735825283633, 11068.501917413574, 11149.386783726974, 11293.096552275634, 11305.208635395444, 11388.0, 10975.341479511255, 10977.3962432067, 11214.0, 11328.0, 11432.371219583003, 9153.855768028996, 10093.596256149673, 11342.773144537228, 11537.307761534335, 11560.94219528897, 8121.8375632488205, 8147.266745992889, 8223.917760822555, 8234.258916697527, 8273.0, 9519.381240219363, 10237.641682541076, 10659.680209593724, 11100.056495197998, 11208.159388045766], "value": 9648.544311974998, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.4610709609062, 1464.2166440954088, 1476.2249818845107, 1641.302446460255, 1823.2342416185202, 7708.498947568404, 8177.386695997801, 8545.0, 8795.384323097385, 8804.603792829323, 8635.568221588926, 8713.607887645056, 8731.126887311282, 8735.781605459866, 8756.255718263956, 2290.8625482471107, 2314.456102815837, 2317.24689475921, 2325.9534809303805, 2328.3247858121126, 2269.341890851651, 2305.020366344297, 2323.2217207235594, 2325.1513197682893, 2329.848559843613, 2276.260215429992, 2304.412374844412, 2312.0289478419104, 2317.2237300504353, 2322.314917099451, 2271.5002699406105, 2283.748787633359, 2286.1312701173447, 2287.874166920819, 2290.8625482471107, 2274.4541310085624, 2281.0305620111385, 2285.245868863271, 2286.0969916882905, 2290.141197051106, 8641.222289993932, 8660.740177794676, 8733.99559050711, 8744.0, 8744.956275218583, 5056.595472362203, 5274.393444753864, 5275.393329767087, 5297.12597421425, 5305.363356397218, 3608.891733248007, 3631.055925459373, 3694.07648087978, 3694.685951694082, 3700.2257697149025, 993.8211121998038, 1014.4471263161595, 1756.6486702659392, 1813.7460755494242, 1858.256697321069, 10106.64626738068, 11237.213395062348, 11396.088312934946, 11498.080153587693, 11509.194356395055, 3999.1801680655394, 4370.7159034662645, 4444.266695995125, 4513.954860451354, 4524.47968483622, 8984.730458086267, 8995.145461181177, 9006.819863602692, 9014.143656352637, 9020.0, 5200.193969934666, 5208.713520756395, 5214.2960700304975, 5216.634835561475, 5223.3209682741, 4052.5339585947404, 4370.7159034662645, 4537.6143027842345, 4866.148424025781, 4927.5811556017425, 3618.638136186413, 3645.799481028516, 3720.9627903720616, 3740.887773366749, 3741.7567858089137, 1102.327580176092, 1118.0608289037248, 1131.5077941095649, 1131.8981291683624, 1134.2003887259461, 835.9164083591713, 853.1638993786, 898.6630013744846, 903.7559858838077, 924.8011677489372, 5616.887662246814, 5623.2408624835125, 5749.755308311557, 5847.502962248256, 5861.9706901465215, 403.97576145431367, 409.8360655737729, 432.82254275746794, 444.56876829475357, 446.49992008949533, 3769.698424126118, 3908.0, 3999.9400008999887, 4004.819783109767, 4009.4386785850006, 10360.171186305077, 10657.520411581498, 10668.89331106679, 10775.0, 10796.136309095253, 10732.517036733365, 10746.355218686904, 10746.78506429867, 10751.408672523086, 10773.299735517166, 7653.808654783564, 7946.32456241226, 8093.1502192270145, 8194.67221311141, 8258.050324212672, 5731.140328950691, 5857.707114644166, 5932.525397968066, 5991.550633702403, 6042.882066817653, 9735.70792876215, 9806.548362909272, 9936.006399360296, 9995.300328977193, 10050.39697618116, 9296.349255552046, 9605.903940960501, 9646.517674116407, 9923.603055877684, 10022.899771002196, 6752.223494298022, 6939.722411103499, 7375.778726638209, 7377.594232317274, 7417.072865891763, 7894.250046245597, 8067.677292908218, 8145.266925976691, 8169.978752655918, 8174.509529428254, 7305.0, 7312.96343518279, 7336.559806411632, 7337.229590892879, 7527.548347099191, 7110.893336599852, 7184.425245980205, 7228.385587225145, 7237.131544214728, 7291.125064992235, 5922.526197904243, 6830.624315662686, 6885.311468853275, 6916.273791251846, 6925.099737034153, 4776.641751868693, 4819.108464933998, 4884.8290309838985, 4939.110960027229, 4942.258661200849, 4924.556789888928, 4925.532074452921, 4985.1276026695905, 5048.848534543969, 5063.1645778446145], "value": 4422.572775391842, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.6838335555988, 307.776861775213, 309.8745008271649, 315.05797664981714, 319.5941154733487, 4170.145120250349, 5192.039472697549, 5222.738863056847, 5239.816606418776, 5265.578753699704, 5077.41609714882, 5089.974550127245, 5090.643654944146, 5126.051680439122, 5127.641065125443, 3468.6531346865363, 3686.9631303687024, 3731.7312113881276, 3748.906277343061, 3905.7461265017823, 3222.4682927316962, 3907.0427745202464, 3942.369220924653, 3944.842206311744, 4011.438398624195, 3408.6250512443735, 3875.7403843750753, 3880.689544836406, 3914.3345631242755, 3915.23652887687, 3267.5425440438357, 3646.361886669822, 3650.5984341722387, 3910.4720862683457, 3926.371780515118, 2954.2762023304426, 3386.9322613547592, 3388.7797293175863, 3394.575678040245, 3399.5750531183603, 3809.790461524643, 4579.473360563545, 4998.425181104183, 5028.34631497903, 5043.167877300241, 3763.7741735495956, 4429.468463784334, 4434.091011342667, 4454.977725111354, 4464.531224221442, 4206.579342065799, 4292.18448494785, 4909.337239472661, 5382.865428364283, 5468.589855760833, 3132.8746850125967, 3689.3543629864935, 3706.0734816295926, 3728.5525736911472, 3730.198007428416, 5624.0, 5638.323401191842, 5641.2102305677645, 5649.022842005265, 5660.726336574237, 3165.889193878203, 3672.779633221962, 3683.650053244937, 3728.1984373359314, 3911.413288006822, 3951.229510245532, 3954.7033972451604, 3961.0590810502645, 3961.267165574378, 4011.859584914514, 3788.8484460621266, 3870.1292209252692, 4523.909521809545, 4532.592066713945, 4535.546445355504, 5015.4733752956145, 5368.141097424394, 5474.562035037187, 5475.06923822951, 5484.643498172606, 1334.7520068735764, 1354.537099932071, 1361.46902707944, 1361.9114757540729, 1364.590622813152, 728.6575309604477, 742.8477162181848, 805.7864665863551, 833.8749187621905, 848.7708318754026, 4723.881902952454, 4823.831165909176, 4976.2286845539, 5001.349824522788, 5113.51421614946, 5325.573954083664, 5564.805231816867, 5576.605848537865, 5612.719364031782, 5631.380548139701, 4787.4494433140635, 5069.969374347403, 5096.566791822663, 5106.770195341219, 5110.948890511122, 2711.9050833221136, 2857.7570906472765, 2937.4859399604984, 2943.2641839540115, 2975.226441125323, 5249.553787927993, 5404.675854415615, 5746.741396637161, 5757.625754325955, 5773.066022882382, 4658.277966915066, 5720.740307578566, 5746.971265143731, 5751.223584815996, 5790.36306006339, 5531.861703457445, 5805.593608447368, 5816.651000939957, 5832.80427512359, 5838.095095260242, 4954.950450495449, 5450.937067271844, 5629.648884267828, 5634.32388113429, 5663.7451314690115, 4891.902161956812, 5308.920366194433, 5488.780448782004, 5628.662280263197, 5669.31968163823, 4960.578350840219, 5205.323307969939, 5681.318241811009, 5827.4172582741385, 5889.94110058894, 3256.8132986542805, 3543.0, 3758.9436158457097, 3780.6389699708634, 3813.550850676725, 4882.316475693335, 5203.869903252449, 5617.5505959522325, 5622.297212848394, 5759.7408116634015, 4862.489438608895, 5442.673439593637, 5457.918131227955, 5513.58648101386, 5551.417101204315, 4605.4933957264, 5302.443243459536, 5488.780448782004, 5517.586181036519, 5597.468240517144, 4392.912141757083, 4545.863624091283, 5365.651232669864, 5366.0, 5386.353637563518, 5137.768800403916, 5267.7094111942815, 5354.196870469461, 5411.458854114557, 5475.904819036288, 5305.469453054664, 5316.468353164652, 5323.2547443358735, 5334.813281535127, 5357.437304192824], "value": 3961.825292740927, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.7127077898061, 709.4537206351107, 757.2314101187296, 786.4180506425247, 792.6036981509244, 15536.456224032161, 15792.131432771193, 15816.44642437515, 15816.920915395407, 16149.596260093504, 14139.36372863221, 14221.502247421342, 14241.71516569668, 14243.287835608204, 14268.357923893424, 665.5274754923986, 678.7726111752556, 689.0766373060098, 691.5159388428095, 813.3574476163824, 839.039300001498, 839.2027573804879, 845.0957475501216, 848.855694531931, 849.1932663969224, 899.1817446124029, 902.7246689759621, 904.8733177355142, 905.3481493324796, 905.4160066756938, 893.9553022348856, 894.7181637784078, 895.9462432254086, 897.1611543207122, 898.883145191121, 527.8996990571779, 545.1849485019881, 649.6004956951488, 661.851083506212, 664.833791552112, 14611.561653150422, 14652.926735366362, 14677.045992010591, 14682.119072855556, 14714.33785479656, 11608.0, 13074.0, 13300.3349832508, 13438.46246150153, 13486.662833429145, 12077.214981026205, 12207.145499815017, 12224.511019559208, 12258.387080645933, 12348.135630505869, 4312.374705667692, 4328.740275583444, 4353.151135528573, 4372.234858899712, 4476.932365954326, 114893.0, 117092.0, 118180.0, 118546.40726796396, 121460.78539214672, 10498.0, 10559.736006599744, 10602.25784195099, 10613.310134841366, 11021.559137634566, 20712.58574828525, 20764.480887977923, 20793.272235471686, 20820.37538873836, 20834.1666333348, 7452.180260171377, 7570.16728159902, 7616.0, 7721.575313357707, 7816.296533312029, 4151.1075118848985, 4168.43726096973, 4189.958100419018, 4234.2801723706425, 4335.6965012449455, 3329.933401332008, 3434.6565343465454, 3439.6044454887506, 3441.535392722001, 3444.156181735441, 636.2905360522983, 637.7990932856136, 641.2657507154282, 648.8961766117399, 662.2979641579941, 528.5744975294848, 546.3416583017455, 573.827851644505, 598.530153829242, 608.1971797227706, 8915.063918288615, 9012.684556040507, 9032.8645070324, 9043.276537876955, 9140.63437462494, 488.0994812086681, 509.3454910440067, 534.1027074514852, 603.5382932056892, 626.8746250749869, 4109.794510274474, 4215.473065866767, 4351.956480435155, 4410.977945110254, 4437.467503899553, 93965.0, 108669.61286194171, 132752.33623832013, 163791.181044094, 171732.14133929252, 91390.54304728567, 137560.0, 145147.0, 145398.0, 148874.0, 116716.83283167229, 118235.27058917547, 121451.0, 121601.0, 124372.0, 8382.748517544484, 8470.207260319421, 8485.872711909204, 8516.61675224604, 8678.78303042429, 63970.3602963983, 64732.0, 65319.34680653133, 66489.35372432039, 67531.32468675447, 96198.0, 99229.50385248028, 99570.5021474917, 106284.9371506275, 107939.46030269799, 9871.0, 11137.498812553617, 11222.270552414067, 11358.76532577018, 11552.364619945647, 11927.582534611247, 11977.820332695192, 11986.160968732454, 12156.149069565046, 12265.57070502528, 9487.20884503762, 11466.541338346373, 11505.884941150482, 11669.88330116688, 11723.0, 9844.704658860246, 13306.600801975956, 13709.794353084912, 13863.237521935987, 14175.716485670435, 13824.170549766644, 13837.930810345884, 14250.287485625884, 14309.356078976263, 14399.640008999859, 9365.250779937453, 11488.253263537843, 11502.769944600894, 11562.76874462523, 11666.0, 9650.855237171307, 9791.559379827782, 11318.120858904895, 11395.0, 11706.590269340531], "value": 7580.327868697787, "unit": "score"}], "name": "dromaeo_css", "value": 7224.07510218656, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 112.0, 110.0, 112.0, 113.0, 118.0, 160.0, 160.0, 110.0], "value": 121.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 111.0, 116.0, 148.0, 119.0, 113.0, 112.0, 112.0, 143.0, 112.0], "value": 123.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 181.0, 199.0, 268.0, 212.0, 183.0, 182.0, 182.0, 182.0, 255.0], "value": 202.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 85.0, 60.0, 59.0, 60.0, 57.0, 82.0, 57.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 90.0, 69.0, 67.0, 69.0, 93.0, 68.0, 75.0, 124.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 83.0, 86.0, 83.0, 86.0, 83.0, 86.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 93.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 84.0, 83.0, 83.0, 86.0, 85.0, 85.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 51.0, 52.0, 53.0, 55.0, 53.0, 54.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 65.0, 77.0, 71.0, 70.0, 68.0, 70.0, 69.0, 71.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 85.0, 97.0, 108.0, 85.0, 85.0, 89.0, 88.0, 78.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 157.0, 154.0, 140.0, 145.0, 144.0, 147.0, 145.0, 180.0, 146.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 172.0, 173.0, 173.0, 175.0, 172.0, 174.0, 171.0, 173.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 70.0, 69.0, 70.0, 69.0, 68.0, 70.0, 67.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1463.5, "alertThreshold": 2.0}]} 16:58:14 INFO - Return code: 0 16:58:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:58:14 INFO - # TBPL SUCCESS # 16:58:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:58:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:58:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:58:14 INFO - 2016-10-11 16:58:14.621 screenresolution[1684:9884] starting screenresolution argv=screenresolution get 16:58:14 INFO - 2016-10-11 16:58:14.624 screenresolution[1684:9884] Display 0: 1600x1200x32@60 16:58:14 INFO - 2016-10-11 16:58:14.630 screenresolution[1685:9887] starting screenresolution argv=screenresolution list 16:58:14 INFO - Available Modes on Display 0 16:58:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:58:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:58:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:58:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:58:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:58:14 INFO - Intel Iris: 16:58:14 INFO - Chipset Model: Intel Iris 16:58:14 INFO - Type: GPU 16:58:14 INFO - Bus: Built-In 16:58:14 INFO - VRAM (Dynamic, Max): 1536 MB 16:58:14 INFO - Vendor: Intel (0x8086) 16:58:14 INFO - Device ID: 0x0a2e 16:58:14 INFO - Revision ID: 0x0009 16:58:14 INFO - Displays: 16:58:14 INFO - Display: 16:58:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:58:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:58:14 INFO - Display Serial Number: 1600x1200 60 16:58:14 INFO - Main Display: Yes 16:58:14 INFO - Mirror: Off 16:58:14 INFO - Online: Yes 16:58:14 INFO - Rotation: Supported 16:58:14 INFO - Return code: 0 16:58:14 INFO - Running post-action listener: _resource_record_post_action 16:58:14 INFO - [mozharness: 2016-10-11 23:58:14.872656Z] Finished run-tests step (success) 16:58:14 INFO - Running post-run listener: _resource_record_post_run 16:58:14 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37245952; Write bytes: 704625664; Read time: 244; Write time: 1937 16:58:14 INFO - TinderboxPrint: CPU usage
53.5% 16:58:14 INFO - TinderboxPrint: I/O read bytes / time
37,245,952 / 244 16:58:14 INFO - TinderboxPrint: I/O write bytes / time
704,625,664 / 1,937 16:58:14 INFO - TinderboxPrint: CPU idle
2,256.5 (46.5%) 16:58:14 INFO - TinderboxPrint: CPU system
972.7 (20.0%) 16:58:14 INFO - TinderboxPrint: CPU user
1,628.6 (33.5%) 16:58:14 INFO - TinderboxPrint: Swap in / out
443,875,328 / 0 16:58:14 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 398488064; Write bytes: 387209216; Read time: 29220; Write time: 794 16:58:14 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31063040; Write bytes: 294913024; Read time: 184; Write time: 1086 16:58:15 INFO - Running post-run listener: _upload_blobber_files 16:58:15 INFO - Blob upload gear active. 16:58:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:58:15 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 16:58:15 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:58:15 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:58:15 INFO - (blobuploader) - INFO - Open directory for files ... 16:58:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:58:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:58:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:16 INFO - (blobuploader) - INFO - Done attempting. 16:58:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:58:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:58:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:17 INFO - (blobuploader) - INFO - Done attempting. 16:58:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:58:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:58:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:20 INFO - (blobuploader) - INFO - Done attempting. 16:58:20 INFO - (blobuploader) - INFO - Iteration through files over. 16:58:20 INFO - Return code: 0 16:58:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:58:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:58:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/a73506a896ecf07fba3b91897f0b0b4b5b8cfb36a66b92e88be1478ea14864ce4f9a88c4f38c3fd51364e801cf2881234a925fd09c17e8ad81108c265186a44b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/0ca3439bd903779c88bc7f6753ff8e0792de268d3063987ac0bce3b0e2db08f2f9903d539081ea5646d0ec231d39dc445ca94ff9139e08e880d81f765924ab5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/29d608e6d575a433eba40ceb04bb8ab67d2cbd53c00b9dcd7a66602a5718e1bb77a61e7003a69f0dbfbe7dd5b2eac70836e572146d578d232eb4b48b02d5974b"} 16:58:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:58:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:58:20 INFO - Contents: 16:58:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/a73506a896ecf07fba3b91897f0b0b4b5b8cfb36a66b92e88be1478ea14864ce4f9a88c4f38c3fd51364e801cf2881234a925fd09c17e8ad81108c265186a44b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/0ca3439bd903779c88bc7f6753ff8e0792de268d3063987ac0bce3b0e2db08f2f9903d539081ea5646d0ec231d39dc445ca94ff9139e08e880d81f765924ab5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/29d608e6d575a433eba40ceb04bb8ab67d2cbd53c00b9dcd7a66602a5718e1bb77a61e7003a69f0dbfbe7dd5b2eac70836e572146d578d232eb4b48b02d5974b"} 16:58:20 INFO - Running post-run listener: copy_logs_to_upload_dir 16:58:20 INFO - Copying logs to upload dir... 16:58:20 INFO - mkdir: /builds/slave/test/build/upload/logs 16:58:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.394227 ========= master_lag: 0.30 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-11 16:58:20.366137) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 16:58:20.369781) ========= 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.jfq5dRdIpv/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.bBNcA279JH/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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/Larch/sha512/a73506a896ecf07fba3b91897f0b0b4b5b8cfb36a66b92e88be1478ea14864ce4f9a88c4f38c3fd51364e801cf2881234a925fd09c17e8ad81108c265186a44b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/0ca3439bd903779c88bc7f6753ff8e0792de268d3063987ac0bce3b0e2db08f2f9903d539081ea5646d0ec231d39dc445ca94ff9139e08e880d81f765924ab5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/29d608e6d575a433eba40ceb04bb8ab67d2cbd53c00b9dcd7a66602a5718e1bb77a61e7003a69f0dbfbe7dd5b2eac70836e572146d578d232eb4b48b02d5974b"} build_url:https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011103 build_url: 'https://queue.taskcluster.net/v1/task/b4os_SLCQvubQen0conrOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/a73506a896ecf07fba3b91897f0b0b4b5b8cfb36a66b92e88be1478ea14864ce4f9a88c4f38c3fd51364e801cf2881234a925fd09c17e8ad81108c265186a44b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/0ca3439bd903779c88bc7f6753ff8e0792de268d3063987ac0bce3b0e2db08f2f9903d539081ea5646d0ec231d39dc445ca94ff9139e08e880d81f765924ab5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/29d608e6d575a433eba40ceb04bb8ab67d2cbd53c00b9dcd7a66602a5718e1bb77a61e7003a69f0dbfbe7dd5b2eac70836e572146d578d232eb4b48b02d5974b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 16:58:20.403318) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 16:58:20.403774) ========= 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.jfq5dRdIpv/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.bBNcA279JH/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.005099 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 16:58:20.453448) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 16:58:20.453762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 16:58:20.454142) ========= ========= Total master_lag: 0.45 =========