builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0282 starttime: 1487094415.19 results: success (0) buildid: 20170214070945 builduid: 15eb97c329c14a38b448e071f7a15064 revision: 3a0e9dab386403cec5b899eb7f321c2aa27e0186 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 09:46:55.195524) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 09:46:55.196444) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 09:46:55.197164) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 09:46:55.223611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 09:46:55.224301) ========= 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.ac7ViV3T15/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.B6rY9HlAw9/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-14 09:46:55-- 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 2017-02-14 09:46:55 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099323 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 09:46:55.352350) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 09:46:55.353049) ========= 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.ac7ViV3T15/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.B6rY9HlAw9/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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.027691 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 09:46:55.406862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 09:46:55.407581) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3a0e9dab386403cec5b899eb7f321c2aa27e0186 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3a0e9dab386403cec5b899eb7f321c2aa27e0186 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ac7ViV3T15/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.B6rY9HlAw9/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-14 09:46:55,515 truncating revision to first 12 chars 2017-02-14 09:46:55,516 Setting DEBUG logging. 2017-02-14 09:46:55,516 attempt 1/10 2017-02-14 09:46:55,516 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3a0e9dab3864?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-14 09:46:56,555 unpacking tar archive at: mozilla-beta-3a0e9dab3864/testing/mozharness/ program finished with exit code 0 elapsedTime=1.325353 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 09:46:57.006372) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 09:46:57.006858) ========= script_repo_revision: 3a0e9dab386403cec5b899eb7f321c2aa27e0186 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 09:46:57.007426) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 09:46:57.007707) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 09:46:57.028393) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-14 09:46:57.029055) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ac7ViV3T15/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.B6rY9HlAw9/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 09:46:57 INFO - MultiFileLogger online at 20170214 09:46:57 in /builds/slave/test 09:46:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:46:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:46:57 INFO - {'append_to_log': False, 09:46:57 INFO - 'base_work_dir': '/builds/slave/test', 09:46:57 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:46:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:46:57 INFO - 'branch': 'Mozilla-Beta', 09:46:57 INFO - 'buildbot_json_path': 'buildprops.json', 09:46:57 INFO - 'config_files': ('talos/mac_config.py',), 09:46:57 INFO - 'default_actions': ('clobber', 09:46:57 INFO - 'read-buildbot-config', 09:46:57 INFO - 'download-and-extract', 09:46:57 INFO - 'populate-webroot', 09:46:57 INFO - 'create-virtualenv', 09:46:57 INFO - 'install', 09:46:57 INFO - 'run-tests'), 09:46:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:46:57 INFO - 'download_minidump_stackwalk': True, 09:46:57 INFO - 'download_symbols': 'ondemand', 09:46:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:46:57 INFO - 'tooltool.py': '/tools/tooltool.py', 09:46:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:46:57 INFO - '/tools/misc-python/virtualenv.py')}, 09:46:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:46:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:46:57 INFO - 'installer_path': 'installer.exe', 09:46:57 INFO - 'log_level': 'info', 09:46:57 INFO - 'log_name': 'talos', 09:46:57 INFO - 'log_to_console': True, 09:46:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:46:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:46:57 INFO - 'opt_config_files': (), 09:46:57 INFO - 'pip_index': False, 09:46:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:46:57 INFO - 'cmd': ('bash', 09:46:57 INFO - '-c', 09:46:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:46:57 INFO - 'enabled': True, 09:46:57 INFO - 'halt_on_failure': False, 09:46:57 INFO - 'name': 'check_screen_resolution'},), 09:46:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:46:57 INFO - 'cmd': ('bash', 09:46:57 INFO - '-c', 09:46:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:46:57 INFO - 'enabled': True, 09:46:57 INFO - 'halt_on_failure': False, 09:46:57 INFO - 'name': 'check_screen_resolution'},), 09:46:57 INFO - 'run_cmd_checks_enabled': True, 09:46:57 INFO - 'sps_profile': False, 09:46:57 INFO - 'sps_profile_interval': 0, 09:46:57 INFO - 'suite': 'dromaeojs', 09:46:57 INFO - 'system_bits': '32', 09:46:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:46:57 INFO - 'title': 't-yosemite-r7-0282', 09:46:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:46:57 INFO - 'use_talos_json': True, 09:46:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:46:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:46:57 INFO - 'work_dir': 'build'} 09:46:57 INFO - [mozharness: 2017-02-14 17:46:57.239818Z] Running clobber step. 09:46:57 INFO - Running pre-action listener: _resource_record_pre_action 09:46:57 INFO - Running main action method: clobber 09:46:57 INFO - rmtree: /builds/slave/test/build 09:46:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:46:59 INFO - Running post-action listener: _resource_record_post_action 09:46:59 INFO - [mozharness: 2017-02-14 17:46:59.695117Z] Finished clobber step (success) 09:46:59 INFO - [mozharness: 2017-02-14 17:46:59.695240Z] Running read-buildbot-config step. 09:46:59 INFO - Running pre-action listener: _resource_record_pre_action 09:46:59 INFO - Running main action method: read_buildbot_config 09:46:59 INFO - Using buildbot properties: 09:46:59 INFO - { 09:46:59 INFO - "project": "", 09:46:59 INFO - "product": "firefox", 09:46:59 INFO - "script_repo_revision": "production", 09:46:59 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:46:59 INFO - "repository": "", 09:46:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:46:59 INFO - "buildid": "20170214070945", 09:46:59 INFO - "pgo_build": "False", 09:46:59 INFO - "basedir": "/builds/slave/test", 09:46:59 INFO - "buildnumber": 7, 09:46:59 INFO - "slavename": "t-yosemite-r7-0282", 09:46:59 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:46:59 INFO - "platform": "yosemite_r7", 09:46:59 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:46:59 INFO - "branch": "mozilla-beta", 09:46:59 INFO - "repo_path": "releases/mozilla-beta", 09:46:59 INFO - "revision": "3a0e9dab386403cec5b899eb7f321c2aa27e0186", 09:46:59 INFO - "stage_platform": "macosx64", 09:46:59 INFO - "builduid": "15eb97c329c14a38b448e071f7a15064", 09:46:59 INFO - "slavebuilddir": "test" 09:46:59 INFO - } 09:46:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 09:46:59 INFO - Running post-action listener: _resource_record_post_action 09:46:59 INFO - [mozharness: 2017-02-14 17:46:59.698565Z] Finished read-buildbot-config step (success) 09:46:59 INFO - [mozharness: 2017-02-14 17:46:59.698709Z] Running download-and-extract step. 09:46:59 INFO - Running pre-action listener: _resource_record_pre_action 09:46:59 INFO - Running main action method: download_and_extract 09:46:59 INFO - mkdir: /builds/slave/test/build/tests 09:46: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')]} 09:46:59 INFO - trying https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 09:46:59 INFO - Downloading https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:46:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 09:47:01 INFO - Downloaded 1165 bytes. 09:47:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:47:01 INFO - Using the following test package requirements: 09:47:01 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:47:01 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:47:01 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 09:47:01 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:47:01 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 09:47:01 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:47:01 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:47:01 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 09:47:01 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:47:01 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:47:01 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 09:47:01 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:47:01 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 09:47:01 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:47:01 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 09:47:01 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:47:01 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 09:47:01 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 09:47:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:47:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:47:01 INFO - Fetch https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:47:01 INFO - Http code: 200 09:47:01 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 09:47:01 INFO - x-amz-cf-id: IvZ_YP4EG724s6so9kMhc7Ywqd9r9dk6LKbLsb5p2O1E88g3yDnDhg== 09:47:01 INFO - x-amz-version-id: fcHQCB3lps82cGuN4Ld9cpiPR1Zgkm1z 09:47:01 INFO - Expected file size: 16094119 09:47:01 INFO - Obtained file size: 16094119 09:47:08 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:47:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:47:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:47:08 INFO - Fetch https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:47:09 INFO - Http code: 200 09:47:09 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 09:47:09 INFO - x-amz-cf-id: lgGGG_Ymd9FAPQFvGjYhhSyoRz1eSuzXFklmI1Oh0mGEU37FuFfRHw== 09:47:09 INFO - x-amz-version-id: fcHQCB3lps82cGuN4Ld9cpiPR1Zgkm1z 09:47:09 INFO - Expected file size: 16094119 09:47:09 INFO - Obtained file size: 16094119 09:47:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 09:47:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 09:47:15 INFO - Fetch https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 09:47:16 INFO - Http code: 200 09:47:16 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 09:47:16 INFO - x-amz-cf-id: e0P3Z0OA8FpnNMp7wd9RryErjggN0v5IOKx_YoJ8CN7u_h3S3YIcnA== 09:47:16 INFO - x-amz-version-id: 8R8Qv0fRQmxtvazaEJo1GFgQN3N3kxcg 09:47:16 INFO - Expected file size: 14403005 09:47:16 INFO - Obtained file size: 14403005 09:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:16 INFO - trying https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:47:16 INFO - Downloading https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 09:47:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 09:47:19 INFO - Downloaded 82111699 bytes. 09:47:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:47:19 INFO - mkdir: /builds/slave/test/properties 09:47:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:47:19 INFO - Writing to file /builds/slave/test/properties/build_url 09:47:19 INFO - Contents: 09:47:19 INFO - build_url:https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:47:19 INFO - Running post-action listener: _resource_record_post_action 09:47:19 INFO - Running post-action listener: set_extra_try_arguments 09:47:19 INFO - [mozharness: 2017-02-14 17:47:19.723024Z] Finished download-and-extract step (success) 09:47:19 INFO - [mozharness: 2017-02-14 17:47:19.723155Z] Running populate-webroot step. 09:47:19 INFO - Running pre-action listener: _resource_record_pre_action 09:47:19 INFO - Running main action method: populate_webroot 09:47:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:47:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:47:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:47:19 INFO - '--tppagecycles', 09:47:19 INFO - '7'], 09:47:19 INFO - 'tests': ['tsvgm']}}, 09:47:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:47:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:47:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:47:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:47:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:47:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:47:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:19 INFO - 'talos_options': ['--disable-e10s'], 09:47:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:47:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:47:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:19 INFO - 'talos_options': ['--disable-e10s'], 09:47:19 INFO - 'tests': ['damp', 'tps']}, 09:47:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:19 INFO - 'tests': ['damp', 'tps']}, 09:47:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:47:19 INFO - 'tests': ['dromaeo_dom']}, 09:47:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:47:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:47:19 INFO - 'tests': ['basic_compositor_video']}, 09:47:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:47:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:47:19 INFO - 'tests': ['a11yr', 09:47:19 INFO - 'ts_paint', 09:47:19 INFO - 'tpaint', 09:47:19 INFO - 'sessionrestore', 09:47:19 INFO - 'sessionrestore_no_auto_restore', 09:47:19 INFO - 'tabpaint']}, 09:47:19 INFO - 'other-e10s': {'tests': ['a11yr', 09:47:19 INFO - 'ts_paint', 09:47:19 INFO - 'tpaint', 09:47:19 INFO - 'sessionrestore', 09:47:19 INFO - 'sessionrestore_no_auto_restore', 09:47:19 INFO - 'tabpaint']}, 09:47:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:47:19 INFO - 'ts_paint', 09:47:19 INFO - 'tpaint', 09:47:19 INFO - 'sessionrestore', 09:47:19 INFO - 'sessionrestore_no_auto_restore', 09:47:19 INFO - 'tabpaint']}, 09:47:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:47:19 INFO - 'ts_paint', 09:47:19 INFO - 'tpaint', 09:47:19 INFO - 'sessionrestore', 09:47:19 INFO - 'sessionrestore_no_auto_restore', 09:47:19 INFO - 'tabpaint']}, 09:47:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:47:19 INFO - 'tests': ['a11yr', 09:47:19 INFO - 'ts_paint', 09:47:19 INFO - 'tpaint', 09:47:19 INFO - 'sessionrestore', 09:47:19 INFO - 'sessionrestore_no_auto_restore', 09:47:19 INFO - 'tabpaint']}, 09:47:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:47:19 INFO - 'tests': ['a11yr', 09:47:19 INFO - 'ts_paint', 09:47:19 INFO - 'tpaint', 09:47:19 INFO - 'sessionrestore', 09:47:19 INFO - 'sessionrestore_no_auto_restore', 09:47:19 INFO - 'tabpaint']}, 09:47:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:47:19 INFO - 'tests': ['tsvgx', 09:47:19 INFO - 'tsvgr_opacity', 09:47:19 INFO - 'tart', 09:47:19 INFO - 'tscrollx', 09:47:19 INFO - 'cart']}, 09:47:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:47:19 INFO - 'tsvgr_opacity', 09:47:19 INFO - 'tart', 09:47:19 INFO - 'tscrollx', 09:47:19 INFO - 'cart']}, 09:47:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:19 INFO - 'talos_options': ['--disable-e10s'], 09:47:19 INFO - 'tests': ['tp5o']}, 09:47:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:19 INFO - 'tests': ['tp5o']}, 09:47:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:19 INFO - 'talos_options': ['--disable-e10s', 09:47:19 INFO - '--xperf_path', 09:47:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:47:19 INFO - 'tests': ['tp5n']}, 09:47:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:19 INFO - 'talos_options': ['--xperf_path', 09:47:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:47:19 INFO - 'tests': ['tp5n']}}, 09:47:19 INFO - 'talos.zip': {'path': '', 09:47:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:47:19 INFO - Running post-action listener: _resource_record_post_action 09:47:19 INFO - [mozharness: 2017-02-14 17:47:19.742208Z] Finished populate-webroot step (success) 09:47:19 INFO - [mozharness: 2017-02-14 17:47:19.742302Z] Running create-virtualenv step. 09:47:19 INFO - Running pre-action listener: _resource_record_pre_action 09:47:19 INFO - Running main action method: create_virtualenv 09:47:19 INFO - Creating virtualenv /builds/slave/test/build/venv 09:47:19 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 09:47:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:47:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:47:19 INFO - Using real prefix '/tools/python27' 09:47:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:47:20 INFO - Installing distribute.............................................................................................................................................................................................done. 09:47:23 INFO - Installing pip.................done. 09:47:23 INFO - Return code: 0 09:47:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:47:23 INFO - Reading from file tmpfile_stdout 09:47:23 INFO - Output received: 09:47:23 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) 09:47:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:47: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')]} 09:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47: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')]} 09:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:23 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 0x108863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d25845c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108677d30>, '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 0x1084dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10866fb20>, '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.ac7ViV3T15/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.B6rY9HlAw9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 09:47:23 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 09:47:23 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 09:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ac7ViV3T15/Render', 09:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:23 INFO - 'HOME': '/Users/cltbld', 09:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:23 INFO - 'LOGNAME': 'cltbld', 09:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:23 INFO - 'MOZ_NO_REMOTE': '1', 09:47:23 INFO - 'NO_EM_RESTART': '1', 09:47:23 INFO - 'PAGER': '/bin/cat', 09:47:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:23 INFO - 'PWD': '/builds/slave/test', 09:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:23 INFO - 'SHELL': '/bin/bash', 09:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6rY9HlAw9/Listeners', 09:47:23 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 09:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:23 INFO - 'USER': 'cltbld', 09:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:23 INFO - 'XPC_FLAGS': '0x0', 09:47:23 INFO - 'XPC_SERVICE_NAME': '0', 09:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:24 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 09:47:24 INFO - Cleaning up... 09:47:24 INFO - Return code: 0 09:47:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d25845c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108677d30>, '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 0x1084dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10866fb20>, '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.ac7ViV3T15/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.B6rY9HlAw9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 09:47:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:47:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ac7ViV3T15/Render', 09:47:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:24 INFO - 'HOME': '/Users/cltbld', 09:47:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:24 INFO - 'LOGNAME': 'cltbld', 09:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:24 INFO - 'MOZ_NO_REMOTE': '1', 09:47:24 INFO - 'NO_EM_RESTART': '1', 09:47:24 INFO - 'PAGER': '/bin/cat', 09:47:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:24 INFO - 'PWD': '/builds/slave/test', 09:47:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:24 INFO - 'SHELL': '/bin/bash', 09:47:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6rY9HlAw9/Listeners', 09:47:24 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 09:47:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:24 INFO - 'USER': 'cltbld', 09:47:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:24 INFO - 'XPC_FLAGS': '0x0', 09:47:24 INFO - 'XPC_SERVICE_NAME': '0', 09:47:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:24 INFO - Downloading/unpacking psutil>=3.1.1 09:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:47:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:47:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:47:27 INFO - Installing collected packages: psutil 09:47:27 INFO - Running setup.py install for psutil 09:47:27 INFO - building 'psutil._psutil_osx' extension 09:47:27 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 09:47:28 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 09:47:28 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 09:47:28 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 09:47:28 INFO - building 'psutil._psutil_posix' extension 09:47:28 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 09:47:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:47:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:47:28 INFO - ^ 09:47:28 INFO - 1 warning generated. 09:47:28 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 09:47:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:47:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:47:28 INFO - Successfully installed psutil 09:47:28 INFO - Cleaning up... 09:47:28 INFO - Return code: 0 09:47:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d25845c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108677d30>, '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 0x1084dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10866fb20>, '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.ac7ViV3T15/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.B6rY9HlAw9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 09:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:47:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ac7ViV3T15/Render', 09:47:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:28 INFO - 'HOME': '/Users/cltbld', 09:47:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:28 INFO - 'LOGNAME': 'cltbld', 09:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:28 INFO - 'MOZ_NO_REMOTE': '1', 09:47:28 INFO - 'NO_EM_RESTART': '1', 09:47:28 INFO - 'PAGER': '/bin/cat', 09:47:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:28 INFO - 'PWD': '/builds/slave/test', 09:47:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:28 INFO - 'SHELL': '/bin/bash', 09:47:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6rY9HlAw9/Listeners', 09:47:28 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 09:47:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:28 INFO - 'USER': 'cltbld', 09:47:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:28 INFO - 'XPC_FLAGS': '0x0', 09:47:28 INFO - 'XPC_SERVICE_NAME': '0', 09:47:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:47:32 INFO - Installing collected packages: mozsystemmonitor 09:47:32 INFO - Running setup.py install for mozsystemmonitor 09:47:33 INFO - Successfully installed mozsystemmonitor 09:47:33 INFO - Cleaning up... 09:47:33 INFO - Return code: 0 09:47:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:33 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 0x108863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d25845c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108677d30>, '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 0x1084dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10866fb20>, '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.ac7ViV3T15/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.B6rY9HlAw9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 09:47:33 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 09:47:33 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 09:47:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ac7ViV3T15/Render', 09:47:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:33 INFO - 'HOME': '/Users/cltbld', 09:47:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:33 INFO - 'LOGNAME': 'cltbld', 09:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:33 INFO - 'MOZ_NO_REMOTE': '1', 09:47:33 INFO - 'NO_EM_RESTART': '1', 09:47:33 INFO - 'PAGER': '/bin/cat', 09:47:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:33 INFO - 'PWD': '/builds/slave/test', 09:47:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:33 INFO - 'SHELL': '/bin/bash', 09:47:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6rY9HlAw9/Listeners', 09:47:33 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 09:47:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:33 INFO - 'USER': 'cltbld', 09:47:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:33 INFO - 'XPC_FLAGS': '0x0', 09:47:33 INFO - 'XPC_SERVICE_NAME': '0', 09:47:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:33 INFO - Downloading/unpacking jsonschema==2.5.1 09:47:33 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 09:47:33 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 09:47:33 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 09:47:33 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 09:47:33 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 09:47:33 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 09:47:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:47:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:47: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 09:47: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 09:47: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 09:47: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 09:47: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 09:47: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 09:47:36 INFO - Downloading functools32-3.2.3-2.tar.gz 09:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:47:36 INFO - warning: no files found matching '*.txt' 09:47:36 INFO - no previously-included directories found matching 'build' 09:47:36 INFO - no previously-included directories found matching 'dist' 09:47:36 INFO - no previously-included directories found matching '.git*' 09:47:36 INFO - Installing collected packages: jsonschema, functools32 09:47:36 INFO - Running setup.py install for functools32 09:47:36 INFO - warning: no files found matching '*.txt' 09:47:36 INFO - no previously-included directories found matching 'build' 09:47:36 INFO - no previously-included directories found matching 'dist' 09:47:36 INFO - no previously-included directories found matching '.git*' 09:47:36 INFO - Successfully installed jsonschema functools32 09:47:36 INFO - Cleaning up... 09:47:36 INFO - Return code: 0 09:47:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:47: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')]} 09:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47: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')]} 09:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47: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', '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 0x108863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d25845c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108677d30>, '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 0x1084dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10866fb20>, '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.ac7ViV3T15/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.B6rY9HlAw9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 09:47: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:47: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 functools32==3.2.3-2 09:47:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ac7ViV3T15/Render', 09:47:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:36 INFO - 'HOME': '/Users/cltbld', 09:47:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:36 INFO - 'LOGNAME': 'cltbld', 09:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:36 INFO - 'MOZ_NO_REMOTE': '1', 09:47:36 INFO - 'NO_EM_RESTART': '1', 09:47:36 INFO - 'PAGER': '/bin/cat', 09:47:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:36 INFO - 'PWD': '/builds/slave/test', 09:47:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:36 INFO - 'SHELL': '/bin/bash', 09:47:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6rY9HlAw9/Listeners', 09:47:36 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 09:47:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:36 INFO - 'USER': 'cltbld', 09:47:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:36 INFO - 'XPC_FLAGS': '0x0', 09:47:36 INFO - 'XPC_SERVICE_NAME': '0', 09:47:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:47:37 INFO - Cleaning up... 09:47:37 INFO - Return code: 0 09:47:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:47:37 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')]} 09:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:37 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')]} 09:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:37 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 0x108863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d25845c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108677d30>, '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 0x1084dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10866fb20>, '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.ac7ViV3T15/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.B6rY9HlAw9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 09:47:37 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 09:47:37 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 09:47:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ac7ViV3T15/Render', 09:47:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:37 INFO - 'HOME': '/Users/cltbld', 09:47:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:37 INFO - 'LOGNAME': 'cltbld', 09:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:37 INFO - 'MOZ_NO_REMOTE': '1', 09:47:37 INFO - 'NO_EM_RESTART': '1', 09:47:37 INFO - 'PAGER': '/bin/cat', 09:47:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:37 INFO - 'PWD': '/builds/slave/test', 09:47:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:37 INFO - 'SHELL': '/bin/bash', 09:47:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6rY9HlAw9/Listeners', 09:47:37 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 09:47:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:37 INFO - 'USER': 'cltbld', 09:47:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:37 INFO - 'XPC_FLAGS': '0x0', 09:47:37 INFO - 'XPC_SERVICE_NAME': '0', 09:47:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:37 INFO - Downloading/unpacking blobuploader==1.2.4 09:47:37 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 09:47:37 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 09:47:37 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 09:47:37 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 09:47:37 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 09:47:37 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 09:47:39 INFO - Downloading blobuploader-1.2.4.tar.gz 09:47:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:47:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:47:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:41 INFO - Downloading docopt-0.6.1.tar.gz 09:47:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:47:41 INFO - Installing collected packages: blobuploader, requests, docopt 09:47:41 INFO - Running setup.py install for blobuploader 09:47:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:47:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:47:41 INFO - Running setup.py install for requests 09:47:42 INFO - Running setup.py install for docopt 09:47:42 INFO - Successfully installed blobuploader requests docopt 09:47:42 INFO - Cleaning up... 09:47:42 INFO - Return code: 0 09:47:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47: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')]} 09:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47: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')]} 09:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:42 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 0x108863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d25845c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108677d30>, '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 0x1084dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10866fb20>, '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.ac7ViV3T15/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.B6rY9HlAw9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 09:47:42 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 09:47:42 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 09:47:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ac7ViV3T15/Render', 09:47:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:42 INFO - 'HOME': '/Users/cltbld', 09:47:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:42 INFO - 'LOGNAME': 'cltbld', 09:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:42 INFO - 'MOZ_NO_REMOTE': '1', 09:47:42 INFO - 'NO_EM_RESTART': '1', 09:47:42 INFO - 'PAGER': '/bin/cat', 09:47:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:42 INFO - 'PWD': '/builds/slave/test', 09:47:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:42 INFO - 'SHELL': '/bin/bash', 09:47:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6rY9HlAw9/Listeners', 09:47:42 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 09:47:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:42 INFO - 'USER': 'cltbld', 09:47:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:42 INFO - 'XPC_FLAGS': '0x0', 09:47:42 INFO - 'XPC_SERVICE_NAME': '0', 09:47:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:47:42 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-ghpezO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:47:42 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-Qfj4Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:47:42 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-Rk4yd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:47:42 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-O8Ml_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:47:42 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-5E9XeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:47:43 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-PzHeio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:47:43 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-_Xmuvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:47:43 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-4uEDC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:47:43 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-INav_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:47:43 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-j1fL4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:47:43 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-kTpasx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:47:43 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-s1Q7xG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:47:43 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-EVwupn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:47:43 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-d6D1tN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:44 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-84y54n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:47:44 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-3UkzHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:47:44 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-u8uU_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:47:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:47:44 INFO - Running setup.py install for manifestparser 09:47:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:47:44 INFO - Running setup.py install for mozcrash 09:47:44 INFO - Running setup.py install for mozdebug 09:47:44 INFO - Running setup.py install for mozdevice 09:47:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:47:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:47:44 INFO - Running setup.py install for mozfile 09:47:45 INFO - Running setup.py install for mozhttpd 09:47:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:47:45 INFO - Running setup.py install for mozinfo 09:47:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:47:45 INFO - Running setup.py install for mozInstall 09:47:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:47:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:47:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:47:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:47:45 INFO - Running setup.py install for mozleak 09:47:45 INFO - Running setup.py install for mozlog 09:47:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:47:45 INFO - Running setup.py install for moznetwork 09:47:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:47:45 INFO - Running setup.py install for mozprocess 09:47:46 INFO - Running setup.py install for mozprofile 09:47:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:47:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:47:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:47:46 INFO - Running setup.py install for mozrunner 09:47:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:47:46 INFO - Running setup.py install for mozscreenshot 09:47:46 INFO - Running setup.py install for moztest 09:47:46 INFO - Running setup.py install for mozversion 09:47:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:47:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:47:46 INFO - Cleaning up... 09:47:46 INFO - Return code: 0 09:47:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47:46 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')]} 09:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:46 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')]} 09:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:46 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 0x108863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d25845c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108677d30>, '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 0x1084dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10866fb20>, '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.ac7ViV3T15/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.B6rY9HlAw9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 09:47:46 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 09:47:46 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 09:47:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ac7ViV3T15/Render', 09:47:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:46 INFO - 'HOME': '/Users/cltbld', 09:47:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:46 INFO - 'LOGNAME': 'cltbld', 09:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:46 INFO - 'MOZ_NO_REMOTE': '1', 09:47:46 INFO - 'NO_EM_RESTART': '1', 09:47:46 INFO - 'PAGER': '/bin/cat', 09:47:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:46 INFO - 'PWD': '/builds/slave/test', 09:47:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:46 INFO - 'SHELL': '/bin/bash', 09:47:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6rY9HlAw9/Listeners', 09:47:46 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 09:47:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:46 INFO - 'USER': 'cltbld', 09:47:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:46 INFO - 'XPC_FLAGS': '0x0', 09:47:46 INFO - 'XPC_SERVICE_NAME': '0', 09:47:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:47:47 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-JQHUKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:47:47 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)) 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:47:47 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-e31Quo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:47:47 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-IUEBzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:47:47 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)) 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:47:47 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-foDcYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:47:47 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)) 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:47:47 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-0LyivN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:47:47 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)) 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:47:47 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-jSCLBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:47:47 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)) 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:47:47 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-QSF2hT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:47:47 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)) 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:47:47 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-VpIWXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:47:48 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)) 09:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:47:48 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-i9M9wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:47:48 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)) 09:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:47:48 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-hUj1lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:47:48 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)) 09:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:47:48 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-YfND8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:47:48 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)) 09:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:47:48 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-0C45vC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:47:48 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)) 09:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:47:48 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-vd_3X_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:47:48 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)) 09:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:47:48 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-Fr2JP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:47:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:48 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-vCMGse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:48 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)) 09:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:47:48 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-au_1wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:47:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:47:48 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-mQu_IA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:47:48 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)) 09:47:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:47:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:47:48 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)) 09:47:48 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)) 09:47:48 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)) 09:47:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:47:48 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 09:47:48 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 09:47:48 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 09:47:48 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 09:47:48 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 09:47:48 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 09:47:51 INFO - Downloading blessings-1.6.tar.gz 09:47:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:47:51 INFO - Installing collected packages: blessings 09:47:51 INFO - Running setup.py install for blessings 09:47:51 INFO - Successfully installed blessings 09:47:51 INFO - Cleaning up... 09:47:51 INFO - Return code: 0 09:47:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:47:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:47:52 INFO - Reading from file tmpfile_stdout 09:47:52 INFO - Current package versions: 09:47:52 INFO - blessings == 1.6 09:47:52 INFO - blobuploader == 1.2.4 09:47:52 INFO - docopt == 0.6.1 09:47:52 INFO - functools32 == 3.2.3-2 09:47:52 INFO - jsonschema == 2.5.1 09:47:52 INFO - manifestparser == 1.1 09:47:52 INFO - mozInstall == 1.12 09:47:52 INFO - mozcrash == 1.0 09:47:52 INFO - mozdebug == 0.1 09:47:52 INFO - mozdevice == 0.48 09:47:52 INFO - mozfile == 1.2 09:47:52 INFO - mozhttpd == 0.7 09:47:52 INFO - mozinfo == 0.9 09:47:52 INFO - mozleak == 0.1 09:47:52 INFO - mozlog == 3.4 09:47:52 INFO - moznetwork == 0.27 09:47:52 INFO - mozprocess == 0.23 09:47:52 INFO - mozprofile == 0.28 09:47:52 INFO - mozrunner == 6.13 09:47:52 INFO - mozscreenshot == 0.1 09:47:52 INFO - mozsystemmonitor == 0.3 09:47:52 INFO - moztest == 0.8 09:47:52 INFO - mozversion == 1.4 09:47:52 INFO - psutil == 3.1.1 09:47:52 INFO - requests == 1.2.3 09:47:52 INFO - wsgiref == 0.1.2 09:47:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47: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')]} 09:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47: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')]} 09:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:52 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 0x108863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d25845c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108677d30>, '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 0x1084dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10866fb20>, '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.ac7ViV3T15/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.B6rY9HlAw9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 09:47:52 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 09:47:52 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 09:47:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ac7ViV3T15/Render', 09:47:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:52 INFO - 'HOME': '/Users/cltbld', 09:47:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:52 INFO - 'LOGNAME': 'cltbld', 09:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:52 INFO - 'MOZ_NO_REMOTE': '1', 09:47:52 INFO - 'NO_EM_RESTART': '1', 09:47:52 INFO - 'PAGER': '/bin/cat', 09:47:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:52 INFO - 'PWD': '/builds/slave/test', 09:47:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:52 INFO - 'SHELL': '/bin/bash', 09:47:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6rY9HlAw9/Listeners', 09:47:52 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 09:47:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:52 INFO - 'USER': 'cltbld', 09:47:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:52 INFO - 'XPC_FLAGS': '0x0', 09:47:52 INFO - 'XPC_SERVICE_NAME': '0', 09:47:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:53 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)) 09:47:53 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)) 09:47:53 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)) 09:47:53 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)) 09:47:53 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)) 09:47:53 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)) 09:47:53 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)) 09:47:53 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)) 09:47:53 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)) 09:47:53 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)) 09:47:53 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)) 09:47:53 INFO - Cleaning up... 09:47:53 INFO - Return code: 0 09:47:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:47:53 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')]} 09:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:53 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')]} 09:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:53 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 0x108863490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d25845c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108677d30>, '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 0x1084dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10866fb20>, '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.ac7ViV3T15/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.B6rY9HlAw9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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 09:47:53 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 09:47:53 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 09:47:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ac7ViV3T15/Render', 09:47:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:53 INFO - 'HOME': '/Users/cltbld', 09:47:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:53 INFO - 'LOGNAME': 'cltbld', 09:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:53 INFO - 'MOZ_NO_REMOTE': '1', 09:47:53 INFO - 'NO_EM_RESTART': '1', 09:47:53 INFO - 'PAGER': '/bin/cat', 09:47:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:53 INFO - 'PWD': '/builds/slave/test', 09:47:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:53 INFO - 'SHELL': '/bin/bash', 09:47:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6rY9HlAw9/Listeners', 09:47:53 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 09:47:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:53 INFO - 'USER': 'cltbld', 09:47:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:53 INFO - 'XPC_FLAGS': '0x0', 09:47:53 INFO - 'XPC_SERVICE_NAME': '0', 09:47:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:47:53 INFO - Cleaning up... 09:47:53 INFO - Return code: 0 09:47:53 INFO - Running post-action listener: _resource_record_post_action 09:47:53 INFO - Running post-action listener: _start_resource_monitoring 09:47:53 INFO - Starting resource monitoring. 09:47:53 INFO - [mozharness: 2017-02-14 17:47:53.917283Z] Finished create-virtualenv step (success) 09:47:53 INFO - [mozharness: 2017-02-14 17:47:53.918296Z] Running install step. 09:47:53 INFO - Running pre-action listener: _resource_record_pre_action 09:47:53 INFO - Running main action method: install 09:47:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:47:54 INFO - Reading from file tmpfile_stdout 09:47:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:47:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:47:54 INFO - Reading from file tmpfile_stdout 09:47:54 INFO - Output received: 09:47:54 INFO - Usage: mozinstall [options] installer 09:47:54 INFO - Options: 09:47:54 INFO - -h, --help show this help message and exit 09:47:54 INFO - -d DEST, --destination=DEST 09:47:54 INFO - Directory to install application into. [default: 09:47:54 INFO - "/builds/slave/test"] 09:47:54 INFO - --app=APP Application being installed. [default: firefox] 09:47:54 INFO - mkdir: /builds/slave/test/build/application 09:47:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:48:16 INFO - Reading from file tmpfile_stdout 09:48:16 INFO - Output received: 09:48:16 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:48:16 INFO - Running post-action listener: _resource_record_post_action 09:48:16 INFO - [mozharness: 2017-02-14 17:48:16.409192Z] Finished install step (success) 09:48:16 INFO - [mozharness: 2017-02-14 17:48:16.409293Z] Running run-tests step. 09:48:16 INFO - Running pre-action listener: _resource_record_pre_action 09:48:16 INFO - Running main action method: run_tests 09:48:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:48:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:48:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:48:16 INFO - 2017-02-14 09:48:16.423 screenresolution[1626:7384] starting screenresolution argv=screenresolution get 09:48:16 INFO - 2017-02-14 09:48:16.426 screenresolution[1626:7384] Display 0: 1600x1200x32@60 09:48:16 INFO - 2017-02-14 09:48:16.431 screenresolution[1627:7386] starting screenresolution argv=screenresolution list 09:48:16 INFO - Available Modes on Display 0 09:48:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:48:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:48:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:48:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:48:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:48:16 INFO - Intel Iris: 09:48:16 INFO - Chipset Model: Intel Iris 09:48:16 INFO - Type: GPU 09:48:16 INFO - Bus: Built-In 09:48:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:48:16 INFO - Vendor: Intel (0x8086) 09:48:16 INFO - Device ID: 0x0a2e 09:48:16 INFO - Revision ID: 0x0009 09:48:16 INFO - Displays: 09:48:16 INFO - Display: 09:48:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:48:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:48:16 INFO - Display Serial Number: 1600x1200 60 09:48:16 INFO - Main Display: Yes 09:48:16 INFO - Mirror: Off 09:48:16 INFO - Online: Yes 09:48:16 INFO - Rotation: Supported 09:48:16 INFO - Return code: 0 09:48:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:48:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:48:16 INFO - Python 2.7.3 09:48:16 INFO - Return code: 0 09:48:16 INFO - grabbing minidump binary from tooltool 09:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:16 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 0x108677d30>, '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 0x1084dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10866fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:48:16 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 09:48:16 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 09:48:16 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 09:48:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:48:16 INFO - Return code: 0 09:48:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:48:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:48:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:48:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:48:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:48:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0282', '--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 09:48:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0282 --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 09:48:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ac7ViV3T15/Render', 09:48:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:16 INFO - 'HOME': '/Users/cltbld', 09:48:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:16 INFO - 'LOGNAME': 'cltbld', 09:48:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:48:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:16 INFO - 'MOZ_NO_REMOTE': '1', 09:48:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:48:16 INFO - 'NO_EM_RESTART': '1', 09:48:16 INFO - 'PAGER': '/bin/cat', 09:48:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:16 INFO - 'PWD': '/builds/slave/test', 09:48:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:48:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:16 INFO - 'SHELL': '/bin/bash', 09:48:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6rY9HlAw9/Listeners', 09:48:16 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 09:48:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:16 INFO - 'USER': 'cltbld', 09:48:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:16 INFO - 'XPC_FLAGS': '0x0', 09:48:16 INFO - 'XPC_SERVICE_NAME': '0', 09:48:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0282', '--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 09:48:17 INFO - mozversion application_buildid: 20170214070945 09:48:17 INFO - mozversion application_changeset: 3a0e9dab386403cec5b899eb7f321c2aa27e0186 09:48:17 INFO - mozversion application_display_name: Firefox 09:48:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:48:17 INFO - mozversion application_name: Firefox 09:48:17 INFO - mozversion application_remotingname: firefox 09:48:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:48:17 INFO - mozversion application_vendor: Mozilla 09:48:17 INFO - mozversion application_version: 52.0 09:48:17 INFO - mozversion platform_buildid: 20170214070945 09:48:17 INFO - mozversion platform_changeset: 3a0e9dab386403cec5b899eb7f321c2aa27e0186 09:48:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:48:17 INFO - mozversion platform_version: 52.0 09:48:17 INFO - using testdate: 1487094497 09:48:17 INFO - actual date: 1487094497 09:48:17 INFO - starting webserver on 'localhost:49241' 09:48:17 INFO - SUITE-START | Running 2 tests 09:48:17 INFO - TEST-START | dromaeo_css 09:48:17 INFO - operating with platform_type : mac_ 09:48:17 INFO - Initialising browser for dromaeo_css test... 09:48:17 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmpSEgHR9/profile http://localhost:49241/getInfo.html) 09:48:19 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 09:48:19 INFO - PROCESS | 1637 | colorDepth:24 09:48:19 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 09:48:19 INFO - PROCESS | 1637 | __metrics 09:48:19 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:48:19 INFO - PROCESS | 1637 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:48:20 INFO - TEST-INFO | 1637: exit 0 09:48:20 INFO - Browser initialized. 09:48:20 INFO - Running cycle 1/1 for dromaeo_css test... 09:48:20 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmpSEgHR9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:48:32 INFO - PROCESS | 1641 | RSS: Main: 171892736 09:48:32 INFO - PROCESS | 1641 | 09:51:35 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:51:37 INFO - PROCESS | 1641 | RSS: Main: 324349952 09:51:37 INFO - PROCESS | 1641 | 09:54:40 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:54:40 INFO - PROCESS | 1641 | RSS: Main: 296189952 09:54:40 INFO - PROCESS | 1641 | 09:57:42 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:57:43 INFO - PROCESS | 1641 | RSS: Main: 267472896 09:57:43 INFO - PROCESS | 1641 | 10:00:45 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 10:00:46 INFO - PROCESS | 1641 | RSS: Main: 268210176 10:00:46 INFO - PROCESS | 1641 | 10:03:49 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 10:03:50 INFO - PROCESS | 1641 | RSS: Main: 253554688 10:03:50 INFO - PROCESS | 1641 | 10:06:53 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 10:06:53 INFO - PROCESS | 1641 | RSS: Main: 386293760 10:06:53 INFO - PROCESS | 1641 | 10:06:53 INFO - PROCESS | 1641 | __start_tp_report 10:06:53 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 10:06:53 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 10:06:53 INFO - PROCESS | 1641 | |i|pagename|runs| 10:06:53 INFO - PROCESS | 1641 | |0;dojo.html;2976.8687898598528;3350.8827191048317;3374.8481318340655;3406.863725450982;3416.4021296273145;5516.696581688006;5581.079121944874;5589.049861523551;5592.328920529537;5617.017022021145;5520.751566179521;5571.247881535992;5583.3858275589755;5586.273784408021;5620.550355971523;4079.4492743479545;4158.750474971512;5085.974570127144;5141.218995388259;5228.8692782680355;5071.644984851062;5082.1360368737405;5092.745362731867;5128.53843154116;5194.480551944813;5116.079105760961;5121.513456221672;5143.228515722652;5152.124138896378;5182.766775495093;5165.896682066375;5172.017316709813;5173.637845350846;5192.480751924815;5209.479052094798;4943.555080042777;5093.159628661267;5119.744012799345;5119.923201151985;5138.434772175057;5399.460053994609;5430.239766432703;5439.428859969686;5460.945390546123;5497.202905578709;5986.28164620244;5995.61028533144;6041.24484439445;6055.666938318391;6060.757569697207;5954.583179177459;6164.260288765377;6176.567640265183;6185.0413185955795;6188.783392581283;4719.7404142772475;5538.889222215533;5575.749091290902;5601.047821870292;5672.4894759471845;6214.316425193225;6220.844478887973;6224.221972253468;6232.3144454110015;6240.251169859555;5898.498627616615;5905.822825315247;5907.527397808165;5921.496672782776;5934;4901.1913034349645;5966.105084237312;6006.189164462741;6047.0929360596265;6077.3314935357075;5991.580589358703;5992.490638295793;6001.549883758736;6006.669633170218;6028.668423236676;5942.64344139353;5976.701164941735;6010;6031.94440972828;6032.4570788629235;4755.096531658974;4789.832355867528;4835.153848076572;4861.854144375674;4889.144399730033;4373.497047839475;4403.691741578123;4407.3168658857285;4411.801468933906;4458.308962110878;5569.220309156722;5594.636348637407;5598.1602759586385;5608.85977850557;5621.796439462362;5970.462658360769;6141.025769127022;6157.507399408037;6170.259568851767;6200.100985357098;5414.052540805344;5513.255710479114;5566.972165139148;5588.21764952907;5622.6345287557;5243.292155558951;5297.3643162819935;5300.522952934254;5320.654157479751;5321.228421878806;6188.44304012641;6281.842953926189;6313.684315784284;6315.778947736807;6321;4699.929501057419;5999.190109335358;6042.123892035543;6077.027675571887;6199.473044791243;6264.31092579825;6297.433231009231;6318.4313411793155;6323.557350985571;6327;6074.42292982166;6075.756969721162;6087.421694938974;6093.573449858467;6097.603655762538;5971.283445986335;6020.337762845996;6047.183630209865;6095.2685677718955;6115.510759139169;5827;5857.092150716646;5871.823845284648;5885.058390657474;5896.027155519463;5930.495907847709;5957.970210148921;5960.850978725566;5966.403359663999;5975.282966044103;5788.855278618068;5793.449622285876;5824.475797178275;5828.70856457167;5852.209951656472;5746.5402767779315;5803.332616749128;5842.503387211965;5851.444112809277;5965.194698715618;5762.4525670061275;5766.913496297475;5768.913466297925;5776.249087618583;5814.912776308443 10:06:53 INFO - PROCESS | 1641 | |1;ext.html;450.32001677467025;481.0907385042271;504.88387670835687;514.5266354953445;521.457684008631;29783;38539;39213.82358529242;39303.80348098263;41649;41649.95875103124;42013;42088;42180.156396872044;42314;9267.81464370714;9423.293253006017;9441.716748497556;9447.244220462346;9453.52732363379;8697.086805885387;8865.822683546325;11248.26886252395;11458.197926145172;11542.769144617103;11378.317300961928;11564.132690048238;11564.42177891102;11568.884311156864;11573.305601663928;11494.827577586342;11556.826647600292;11578.942105289503;11579.247348922378;11580.999999999958;11432;11472.942635286854;11487.966083052564;11512.597059102975;11515;39167.41248881269;39465;39578.40632390516;39683.20633587341;39741.80129099365;3183.5861338025907;3197.2646291353117;3230.7400113955578;3409.931801363959;3548.964510354889;21200.78799212019;28845.42309153826;28852.855735721398;29120.126396208147;29159.979400720873;3184.601924759405;3196.8721251149927;3233.611966564004;3234.3531293741344;3326.135204846733;520057;520565;521696;521880;522402;33159.83420082884;33293.3341333172;56287.43712562904;56624;56713.716431417575;35046.649533504846;35415.64584354175;35443;35486.290274194886;35514;14758.188299643409;14879;14925.776113358308;14962.70074598502;14967.550973470814;11502.137339699557;11684.357360345093;12613.810792838114;12693.49226030967;12706.2376257423;7686.346660533805;7692.499987500906;7700.537967721954;7938.285554300025;7999.440039197317;3290.588676415448;3330.483775014828;3345.5985281766343;3361.210115622827;3366.4781958796425;968.3124981263242;975.1272611013104;1050.369778133114;1077.2620754783;1092.1208427216009;28285;29138.417231655247;29293.56059659107;29949.550756738667;30042.69957300443;995.1887564632444;1004.7287232447198;1045.895410458948;1080.4057768227444;1130.37829193943;14722.55832325032;15121.395144194328;15147.091174529563;15514.146721930176;15537.06777593348;670423;676733;678707;678991.6050419717;679740;56857;57244.427555724746;57335.426645733845;57348;57402;1192.2369683402803;1267.3979859566816;1283.1018287199;1372.835259768834;1391.2139641102744;24218.878905605357;29926;29947.70052299536;30320.696793031788;30785.076447706604;46374;47128;47193.528064718914;47225.527744722116;47327.52672473231;558212;561060;561294;561464;562303;23056;23180.304590862303;24612.753872461046;25052.62421063722;25620.743792561836;37281.62718372782;44692.55307447014;44865.10269794521;45252.094958099995;45260.86847828699;29925.700742993162;37073.88778336654;37089.07277318089;37152.62847371492;37793.2441351177;36128.45807312945;36614.08464788402;36969.6303036977;37240.6275937248;37648;36152.45771313485;36167.457488137174;36470.27059458849;36645.450318244715;36899.631003690694;26700.332491687863;31048;34058.97823065312;34138;34167.487487687205;20782;25444;25577.360565986;25919.092831750797;25977.75278090239 10:06:53 INFO - PROCESS | 1641 | |2;jquery.html;374.16934405619514;375.7013174526251;388.9611038896111;394.2174783055636;404.97367671101375;18656.813431865678;20455;21182.788172118275;21435.356939291847;21469.355919322425;11778.587749428772;12323.568675096374;12330;12412;20409.897950510265;5189.818356357538;5443.292371991635;5458.017556839767;5461.5357694596005;5464.562834973192;5185.507376799198;5338;5400.135978243482;5434.755436005369;5450.400455949843;5436.619436639437;5439.918401223985;5441.863953401157;5443.700596467193;5445.727713614323;5435.701036442994;5740.339860916007;5995.550333724967;6060.484858787008;6113.877722445571;5727.885442291173;5894.17481552583;5902.173695682608;5906.26171728534;5912.645241285537;12907.419166137546;13134.86865131346;21470.497065205444;23999.88000060006;24870;2160.567886422706;2265.920692775745;2279.261801721133;2342.601757701195;2777.8610769584575;9729.270304727102;9886;10224.74438139045;10391.792164156675;10411.5835366586;1659.568512186828;1844.1609067874085;1854.7681539807525;1897.791242963273;1934.8258656720823;119319.8068019326;121113;124551;125768;130540.69459305475;11274.154438417152;11611.535538578362;11642.825357619642;11684.357360345262;11842.763144737057;14784.408623654934;14801.407943682132;14806.481773137888;14833.480828171178;14838.554843354501;8448.493090414471;8671.913280867237;8680.262177714965;8798.648054077894;8805.031446540876;7694.653740581687;8457.450265732708;8664.046954834963;8842.867356989651;8863.955680221687;4441.755703436342;4546.681732278775;4571.6742144777645;4621.930671039937;4627.431775364705;1626.6502701919144;1830.9289065896332;1909.455805095541;1927.816857398545;1943.5141214696325;716.634516396631;845.560308639504;930.418488444722;986.9950650246847;1020.1023099672241;16947.91526042362;19200.231990720495;20807.68788468174;21059.368218953456;21073;778.373409405434;787.6455594982281;940.3229674634252;949.7768024514234;974.0308393148862;10722.463876806129;10910.23628346008;11024.621922259717;11080.501377438035;11121.221514493907;574534;591799;592372;608359;617190.9140454269;128113;129312;132096;134569;139937.3003134998;945.9574319155516;953.208836665566;964.5418426247477;965.3628605120587;985.3250523391356;17449.56376090608;17993.640127197123;18197.363092292235;18450.538736531158;18474.44576662702;53229.467705324;53901;53923.460765393414;53972;54971.72514137404;74656.13359666051;77703;78511.82232266635;80006.5999669998;80770.59614701889;6955.826104347432;7193.5324203926575;7288;7341.302576255247;7493.325600695964;9676.419414835133;12268.509259629514;12347.320897350732;12455.813162802746;12465.93767031159;10225.48872556384;10416.270861039957;10528;10842.24104312722;10862.674119776419;10570.682879513626;10773.946130269298;10782.622608208674;10879.129669626253;11158.72103197394;9806.85289720669;10451.372917624967;10874.293170943864;10991;11091.611793587186;7169.641517924188;7299.05112335393;7436.219196984239;7480.70077196906;7559.962200188964;10397.84403233937;10559.788804224027;10716.678499645022;10753.032227099598;10757.977992091051 10:06:53 INFO - PROCESS | 1641 | |3;mootools.html;1478.0688166455136;1526.6488707597252;1662.3849175804946;1816.5821860971976;1820.3446759166707;7938.2855543001115;8320.500769953793;8327.541985190812;8332.541710205936;8336.958315208423;7331.816704582388;7555.773326800191;7567.735129270477;7843.215678432154;8116.91883081169;2296.3684986628687;2338.2751347082376;2339.5905716499547;2340.1458467659268;2340.262817212581;2043.56063446359;2338.4387746940697;2354.2466410748566;2358.8230882683865;2385.2367242482414;2239.9776002239932;2241.7309922809286;2264.830137739668;2274.7270327560714;2291.049214575957;1888.6317168152216;2226.899789509476;2251.3358559224985;2264.6942662740485;2274.2040285900052;2296.127471560796;2356.8350215484925;2357.03361621736;2358.033206385374;2360.5986982212894;6567.67161641916;8168.938038055075;8244.793880152984;8255.711050113217;8281.751547453587;4776.522347765231;4903;4903.583195428393;4904.239842824368;4916.336294600219;3098.7211150996295;3160.952585711216;3476.739244556643;3478.3217272631596;3481.791092534431;1048.4862417415488;1068.471106802138;1069.8716154061485;1111.8443417921496;1115.068917453927;10509.316894401916;10606.52270647815;10639;10647;10659.093977011964;4343.609075183249;4457.353683715843;4540.977295113504;4541.84103556374;4595.40259766235;7717.421193410517;9193.632254709737;9234.861477077715;9239.676611318571;9247.029061948399;5063.645544811901;5066.670666406671;5073.670211436245;5077.23841423782;5079.31429257053;4199.223143718422;4333.696641235147;4482.282834746425;4612.400387949545;4665.95334046662;3707.8146092695797;3735.364987952055;3796.6393192646656;3825.6174382562076;3846.999780057149;1026.9743256418649;1227.4292454008928;1231.199720181871;1239.3555351217497;1240.528599132324;771.8687823070092;867.3061550759368;898.833715762586;910.7814124610046;912.3750231091724;5302;5309.628326017141;5353.57171426285;5388.7305634718105;5555.30558680165;812.2405550810012;898.9730308090768;932.2402242172608;943.4763706143157;951.5765484359393;3538.239278555123;3642.872499462559;3661.8718344857803;3690.926181476409;3765.7363984521367;9384.718458446258;9848.965858584888;9863.654772083086;9864.865540462795;9876.703698889045;9790.118889299998;9824.361416507903;9831.213502919893;9834.213262938947;9840.507974601242;7521.5111017783665;7681.3854891608535;7683.846323073507;7694.692212311556;7704.499207551491;5046.091703493406;5177.870553236199;5185.9222111669105;5338.8932221356135;5438.075527160313;7440.665170067252;8992.415492992934;9122.863157052518;9157.077013827171;9158.542072896194;9012.774680632774;9074.546272686472;9202.21781148583;9285.025072367574;9288.303377246868;6227.128202051807;6353.809385718436;6363.87272254543;6493.22081350241;6701;7278.745243916437;7355.043844300207;7370;7408.555486670817;7579.696812127674;6761.492888033319;6872.725090996504;6880.58716476993;6905.447564194953;7025.824354391181;6793.830154246183;6806.455483561204;6814.284500127415;6837.38463538264;6849.349311815369;6430.678466076584;6442.742290308335;6448.129502517288;6516.055172000129;6518.185226846645;4476.79854406559;4566.520515345841;4573.519780423141;4637.744924029211;4641.932355558173;4576.519465456212;4626.884327891829;4754.429468463806;4756.785944632431;4789.568938795525 10:06:53 INFO - PROCESS | 1641 | |4;prototype.html;251.64141098934022;303.8708548866731;313.9968600313996;319.5893277138877;319.78734141795707;4441.8223271069155;5425;5425.182563841108;5468.562514998801;5517.420670829565;5126.92309615356;5206.3231779868565;5269.552088072509;5350.8061694705175;5431.321084864392;3329.384063948165;3640.672339489445;4109.034376921429;4142.958570414303;4164.708470407073;4142.730722503027;4184.351425529047;4202.453681021463;4222.429971953793;4227.873163805076;3496;3854;4071.3485842265245;4091.529474110486;4139.337705967046;3231.8688459039267;3708.740388172829;4084;4087.9182416351805;4113.938290925608;2932.3695405487924;3537.5047493350953;3560.5193298904574;3568.2863427314383;3573.8391772370305;4888.364512613338;5311.336082989626;5335.759890804884;5351.28758797185;5360.52585538976;4398.406215160944;4678.7426691531955;4694.906101877978;4707.646926480527;4711.057788442326;4815.277708343741;5406.54044406226;5654.349749778787;5679.034564124109;5698.350267125807;3433.828308584561;3610;3797.8670746524017;3923.8234279457206;3926.7447615904875;5302.257683924215;5639.436056394369;5746.425357464262;5920;5980.192673989043;3943.5859234779937;3944.4674968878835;3949.5260568731937;3955.980220098939;3958.465607142999;4020.8540565938565;4022.4770779798437;4042.717009809285;4057.1479989202007;4058.6144316289906;3851.6533511984057;3974.0328537374185;4491.797869095899;4580.88547786308;4686.625069994392;5572.718274796819;5654.604177707603;5712.542996560265;5714.257146570919;5725.4749167054;1105.8562386889814;1177.9293242405483;1183.7810005148904;1256.0265794009533;1292.6251387097825;699.5557820783839;734.7942576078707;745.4185735126609;863.4344504349662;877.8902637170354;4013.2976729072298;4250.086231460251;4961.627877909171;5074.198659475906;5122.385313762373;5332;5598.552115830724;5611.128321458181;5695.003374409544;5800.361960184377;4844.069338050499;5069.9746501267255;5195.0907491803955;5432.8047829477455;5500.992137869729;2633.2752047408976;2956.305268261957;2970.56926745625;2971.435427268812;3015.276333679901;4690.209325451351;5212.843614691566;5337.2527846101575;5470.972645136749;5622.8313150605545;4877.487863774252;5060.002597947654;5819.767209311664;5846.532277417797;5851.64890106595;4954.331165292711;5234.555062819627;5380.973095134499;5539.7784088636;5578.414266502121;4671.8131274749985;4810.39870016248;5551.750171242385;5626.690532020778;5701.914471282851;5113.446154922293;5521.972390138024;5646.661200327993;5923.911141332969;5928.56143436797;5604.3835178131185;5986.725044483069;6004.708987567694;6207.099970504161;6218.315985241529;3159.020703581897;3364.755040634883;3849.1339448624954;3876.8449262029203;3971.72197946141;4712.69367491112;5151.768170432414;5176.4305926348825;5620.662760234399;5891.528677705687;5030.974845125751;5113.874947511542;5794.739236734441;5806.216160818404;5868.823935281948;5575.665460072409;5741.641139933019;5785.30576330843;5785.971070144622;5809.419058094157;4641.512641172763;5254.605904557097;5524.198991146181;5555.916661250165;5652.7738890443925;4852.466228714909;5325.467453254643;5628;5656.688882111359;5754.992876246723;5571.944280557304;5593.881223755184;5600.243967064394;5609.719514024364;5617.775288988395 10:06:53 INFO - PROCESS | 1641 | |5;yui.html;715.3097261142996;738.6860584251692;776.2741836382986;787.5392895156333;825.8389614025264;14284.14295142291;14848.628784280385;15297.005694629841;15449.07305561667;15571.143587102704;12818.615441536745;12894.4197511112;12894.484220631164;12917.74164516709;12927.030472714561;685.6640246279312;821.48246604639;836.6318819719304;844.9535275559841;845.1337379186338;849.8810166576684;850.9531975741331;851.0723311590365;851.3019324154196;853.6798700487317;762.2529920677739;901.4230892228978;901.5041727050129;901.9413738107035;902.6479672927563;896.8116695493954;897.5736525150567;897.8653202019717;898.4384759525296;899.7795540092686;661.5237029338869;661.6162625677143;661.9338066193391;661.9503537234726;662.8806814773338;14069.577912662637;14257.714845703027;14276.714465710627;14277.21534808149;14706.926465367711;13926.860731392657;14260.92869535656;14307.713845723132;14336.713265734732;14445.422183112663;11385.601503947404;11440.828387574193;11504.36293205005;11609.01323387513;11864.644060678107;3618.8733394331334;3721.1255354991554;3736.252749450121;3738.065483629093;3865.1689886674217;86924;91135;93307.53346233294;93422;93929;8892.555372231493;10122.58283840263;10473.214508911862;10578.153747700166;10858.891411085788;19058.33295834667;19225.327113551237;19319.90340048291;19345;19639.509012274808;6110.847228819226;6828.487863410264;7698.191689872595;7720.652570634335;7933.722319718782;3786.8295926683363;4345.630621397154;4375.7155784873885;4495.483019452739;4512.481064677604;3410.18155642644;3517.4196257617205;3521.1373213562842;3521.3133438979153;3522.982385088058;631.4601016131234;641.8812519683873;648.176815444383;653.0204692960559;660.6828722213364;644.9967750161219;662.3991920512025;665.6305750308528;679.2697849811374;687.9449644028466;8943.329250306253;9053.502057386775;10138.03688649577;10372.15988499779;10482.318649287925;561.4946548106655;599.7780821096222;681.3425044831761;684.674779479753;688.5352387138662;4395;4503.752293623882;4510.120526497367;4557.589816916494;4634.281686338555;89692.5515372432;107893.46053269683;108564;110998.44500777444;111352;75137.87293190607;80267;86268;97899.741529725;97909;60088;78214.21785782183;80311.59844200741;83401.16598834055;84127.7380839288;8520.36097292718;9658.275629327969;9804.068613481708;10050.949745251228;10064.547095380873;47723.80690482766;53755.656108596035;56691.86616267569;56770;58190.836183276944;65178.67410663106;77472.45055098979;78188.60905695434;80219.59890200512;80411.19588804037;12130.454129564014;12452.626421207378;12595.622131336075;12677.112602118132;12688.365581721062;13727.931360343533;13846.584602461942;14111.364988575333;14284.857151428352;14987.925060374628;12278.447469863699;12282.07884408655;12647.936760316508;12777.552785652457;13807.585772426843;12448.688782780502;13029.804552931902;13382.702988627394;13509.797353039909;13522.864771352553;12034.699132521757;13361.064725469123;13415.731685366432;13626.659333516742;13819.516316929261;10349.9482502587;11018.088578554818;11289;11423.543058277575;11772.529098836294;8520.403571749917;9549.952250238983;9580.712578622653;10103.54534045955;11475.254108482923 10:06:53 INFO - PROCESS | 1641 | __end_tp_report 10:06:53 INFO - PROCESS | 1641 | __start_cc_report 10:06:53 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1729 10:06:53 INFO - PROCESS | 1641 | __end_cc_report 10:06:53 INFO - PROCESS | 1641 | __startTimestamp1487095613289__endTimestamp 10:06:53 INFO - PROCESS | 1641 | 10:06:53 INFO - PROCESS | 1641 | ------- Summary: start ------- 10:06:53 INFO - PROCESS | 1641 | Number of tests: 6 10:06:53 INFO - PROCESS | 1641 | 10:06:53 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5584.46 Median:5788.86 stddev:639.37 (11.0%) stddev-sans-first:607.73 10:06:53 INFO - PROCESS | 1641 | Values: 2976.9 3350.9 3374.8 3406.9 3416.4 5516.7 5581.1 5589.0 5592.3 5617.0 5520.8 5571.2 5583.4 5586.3 5620.6 4079.4 4158.8 5086.0 5141.2 5228.9 5071.6 5082.1 5092.7 5128.5 5194.5 5116.1 5121.5 5143.2 5152.1 5182.8 5165.9 5172.0 5173.6 5192.5 5209.5 4943.6 5093.2 5119.7 5119.9 5138.4 5399.5 5430.2 5439.4 5460.9 5497.2 5986.3 5995.6 6041.2 6055.7 6060.8 5954.6 6164.3 6176.6 6185.0 6188.8 4719.7 5538.9 5575.7 5601.0 5672.5 6214.3 6220.8 6224.2 6232.3 6240.3 5898.5 5905.8 5907.5 5921.5 5934.0 4901.2 5966.1 6006.2 6047.1 6077.3 5991.6 5992.5 6001.5 6006.7 6028.7 5942.6 5976.7 6010.0 6031.9 6032.5 4755.1 4789.8 4835.2 4861.9 4889.1 4373.5 4403.7 4407.3 4411.8 4458.3 5569.2 5594.6 5598.2 5608.9 5621.8 5970.5 6141.0 6157.5 6170.3 6200.1 5414.1 5513.3 5567.0 5588.2 5622.6 5243.3 5297.4 5300.5 5320.7 5321.2 6188.4 6281.8 6313.7 6315.8 6321.0 4699.9 5999.2 6042.1 6077.0 6199.5 6264.3 6297.4 6318.4 6323.6 6327.0 6074.4 6075.8 6087.4 6093.6 6097.6 5971.3 6020.3 6047.2 6095.3 6115.5 5827.0 5857.1 5871.8 5885.1 5896.0 5930.5 5958.0 5960.9 5966.4 5975.3 5788.9 5793.4 5824.5 5828.7 5852.2 5746.5 5803.3 5842.5 5851.4 5965.2 5762.5 5766.9 5768.9 5776.2 5814.9 10:06:53 INFO - PROCESS | 1641 | 10:06:53 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:69529.78 Median:18773.97 stddev:158229.26 (842.8%) stddev-sans-first:158588.13 10:06:53 INFO - PROCESS | 1641 | Values: 450.3 481.1 504.9 514.5 521.5 29783.0 38539.0 39213.8 39303.8 41649.0 41650.0 42013.0 42088.0 42180.2 42314.0 9267.8 9423.3 9441.7 9447.2 9453.5 8697.1 8865.8 11248.3 11458.2 11542.8 11378.3 11564.1 11564.4 11568.9 11573.3 11494.8 11556.8 11578.9 11579.2 11581.0 11432.0 11472.9 11488.0 11512.6 11515.0 39167.4 39465.0 39578.4 39683.2 39741.8 3183.6 3197.3 3230.7 3409.9 3549.0 21200.8 28845.4 28852.9 29120.1 29160.0 3184.6 3196.9 3233.6 3234.4 3326.1 520057.0 520565.0 521696.0 521880.0 522402.0 33159.8 33293.3 56287.4 56624.0 56713.7 35046.6 35415.6 35443.0 35486.3 35514.0 14758.2 14879.0 14925.8 14962.7 14967.6 11502.1 11684.4 12613.8 12693.5 12706.2 7686.3 7692.5 7700.5 7938.3 7999.4 3290.6 3330.5 3345.6 3361.2 3366.5 968.3 975.1 1050.4 1077.3 1092.1 28285.0 29138.4 29293.6 29949.6 30042.7 995.2 1004.7 1045.9 1080.4 1130.4 14722.6 15121.4 15147.1 15514.1 15537.1 670423.0 676733.0 678707.0 678991.6 679740.0 56857.0 57244.4 57335.4 57348.0 57402.0 1192.2 1267.4 1283.1 1372.8 1391.2 24218.9 29926.0 29947.7 30320.7 30785.1 46374.0 47128.0 47193.5 47225.5 47327.5 558212.0 561060.0 561294.0 561464.0 562303.0 23056.0 23180.3 24612.8 25052.6 25620.7 37281.6 44692.6 44865.1 45252.1 45260.9 29925.7 37073.9 37089.1 37152.6 37793.2 36128.5 36614.1 36969.6 37240.6 37648.0 36152.5 36167.5 36470.3 36645.5 36899.6 26700.3 31048.0 34059.0 34138.0 34167.5 20782.0 25444.0 25577.4 25919.1 25977.8 10:06:53 INFO - PROCESS | 1641 | 10:06:53 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:34820.01 Median:13823.93 stddev:100047.86 (723.7%) stddev-sans-first:100295.09 10:06:53 INFO - PROCESS | 1641 | Values: 374.2 375.7 389.0 394.2 405.0 18656.8 20455.0 21182.8 21435.4 21469.4 11778.6 12323.6 12330.0 12412.0 20409.9 5189.8 5443.3 5458.0 5461.5 5464.6 5185.5 5338.0 5400.1 5434.8 5450.4 5436.6 5439.9 5441.9 5443.7 5445.7 5435.7 5740.3 5995.6 6060.5 6113.9 5727.9 5894.2 5902.2 5906.3 5912.6 12907.4 13134.9 21470.5 23999.9 24870.0 2160.6 2265.9 2279.3 2342.6 2777.9 9729.3 9886.0 10224.7 10391.8 10411.6 1659.6 1844.2 1854.8 1897.8 1934.8 119319.8 121113.0 124551.0 125768.0 130540.7 11274.2 11611.5 11642.8 11684.4 11842.8 14784.4 14801.4 14806.5 14833.5 14838.6 8448.5 8671.9 8680.3 8798.6 8805.0 7694.7 8457.5 8664.0 8842.9 8864.0 4441.8 4546.7 4571.7 4621.9 4627.4 1626.7 1830.9 1909.5 1927.8 1943.5 716.6 845.6 930.4 987.0 1020.1 16947.9 19200.2 20807.7 21059.4 21073.0 778.4 787.6 940.3 949.8 974.0 10722.5 10910.2 11024.6 11080.5 11121.2 574534.0 591799.0 592372.0 608359.0 617190.9 128113.0 129312.0 132096.0 134569.0 139937.3 946.0 953.2 964.5 965.4 985.3 17449.6 17993.6 18197.4 18450.5 18474.4 53229.5 53901.0 53923.5 53972.0 54971.7 74656.1 77703.0 78511.8 80006.6 80770.6 6955.8 7193.5 7288.0 7341.3 7493.3 9676.4 12268.5 12347.3 12455.8 12465.9 10225.5 10416.3 10528.0 10842.2 10862.7 10570.7 10773.9 10782.6 10879.1 11158.7 9806.9 10451.4 10874.3 10991.0 11091.6 7169.6 7299.1 7436.2 7480.7 7560.0 10397.8 10559.8 10716.7 10753.0 10758.0 10:06:53 INFO - PROCESS | 1641 | 10:06:53 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5258.36 Median:5128.59 stddev:2859.29 (55.8%) stddev-sans-first:2853.20 10:06:53 INFO - PROCESS | 1641 | Values: 1478.1 1526.6 1662.4 1816.6 1820.3 7938.3 8320.5 8327.5 8332.5 8337.0 7331.8 7555.8 7567.7 7843.2 8116.9 2296.4 2338.3 2339.6 2340.1 2340.3 2043.6 2338.4 2354.2 2358.8 2385.2 2240.0 2241.7 2264.8 2274.7 2291.0 1888.6 2226.9 2251.3 2264.7 2274.2 2296.1 2356.8 2357.0 2358.0 2360.6 6567.7 8168.9 8244.8 8255.7 8281.8 4776.5 4903.0 4903.6 4904.2 4916.3 3098.7 3161.0 3476.7 3478.3 3481.8 1048.5 1068.5 1069.9 1111.8 1115.1 10509.3 10606.5 10639.0 10647.0 10659.1 4343.6 4457.4 4541.0 4541.8 4595.4 7717.4 9193.6 9234.9 9239.7 9247.0 5063.6 5066.7 5073.7 5077.2 5079.3 4199.2 4333.7 4482.3 4612.4 4666.0 3707.8 3735.4 3796.6 3825.6 3847.0 1027.0 1227.4 1231.2 1239.4 1240.5 771.9 867.3 898.8 910.8 912.4 5302.0 5309.6 5353.6 5388.7 5555.3 812.2 899.0 932.2 943.5 951.6 3538.2 3642.9 3661.9 3690.9 3765.7 9384.7 9849.0 9863.7 9864.9 9876.7 9790.1 9824.4 9831.2 9834.2 9840.5 7521.5 7681.4 7683.8 7694.7 7704.5 5046.1 5177.9 5185.9 5338.9 5438.1 7440.7 8992.4 9122.9 9157.1 9158.5 9012.8 9074.5 9202.2 9285.0 9288.3 6227.1 6353.8 6363.9 6493.2 6701.0 7278.7 7355.0 7370.0 7408.6 7579.7 6761.5 6872.7 6880.6 6905.4 7025.8 6793.8 6806.5 6814.3 6837.4 6849.3 6430.7 6442.7 6448.1 6516.1 6518.2 4476.8 4566.5 4573.5 4637.7 4641.9 4576.5 4626.9 4754.4 4756.8 4789.6 10:06:53 INFO - PROCESS | 1641 | 10:06:53 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4524.38 Median:5118.13 stddev:1411.21 (27.6%) stddev-sans-first:1378.25 10:06:53 INFO - PROCESS | 1641 | Values: 251.6 303.9 314.0 319.6 319.8 4441.8 5425.0 5425.2 5468.6 5517.4 5126.9 5206.3 5269.6 5350.8 5431.3 3329.4 3640.7 4109.0 4143.0 4164.7 4142.7 4184.4 4202.5 4222.4 4227.9 3496.0 3854.0 4071.3 4091.5 4139.3 3231.9 3708.7 4084.0 4087.9 4113.9 2932.4 3537.5 3560.5 3568.3 3573.8 4888.4 5311.3 5335.8 5351.3 5360.5 4398.4 4678.7 4694.9 4707.6 4711.1 4815.3 5406.5 5654.3 5679.0 5698.4 3433.8 3610.0 3797.9 3923.8 3926.7 5302.3 5639.4 5746.4 5920.0 5980.2 3943.6 3944.5 3949.5 3956.0 3958.5 4020.9 4022.5 4042.7 4057.1 4058.6 3851.7 3974.0 4491.8 4580.9 4686.6 5572.7 5654.6 5712.5 5714.3 5725.5 1105.9 1177.9 1183.8 1256.0 1292.6 699.6 734.8 745.4 863.4 877.9 4013.3 4250.1 4961.6 5074.2 5122.4 5332.0 5598.6 5611.1 5695.0 5800.4 4844.1 5070.0 5195.1 5432.8 5501.0 2633.3 2956.3 2970.6 2971.4 3015.3 4690.2 5212.8 5337.3 5471.0 5622.8 4877.5 5060.0 5819.8 5846.5 5851.6 4954.3 5234.6 5381.0 5539.8 5578.4 4671.8 4810.4 5551.8 5626.7 5701.9 5113.4 5522.0 5646.7 5923.9 5928.6 5604.4 5986.7 6004.7 6207.1 6218.3 3159.0 3364.8 3849.1 3876.8 3971.7 4712.7 5151.8 5176.4 5620.7 5891.5 5031.0 5113.9 5794.7 5806.2 5868.8 5575.7 5741.6 5785.3 5786.0 5809.4 4641.5 5254.6 5524.2 5555.9 5652.8 4852.5 5325.5 5628.0 5656.7 5755.0 5571.9 5593.9 5600.2 5609.7 5617.8 10:06:53 INFO - PROCESS | 1641 | 10:06:53 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:20199.04 Median:4506.94 stddev:29153.70 (646.9%) stddev-sans-first:29198.78 10:06:53 INFO - PROCESS | 1641 | Values: 715.3 738.7 776.3 787.5 825.8 14284.1 14848.6 15297.0 15449.1 15571.1 12818.6 12894.4 12894.5 12917.7 12927.0 685.7 821.5 836.6 845.0 845.1 849.9 851.0 851.1 851.3 853.7 762.3 901.4 901.5 901.9 902.6 896.8 897.6 897.9 898.4 899.8 661.5 661.6 661.9 662.0 662.9 14069.6 14257.7 14276.7 14277.2 14706.9 13926.9 14260.9 14307.7 14336.7 14445.4 11385.6 11440.8 11504.4 11609.0 11864.6 3618.9 3721.1 3736.3 3738.1 3865.2 86924.0 91135.0 93307.5 93422.0 93929.0 8892.6 10122.6 10473.2 10578.2 10858.9 19058.3 19225.3 19319.9 19345.0 19639.5 6110.8 6828.5 7698.2 7720.7 7933.7 3786.8 4345.6 4375.7 4495.5 4512.5 3410.2 3517.4 3521.1 3521.3 3523.0 631.5 641.9 648.2 653.0 660.7 645.0 662.4 665.6 679.3 687.9 8943.3 9053.5 10138.0 10372.2 10482.3 561.5 599.8 681.3 684.7 688.5 4395.0 4503.8 4510.1 4557.6 4634.3 89692.6 107893.5 108564.0 110998.4 111352.0 75137.9 80267.0 86268.0 97899.7 97909.0 60088.0 78214.2 80311.6 83401.2 84127.7 8520.4 9658.3 9804.1 10050.9 10064.5 47723.8 53755.7 56691.9 56770.0 58190.8 65178.7 77472.5 78188.6 80219.6 80411.2 12130.5 12452.6 12595.6 12677.1 12688.4 13727.9 13846.6 14111.4 14284.9 14987.9 12278.4 12282.1 12647.9 12777.6 13807.6 12448.7 13029.8 13382.7 13509.8 13522.9 12034.7 13361.1 13415.7 13626.7 13819.5 10349.9 11018.1 11289.0 11423.5 11772.5 8520.4 9550.0 9580.7 10103.5 11475.3 10:06:53 INFO - PROCESS | 1641 | -------- Summary: end -------- 10:06:53 INFO - PROCESS | 1641 | 10:06:53 INFO - TEST-INFO | 1641: exit 0 10:06:53 INFO - TEST-OK | dromaeo_css | took 1116885ms 10:06:53 INFO - TEST-START | kraken 10:06:53 INFO - operating with platform_type : mac_ 10:06:53 INFO - Initialising browser for kraken test... 10:06:53 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmpoDG5rS/profile http://localhost:49241/getInfo.html) 10:06:56 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 10:06:56 INFO - PROCESS | 1650 | colorDepth:24 10:06:56 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 10:06:56 INFO - PROCESS | 1650 | __metrics 10:06:56 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:06:56 INFO - PROCESS | 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:06:57 INFO - TEST-INFO | 1650: exit 0 10:06:57 INFO - Browser initialized. 10:06:57 INFO - Running cycle 1/1 for kraken test... 10:06:57 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmpoDG5rS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:09 INFO - PROCESS | 1652 | RSS: Main: 171626496 10:07:09 INFO - PROCESS | 1652 | 10:07:12 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 10:07:12 INFO - PROCESS | 1652 | RSS: Main: 221163520 10:07:12 INFO - PROCESS | 1652 | 10:07:15 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 10:07:16 INFO - PROCESS | 1652 | RSS: Main: 233451520 10:07:16 INFO - PROCESS | 1652 | 10:07:19 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 10:07:19 INFO - PROCESS | 1652 | RSS: Main: 329703424 10:07:19 INFO - PROCESS | 1652 | 10:07:21 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 10:07:22 INFO - PROCESS | 1652 | RSS: Main: 232787968 10:07:22 INFO - PROCESS | 1652 | 10:07:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:07:24 INFO - PROCESS | 1652 | RSS: Main: 233787392 10:07:24 INFO - PROCESS | 1652 | 10:07:27 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 10:07:28 INFO - PROCESS | 1652 | RSS: Main: 273448960 10:07:28 INFO - PROCESS | 1652 | 10:07:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 10:07:31 INFO - PROCESS | 1652 | RSS: Main: 275615744 10:07:31 INFO - PROCESS | 1652 | 10:07:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 10:07:35 INFO - PROCESS | 1652 | RSS: Main: 271699968 10:07:35 INFO - PROCESS | 1652 | 10:07:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:07:37 INFO - PROCESS | 1652 | RSS: Main: 247054336 10:07:37 INFO - PROCESS | 1652 | 10:07:39 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:07:39 INFO - PROCESS | 1652 | RSS: Main: 251015168 10:07:39 INFO - PROCESS | 1652 | 10:07:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:07:42 INFO - PROCESS | 1652 | RSS: Main: 252833792 10:07:42 INFO - PROCESS | 1652 | 10:07:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:07:46 INFO - PROCESS | 1652 | RSS: Main: 269418496 10:07:46 INFO - PROCESS | 1652 | 10:07:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:07:49 INFO - PROCESS | 1652 | RSS: Main: 263237632 10:07:49 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 10:07:51 INFO - PROCESS | 1652 | RSS: Main: 307507200 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | __start_tp_report 10:07:51 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 10:07:51 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 10:07:51 INFO - PROCESS | 1652 | |i|pagename|runs| 10:07:51 INFO - PROCESS | 1652 | |0;ai-astar;114;113;114;115;115;114;116;114;115;115 10:07:51 INFO - PROCESS | 1652 | |1;audio-beat-detection;143;108;106;141;111;116;105;108;135;108 10:07:51 INFO - PROCESS | 1652 | |2;audio-dft;185;186;182;182;183;182;184;184;183;184 10:07:51 INFO - PROCESS | 1652 | |3;audio-fft;82;58;58;88;61;60;61;61;84;75 10:07:51 INFO - PROCESS | 1652 | |4;audio-oscillator;84;70;92;70;70;84;113;69;68;90 10:07:51 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;92;89;92;89;92;89;92;89;88;128 10:07:51 INFO - PROCESS | 1652 | |6;imaging-darkroom;100;108;100;102;100;100;101;100;101;100 10:07:51 INFO - PROCESS | 1652 | |7;imaging-desaturate;84;82;79;83;82;81;86;85;81;83 10:07:51 INFO - PROCESS | 1652 | |8;json-parse-financial;55;53;54;54;56;57;56;57;56;56 10:07:51 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;62;72;76;76;72;66;66;68;67;67 10:07:51 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;83;82;82;81;82;84;82;82;85;82 10:07:51 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;134;135;137;133;136;139;138;137;183;140 10:07:51 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;159;163;161;165;161;159;161;164;160;160 10:07:51 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;66;65;65;65;65;65;66;63;62;64 10:07:51 INFO - PROCESS | 1652 | __end_tp_report 10:07:51 INFO - PROCESS | 1652 | __start_cc_report 10:07:51 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1938 10:07:51 INFO - PROCESS | 1652 | __end_cc_report 10:07:51 INFO - PROCESS | 1652 | __startTimestamp1487095671318__endTimestamp 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | ------- Summary: start ------- 10:07:51 INFO - PROCESS | 1652 | Number of tests: 14 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 10:07:51 INFO - PROCESS | 1652 | Values: 114.0 113.0 114.0 115.0 115.0 114.0 116.0 114.0 115.0 115.0 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:118.10 Median:113.50 stddev:15.31 (13.5%) stddev-sans-first:13.32 10:07:51 INFO - PROCESS | 1652 | Values: 143.0 108.0 106.0 141.0 111.0 116.0 105.0 108.0 135.0 108.0 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.35 (0.7%) stddev-sans-first:1.32 10:07:51 INFO - PROCESS | 1652 | Values: 185.0 186.0 182.0 182.0 183.0 182.0 184.0 184.0 183.0 184.0 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:68.80 Median:68.00 stddev:12.04 (17.7%) stddev-sans-first:11.79 10:07:51 INFO - PROCESS | 1652 | Values: 82.0 58.0 58.0 88.0 61.0 60.0 61.0 61.0 84.0 75.0 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:81.00 Median:77.00 stddev:14.61 (19.0%) stddev-sans-first:15.45 10:07:51 INFO - PROCESS | 1652 | Values: 84.0 70.0 92.0 70.0 70.0 84.0 113.0 69.0 68.0 90.0 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:94.00 Median:90.50 stddev:12.06 (13.3%) stddev-sans-first:12.76 10:07:51 INFO - PROCESS | 1652 | Values: 92.0 89.0 92.0 89.0 92.0 89.0 92.0 89.0 88.0 128.0 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:101.20 Median:100.50 stddev:2.49 (2.5%) stddev-sans-first:2.60 10:07:51 INFO - PROCESS | 1652 | Values: 100.0 108.0 100.0 102.0 100.0 100.0 101.0 100.0 101.0 100.0 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:82.60 Median:83.00 stddev:2.07 (2.5%) stddev-sans-first:2.13 10:07:51 INFO - PROCESS | 1652 | Values: 84.0 82.0 79.0 83.0 82.0 81.0 86.0 85.0 81.0 83.0 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.35 (2.4%) stddev-sans-first:1.42 10:07:51 INFO - PROCESS | 1652 | Values: 55.0 53.0 54.0 54.0 56.0 57.0 56.0 57.0 56.0 56.0 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:70.00 stddev:4.61 (6.6%) stddev-sans-first:4.09 10:07:51 INFO - PROCESS | 1652 | Values: 62.0 72.0 76.0 76.0 72.0 66.0 66.0 68.0 67.0 67.0 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.00 stddev:1.18 (1.4%) stddev-sans-first:1.24 10:07:51 INFO - PROCESS | 1652 | Values: 83.0 82.0 82.0 81.0 82.0 84.0 82.0 82.0 85.0 82.0 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:137.50 stddev:14.85 (10.8%) stddev-sans-first:15.52 10:07:51 INFO - PROCESS | 1652 | Values: 134.0 135.0 137.0 133.0 136.0 139.0 138.0 137.0 183.0 140.0 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.00 stddev:2.06 (1.3%) stddev-sans-first:2.01 10:07:51 INFO - PROCESS | 1652 | Values: 159.0 163.0 161.0 165.0 161.0 159.0 161.0 164.0 160.0 160.0 10:07:51 INFO - PROCESS | 1652 | 10:07:51 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.24 10:07:51 INFO - PROCESS | 1652 | Values: 66.0 65.0 65.0 65.0 65.0 65.0 66.0 63.0 62.0 64.0 10:07:51 INFO - PROCESS | 1652 | -------- Summary: end -------- 10:07:51 INFO - PROCESS | 1652 | 10:07:52 INFO - TEST-INFO | 1652: exit 0 10:07:52 INFO - TEST-OK | kraken | took 58411ms 10:07:52 INFO - SUITE-END | took 1175s 10:07:52 INFO - Completed test suite (00:19:35) 10:07:52 INFO - javascript benchmark 10:07:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2976.8687898598528, 3350.8827191048317, 3374.8481318340655, 3406.863725450982, 3416.4021296273145, 5516.696581688006, 5581.079121944874, 5589.049861523551, 5592.328920529537, 5617.017022021145, 5520.751566179521, 5571.247881535992, 5583.3858275589755, 5586.273784408021, 5620.550355971523, 4079.4492743479545, 4158.750474971512, 5085.974570127144, 5141.218995388259, 5228.8692782680355, 5071.644984851062, 5082.1360368737405, 5092.745362731867, 5128.53843154116, 5194.480551944813, 5116.079105760961, 5121.513456221672, 5143.228515722652, 5152.124138896378, 5182.766775495093, 5165.896682066375, 5172.017316709813, 5173.637845350846, 5192.480751924815, 5209.479052094798, 4943.555080042777, 5093.159628661267, 5119.744012799345, 5119.923201151985, 5138.434772175057, 5399.460053994609, 5430.239766432703, 5439.428859969686, 5460.945390546123, 5497.202905578709, 5986.28164620244, 5995.61028533144, 6041.24484439445, 6055.666938318391, 6060.757569697207, 5954.583179177459, 6164.260288765377, 6176.567640265183, 6185.0413185955795, 6188.783392581283, 4719.7404142772475, 5538.889222215533, 5575.749091290902, 5601.047821870292, 5672.4894759471845, 6214.316425193225, 6220.844478887973, 6224.221972253468, 6232.3144454110015, 6240.251169859555, 5898.498627616615, 5905.822825315247, 5907.527397808165, 5921.496672782776, 5934.0, 4901.1913034349645, 5966.105084237312, 6006.189164462741, 6047.0929360596265, 6077.3314935357075, 5991.580589358703, 5992.490638295793, 6001.549883758736, 6006.669633170218, 6028.668423236676, 5942.64344139353, 5976.701164941735, 6010.0, 6031.94440972828, 6032.4570788629235, 4755.096531658974, 4789.832355867528, 4835.153848076572, 4861.854144375674, 4889.144399730033, 4373.497047839475, 4403.691741578123, 4407.3168658857285, 4411.801468933906, 4458.308962110878, 5569.220309156722, 5594.636348637407, 5598.1602759586385, 5608.85977850557, 5621.796439462362, 5970.462658360769, 6141.025769127022, 6157.507399408037, 6170.259568851767, 6200.100985357098, 5414.052540805344, 5513.255710479114, 5566.972165139148, 5588.21764952907, 5622.6345287557, 5243.292155558951, 5297.3643162819935, 5300.522952934254, 5320.654157479751, 5321.228421878806, 6188.44304012641, 6281.842953926189, 6313.684315784284, 6315.778947736807, 6321.0, 4699.929501057419, 5999.190109335358, 6042.123892035543, 6077.027675571887, 6199.473044791243, 6264.31092579825, 6297.433231009231, 6318.4313411793155, 6323.557350985571, 6327.0, 6074.42292982166, 6075.756969721162, 6087.421694938974, 6093.573449858467, 6097.603655762538, 5971.283445986335, 6020.337762845996, 6047.183630209865, 6095.2685677718955, 6115.510759139169, 5827.0, 5857.092150716646, 5871.823845284648, 5885.058390657474, 5896.027155519463, 5930.495907847709, 5957.970210148921, 5960.850978725566, 5966.403359663999, 5975.282966044103, 5788.855278618068, 5793.449622285876, 5824.475797178275, 5828.70856457167, 5852.209951656472, 5746.5402767779315, 5803.332616749128, 5842.503387211965, 5851.444112809277, 5965.194698715618, 5762.4525670061275, 5766.913496297475, 5768.913466297925, 5776.249087618583, 5814.912776308443], "value": 5544.71723378176, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.32001677467025, 481.0907385042271, 504.88387670835687, 514.5266354953445, 521.457684008631, 29783.0, 38539.0, 39213.82358529242, 39303.80348098263, 41649.0, 41649.95875103124, 42013.0, 42088.0, 42180.156396872044, 42314.0, 9267.81464370714, 9423.293253006017, 9441.716748497556, 9447.244220462346, 9453.52732363379, 8697.086805885387, 8865.822683546325, 11248.26886252395, 11458.197926145172, 11542.769144617103, 11378.317300961928, 11564.132690048238, 11564.42177891102, 11568.884311156864, 11573.305601663928, 11494.827577586342, 11556.826647600292, 11578.942105289503, 11579.247348922378, 11580.999999999958, 11432.0, 11472.942635286854, 11487.966083052564, 11512.597059102975, 11515.0, 39167.41248881269, 39465.0, 39578.40632390516, 39683.20633587341, 39741.80129099365, 3183.5861338025907, 3197.2646291353117, 3230.7400113955578, 3409.931801363959, 3548.964510354889, 21200.78799212019, 28845.42309153826, 28852.855735721398, 29120.126396208147, 29159.979400720873, 3184.601924759405, 3196.8721251149927, 3233.611966564004, 3234.3531293741344, 3326.135204846733, 520057.0, 520565.0, 521696.0, 521880.0, 522402.0, 33159.83420082884, 33293.3341333172, 56287.43712562904, 56624.0, 56713.716431417575, 35046.649533504846, 35415.64584354175, 35443.0, 35486.290274194886, 35514.0, 14758.188299643409, 14879.0, 14925.776113358308, 14962.70074598502, 14967.550973470814, 11502.137339699557, 11684.357360345093, 12613.810792838114, 12693.49226030967, 12706.2376257423, 7686.346660533805, 7692.499987500906, 7700.537967721954, 7938.285554300025, 7999.440039197317, 3290.588676415448, 3330.483775014828, 3345.5985281766343, 3361.210115622827, 3366.4781958796425, 968.3124981263242, 975.1272611013104, 1050.369778133114, 1077.2620754783, 1092.1208427216009, 28285.0, 29138.417231655247, 29293.56059659107, 29949.550756738667, 30042.69957300443, 995.1887564632444, 1004.7287232447198, 1045.895410458948, 1080.4057768227444, 1130.37829193943, 14722.55832325032, 15121.395144194328, 15147.091174529563, 15514.146721930176, 15537.06777593348, 670423.0, 676733.0, 678707.0, 678991.6050419717, 679740.0, 56857.0, 57244.427555724746, 57335.426645733845, 57348.0, 57402.0, 1192.2369683402803, 1267.3979859566816, 1283.1018287199, 1372.835259768834, 1391.2139641102744, 24218.878905605357, 29926.0, 29947.70052299536, 30320.696793031788, 30785.076447706604, 46374.0, 47128.0, 47193.528064718914, 47225.527744722116, 47327.52672473231, 558212.0, 561060.0, 561294.0, 561464.0, 562303.0, 23056.0, 23180.304590862303, 24612.753872461046, 25052.62421063722, 25620.743792561836, 37281.62718372782, 44692.55307447014, 44865.10269794521, 45252.094958099995, 45260.86847828699, 29925.700742993162, 37073.88778336654, 37089.07277318089, 37152.62847371492, 37793.2441351177, 36128.45807312945, 36614.08464788402, 36969.6303036977, 37240.6275937248, 37648.0, 36152.45771313485, 36167.457488137174, 36470.27059458849, 36645.450318244715, 36899.631003690694, 26700.332491687863, 31048.0, 34058.97823065312, 34138.0, 34167.487487687205, 20782.0, 25444.0, 25577.360565986, 25919.092831750797, 25977.75278090239], "value": 18514.526721390685, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.16934405619514, 375.7013174526251, 388.9611038896111, 394.2174783055636, 404.97367671101375, 18656.813431865678, 20455.0, 21182.788172118275, 21435.356939291847, 21469.355919322425, 11778.587749428772, 12323.568675096374, 12330.0, 12412.0, 20409.897950510265, 5189.818356357538, 5443.292371991635, 5458.017556839767, 5461.5357694596005, 5464.562834973192, 5185.507376799198, 5338.0, 5400.135978243482, 5434.755436005369, 5450.400455949843, 5436.619436639437, 5439.918401223985, 5441.863953401157, 5443.700596467193, 5445.727713614323, 5435.701036442994, 5740.339860916007, 5995.550333724967, 6060.484858787008, 6113.877722445571, 5727.885442291173, 5894.17481552583, 5902.173695682608, 5906.26171728534, 5912.645241285537, 12907.419166137546, 13134.86865131346, 21470.497065205444, 23999.88000060006, 24870.0, 2160.567886422706, 2265.920692775745, 2279.261801721133, 2342.601757701195, 2777.8610769584575, 9729.270304727102, 9886.0, 10224.74438139045, 10391.792164156675, 10411.5835366586, 1659.568512186828, 1844.1609067874085, 1854.7681539807525, 1897.791242963273, 1934.8258656720823, 119319.8068019326, 121113.0, 124551.0, 125768.0, 130540.69459305475, 11274.154438417152, 11611.535538578362, 11642.825357619642, 11684.357360345262, 11842.763144737057, 14784.408623654934, 14801.407943682132, 14806.481773137888, 14833.480828171178, 14838.554843354501, 8448.493090414471, 8671.913280867237, 8680.262177714965, 8798.648054077894, 8805.031446540876, 7694.653740581687, 8457.450265732708, 8664.046954834963, 8842.867356989651, 8863.955680221687, 4441.755703436342, 4546.681732278775, 4571.6742144777645, 4621.930671039937, 4627.431775364705, 1626.6502701919144, 1830.9289065896332, 1909.455805095541, 1927.816857398545, 1943.5141214696325, 716.634516396631, 845.560308639504, 930.418488444722, 986.9950650246847, 1020.1023099672241, 16947.91526042362, 19200.231990720495, 20807.68788468174, 21059.368218953456, 21073.0, 778.373409405434, 787.6455594982281, 940.3229674634252, 949.7768024514234, 974.0308393148862, 10722.463876806129, 10910.23628346008, 11024.621922259717, 11080.501377438035, 11121.221514493907, 574534.0, 591799.0, 592372.0, 608359.0, 617190.9140454269, 128113.0, 129312.0, 132096.0, 134569.0, 139937.3003134998, 945.9574319155516, 953.208836665566, 964.5418426247477, 965.3628605120587, 985.3250523391356, 17449.56376090608, 17993.640127197123, 18197.363092292235, 18450.538736531158, 18474.44576662702, 53229.467705324, 53901.0, 53923.460765393414, 53972.0, 54971.72514137404, 74656.13359666051, 77703.0, 78511.82232266635, 80006.5999669998, 80770.59614701889, 6955.826104347432, 7193.5324203926575, 7288.0, 7341.302576255247, 7493.325600695964, 9676.419414835133, 12268.509259629514, 12347.320897350732, 12455.813162802746, 12465.93767031159, 10225.48872556384, 10416.270861039957, 10528.0, 10842.24104312722, 10862.674119776419, 10570.682879513626, 10773.946130269298, 10782.622608208674, 10879.129669626253, 11158.72103197394, 9806.85289720669, 10451.372917624967, 10874.293170943864, 10991.0, 11091.611793587186, 7169.641517924188, 7299.05112335393, 7436.219196984239, 7480.70077196906, 7559.962200188964, 10397.84403233937, 10559.788804224027, 10716.678499645022, 10753.032227099598, 10757.977992091051], "value": 9235.329966053643, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.0688166455136, 1526.6488707597252, 1662.3849175804946, 1816.5821860971976, 1820.3446759166707, 7938.2855543001115, 8320.500769953793, 8327.541985190812, 8332.541710205936, 8336.958315208423, 7331.816704582388, 7555.773326800191, 7567.735129270477, 7843.215678432154, 8116.91883081169, 2296.3684986628687, 2338.2751347082376, 2339.5905716499547, 2340.1458467659268, 2340.262817212581, 2043.56063446359, 2338.4387746940697, 2354.2466410748566, 2358.8230882683865, 2385.2367242482414, 2239.9776002239932, 2241.7309922809286, 2264.830137739668, 2274.7270327560714, 2291.049214575957, 1888.6317168152216, 2226.899789509476, 2251.3358559224985, 2264.6942662740485, 2274.2040285900052, 2296.127471560796, 2356.8350215484925, 2357.03361621736, 2358.033206385374, 2360.5986982212894, 6567.67161641916, 8168.938038055075, 8244.793880152984, 8255.711050113217, 8281.751547453587, 4776.522347765231, 4903.0, 4903.583195428393, 4904.239842824368, 4916.336294600219, 3098.7211150996295, 3160.952585711216, 3476.739244556643, 3478.3217272631596, 3481.791092534431, 1048.4862417415488, 1068.471106802138, 1069.8716154061485, 1111.8443417921496, 1115.068917453927, 10509.316894401916, 10606.52270647815, 10639.0, 10647.0, 10659.093977011964, 4343.609075183249, 4457.353683715843, 4540.977295113504, 4541.84103556374, 4595.40259766235, 7717.421193410517, 9193.632254709737, 9234.861477077715, 9239.676611318571, 9247.029061948399, 5063.645544811901, 5066.670666406671, 5073.670211436245, 5077.23841423782, 5079.31429257053, 4199.223143718422, 4333.696641235147, 4482.282834746425, 4612.400387949545, 4665.95334046662, 3707.8146092695797, 3735.364987952055, 3796.6393192646656, 3825.6174382562076, 3846.999780057149, 1026.9743256418649, 1227.4292454008928, 1231.199720181871, 1239.3555351217497, 1240.528599132324, 771.8687823070092, 867.3061550759368, 898.833715762586, 910.7814124610046, 912.3750231091724, 5302.0, 5309.628326017141, 5353.57171426285, 5388.7305634718105, 5555.30558680165, 812.2405550810012, 898.9730308090768, 932.2402242172608, 943.4763706143157, 951.5765484359393, 3538.239278555123, 3642.872499462559, 3661.8718344857803, 3690.926181476409, 3765.7363984521367, 9384.718458446258, 9848.965858584888, 9863.654772083086, 9864.865540462795, 9876.703698889045, 9790.118889299998, 9824.361416507903, 9831.213502919893, 9834.213262938947, 9840.507974601242, 7521.5111017783665, 7681.3854891608535, 7683.846323073507, 7694.692212311556, 7704.499207551491, 5046.091703493406, 5177.870553236199, 5185.9222111669105, 5338.8932221356135, 5438.075527160313, 7440.665170067252, 8992.415492992934, 9122.863157052518, 9157.077013827171, 9158.542072896194, 9012.774680632774, 9074.546272686472, 9202.21781148583, 9285.025072367574, 9288.303377246868, 6227.128202051807, 6353.809385718436, 6363.87272254543, 6493.22081350241, 6701.0, 7278.745243916437, 7355.043844300207, 7370.0, 7408.555486670817, 7579.696812127674, 6761.492888033319, 6872.725090996504, 6880.58716476993, 6905.447564194953, 7025.824354391181, 6793.830154246183, 6806.455483561204, 6814.284500127415, 6837.38463538264, 6849.349311815369, 6430.678466076584, 6442.742290308335, 6448.129502517288, 6516.055172000129, 6518.185226846645, 4476.79854406559, 4566.520515345841, 4573.519780423141, 4637.744924029211, 4641.932355558173, 4576.519465456212, 4626.884327891829, 4754.429468463806, 4756.785944632431, 4789.568938795525], "value": 4291.896530875722, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [251.64141098934022, 303.8708548866731, 313.9968600313996, 319.5893277138877, 319.78734141795707, 4441.8223271069155, 5425.0, 5425.182563841108, 5468.562514998801, 5517.420670829565, 5126.92309615356, 5206.3231779868565, 5269.552088072509, 5350.8061694705175, 5431.321084864392, 3329.384063948165, 3640.672339489445, 4109.034376921429, 4142.958570414303, 4164.708470407073, 4142.730722503027, 4184.351425529047, 4202.453681021463, 4222.429971953793, 4227.873163805076, 3496.0, 3854.0, 4071.3485842265245, 4091.529474110486, 4139.337705967046, 3231.8688459039267, 3708.740388172829, 4084.0, 4087.9182416351805, 4113.938290925608, 2932.3695405487924, 3537.5047493350953, 3560.5193298904574, 3568.2863427314383, 3573.8391772370305, 4888.364512613338, 5311.336082989626, 5335.759890804884, 5351.28758797185, 5360.52585538976, 4398.406215160944, 4678.7426691531955, 4694.906101877978, 4707.646926480527, 4711.057788442326, 4815.277708343741, 5406.54044406226, 5654.349749778787, 5679.034564124109, 5698.350267125807, 3433.828308584561, 3610.0, 3797.8670746524017, 3923.8234279457206, 3926.7447615904875, 5302.257683924215, 5639.436056394369, 5746.425357464262, 5920.0, 5980.192673989043, 3943.5859234779937, 3944.4674968878835, 3949.5260568731937, 3955.980220098939, 3958.465607142999, 4020.8540565938565, 4022.4770779798437, 4042.717009809285, 4057.1479989202007, 4058.6144316289906, 3851.6533511984057, 3974.0328537374185, 4491.797869095899, 4580.88547786308, 4686.625069994392, 5572.718274796819, 5654.604177707603, 5712.542996560265, 5714.257146570919, 5725.4749167054, 1105.8562386889814, 1177.9293242405483, 1183.7810005148904, 1256.0265794009533, 1292.6251387097825, 699.5557820783839, 734.7942576078707, 745.4185735126609, 863.4344504349662, 877.8902637170354, 4013.2976729072298, 4250.086231460251, 4961.627877909171, 5074.198659475906, 5122.385313762373, 5332.0, 5598.552115830724, 5611.128321458181, 5695.003374409544, 5800.361960184377, 4844.069338050499, 5069.9746501267255, 5195.0907491803955, 5432.8047829477455, 5500.992137869729, 2633.2752047408976, 2956.305268261957, 2970.56926745625, 2971.435427268812, 3015.276333679901, 4690.209325451351, 5212.843614691566, 5337.2527846101575, 5470.972645136749, 5622.8313150605545, 4877.487863774252, 5060.002597947654, 5819.767209311664, 5846.532277417797, 5851.64890106595, 4954.331165292711, 5234.555062819627, 5380.973095134499, 5539.7784088636, 5578.414266502121, 4671.8131274749985, 4810.39870016248, 5551.750171242385, 5626.690532020778, 5701.914471282851, 5113.446154922293, 5521.972390138024, 5646.661200327993, 5923.911141332969, 5928.56143436797, 5604.3835178131185, 5986.725044483069, 6004.708987567694, 6207.099970504161, 6218.315985241529, 3159.020703581897, 3364.755040634883, 3849.1339448624954, 3876.8449262029203, 3971.72197946141, 4712.69367491112, 5151.768170432414, 5176.4305926348825, 5620.662760234399, 5891.528677705687, 5030.974845125751, 5113.874947511542, 5794.739236734441, 5806.216160818404, 5868.823935281948, 5575.665460072409, 5741.641139933019, 5785.30576330843, 5785.971070144622, 5809.419058094157, 4641.512641172763, 5254.605904557097, 5524.198991146181, 5555.916661250165, 5652.7738890443925, 4852.466228714909, 5325.467453254643, 5628.0, 5656.688882111359, 5754.992876246723, 5571.944280557304, 5593.881223755184, 5600.243967064394, 5609.719514024364, 5617.775288988395], "value": 4060.3087581081013, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.3097261142996, 738.6860584251692, 776.2741836382986, 787.5392895156333, 825.8389614025264, 14284.14295142291, 14848.628784280385, 15297.005694629841, 15449.07305561667, 15571.143587102704, 12818.615441536745, 12894.4197511112, 12894.484220631164, 12917.74164516709, 12927.030472714561, 685.6640246279312, 821.48246604639, 836.6318819719304, 844.9535275559841, 845.1337379186338, 849.8810166576684, 850.9531975741331, 851.0723311590365, 851.3019324154196, 853.6798700487317, 762.2529920677739, 901.4230892228978, 901.5041727050129, 901.9413738107035, 902.6479672927563, 896.8116695493954, 897.5736525150567, 897.8653202019717, 898.4384759525296, 899.7795540092686, 661.5237029338869, 661.6162625677143, 661.9338066193391, 661.9503537234726, 662.8806814773338, 14069.577912662637, 14257.714845703027, 14276.714465710627, 14277.21534808149, 14706.926465367711, 13926.860731392657, 14260.92869535656, 14307.713845723132, 14336.713265734732, 14445.422183112663, 11385.601503947404, 11440.828387574193, 11504.36293205005, 11609.01323387513, 11864.644060678107, 3618.8733394331334, 3721.1255354991554, 3736.252749450121, 3738.065483629093, 3865.1689886674217, 86924.0, 91135.0, 93307.53346233294, 93422.0, 93929.0, 8892.555372231493, 10122.58283840263, 10473.214508911862, 10578.153747700166, 10858.891411085788, 19058.33295834667, 19225.327113551237, 19319.90340048291, 19345.0, 19639.509012274808, 6110.847228819226, 6828.487863410264, 7698.191689872595, 7720.652570634335, 7933.722319718782, 3786.8295926683363, 4345.630621397154, 4375.7155784873885, 4495.483019452739, 4512.481064677604, 3410.18155642644, 3517.4196257617205, 3521.1373213562842, 3521.3133438979153, 3522.982385088058, 631.4601016131234, 641.8812519683873, 648.176815444383, 653.0204692960559, 660.6828722213364, 644.9967750161219, 662.3991920512025, 665.6305750308528, 679.2697849811374, 687.9449644028466, 8943.329250306253, 9053.502057386775, 10138.03688649577, 10372.15988499779, 10482.318649287925, 561.4946548106655, 599.7780821096222, 681.3425044831761, 684.674779479753, 688.5352387138662, 4395.0, 4503.752293623882, 4510.120526497367, 4557.589816916494, 4634.281686338555, 89692.5515372432, 107893.46053269683, 108564.0, 110998.44500777444, 111352.0, 75137.87293190607, 80267.0, 86268.0, 97899.741529725, 97909.0, 60088.0, 78214.21785782183, 80311.59844200741, 83401.16598834055, 84127.7380839288, 8520.36097292718, 9658.275629327969, 9804.068613481708, 10050.949745251228, 10064.547095380873, 47723.80690482766, 53755.656108596035, 56691.86616267569, 56770.0, 58190.836183276944, 65178.67410663106, 77472.45055098979, 78188.60905695434, 80219.59890200512, 80411.19588804037, 12130.454129564014, 12452.626421207378, 12595.622131336075, 12677.112602118132, 12688.365581721062, 13727.931360343533, 13846.584602461942, 14111.364988575333, 14284.857151428352, 14987.925060374628, 12278.447469863699, 12282.07884408655, 12647.936760316508, 12777.552785652457, 13807.585772426843, 12448.688782780502, 13029.804552931902, 13382.702988627394, 13509.797353039909, 13522.864771352553, 12034.699132521757, 13361.064725469123, 13415.731685366432, 13626.659333516742, 13819.516316929261, 10349.9482502587, 11018.088578554818, 11289.0, 11423.543058277575, 11772.529098836294, 8520.403571749917, 9549.952250238983, 9580.712578622653, 10103.54534045955, 11475.254108482923], "value": 7336.457320126672, "unit": "score"}], "name": "dromaeo_css", "value": 7035.000715035617, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 115.0, 115.0, 114.0, 116.0, 114.0, 115.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 106.0, 141.0, 111.0, 116.0, 105.0, 108.0, 135.0, 108.0], "value": 118.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 182.0, 182.0, 183.0, 182.0, 184.0, 184.0, 183.0, 184.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 88.0, 61.0, 60.0, 61.0, 61.0, 84.0, 75.0], "value": 68.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 92.0, 70.0, 70.0, 84.0, 113.0, 69.0, 68.0, 90.0], "value": 81.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 92.0, 89.0, 92.0, 89.0, 92.0, 89.0, 88.0, 128.0], "value": 94.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 100.0, 102.0, 100.0, 100.0, 101.0, 100.0, 101.0, 100.0], "value": 101.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 79.0, 83.0, 82.0, 81.0, 86.0, 85.0, 81.0, 83.0], "value": 82.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 56.0, 57.0, 56.0, 57.0, 56.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 72.0, 76.0, 76.0, 72.0, 66.0, 66.0, 68.0, 67.0, 67.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 81.0, 82.0, 84.0, 82.0, 82.0, 85.0, 82.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 137.0, 133.0, 136.0, 139.0, 138.0, 137.0, 183.0, 140.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 161.0, 165.0, 161.0, 159.0, 161.0, 164.0, 160.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 63.0, 62.0, 64.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1417.9, "alertThreshold": 2.0}]} 10:07:52 INFO - Return code: 0 10:07:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:07:52 INFO - # TBPL SUCCESS # 10:07:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:07:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:07:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:07:52 INFO - 2017-02-14 10:07:52.645 screenresolution[1656:9820] starting screenresolution argv=screenresolution get 10:07:52 INFO - 2017-02-14 10:07:52.649 screenresolution[1656:9820] Display 0: 1600x1200x32@60 10:07:52 INFO - 2017-02-14 10:07:52.656 screenresolution[1657:9824] starting screenresolution argv=screenresolution list 10:07:52 INFO - Available Modes on Display 0 10:07:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:07:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:07:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:07:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:07:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:07:52 INFO - Intel Iris: 10:07:52 INFO - Chipset Model: Intel Iris 10:07:52 INFO - Type: GPU 10:07:52 INFO - Bus: Built-In 10:07:52 INFO - VRAM (Dynamic, Max): 1536 MB 10:07:52 INFO - Vendor: Intel (0x8086) 10:07:52 INFO - Device ID: 0x0a2e 10:07:52 INFO - Revision ID: 0x0009 10:07:52 INFO - Displays: 10:07:52 INFO - Display: 10:07:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:07:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:07:52 INFO - Display Serial Number: 1600x1200 60 10:07:52 INFO - Main Display: Yes 10:07:52 INFO - Mirror: Off 10:07:52 INFO - Online: Yes 10:07:52 INFO - Rotation: Supported 10:07:52 INFO - Return code: 0 10:07:52 INFO - Running post-action listener: _resource_record_post_action 10:07:52 INFO - [mozharness: 2017-02-14 18:07:52.895921Z] Finished run-tests step (success) 10:07:52 INFO - Running post-run listener: _resource_record_post_run 10:07:52 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 38028288; Write bytes: 502936064; Read time: 243; Write time: 1585 10:07:52 INFO - TinderboxPrint: CPU usage
53.2% 10:07:52 INFO - TinderboxPrint: I/O read bytes / time
38,028,288 / 243 10:07:52 INFO - TinderboxPrint: I/O write bytes / time
502,936,064 / 1,585 10:07:52 INFO - TinderboxPrint: CPU idle
2,241.5 (46.8%) 10:07:52 INFO - TinderboxPrint: CPU system
959.3 (20.0%) 10:07:52 INFO - TinderboxPrint: CPU user
1,592.8 (33.2%) 10:07:52 INFO - TinderboxPrint: Swap in / out
229,543,936 / 0 10:07:52 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 187898368; Write bytes: 190502912; Read time: 17877; Write time: 439 10:07:52 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 36049920; Write bytes: 305490432; Read time: 227; Write time: 1120 10:07:53 INFO - Running post-run listener: _upload_blobber_files 10:07:53 INFO - Blob upload gear active. 10:07:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:07:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:07:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:07:53 INFO - (blobuploader) - INFO - Open directory for files ... 10:07:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:07:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:07:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:07:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:07:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:07:54 INFO - (blobuploader) - INFO - Done attempting. 10:07:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:07:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:07:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:07:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:07:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:07:55 INFO - (blobuploader) - INFO - Done attempting. 10:07:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:07:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:07:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:07:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:07:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:07:58 INFO - (blobuploader) - INFO - Done attempting. 10:07:58 INFO - (blobuploader) - INFO - Iteration through files over. 10:07:58 INFO - Return code: 0 10:07:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:07:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:07:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63ae451bd13a008b1ab5e84a63b28a6e7065401a93c776dba828604ec583fef6a19bd7c075c093445e9b86f96d0b24ee9baa35b368885fc127684cbcc56f8de6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc06688492827a86f3942409773ea3702561b50647d2745183e2f0e80f703b1c69c86b1e7511584a7bd8df8652008abb5d701338d7624e752012037c955521a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/352ae21e86e37591553b272dffcf3cc17be3def861c0c5f896350aead2d7fa965404a6c98714cc63c22fdfcd877bb52898fc387e6a5850ea975000c76d8df7f3"} 10:07:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:07:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:07:58 INFO - Contents: 10:07:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63ae451bd13a008b1ab5e84a63b28a6e7065401a93c776dba828604ec583fef6a19bd7c075c093445e9b86f96d0b24ee9baa35b368885fc127684cbcc56f8de6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc06688492827a86f3942409773ea3702561b50647d2745183e2f0e80f703b1c69c86b1e7511584a7bd8df8652008abb5d701338d7624e752012037c955521a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/352ae21e86e37591553b272dffcf3cc17be3def861c0c5f896350aead2d7fa965404a6c98714cc63c22fdfcd877bb52898fc387e6a5850ea975000c76d8df7f3"} 10:07:58 INFO - Running post-run listener: copy_logs_to_upload_dir 10:07:58 INFO - Copying logs to upload dir... 10:07:58 INFO - mkdir: /builds/slave/test/build/upload/logs 10:07:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.359206 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-14 10:07:58.659535) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 10:07:58.664975) ========= 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.ac7ViV3T15/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.B6rY9HlAw9/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63ae451bd13a008b1ab5e84a63b28a6e7065401a93c776dba828604ec583fef6a19bd7c075c093445e9b86f96d0b24ee9baa35b368885fc127684cbcc56f8de6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc06688492827a86f3942409773ea3702561b50647d2745183e2f0e80f703b1c69c86b1e7511584a7bd8df8652008abb5d701338d7624e752012037c955521a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/352ae21e86e37591553b272dffcf3cc17be3def861c0c5f896350aead2d7fa965404a6c98714cc63c22fdfcd877bb52898fc387e6a5850ea975000c76d8df7f3"} build_url:https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011002 build_url: 'https://queue.taskcluster.net/v1/task/BdPrrjp6Q5SBpW1w-D7YyQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63ae451bd13a008b1ab5e84a63b28a6e7065401a93c776dba828604ec583fef6a19bd7c075c093445e9b86f96d0b24ee9baa35b368885fc127684cbcc56f8de6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc06688492827a86f3942409773ea3702561b50647d2745183e2f0e80f703b1c69c86b1e7511584a7bd8df8652008abb5d701338d7624e752012037c955521a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/352ae21e86e37591553b272dffcf3cc17be3def861c0c5f896350aead2d7fa965404a6c98714cc63c22fdfcd877bb52898fc387e6a5850ea975000c76d8df7f3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 10:07:58.700169) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 10:07:58.700451) ========= 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.ac7ViV3T15/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.B6rY9HlAw9/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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.005051 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 10:07:58.749197) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 10:07:58.749742) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 10:07:58.750193) ========= ========= Total master_lag: 0.67 =========