builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0264 starttime: 1487268334.74 results: success (0) buildid: 20170216073619 builduid: 01753a70e3fb4e14a92f34dc8d3f5228 revision: d0d5f1187d755b0d1fc65baaecd0ca2e5d16d842 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 10:05:34.735470) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 10:05:34.735882) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 10:05:34.736157) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 10:05:34.761502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 10:05:34.761762) ========= 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.yCaRkD21fT/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.2dzMZR0hD2/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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-16 10:05:34-- 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% 211M=0s 2017-02-16 10:05:34 (211 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156441 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 10:05:34.941414) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 10:05:34.941712) ========= 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.yCaRkD21fT/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.2dzMZR0hD2/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.025942 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 10:05:34.989613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-16 10:05:34.989923) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d0d5f1187d755b0d1fc65baaecd0ca2e5d16d842 --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 d0d5f1187d755b0d1fc65baaecd0ca2e5d16d842 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yCaRkD21fT/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.2dzMZR0hD2/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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-16 10:05:35,101 truncating revision to first 12 chars 2017-02-16 10:05:35,101 Setting DEBUG logging. 2017-02-16 10:05:35,101 attempt 1/10 2017-02-16 10:05:35,101 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d0d5f1187d75?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-16 10:05:37,152 unpacking tar archive at: mozilla-beta-d0d5f1187d75/testing/mozharness/ program finished with exit code 0 elapsedTime=2.325569 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-16 10:05:37.344428) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 10:05:37.344746) ========= script_repo_revision: d0d5f1187d755b0d1fc65baaecd0ca2e5d16d842 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 10:05:37.345148) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 10:05:37.345423) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 10:05:37.364775) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-16 10:05:37.365058) ========= /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.yCaRkD21fT/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.2dzMZR0hD2/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:05:37 INFO - MultiFileLogger online at 20170216 10:05:37 in /builds/slave/test 10:05:37 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 10:05:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:37 INFO - {'append_to_log': False, 10:05:37 INFO - 'base_work_dir': '/builds/slave/test', 10:05:37 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:05:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:37 INFO - 'branch': 'Mozilla-Beta', 10:05:37 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:37 INFO - 'config_files': ('talos/mac_config.py',), 10:05:37 INFO - 'default_actions': ('clobber', 10:05:37 INFO - 'read-buildbot-config', 10:05:37 INFO - 'download-and-extract', 10:05:37 INFO - 'populate-webroot', 10:05:37 INFO - 'create-virtualenv', 10:05:37 INFO - 'install', 10:05:37 INFO - 'run-tests'), 10:05:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:37 INFO - 'download_minidump_stackwalk': True, 10:05:37 INFO - 'download_symbols': 'ondemand', 10:05:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:37 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:37 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:37 INFO - 'installer_path': 'installer.exe', 10:05:37 INFO - 'log_level': 'info', 10:05:37 INFO - 'log_name': 'talos', 10:05:37 INFO - 'log_to_console': True, 10:05:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:05:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:05:37 INFO - 'opt_config_files': (), 10:05:37 INFO - 'pip_index': False, 10:05:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:05:37 INFO - 'cmd': ('bash', 10:05:37 INFO - '-c', 10:05:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:05:37 INFO - 'enabled': True, 10:05:37 INFO - 'halt_on_failure': False, 10:05:37 INFO - 'name': 'check_screen_resolution'},), 10:05:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:05:37 INFO - 'cmd': ('bash', 10:05:37 INFO - '-c', 10:05:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:05:37 INFO - 'enabled': True, 10:05:37 INFO - 'halt_on_failure': False, 10:05:37 INFO - 'name': 'check_screen_resolution'},), 10:05:37 INFO - 'run_cmd_checks_enabled': True, 10:05:37 INFO - 'sps_profile': False, 10:05:37 INFO - 'sps_profile_interval': 0, 10:05:37 INFO - 'suite': 'dromaeojs', 10:05:37 INFO - 'system_bits': '32', 10:05:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:37 INFO - 'title': 't-yosemite-r7-0264', 10:05:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:37 INFO - 'use_talos_json': True, 10:05:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:37 INFO - 'work_dir': 'build'} 10:05:37 INFO - [mozharness: 2017-02-16 18:05:37.580956Z] Running clobber step. 10:05:37 INFO - Running pre-action listener: _resource_record_pre_action 10:05:37 INFO - Running main action method: clobber 10:05:37 INFO - rmtree: /builds/slave/test/build 10:05:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:41 INFO - Running post-action listener: _resource_record_post_action 10:05:41 INFO - [mozharness: 2017-02-16 18:05:41.833807Z] Finished clobber step (success) 10:05:41 INFO - [mozharness: 2017-02-16 18:05:41.834029Z] Running read-buildbot-config step. 10:05:41 INFO - Running pre-action listener: _resource_record_pre_action 10:05:41 INFO - Running main action method: read_buildbot_config 10:05:41 INFO - Using buildbot properties: 10:05:41 INFO - { 10:05:41 INFO - "project": "", 10:05:41 INFO - "product": "firefox", 10:05:41 INFO - "script_repo_revision": "production", 10:05:41 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:05:41 INFO - "repository": "", 10:05:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:05:41 INFO - "buildid": "20170216073619", 10:05:41 INFO - "pgo_build": "False", 10:05:41 INFO - "basedir": "/builds/slave/test", 10:05:41 INFO - "buildnumber": 40, 10:05:41 INFO - "slavename": "t-yosemite-r7-0264", 10:05:41 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:05:41 INFO - "platform": "yosemite_r7", 10:05:41 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:05:41 INFO - "branch": "mozilla-beta", 10:05:41 INFO - "repo_path": "releases/mozilla-beta", 10:05:41 INFO - "revision": "d0d5f1187d755b0d1fc65baaecd0ca2e5d16d842", 10:05:41 INFO - "stage_platform": "macosx64", 10:05:41 INFO - "builduid": "01753a70e3fb4e14a92f34dc8d3f5228", 10:05:41 INFO - "slavebuilddir": "test" 10:05:41 INFO - } 10:05:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 10:05:41 INFO - Running post-action listener: _resource_record_post_action 10:05:41 INFO - [mozharness: 2017-02-16 18:05:41.839689Z] Finished read-buildbot-config step (success) 10:05:41 INFO - [mozharness: 2017-02-16 18:05:41.839920Z] Running download-and-extract step. 10:05:41 INFO - Running pre-action listener: _resource_record_pre_action 10:05:41 INFO - Running main action method: download_and_extract 10:05:41 INFO - mkdir: /builds/slave/test/build/tests 10:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:41 INFO - trying https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 10:05:41 INFO - Downloading https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/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 10:05:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/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 10:05:42 INFO - Downloaded 1165 bytes. 10:05:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 10:05:42 INFO - Using the following test package requirements: 10:05:42 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 10:05:42 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:05:42 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 10:05:42 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:05:42 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 10:05:42 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:05:42 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:05:42 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 10:05:42 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 10:05:42 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:05:42 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 10:05:42 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:05:42 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 10:05:42 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:05:42 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 10:05:42 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:05:42 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 10:05:42 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 10:05:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 10:05:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 10:05:42 INFO - Fetch https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 10:05:43 INFO - Http code: 200 10:05:43 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 10:05:43 INFO - x-amz-cf-id: qc-ZR4VeMBHXroFhK7rJidbUR1R1WMMRS1igJiDlRB9KxeIodsTa7w== 10:05:43 INFO - x-amz-version-id: GhuZ.RgxJ.1AL46fHGPmemf41zo7PrUI 10:05:43 INFO - Expected file size: 16094083 10:05:43 INFO - Obtained file size: 16094083 10:05:50 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 10:05:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 10:05:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 10:05:50 INFO - Fetch https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 10:05:50 INFO - Http code: 200 10:05:50 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 10:05:50 INFO - x-amz-cf-id: j0QO0jZY3QCa9W_ByVi61dEWKGc2GoQ-5DNdQmgwnUuBhft0y7D6iA== 10:05:50 INFO - x-amz-version-id: GhuZ.RgxJ.1AL46fHGPmemf41zo7PrUI 10:05:51 INFO - Expected file size: 16094083 10:05:51 INFO - Obtained file size: 16094083 10:05:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 10:05:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 10:05:57 INFO - Fetch https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 10:05:58 INFO - Http code: 200 10:05:58 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 10:05:58 INFO - x-amz-cf-id: CvoYZVA2r2ccrLGxMXJl88PrfVkD7E5KpuLkR4JcQscMT83K9X6c9A== 10:05:58 INFO - x-amz-version-id: yKMgHyqDLI2dI12oeLbTCvhZQE5fluAG 10:05:58 INFO - Expected file size: 14403005 10:05:58 INFO - Obtained file size: 14403005 10:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:58 INFO - trying https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:05:58 INFO - Downloading https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 10:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/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 10:06:00 INFO - Downloaded 82110756 bytes. 10:06:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:06:00 INFO - mkdir: /builds/slave/test/properties 10:06:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:06:00 INFO - Writing to file /builds/slave/test/properties/build_url 10:06:00 INFO - Contents: 10:06:00 INFO - build_url:https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:06:01 INFO - Running post-action listener: _resource_record_post_action 10:06:01 INFO - Running post-action listener: set_extra_try_arguments 10:06:01 INFO - [mozharness: 2017-02-16 18:06:01.947137Z] Finished download-and-extract step (success) 10:06:01 INFO - [mozharness: 2017-02-16 18:06:01.947257Z] Running populate-webroot step. 10:06:01 INFO - Running pre-action listener: _resource_record_pre_action 10:06:01 INFO - Running main action method: populate_webroot 10:06:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:06:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:06:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:06:01 INFO - '--tppagecycles', 10:06:01 INFO - '7'], 10:06:01 INFO - 'tests': ['tsvgm']}}, 10:06:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:06:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:06:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:06:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:06:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:06:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:06:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:01 INFO - 'talos_options': ['--disable-e10s'], 10:06:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:01 INFO - 'talos_options': ['--disable-e10s'], 10:06:01 INFO - 'tests': ['damp', 'tps']}, 10:06:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:01 INFO - 'tests': ['damp', 'tps']}, 10:06:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:06:01 INFO - 'tests': ['dromaeo_dom']}, 10:06:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:06:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:06:01 INFO - 'tests': ['basic_compositor_video']}, 10:06:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:06:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:06:01 INFO - 'tests': ['a11yr', 10:06:01 INFO - 'ts_paint', 10:06:01 INFO - 'tpaint', 10:06:01 INFO - 'sessionrestore', 10:06:01 INFO - 'sessionrestore_no_auto_restore', 10:06:01 INFO - 'tabpaint']}, 10:06:01 INFO - 'other-e10s': {'tests': ['a11yr', 10:06:01 INFO - 'ts_paint', 10:06:01 INFO - 'tpaint', 10:06:01 INFO - 'sessionrestore', 10:06:01 INFO - 'sessionrestore_no_auto_restore', 10:06:01 INFO - 'tabpaint']}, 10:06:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:06:01 INFO - 'ts_paint', 10:06:01 INFO - 'tpaint', 10:06:01 INFO - 'sessionrestore', 10:06:01 INFO - 'sessionrestore_no_auto_restore', 10:06:01 INFO - 'tabpaint']}, 10:06:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:06:01 INFO - 'ts_paint', 10:06:01 INFO - 'tpaint', 10:06:01 INFO - 'sessionrestore', 10:06:01 INFO - 'sessionrestore_no_auto_restore', 10:06:01 INFO - 'tabpaint']}, 10:06:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:06:01 INFO - 'tests': ['a11yr', 10:06:01 INFO - 'ts_paint', 10:06:01 INFO - 'tpaint', 10:06:01 INFO - 'sessionrestore', 10:06:01 INFO - 'sessionrestore_no_auto_restore', 10:06:01 INFO - 'tabpaint']}, 10:06:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:06:01 INFO - 'tests': ['a11yr', 10:06:01 INFO - 'ts_paint', 10:06:01 INFO - 'tpaint', 10:06:01 INFO - 'sessionrestore', 10:06:01 INFO - 'sessionrestore_no_auto_restore', 10:06:01 INFO - 'tabpaint']}, 10:06:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:06:01 INFO - 'tests': ['tsvgx', 10:06:01 INFO - 'tsvgr_opacity', 10:06:01 INFO - 'tart', 10:06:01 INFO - 'tscrollx', 10:06:01 INFO - 'cart']}, 10:06:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:06:01 INFO - 'tsvgr_opacity', 10:06:01 INFO - 'tart', 10:06:01 INFO - 'tscrollx', 10:06:01 INFO - 'cart']}, 10:06:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:01 INFO - 'talos_options': ['--disable-e10s'], 10:06:01 INFO - 'tests': ['tp5o']}, 10:06:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:01 INFO - 'tests': ['tp5o']}, 10:06:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:01 INFO - 'talos_options': ['--disable-e10s', 10:06:01 INFO - '--xperf_path', 10:06:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:01 INFO - 'tests': ['tp5n']}, 10:06:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:01 INFO - 'talos_options': ['--xperf_path', 10:06:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:01 INFO - 'tests': ['tp5n']}}, 10:06:01 INFO - 'talos.zip': {'path': '', 10:06:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:06:01 INFO - Running post-action listener: _resource_record_post_action 10:06:01 INFO - [mozharness: 2017-02-16 18:06:01.966040Z] Finished populate-webroot step (success) 10:06:01 INFO - [mozharness: 2017-02-16 18:06:01.966120Z] Running create-virtualenv step. 10:06:01 INFO - Running pre-action listener: _resource_record_pre_action 10:06:01 INFO - Running main action method: create_virtualenv 10:06:01 INFO - Creating virtualenv /builds/slave/test/build/venv 10:06:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:06:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:06:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:06:02 INFO - Using real prefix '/tools/python27' 10:06:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:06:02 INFO - Installing distribute.............................................................................................................................................................................................done. 10:06:05 INFO - Installing pip.................done. 10:06:05 INFO - Return code: 0 10:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:06:05 INFO - Reading from file tmpfile_stdout 10:06:05 INFO - Output received: 10:06:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:06:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:05 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 0x1092b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10922d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefa858b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090cbd30>, '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 0x108f31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090c3b20>, '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.yCaRkD21fT/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.2dzMZR0hD2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:06:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCaRkD21fT/Render', 10:06:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:05 INFO - 'HOME': '/Users/cltbld', 10:06:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:05 INFO - 'LOGNAME': 'cltbld', 10:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:05 INFO - 'MOZ_NO_REMOTE': '1', 10:06:05 INFO - 'NO_EM_RESTART': '1', 10:06:05 INFO - 'PAGER': '/bin/cat', 10:06:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:05 INFO - 'PWD': '/builds/slave/test', 10:06:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:05 INFO - 'SHELL': '/bin/bash', 10:06:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dzMZR0hD2/Listeners', 10:06:05 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:06:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:05 INFO - 'USER': 'cltbld', 10:06:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:05 INFO - 'XPC_FLAGS': '0x0', 10:06:05 INFO - 'XPC_SERVICE_NAME': '0', 10:06:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:06:06 INFO - Cleaning up... 10:06:06 INFO - Return code: 0 10:06:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 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 0x1092b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10922d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefa858b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090cbd30>, '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 0x108f31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090c3b20>, '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.yCaRkD21fT/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.2dzMZR0hD2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:06:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCaRkD21fT/Render', 10:06:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:06 INFO - 'HOME': '/Users/cltbld', 10:06:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:06 INFO - 'LOGNAME': 'cltbld', 10:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:06 INFO - 'MOZ_NO_REMOTE': '1', 10:06:06 INFO - 'NO_EM_RESTART': '1', 10:06:06 INFO - 'PAGER': '/bin/cat', 10:06:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:06 INFO - 'PWD': '/builds/slave/test', 10:06:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:06 INFO - 'SHELL': '/bin/bash', 10:06:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dzMZR0hD2/Listeners', 10:06:06 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:06:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:06 INFO - 'USER': 'cltbld', 10:06:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:06 INFO - 'XPC_FLAGS': '0x0', 10:06:06 INFO - 'XPC_SERVICE_NAME': '0', 10:06:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:06 INFO - Downloading/unpacking psutil>=3.1.1 10:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:06:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:09 INFO - Installing collected packages: psutil 10:06:09 INFO - Running setup.py install for psutil 10:06:10 INFO - building 'psutil._psutil_osx' extension 10:06:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:06:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:06:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:06:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:06:10 INFO - building 'psutil._psutil_posix' extension 10:06:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:06:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:06:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:06:10 INFO - ^ 10:06:10 INFO - 1 warning generated. 10:06:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:06:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:11 INFO - Successfully installed psutil 10:06:11 INFO - Cleaning up... 10:06:11 INFO - Return code: 0 10:06:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:11 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 0x1092b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10922d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefa858b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090cbd30>, '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 0x108f31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090c3b20>, '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.yCaRkD21fT/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.2dzMZR0hD2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:06:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCaRkD21fT/Render', 10:06:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:11 INFO - 'HOME': '/Users/cltbld', 10:06:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:11 INFO - 'LOGNAME': 'cltbld', 10:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:11 INFO - 'MOZ_NO_REMOTE': '1', 10:06:11 INFO - 'NO_EM_RESTART': '1', 10:06:11 INFO - 'PAGER': '/bin/cat', 10:06:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:11 INFO - 'PWD': '/builds/slave/test', 10:06:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:11 INFO - 'SHELL': '/bin/bash', 10:06:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dzMZR0hD2/Listeners', 10:06:11 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:06:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:11 INFO - 'USER': 'cltbld', 10:06:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:11 INFO - 'XPC_FLAGS': '0x0', 10:06:11 INFO - 'XPC_SERVICE_NAME': '0', 10:06:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:06:15 INFO - Installing collected packages: mozsystemmonitor 10:06:15 INFO - Running setup.py install for mozsystemmonitor 10:06:15 INFO - Successfully installed mozsystemmonitor 10:06:15 INFO - Cleaning up... 10:06:15 INFO - Return code: 0 10:06:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:15 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 0x1092b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10922d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefa858b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090cbd30>, '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 0x108f31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090c3b20>, '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.yCaRkD21fT/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.2dzMZR0hD2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:06:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCaRkD21fT/Render', 10:06:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:15 INFO - 'HOME': '/Users/cltbld', 10:06:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:15 INFO - 'LOGNAME': 'cltbld', 10:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:15 INFO - 'MOZ_NO_REMOTE': '1', 10:06:15 INFO - 'NO_EM_RESTART': '1', 10:06:15 INFO - 'PAGER': '/bin/cat', 10:06:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:15 INFO - 'PWD': '/builds/slave/test', 10:06:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:15 INFO - 'SHELL': '/bin/bash', 10:06:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dzMZR0hD2/Listeners', 10:06:15 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:06:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:15 INFO - 'USER': 'cltbld', 10:06:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:15 INFO - 'XPC_FLAGS': '0x0', 10:06:15 INFO - 'XPC_SERVICE_NAME': '0', 10:06:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:15 INFO - Downloading/unpacking jsonschema==2.5.1 10:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:06:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:18 INFO - Downloading functools32-3.2.3-2.tar.gz 10:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:06:18 INFO - warning: no files found matching '*.txt' 10:06:18 INFO - no previously-included directories found matching 'build' 10:06:18 INFO - no previously-included directories found matching 'dist' 10:06:18 INFO - no previously-included directories found matching '.git*' 10:06:18 INFO - Installing collected packages: jsonschema, functools32 10:06:18 INFO - Running setup.py install for functools32 10:06:19 INFO - warning: no files found matching '*.txt' 10:06:19 INFO - no previously-included directories found matching 'build' 10:06:19 INFO - no previously-included directories found matching 'dist' 10:06:19 INFO - no previously-included directories found matching '.git*' 10:06:19 INFO - Successfully installed jsonschema functools32 10:06:19 INFO - Cleaning up... 10:06:19 INFO - Return code: 0 10:06:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:19 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 0x1092b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10922d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefa858b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090cbd30>, '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 0x108f31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090c3b20>, '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.yCaRkD21fT/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.2dzMZR0hD2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCaRkD21fT/Render', 10:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:19 INFO - 'HOME': '/Users/cltbld', 10:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:19 INFO - 'LOGNAME': 'cltbld', 10:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:19 INFO - 'MOZ_NO_REMOTE': '1', 10:06:19 INFO - 'NO_EM_RESTART': '1', 10:06:19 INFO - 'PAGER': '/bin/cat', 10:06:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:19 INFO - 'PWD': '/builds/slave/test', 10:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:19 INFO - 'SHELL': '/bin/bash', 10:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dzMZR0hD2/Listeners', 10:06:19 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:19 INFO - 'USER': 'cltbld', 10:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:19 INFO - 'XPC_FLAGS': '0x0', 10:06:19 INFO - 'XPC_SERVICE_NAME': '0', 10:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:06:19 INFO - Cleaning up... 10:06:19 INFO - Return code: 0 10:06:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:19 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 0x1092b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10922d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefa858b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090cbd30>, '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 0x108f31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090c3b20>, '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.yCaRkD21fT/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.2dzMZR0hD2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCaRkD21fT/Render', 10:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:19 INFO - 'HOME': '/Users/cltbld', 10:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:19 INFO - 'LOGNAME': 'cltbld', 10:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:19 INFO - 'MOZ_NO_REMOTE': '1', 10:06:19 INFO - 'NO_EM_RESTART': '1', 10:06:19 INFO - 'PAGER': '/bin/cat', 10:06:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:19 INFO - 'PWD': '/builds/slave/test', 10:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:19 INFO - 'SHELL': '/bin/bash', 10:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dzMZR0hD2/Listeners', 10:06:19 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:19 INFO - 'USER': 'cltbld', 10:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:19 INFO - 'XPC_FLAGS': '0x0', 10:06:19 INFO - 'XPC_SERVICE_NAME': '0', 10:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:19 INFO - Downloading/unpacking blobuploader==1.2.4 10:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:22 INFO - Downloading blobuploader-1.2.4.tar.gz 10:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:06:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:06:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:23 INFO - Downloading docopt-0.6.1.tar.gz 10:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:06:23 INFO - Installing collected packages: blobuploader, requests, docopt 10:06:23 INFO - Running setup.py install for blobuploader 10:06:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:06:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:06:23 INFO - Running setup.py install for requests 10:06:24 INFO - Running setup.py install for docopt 10:06:24 INFO - Successfully installed blobuploader requests docopt 10:06:24 INFO - Cleaning up... 10:06:24 INFO - Return code: 0 10:06:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:24 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 0x1092b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10922d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefa858b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090cbd30>, '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 0x108f31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090c3b20>, '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.yCaRkD21fT/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.2dzMZR0hD2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:06:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCaRkD21fT/Render', 10:06:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:24 INFO - 'HOME': '/Users/cltbld', 10:06:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:24 INFO - 'LOGNAME': 'cltbld', 10:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:24 INFO - 'MOZ_NO_REMOTE': '1', 10:06:24 INFO - 'NO_EM_RESTART': '1', 10:06:24 INFO - 'PAGER': '/bin/cat', 10:06:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:24 INFO - 'PWD': '/builds/slave/test', 10:06:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:24 INFO - 'SHELL': '/bin/bash', 10:06:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dzMZR0hD2/Listeners', 10:06:24 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:06:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:24 INFO - 'USER': 'cltbld', 10:06:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:24 INFO - 'XPC_FLAGS': '0x0', 10:06:24 INFO - 'XPC_SERVICE_NAME': '0', 10:06:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:24 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-TElVnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:24 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-pJGppC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:24 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-8BAUZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:24 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-4_70iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-IvddNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-yBlXM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-yYDsRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-WyVytA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-SZo13v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-ET_o6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-fCxLTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-PamUk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-A2cpUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:26 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-GnoYAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:26 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-RVRi9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:26 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-uZeiZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:26 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-AcE3ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:06:26 INFO - Running setup.py install for manifestparser 10:06:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:06:26 INFO - Running setup.py install for mozcrash 10:06:26 INFO - Running setup.py install for mozdebug 10:06:26 INFO - Running setup.py install for mozdevice 10:06:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:06:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:06:27 INFO - Running setup.py install for mozfile 10:06:27 INFO - Running setup.py install for mozhttpd 10:06:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:06:27 INFO - Running setup.py install for mozinfo 10:06:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:06:27 INFO - Running setup.py install for mozInstall 10:06:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:06:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:06:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:06:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:06:27 INFO - Running setup.py install for mozleak 10:06:27 INFO - Running setup.py install for mozlog 10:06:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:06:27 INFO - Running setup.py install for moznetwork 10:06:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:06:28 INFO - Running setup.py install for mozprocess 10:06:28 INFO - Running setup.py install for mozprofile 10:06:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:06:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:06:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:06:28 INFO - Running setup.py install for mozrunner 10:06:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:06:28 INFO - Running setup.py install for mozscreenshot 10:06:28 INFO - Running setup.py install for moztest 10:06:28 INFO - Running setup.py install for mozversion 10:06:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:06:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:06:29 INFO - Cleaning up... 10:06:29 INFO - Return code: 0 10:06:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:29 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 0x1092b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10922d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefa858b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090cbd30>, '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 0x108f31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090c3b20>, '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.yCaRkD21fT/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.2dzMZR0hD2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:06:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCaRkD21fT/Render', 10:06:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:29 INFO - 'HOME': '/Users/cltbld', 10:06:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:29 INFO - 'LOGNAME': 'cltbld', 10:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:29 INFO - 'MOZ_NO_REMOTE': '1', 10:06:29 INFO - 'NO_EM_RESTART': '1', 10:06:29 INFO - 'PAGER': '/bin/cat', 10:06:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:29 INFO - 'PWD': '/builds/slave/test', 10:06:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:29 INFO - 'SHELL': '/bin/bash', 10:06:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dzMZR0hD2/Listeners', 10:06:29 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:06:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:29 INFO - 'USER': 'cltbld', 10:06:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:29 INFO - 'XPC_FLAGS': '0x0', 10:06:29 INFO - 'XPC_SERVICE_NAME': '0', 10:06:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:29 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-MoI5Ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:29 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-5MOnqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:29 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-P131f3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:29 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-qw_NW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:29 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)) 10:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:29 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-SqFnMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:29 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-7lPo9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:29 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-2BKCy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Lf_dpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-eAwUaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-txXVBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-9N_reO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-6KMBiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:30 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)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-1yLY_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-455PH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-lOkpUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-eftqx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Uv1OPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:06:31 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)) 10:06:31 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)) 10:06:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:33 INFO - Downloading blessings-1.6.tar.gz 10:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:06:33 INFO - Installing collected packages: blessings 10:06:33 INFO - Running setup.py install for blessings 10:06:34 INFO - Successfully installed blessings 10:06:34 INFO - Cleaning up... 10:06:34 INFO - Return code: 0 10:06:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:06:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:34 INFO - Reading from file tmpfile_stdout 10:06:34 INFO - Current package versions: 10:06:34 INFO - blessings == 1.6 10:06:34 INFO - blobuploader == 1.2.4 10:06:34 INFO - docopt == 0.6.1 10:06:34 INFO - functools32 == 3.2.3-2 10:06:34 INFO - jsonschema == 2.5.1 10:06:34 INFO - manifestparser == 1.1 10:06:34 INFO - mozInstall == 1.12 10:06:34 INFO - mozcrash == 1.0 10:06:34 INFO - mozdebug == 0.1 10:06:34 INFO - mozdevice == 0.48 10:06:34 INFO - mozfile == 1.2 10:06:34 INFO - mozhttpd == 0.7 10:06:34 INFO - mozinfo == 0.9 10:06:34 INFO - mozleak == 0.1 10:06:34 INFO - mozlog == 3.4 10:06:34 INFO - moznetwork == 0.27 10:06:34 INFO - mozprocess == 0.23 10:06:34 INFO - mozprofile == 0.28 10:06:34 INFO - mozrunner == 6.13 10:06:34 INFO - mozscreenshot == 0.1 10:06:34 INFO - mozsystemmonitor == 0.3 10:06:34 INFO - moztest == 0.8 10:06:34 INFO - mozversion == 1.4 10:06:34 INFO - psutil == 3.1.1 10:06:34 INFO - requests == 1.2.3 10:06:34 INFO - wsgiref == 0.1.2 10:06:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:34 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 0x1092b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10922d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefa858b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090cbd30>, '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 0x108f31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090c3b20>, '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.yCaRkD21fT/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.2dzMZR0hD2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:06:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCaRkD21fT/Render', 10:06:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:34 INFO - 'HOME': '/Users/cltbld', 10:06:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:34 INFO - 'LOGNAME': 'cltbld', 10:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:34 INFO - 'MOZ_NO_REMOTE': '1', 10:06:34 INFO - 'NO_EM_RESTART': '1', 10:06:34 INFO - 'PAGER': '/bin/cat', 10:06:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:34 INFO - 'PWD': '/builds/slave/test', 10:06:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:34 INFO - 'SHELL': '/bin/bash', 10:06:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dzMZR0hD2/Listeners', 10:06:34 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:06:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:34 INFO - 'USER': 'cltbld', 10:06:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:34 INFO - 'XPC_FLAGS': '0x0', 10:06:34 INFO - 'XPC_SERVICE_NAME': '0', 10:06:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:06:34 INFO - Cleaning up... 10:06:34 INFO - Return code: 0 10:06:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:34 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 0x1092b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10922d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefa858b990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090cbd30>, '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 0x108f31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090c3b20>, '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.yCaRkD21fT/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.2dzMZR0hD2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:06:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCaRkD21fT/Render', 10:06:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:34 INFO - 'HOME': '/Users/cltbld', 10:06:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:34 INFO - 'LOGNAME': 'cltbld', 10:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:34 INFO - 'MOZ_NO_REMOTE': '1', 10:06:34 INFO - 'NO_EM_RESTART': '1', 10:06:34 INFO - 'PAGER': '/bin/cat', 10:06:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:34 INFO - 'PWD': '/builds/slave/test', 10:06:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:34 INFO - 'SHELL': '/bin/bash', 10:06:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dzMZR0hD2/Listeners', 10:06:34 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:06:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:34 INFO - 'USER': 'cltbld', 10:06:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:34 INFO - 'XPC_FLAGS': '0x0', 10:06:34 INFO - 'XPC_SERVICE_NAME': '0', 10:06:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:06:34 INFO - Cleaning up... 10:06:34 INFO - Return code: 0 10:06:34 INFO - Running post-action listener: _resource_record_post_action 10:06:34 INFO - Running post-action listener: _start_resource_monitoring 10:06:34 INFO - Starting resource monitoring. 10:06:34 INFO - [mozharness: 2017-02-16 18:06:34.963937Z] Finished create-virtualenv step (success) 10:06:34 INFO - [mozharness: 2017-02-16 18:06:34.964917Z] Running install step. 10:06:34 INFO - Running pre-action listener: _resource_record_pre_action 10:06:34 INFO - Running main action method: install 10:06:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:35 INFO - Reading from file tmpfile_stdout 10:06:35 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:06:35 INFO - Reading from file tmpfile_stdout 10:06:35 INFO - Output received: 10:06:35 INFO - Usage: mozinstall [options] installer 10:06:35 INFO - Options: 10:06:35 INFO - -h, --help show this help message and exit 10:06:35 INFO - -d DEST, --destination=DEST 10:06:35 INFO - Directory to install application into. [default: 10:06:35 INFO - "/builds/slave/test"] 10:06:35 INFO - --app=APP Application being installed. [default: firefox] 10:06:35 INFO - mkdir: /builds/slave/test/build/application 10:06:35 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'] 10:06:35 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 10:06:56 INFO - Reading from file tmpfile_stdout 10:06:56 INFO - Output received: 10:06:56 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:06:56 INFO - Running post-action listener: _resource_record_post_action 10:06:56 INFO - [mozharness: 2017-02-16 18:06:56.767101Z] Finished install step (success) 10:06:56 INFO - [mozharness: 2017-02-16 18:06:56.767206Z] Running run-tests step. 10:06:56 INFO - Running pre-action listener: _resource_record_pre_action 10:06:56 INFO - Running main action method: run_tests 10:06:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:06:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:06:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:06:56 INFO - 2017-02-16 10:06:56.779 screenresolution[1628:7313] starting screenresolution argv=screenresolution get 10:06:56 INFO - 2017-02-16 10:06:56.782 screenresolution[1628:7313] Display 0: 1600x1200x32@60 10:06:56 INFO - 2017-02-16 10:06:56.787 screenresolution[1629:7315] starting screenresolution argv=screenresolution list 10:06:56 INFO - Available Modes on Display 0 10:06:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:06:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:06:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:06:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:06:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:06:57 INFO - Intel Iris: 10:06:57 INFO - Chipset Model: Intel Iris 10:06:57 INFO - Type: GPU 10:06:57 INFO - Bus: Built-In 10:06:57 INFO - VRAM (Dynamic, Max): 1536 MB 10:06:57 INFO - Vendor: Intel (0x8086) 10:06:57 INFO - Device ID: 0x0a2e 10:06:57 INFO - Revision ID: 0x0009 10:06:57 INFO - Displays: 10:06:57 INFO - Display: 10:06:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:06:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:06:57 INFO - Display Serial Number: 1600x1200 60 10:06:57 INFO - Main Display: Yes 10:06:57 INFO - Mirror: Off 10:06:57 INFO - Online: Yes 10:06:57 INFO - Rotation: Supported 10:06:57 INFO - Return code: 0 10:06:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:57 INFO - Python 2.7.3 10:06:57 INFO - Return code: 0 10:06:57 INFO - grabbing minidump binary from tooltool 10:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:57 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 0x1090cbd30>, '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 0x108f31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090c3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:06:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:06:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:06:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:57 INFO - Return code: 0 10:06:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:06:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:06:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:57 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/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:06:57 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/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0264 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:06:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCaRkD21fT/Render', 10:06:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:57 INFO - 'HOME': '/Users/cltbld', 10:06:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:57 INFO - 'LOGNAME': 'cltbld', 10:06:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:57 INFO - 'MOZ_NO_REMOTE': '1', 10:06:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:57 INFO - 'NO_EM_RESTART': '1', 10:06:57 INFO - 'PAGER': '/bin/cat', 10:06:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:57 INFO - 'PWD': '/builds/slave/test', 10:06:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:57 INFO - 'SHELL': '/bin/bash', 10:06:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2dzMZR0hD2/Listeners', 10:06:57 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:06:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:57 INFO - 'USER': 'cltbld', 10:06:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:57 INFO - 'XPC_FLAGS': '0x0', 10:06:57 INFO - 'XPC_SERVICE_NAME': '0', 10:06:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:57 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/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:06:57 INFO - mozversion application_buildid: 20170216073619 10:06:57 INFO - mozversion application_changeset: d0d5f1187d755b0d1fc65baaecd0ca2e5d16d842 10:06:57 INFO - mozversion application_display_name: Firefox 10:06:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:57 INFO - mozversion application_name: Firefox 10:06:57 INFO - mozversion application_remotingname: firefox 10:06:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:06:57 INFO - mozversion application_vendor: Mozilla 10:06:57 INFO - mozversion application_version: 52.0 10:06:57 INFO - mozversion platform_buildid: 20170216073619 10:06:57 INFO - mozversion platform_changeset: d0d5f1187d755b0d1fc65baaecd0ca2e5d16d842 10:06:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:06:57 INFO - mozversion platform_version: 52.0 10:06:57 INFO - using testdate: 1487268417 10:06:57 INFO - actual date: 1487268417 10:06:57 INFO - starting webserver on 'localhost:49250' 10:06:57 INFO - SUITE-START | Running 2 tests 10:06:57 INFO - TEST-START | dromaeo_css 10:06:57 INFO - operating with platform_type : mac_ 10:06:57 INFO - Initialising browser for dromaeo_css test... 10:06:57 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpVaGRtA/profile http://localhost:49250/getInfo.html) 10:07:00 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 10:07:00 INFO - PROCESS | 1639 | colorDepth:24 10:07:00 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 10:07:00 INFO - PROCESS | 1639 | __metrics 10:07:00 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:07:00 INFO - PROCESS | 1639 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:07:01 INFO - TEST-INFO | 1639: exit 0 10:07:01 INFO - Browser initialized. 10:07:01 INFO - Running cycle 1/1 for dromaeo_css test... 10:07:01 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpVaGRtA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:13 INFO - PROCESS | 1643 | RSS: Main: 172044288 10:07:13 INFO - PROCESS | 1643 | 10:10:15 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 10:10:17 INFO - PROCESS | 1643 | RSS: Main: 316461056 10:10:17 INFO - PROCESS | 1643 | 10:13:20 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 10:13:21 INFO - PROCESS | 1643 | RSS: Main: 306339840 10:13:21 INFO - PROCESS | 1643 | 10:16:23 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 10:16:24 INFO - PROCESS | 1643 | RSS: Main: 298156032 10:16:24 INFO - PROCESS | 1643 | 10:19:26 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 10:19:26 INFO - PROCESS | 1643 | RSS: Main: 279101440 10:19:26 INFO - PROCESS | 1643 | 10:22:30 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 10:22:30 INFO - PROCESS | 1643 | RSS: Main: 255471616 10:22:30 INFO - PROCESS | 1643 | 10:25:33 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 10:25:34 INFO - PROCESS | 1643 | RSS: Main: 361668608 10:25:34 INFO - PROCESS | 1643 | 10:25:34 INFO - PROCESS | 1643 | __start_tp_report 10:25:34 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 10:25:34 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 10:25:34 INFO - PROCESS | 1643 | |i|pagename|runs| 10:25:34 INFO - PROCESS | 1643 | |0;dojo.html;2488.2908371114236;3490.703290220331;3496.6153723090456;3503;3553.4669799530066;5716.22830917826;5762.423757624236;5791.449812267828;5812.651240925542;5824.737886795099;5753.367129615739;5800.53595712343;5860.326062502802;5861.501772349356;5881.176635271055;5221.973890130544;5266.7629956652045;5294;5294.788208471657;5335.866603334928;5191.325127733408;5211.739413029333;5222.399424066243;5296.788128474856;5363.704996225206;5229.294045303874;5235.345581802275;5242.973785131069;5300.681959082467;5300.840974770744;5269.947300526984;5275.815346462894;5297.258383826267;5298.019866324704;5317.12267475866;4149.33610622299;5182.585393168538;5250.317458730341;5255.237990491396;5255.710935898524;5678.290213723285;5696.316442026983;5723.914141287884;5727.083666613322;5861.85345366365;5135.666181698215;6174;6180.783672571439;6197.535184861108;6206.596571222901;6230.5638605297645;6263.24841019076;6269.2476902771505;6282.497400208018;6285.560010799246;5776.306843178845;5847.766089356378;5996.430339117776;6002.729877155539;6005.1892994445625;6236.781712640036;6309.432151106331;6313;6372.872542549123;6419.2296924369375;6218.160548326008;6222.377762223832;6227.750889964351;6233.750649974041;6237.96881015592;6088.817335479943;6103.8902988373275;6226.533010024175;6229.4393504584805;6232.781852635227;5470.425605311465;6117.736059405486;6150.384961503813;6182.227221597301;6199.597026193283;6183.96908015466;6185.876282474325;6193.659348735863;6199.504039676815;6216.471599914058;4983.700977941263;5071.492850714899;5077.26379674945;5087.186050231945;5092.745362731848;4440.822367105344;4444.2444784386735;4444.577765112309;4500.617447516932;4504.61710754583;6024.378692324932;6058.485028772604;6078.422549857756;6093.29927058394;6123.510119190454;5210.869728256824;6219.0982307566055;6256.468200202943;6288.088227207029;6295.087212354183;5809.6223745457255;5828.88342233153;5895.14520394549;6000.219971403777;6003.8198854034445;5496.203050557647;5526.364468086141;5531.723413829292;5554.055810512223;5567.220589117527;6417.35734778453;6434.485241180788;6438.839029024218;6456.063870738811;6477.028445733084;5864.871603091498;6099.542534310033;6195.876082478415;6254.405831446005;6341.460975817107;6116.548817443993;6300.621962682254;6332.873342533216;6340.7463701451425;6487.578307410192;5175.896482070413;6285.779997700059;6290.968545157428;6292.433680968735;6301.306856245901;6240.095186197885;6258.155149054819;6296.118543404019;6309.3690630936535;6310.905336419865;6027.065804800263;6099.908501372394;6112.480439162721;6116.969415152896;6243.344448832807;6188.752449901954;6211.130441738251;6243.344448832989;6252.187215661935;6256.374362563707;6096.786612468542;6130.6628135452975;6140.846478838065;6149.292831324455;6157.907631385443;6043.335233124265;6101.359357267423;6131.96934015327;6136.386361363828;6224.346443623354;6035.426634469718;6144.109104179958;6150.200473938359;6159.630422174684;6165.260168779775 10:25:34 INFO - PROCESS | 1643 | |1;ext.html;487.17910321108934;488.6017895415237;489.06832484117746;516.7390467813755;527.3302905310259;25178.49643007141;32783;40125.197496050096;40973.77078687637;41000;42286.36570451446;42599.935001624974;42641.57358426415;42659.78670106653;42752;9468.43189408636;9637.084476974676;9639.469829159394;9665.033496650314;9674.177694895941;9005.954970225139;9201.125893040184;9406.811863762721;9526.142647161754;11538.538458461651;11440.370779607118;11753.471093800757;11763.7059073523;11769.705757356049;11793.882061179407;10405.635802746867;11369.545218191262;11733.882661173364;11808.586699465563;11814.46834892432;11750.941245293805;11761.294322340687;11841.703957401047;11846.585369512026;11852.940735296355;40430;40712.796436017634;40722.79638601818;40734.59265407338;40750.77747667575;3208.8235147066903;3278.5737854079057;3399.473081672345;3418.9658103418897;4016.8393264269394;29647;29869.70130298691;29917;30514;31692.207694807585;3182.2839861031316;3247.9188020299443;3345.7156141727983;3413.7951722896705;3430.879919202816;487738;490928;493163;493631;495475;59943.70028149831;60091;60115;60131;60141.69929150326;62468.68765656234;62659.6867015662;62679;62688.37311626917;62752.37247627557;15495.457658982106;15662.295196716175;15705.371785128467;15712.135832529091;15735.763963540556;12152.635420937386;12197.08521860864;12200.511979520898;12208.206466579644;12209;14098.647533811532;14488.855111448962;14493.565193044225;15342.616434589001;16189.109598972169;5385.084535628953;5518.365387980353;5949.137375080589;6051.697415129314;6332.525060620472;834.9540775257419;848.7156802471242;994.8259054665405;995.4574756757585;1059.782744537368;28644.14067577976;29137.980170693925;29758.1072567819;30164.24589385283;30170.24574385614;1019.5259204469957;1085.8154113800672;1093.5407129005837;1093.814051611228;1102.8345748137845;14595.78106328406;15213.895781637717;15370.308336124901;15553.611159720871;15746.606334841721;549319;551574;553704;553722;554819;50996.74501627468;51497.22754158616;57473.56316092131;57690.711546442;58318;1358.280111540885;1367.3095086981011;1397.8881689464818;1401.5725203812935;1411.456589213181;28630.856845716473;30099.09702708922;30287.699652561154;30529.847350763102;31629.051128466184;56936.71531642315;57652;57661.13508297295;57665.13502297385;57721;677061.6146919234;678285;692117;713468;715529;25551.6167257495;25852.741472585785;25867.482650346512;26119.73880261173;26178.952841886112;45621.54378456173;45741.771291144665;45834.77082614566;45961;46095;31325.843370783;32615.836920815244;37024.81487592545;37237.069073273386;37591;36828.44757328696;37407.43888841724;37639.059023524635;38276.6172338273;38316.61683383131;36669.816650916575;37082;37640.81179594085;37682.8115859419;37879.2424151521;29508.852455737582;31480;33810.32379352448;33963.830180848934;34009.65990340065;21489.892550537148;22534.436639084153;24786.636734979027;25055.248342549752;25356.746432535438 10:25:34 INFO - PROCESS | 1643 | |2;jquery.html;384.7172328338669;388.39992212032405;390.7792097464931;391.44805823788465;416.895776055986;17123.82876171238;19754.70367944482;19969.800301996976;20869.269575564856;21260.14959401624;20110.59778804423;20564;21062.789372106276;21340.786592134074;21373.358799236008;5489.34127904652;5887.205227294303;5928.762849486037;5935.9703201483935;5943;5612.943870561283;5774.797882074128;5879.353271140192;5884.029135192688;5884.499817515516;5664.575156863231;5745.683987380713;5812.418758124196;5828.446297601721;5835;5620.381758006616;5815.098659707731;5816.621919575236;5818.854528636775;5833.154192642043;5165.845024649267;5198.428172900978;5202.3497062867145;5210.635255532115;5219.42586315505;25146.49707005868;25253;25419.745802541922;25496.49007019849;25674.871625641754;2135.903884325209;2356.363781778927;2471.987640061788;2830.6461692288462;2911.126662001412;15134.545963621109;15141.015833970867;15441.150736709476;16100.355985760556;16160.111193884331;1833.3766519383341;1863.6459072776129;1914.6457905287566;1966.193860517181;1971.0341932452995;111035;115707;115901.420492897;116483;116954;10054.949725251474;10243.539040743184;10372.636957706594;11269.887301127048;11484.081273498266;14223.146611203361;14235.430582776573;14238.501652442115;14256.786148207786;14272.35774390155;8057.194280572013;8274.875876861852;8286.668533258602;8397.076321604618;8416.452930559493;6668.533202675863;8071.313938315191;8076.4750291230885;8108.675652973933;8291.212334828182;6639.170103737033;6680.665966701646;6781.559198652072;6815.625140617214;6824.781945867613;1603.9438619648256;1874.22219778793;1877.5212320858093;1877.6620208362626;1878.079740926936;794.1621589223424;804.6982381606897;841.3521588376916;934.72425634438;957.1863915671623;18386.172622232032;21490.892545537485;22736.431589210402;22841.771582283964;23574.29277121689;959.9712008639752;961.245422343457;984.2745209382454;1011.8330475471465;1018.4042335233971;7944.761657150295;11330.036946859444;11451.656450306504;11458.369789661649;11471.394004839329;583472;588801;594888;595521;600904.9954750285;80625;135830.64169358378;144095;144685;148371;865.4158443050916;941.9293552983554;982.4449186209625;1006.4213077480478;1007.1640538353149;19099;19739.506512337306;19963.90198539094;20020.499487512345;20039.899800500905;54129.94025448186;56571.434285658266;56902.715486422305;57594;57621.711891440274;78154.43691126259;82649;85035;85737.57131214305;86757.56621216853;6486.967565162144;8059.395545334006;8234.794130146794;8495.065542790164;8534.359923005924;10191.643292484727;12983.415746291628;13010.284434356201;13193;13427.395767190696;9292.95353523228;11111.055560277468;11216.887831121585;11226.66320010401;11505.367204803817;11040.668779936615;11228.93325134111;11270.100440354392;11397.658070257905;11618.419079045845;11311.660650180507;11460.82808757886;11466.426678666201;11701.122415819018;11925.463354149259;8055.113937466756;8100.35197184212;8213.917860821315;8476.872846907425;8544.74365769028;8326.542040187605;10870.239083264096;11262.04272636835;11334.94332528332;11667.066634669376 10:25:34 INFO - PROCESS | 1643 | |3;mootools.html;1374.8212732344793;1505.3978408636544;1541.2447900528741;1699.898006119632;1717.8368055034766;7516.736914208004;7901.84196316074;8099.959500202491;8374.204450577201;8374.37192210585;8295;8341.33269338453;8348.206920342558;8349.54077525736;8358.91641083589;2343.8007769339583;2368.4789346343778;2372.015613520387;2372.9881350593223;2376.714794224687;2348.3659411958847;2392.736798952114;2397.892094855727;2400.663907053014;2402.0511897800448;2004.2984955265686;2321.7910388065156;2348.4011577047827;2361.480474295652;2367.562001029815;2322.883855807203;2331.9300420987397;2355.340504658698;2358.7641235876445;2359.2096647623066;2348.116121062384;2350.6239001759636;2378.6432035194684;2380.702412198475;2382.6664267002634;8361.665533378658;8426.789330266793;8436.198561136682;8436.746897593082;8450.535220562866;5050.39395272566;5236.345456817898;5238.738063096868;5266.368035835686;5269.947300526984;3040.2551374913287;3460.2041530448137;3516.7714098583765;3593.784372937606;3616.3490571697084;1070.7804899995483;1080.4111759091313;1083.3175099687146;1100.5762781329165;1118.5190368141696;10807.513661885234;10854.96877796608;10904.50929708165;10913.508892099795;10932.672019839418;4301.268784306675;4319.568043195655;4459.888502787457;4465.441819772528;4471.28459446487;8690.174433428814;8695.869561956575;8709.042005379402;8714.215720585178;8720.12798720123;4632.258838585877;4859.59071869154;5132.56373208274;5132.743362831919;5143.099957507496;4364.432623758955;4504.459464864237;4675;4750.429948406213;4788.4253889533475;3002.519596864491;3280.2783387654677;3609.5848977367414;3750.474933509311;3779.962200378016;1149.1725957310723;1154.6189757380043;1157.8957893789432;1164.2432418927594;1167.4571324334056;759.2710997442517;853.3301358433724;892.3708785306344;934.2199263614822;958.8274110660009;5622.24099746529;5692.9146062809095;5696.601237913389;5757.309122905278;5959.5828292020005;746.6001247660637;907.3739120007306;913.182701482183;921.1433366968784;949.5584553182803;3748.456473811282;3951.6245956634075;4030.5163380394542;4052.0882801369457;4065.6747460203114;9898.653547125816;10250.333728307636;10253.84619230712;10272.229582781321;10288.948555257326;10096.545655445523;10209.795804083877;10217.693469195936;10227.539760710786;10248.38509689406;7528.096628404626;7845;7923.3661307096445;8036.156203598655;8050.677972881136;5323.281357016753;5689.857753556029;5743.511801496919;5921.319048309328;5961.823934264049;8217.83564328722;9165.679201227926;9285.767855803659;9397;9476.715698529055;9427.3400861939;9505.334626576074;9554.808903821746;9609.519524023632;9653.1794797443;6681.33186681328;6875.724971001104;7088.255733147946;7243;7261.056062712025;6613.470922326299;7378.372838308589;7642.5032372895585;7918.168592297726;8083.232092951161;7144.892826607709;7252.963735181291;7259.963700181465;7274.636268186464;7400.592967386845;6924.861502769816;7039.225685174729;7102.254263302279;7161.677724502514;7203.315685009916;5826.805504871576;6521.608703477807;6772.762953296611;6784.253732089565;6785.762498312535;4824.252240902666;4858.6356023297685;4884.316195732671;4940.629452790983;4957.702537847741;4858.125537403302;4864.318995340726;4922.8769280768265;5024.472430394756;5031.622628302819 10:25:34 INFO - PROCESS | 1643 | |4;prototype.html;281.92528979820366;301.33705847136304;311.14280158164263;319.61965261339014;324.11031717934276;4113.670906327494;5178.171492561191;5222.556082732972;5246.921296180555;5259.710715910624;4909.656324057309;5036.722980236085;5051.625735904128;5134;5168.586513078954;3185.4743967245377;3576.2489877125836;3673.9402959729514;4022.8189731462153;4029.2545879012478;3323.21904352477;3975.688022952433;4002.6197511236387;4019.236345094437;4020.979895100535;3867.8259478323403;3905.047476261869;3942.6648734857426;3980.9004774880714;3996.9400458993136;3279.8524066417067;3977.4033894915992;3992.7604343739176;4009.238244733506;4009.5389030261604;2600.4409052053898;3248.30161515273;3276.8033917965;3362.4620060790403;3517.9296414071573;4164.6251837334785;5090.778213228798;5118.232265160219;5127.717975511346;5157.447063703453;4489.239117942442;4510.368548403226;4549.27211646135;4601.654875884288;4663.743494107823;4738.881527961828;4781.856544303677;4909.631777616657;4926.236433352836;5093.388793344785;3704;3788.916096147108;3900.8882468496627;3906.109478985559;3910.667593254577;5454.809081682161;5745.396733342981;5745.425457454263;5759.769609215668;5766.452187042224;3074.938501229963;3672.6878215351994;3838.3091043611857;3847.499825022729;3851.287511810324;3875.4768106305287;3915.960840391617;3922.882313530599;3925.076712410898;3929.7249192556246;3768.907016965104;3973.92052158961;4298.41971333866;4567.858035491127;4585.747783871852;4620.768961551909;5478.45215478457;5483.272769077727;5535.501804837584;5541.639793413416;1122.629532254354;1192.66605350502;1248.076423446643;1252.2968762483015;1264.6332563556466;736.2894806511742;780.9535222801474;810.9959450202712;839.8782176584361;845.1506236232547;3834.654881060718;4534.59188673021;5281.55106815925;5309.230161626542;5350.438203988603;4761.976190119027;4978.859090591008;5695.145728140812;5772.451617096369;5813.069908814654;4039.777812220297;4194.49666040071;5073.11220536412;5343.332083489564;5378.327709036371;2490.5392502387117;2577.561814491541;2659.986700066487;2840.9857950710116;2848.829070255791;4750.952490475051;4771.498992605796;4807.375041244616;5586.944130558723;5654.575906806924;4786.659735274129;5582.91625625616;5804.622699524517;5852.552060434101;5885.676287804212;5180.533751962342;5899.174115623816;5936.732847021981;5951.434613711691;5965.284165900033;4817.27740838877;4933.703977761345;5309.327561818015;5516.3380394352935;5765.798197063083;5491.078122657038;5550.69471179089;5592.748326325406;5611.3266408031295;5629.183768353484;4588.701734387254;5224.817131400383;5919.260092488439;5924.140999554954;5929.258842644669;3767.9638099521753;3935.6064393560414;3952.9209415810947;3997.040710229582;4016.4577781999055;4638.721676699409;4751.643626728079;5615.241942337732;5621.213030175697;5634.549236061023;4613.976930115328;5421.403645598902;5503.807366742145;5534.91697624544;5557.388687244481;4740.691855029412;5221.120396657125;5291.285676433632;5409.215663728816;5519.3652729936575;5219.608529360237;5413.052715774802;5413.669064748107;5435;5444.972775136099;4328.61042506176;5121.874422114781;5353.2505449237915;5375.435579264121;5499.50504454601;4961.528654777935;5416.485433883775;5426.348838139448;5431.56547476193;5454.227376102862 10:25:34 INFO - PROCESS | 1643 | |5;yui.html;715.9642017899104;717.300631883913;720.5712601002402;775.6742168289318;799.8880156778049;14545.345459454324;15486.845131548682;15493.22533873306;15501.302441390137;15501.689966200669;13827.79258311126;14037.087589306688;14041.087329323613;14054.718905621881;14055.508057218;682.0689758479689;702.2766550453042;706.6466766616692;846.1622993236698;861.4142383179435;697.8046147078826;700.1912790726719;701.9859602807941;829.701307529289;859.299670768325;828.5360198288947;861.6085022688344;895.4895709445618;903.7785742493065;909.3498148823589;909.5861383070687;909.963601455941;910.235402262103;912.6714382822179;914.2137761525083;677.7153595489906;678.7285085965603;679.6194131286495;680.2823021712092;680.323078536859;13873.167609943435;14094.01341906067;14117.941154413358;14123.293835308194;14946.103233806007;12760.872391276154;13877.37551810171;14096.365663545164;14203.005789594732;14244.92877535616;12097.697557561132;12561.623151305475;12723.427445764963;12911.612651620373;13595.52415665447;4454.463210192478;4464.6874718769695;4612.884677883047;4742.9525704742855;4797.592204662573;86946;88264;89469.55265223698;89498;90727;9922.603095876228;10349;10356.585736570452;10414.687559373231;10467.685969420929;19547.49866485654;19584.902075489532;19682.803171968382;19825.900870495843;19844.20623175057;7621.428392870557;7709.7301594443925;7751.418643601753;7853.371730261565;7853.8821917671285;4279.572042795696;4285.142971405669;4354.455693038371;4363.36731173978;4436.401085853433;2821.3087793490317;3240.4005259027153;3322.1362445763793;3346.0798280473064;3355.0270421577957;557.9888402231933;612.0665984373866;681.3391010719594;698.1377998172354;703.8873780195145;557.6152454806171;564.6555601083336;638.5913015669975;664.0968283134932;685.6434653980002;7991.081025682005;8616.569171541523;8769.736907892773;9058.909410905806;9226.477631190779;599.7391134856351;643.8486955565438;659.7921654678761;670.0953712488102;700.3731660164226;4344.587264209895;4393.1872603568445;4750.881227969328;4835.8065677373215;4878.390201224847;107962;114880;116449;116644.41677791727;118813;80111;80427;98199.90431385068;102942.97057029484;103022;66246.66876665586;72594.45919392901;79000.60499697695;86957.13042869617;88434.55782721174;9674;9884.25868059884;9911.058449447291;9927.255455840696;9946.204303655835;53636.73181634067;54470.00414977214;55671;56808.43191568032;57033;53635.73182134065;55272;55397;56042.59893502532;68517.65741171263;12576;12662;12731.745365092831;12932.03009774252;13343.799843002169;13640.045196836523;14150.292485375896;14257.447400867024;14302.284885755462;14605.634859128182;10773.259765703066;13189.274589897264;13624.386902589209;13722.931385343009;13858.514951976633;12354;13237.404316805574;13613.65965850822;13913.095648782797;14264.857351426768;13046.739065218831;13088.345582721016;13499.730005400033;13510.72978540404;13932;10927.289726167774;11097.833532497181;11402.828957565478;11662.183647144619;11734.823977640513;10593.09958653523;11290;11345.716357091138;11570.479328430072;11577.710557236136 10:25:34 INFO - PROCESS | 1643 | __end_tp_report 10:25:34 INFO - PROCESS | 1643 | __start_cc_report 10:25:34 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1854 10:25:34 INFO - PROCESS | 1643 | __end_cc_report 10:25:34 INFO - PROCESS | 1643 | __startTimestamp1487269534223__endTimestamp 10:25:34 INFO - PROCESS | 1643 | 10:25:34 INFO - PROCESS | 1643 | ------- Summary: start ------- 10:25:34 INFO - PROCESS | 1643 | Number of tests: 6 10:25:34 INFO - PROCESS | 1643 | 10:25:34 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5787.98 Median:6093.30 stddev:662.03 (10.9%) stddev-sans-first:611.37 10:25:34 INFO - PROCESS | 1643 | Values: 2488.3 3490.7 3496.6 3503.0 3553.5 5716.2 5762.4 5791.4 5812.7 5824.7 5753.4 5800.5 5860.3 5861.5 5881.2 5222.0 5266.8 5294.0 5294.8 5335.9 5191.3 5211.7 5222.4 5296.8 5363.7 5229.3 5235.3 5243.0 5300.7 5300.8 5269.9 5275.8 5297.3 5298.0 5317.1 4149.3 5182.6 5250.3 5255.2 5255.7 5678.3 5696.3 5723.9 5727.1 5861.9 5135.7 6174.0 6180.8 6197.5 6206.6 6230.6 6263.2 6269.2 6282.5 6285.6 5776.3 5847.8 5996.4 6002.7 6005.2 6236.8 6309.4 6313.0 6372.9 6419.2 6218.2 6222.4 6227.8 6233.8 6238.0 6088.8 6103.9 6226.5 6229.4 6232.8 5470.4 6117.7 6150.4 6182.2 6199.6 6184.0 6185.9 6193.7 6199.5 6216.5 4983.7 5071.5 5077.3 5087.2 5092.7 4440.8 4444.2 4444.6 4500.6 4504.6 6024.4 6058.5 6078.4 6093.3 6123.5 5210.9 6219.1 6256.5 6288.1 6295.1 5809.6 5828.9 5895.1 6000.2 6003.8 5496.2 5526.4 5531.7 5554.1 5567.2 6417.4 6434.5 6438.8 6456.1 6477.0 5864.9 6099.5 6195.9 6254.4 6341.5 6116.5 6300.6 6332.9 6340.7 6487.6 5175.9 6285.8 6291.0 6292.4 6301.3 6240.1 6258.2 6296.1 6309.4 6310.9 6027.1 6099.9 6112.5 6117.0 6243.3 6188.8 6211.1 6243.3 6252.2 6256.4 6096.8 6130.7 6140.8 6149.3 6157.9 6043.3 6101.4 6132.0 6136.4 6224.3 6035.4 6144.1 6150.2 6159.6 6165.3 10:25:34 INFO - PROCESS | 1643 | 10:25:34 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:70897.18 Median:36749.13 stddev:156944.06 (427.1%) stddev-sans-first:157295.29 10:25:34 INFO - PROCESS | 1643 | Values: 487.2 488.6 489.1 516.7 527.3 25178.5 32783.0 40125.2 40973.8 41000.0 42286.4 42599.9 42641.6 42659.8 42752.0 9468.4 9637.1 9639.5 9665.0 9674.2 9006.0 9201.1 9406.8 9526.1 11538.5 11440.4 11753.5 11763.7 11769.7 11793.9 10405.6 11369.5 11733.9 11808.6 11814.5 11750.9 11761.3 11841.7 11846.6 11852.9 40430.0 40712.8 40722.8 40734.6 40750.8 3208.8 3278.6 3399.5 3419.0 4016.8 29647.0 29869.7 29917.0 30514.0 31692.2 3182.3 3247.9 3345.7 3413.8 3430.9 487738.0 490928.0 493163.0 493631.0 495475.0 59943.7 60091.0 60115.0 60131.0 60141.7 62468.7 62659.7 62679.0 62688.4 62752.4 15495.5 15662.3 15705.4 15712.1 15735.8 12152.6 12197.1 12200.5 12208.2 12209.0 14098.6 14488.9 14493.6 15342.6 16189.1 5385.1 5518.4 5949.1 6051.7 6332.5 835.0 848.7 994.8 995.5 1059.8 28644.1 29138.0 29758.1 30164.2 30170.2 1019.5 1085.8 1093.5 1093.8 1102.8 14595.8 15213.9 15370.3 15553.6 15746.6 549319.0 551574.0 553704.0 553722.0 554819.0 50996.7 51497.2 57473.6 57690.7 58318.0 1358.3 1367.3 1397.9 1401.6 1411.5 28630.9 30099.1 30287.7 30529.8 31629.1 56936.7 57652.0 57661.1 57665.1 57721.0 677061.6 678285.0 692117.0 713468.0 715529.0 25551.6 25852.7 25867.5 26119.7 26179.0 45621.5 45741.8 45834.8 45961.0 46095.0 31325.8 32615.8 37024.8 37237.1 37591.0 36828.4 37407.4 37639.1 38276.6 38316.6 36669.8 37082.0 37640.8 37682.8 37879.2 29508.9 31480.0 33810.3 33963.8 34009.7 21489.9 22534.4 24786.6 25055.2 25356.7 10:25:34 INFO - PROCESS | 1643 | 10:25:34 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:35328.19 Median:25458.12 stddev:99131.33 (389.4%) stddev-sans-first:99374.70 10:25:34 INFO - PROCESS | 1643 | Values: 384.7 388.4 390.8 391.4 416.9 17123.8 19754.7 19969.8 20869.3 21260.1 20110.6 20564.0 21062.8 21340.8 21373.4 5489.3 5887.2 5928.8 5936.0 5943.0 5612.9 5774.8 5879.4 5884.0 5884.5 5664.6 5745.7 5812.4 5828.4 5835.0 5620.4 5815.1 5816.6 5818.9 5833.2 5165.8 5198.4 5202.3 5210.6 5219.4 25146.5 25253.0 25419.7 25496.5 25674.9 2135.9 2356.4 2472.0 2830.6 2911.1 15134.5 15141.0 15441.2 16100.4 16160.1 1833.4 1863.6 1914.6 1966.2 1971.0 111035.0 115707.0 115901.4 116483.0 116954.0 10054.9 10243.5 10372.6 11269.9 11484.1 14223.1 14235.4 14238.5 14256.8 14272.4 8057.2 8274.9 8286.7 8397.1 8416.5 6668.5 8071.3 8076.5 8108.7 8291.2 6639.2 6680.7 6781.6 6815.6 6824.8 1603.9 1874.2 1877.5 1877.7 1878.1 794.2 804.7 841.4 934.7 957.2 18386.2 21490.9 22736.4 22841.8 23574.3 960.0 961.2 984.3 1011.8 1018.4 7944.8 11330.0 11451.7 11458.4 11471.4 583472.0 588801.0 594888.0 595521.0 600905.0 80625.0 135830.6 144095.0 144685.0 148371.0 865.4 941.9 982.4 1006.4 1007.2 19099.0 19739.5 19963.9 20020.5 20039.9 54129.9 56571.4 56902.7 57594.0 57621.7 78154.4 82649.0 85035.0 85737.6 86757.6 6487.0 8059.4 8234.8 8495.1 8534.4 10191.6 12983.4 13010.3 13193.0 13427.4 9293.0 11111.1 11216.9 11226.7 11505.4 11040.7 11228.9 11270.1 11397.7 11618.4 11311.7 11460.8 11466.4 11701.1 11925.5 8055.1 8100.4 8213.9 8476.9 8544.7 8326.5 10870.2 11262.0 11334.9 11667.1 10:25:34 INFO - PROCESS | 1643 | 10:25:34 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5431.46 Median:5041.01 stddev:2968.64 (58.9%) stddev-sans-first:2961.31 10:25:34 INFO - PROCESS | 1643 | Values: 1374.8 1505.4 1541.2 1699.9 1717.8 7516.7 7901.8 8100.0 8374.2 8374.4 8295.0 8341.3 8348.2 8349.5 8358.9 2343.8 2368.5 2372.0 2373.0 2376.7 2348.4 2392.7 2397.9 2400.7 2402.1 2004.3 2321.8 2348.4 2361.5 2367.6 2322.9 2331.9 2355.3 2358.8 2359.2 2348.1 2350.6 2378.6 2380.7 2382.7 8361.7 8426.8 8436.2 8436.7 8450.5 5050.4 5236.3 5238.7 5266.4 5269.9 3040.3 3460.2 3516.8 3593.8 3616.3 1070.8 1080.4 1083.3 1100.6 1118.5 10807.5 10855.0 10904.5 10913.5 10932.7 4301.3 4319.6 4459.9 4465.4 4471.3 8690.2 8695.9 8709.0 8714.2 8720.1 4632.3 4859.6 5132.6 5132.7 5143.1 4364.4 4504.5 4675.0 4750.4 4788.4 3002.5 3280.3 3609.6 3750.5 3780.0 1149.2 1154.6 1157.9 1164.2 1167.5 759.3 853.3 892.4 934.2 958.8 5622.2 5692.9 5696.6 5757.3 5959.6 746.6 907.4 913.2 921.1 949.6 3748.5 3951.6 4030.5 4052.1 4065.7 9898.7 10250.3 10253.8 10272.2 10288.9 10096.5 10209.8 10217.7 10227.5 10248.4 7528.1 7845.0 7923.4 8036.2 8050.7 5323.3 5689.9 5743.5 5921.3 5961.8 8217.8 9165.7 9285.8 9397.0 9476.7 9427.3 9505.3 9554.8 9609.5 9653.2 6681.3 6875.7 7088.3 7243.0 7261.1 6613.5 7378.4 7642.5 7918.2 8083.2 7144.9 7253.0 7260.0 7274.6 7400.6 6924.9 7039.2 7102.3 7161.7 7203.3 5826.8 6521.6 6772.8 6784.3 6785.8 4824.3 4858.6 4884.3 4940.6 4957.7 4858.1 4864.3 4922.9 5024.5 5031.6 10:25:34 INFO - PROCESS | 1643 | 10:25:34 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4395.02 Median:4863.45 stddev:1372.89 (28.2%) stddev-sans-first:1341.58 10:25:34 INFO - PROCESS | 1643 | Values: 281.9 301.3 311.1 319.6 324.1 4113.7 5178.2 5222.6 5246.9 5259.7 4909.7 5036.7 5051.6 5134.0 5168.6 3185.5 3576.2 3673.9 4022.8 4029.3 3323.2 3975.7 4002.6 4019.2 4021.0 3867.8 3905.0 3942.7 3980.9 3996.9 3279.9 3977.4 3992.8 4009.2 4009.5 2600.4 3248.3 3276.8 3362.5 3517.9 4164.6 5090.8 5118.2 5127.7 5157.4 4489.2 4510.4 4549.3 4601.7 4663.7 4738.9 4781.9 4909.6 4926.2 5093.4 3704.0 3788.9 3900.9 3906.1 3910.7 5454.8 5745.4 5745.4 5759.8 5766.5 3074.9 3672.7 3838.3 3847.5 3851.3 3875.5 3916.0 3922.9 3925.1 3929.7 3768.9 3973.9 4298.4 4567.9 4585.7 4620.8 5478.5 5483.3 5535.5 5541.6 1122.6 1192.7 1248.1 1252.3 1264.6 736.3 781.0 811.0 839.9 845.2 3834.7 4534.6 5281.6 5309.2 5350.4 4762.0 4978.9 5695.1 5772.5 5813.1 4039.8 4194.5 5073.1 5343.3 5378.3 2490.5 2577.6 2660.0 2841.0 2848.8 4751.0 4771.5 4807.4 5586.9 5654.6 4786.7 5582.9 5804.6 5852.6 5885.7 5180.5 5899.2 5936.7 5951.4 5965.3 4817.3 4933.7 5309.3 5516.3 5765.8 5491.1 5550.7 5592.7 5611.3 5629.2 4588.7 5224.8 5919.3 5924.1 5929.3 3768.0 3935.6 3952.9 3997.0 4016.5 4638.7 4751.6 5615.2 5621.2 5634.5 4614.0 5421.4 5503.8 5534.9 5557.4 4740.7 5221.1 5291.3 5409.2 5519.4 5219.6 5413.1 5413.7 5435.0 5445.0 4328.6 5121.9 5353.3 5375.4 5499.5 4961.5 5416.5 5426.3 5431.6 5454.2 10:25:34 INFO - PROCESS | 1643 | 10:25:34 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20233.64 Median:4677.92 stddev:29338.45 (627.2%) stddev-sans-first:29384.15 10:25:34 INFO - PROCESS | 1643 | Values: 716.0 717.3 720.6 775.7 799.9 14545.3 15486.8 15493.2 15501.3 15501.7 13827.8 14037.1 14041.1 14054.7 14055.5 682.1 702.3 706.6 846.2 861.4 697.8 700.2 702.0 829.7 859.3 828.5 861.6 895.5 903.8 909.3 909.6 910.0 910.2 912.7 914.2 677.7 678.7 679.6 680.3 680.3 13873.2 14094.0 14117.9 14123.3 14946.1 12760.9 13877.4 14096.4 14203.0 14244.9 12097.7 12561.6 12723.4 12911.6 13595.5 4454.5 4464.7 4612.9 4743.0 4797.6 86946.0 88264.0 89469.6 89498.0 90727.0 9922.6 10349.0 10356.6 10414.7 10467.7 19547.5 19584.9 19682.8 19825.9 19844.2 7621.4 7709.7 7751.4 7853.4 7853.9 4279.6 4285.1 4354.5 4363.4 4436.4 2821.3 3240.4 3322.1 3346.1 3355.0 558.0 612.1 681.3 698.1 703.9 557.6 564.7 638.6 664.1 685.6 7991.1 8616.6 8769.7 9058.9 9226.5 599.7 643.8 659.8 670.1 700.4 4344.6 4393.2 4750.9 4835.8 4878.4 107962.0 114880.0 116449.0 116644.4 118813.0 80111.0 80427.0 98199.9 102943.0 103022.0 66246.7 72594.5 79000.6 86957.1 88434.6 9674.0 9884.3 9911.1 9927.3 9946.2 53636.7 54470.0 55671.0 56808.4 57033.0 53635.7 55272.0 55397.0 56042.6 68517.7 12576.0 12662.0 12731.7 12932.0 13343.8 13640.0 14150.3 14257.4 14302.3 14605.6 10773.3 13189.3 13624.4 13722.9 13858.5 12354.0 13237.4 13613.7 13913.1 14264.9 13046.7 13088.3 13499.7 13510.7 13932.0 10927.3 11097.8 11402.8 11662.2 11734.8 10593.1 11290.0 11345.7 11570.5 11577.7 10:25:34 INFO - PROCESS | 1643 | -------- Summary: end -------- 10:25:34 INFO - PROCESS | 1643 | 10:25:34 INFO - TEST-INFO | 1643: exit 0 10:25:34 INFO - TEST-OK | dromaeo_css | took 1117522ms 10:25:34 INFO - TEST-START | kraken 10:25:34 INFO - operating with platform_type : mac_ 10:25:34 INFO - Initialising browser for kraken test... 10:25:34 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpjytZjV/profile http://localhost:49250/getInfo.html) 10:25:37 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 10:25:37 INFO - PROCESS | 1652 | colorDepth:24 10:25:37 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 10:25:37 INFO - PROCESS | 1652 | __metrics 10:25:37 INFO - PROCESS | 1652 | 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:25:37 INFO - PROCESS | 1652 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:25:38 INFO - TEST-INFO | 1652: exit 0 10:25:38 INFO - Browser initialized. 10:25:38 INFO - Running cycle 1/1 for kraken test... 10:25:38 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpjytZjV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:50 INFO - PROCESS | 1654 | RSS: Main: 167862272 10:25:50 INFO - PROCESS | 1654 | 10:25:52 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:53 INFO - PROCESS | 1654 | RSS: Main: 218054656 10:25:53 INFO - PROCESS | 1654 | 10:25:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 10:25:56 INFO - PROCESS | 1654 | RSS: Main: 231473152 10:25:56 INFO - PROCESS | 1654 | 10:25:59 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 10:26:00 INFO - PROCESS | 1654 | RSS: Main: 327983104 10:26:00 INFO - PROCESS | 1654 | 10:26:02 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 10:26:03 INFO - PROCESS | 1654 | RSS: Main: 232890368 10:26:03 INFO - PROCESS | 1654 | 10:26:05 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:26:05 INFO - PROCESS | 1654 | RSS: Main: 234401792 10:26:05 INFO - PROCESS | 1654 | 10:26:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 10:26:08 INFO - PROCESS | 1654 | RSS: Main: 275546112 10:26:08 INFO - PROCESS | 1654 | 10:26:11 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 10:26:12 INFO - PROCESS | 1654 | RSS: Main: 273367040 10:26:12 INFO - PROCESS | 1654 | 10:26:15 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 10:26:15 INFO - PROCESS | 1654 | RSS: Main: 270557184 10:26:15 INFO - PROCESS | 1654 | 10:26:17 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:26:17 INFO - PROCESS | 1654 | RSS: Main: 247664640 10:26:17 INFO - PROCESS | 1654 | 10:26:19 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:26:20 INFO - PROCESS | 1654 | RSS: Main: 250294272 10:26:20 INFO - PROCESS | 1654 | 10:26:22 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:26:23 INFO - PROCESS | 1654 | RSS: Main: 251830272 10:26:23 INFO - PROCESS | 1654 | 10:26:26 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:26:26 INFO - PROCESS | 1654 | RSS: Main: 271073280 10:26:26 INFO - PROCESS | 1654 | 10:26:29 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:26:30 INFO - PROCESS | 1654 | RSS: Main: 264863744 10:26:30 INFO - PROCESS | 1654 | 10:26:31 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 10:26:32 INFO - PROCESS | 1654 | RSS: Main: 309018624 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | __start_tp_report 10:26:32 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 10:26:32 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 10:26:32 INFO - PROCESS | 1654 | |i|pagename|runs| 10:26:32 INFO - PROCESS | 1654 | |0;ai-astar;104;113;114;112;114;114;114;113;113;112 10:26:32 INFO - PROCESS | 1654 | |1;audio-beat-detection;151;107;105;144;109;107;105;110;135;108 10:26:32 INFO - PROCESS | 1654 | |2;audio-dft;184;181;182;185;182;181;181;183;181;182 10:26:32 INFO - PROCESS | 1654 | |3;audio-fft;80;57;58;114;75;60;73;58;81;57 10:26:32 INFO - PROCESS | 1654 | |4;audio-oscillator;88;68;92;70;68;68;89;67;69;91 10:26:32 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;87;84;87;84;86;84;87;84;87;83 10:26:32 INFO - PROCESS | 1654 | |6;imaging-darkroom;93;94;94;94;93;92;94;93;94;94 10:26:32 INFO - PROCESS | 1654 | |7;imaging-desaturate;119;122;94;78;80;81;85;82;83;81 10:26:32 INFO - PROCESS | 1654 | |8;json-parse-financial;54;54;55;55;55;59;55;56;56;55 10:26:32 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;62;71;68;80;74;71;68;68;73;101 10:26:32 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;81;82;82;88;98;84;81;82;81;81 10:26:32 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;135;153;146;151;131;136;138;156;188;134 10:26:32 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;161;160;162;160;163;161;162;161;165;167 10:26:32 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;65;66;66;65;65;65;64;64;63;64 10:26:32 INFO - PROCESS | 1654 | __end_tp_report 10:26:32 INFO - PROCESS | 1654 | __start_cc_report 10:26:32 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1910 10:26:32 INFO - PROCESS | 1654 | __end_cc_report 10:26:32 INFO - PROCESS | 1654 | __startTimestamp1487269592055__endTimestamp 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | ------- Summary: start ------- 10:26:32 INFO - PROCESS | 1654 | Number of tests: 14 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.50 stddev:3.02 (2.7%) stddev-sans-first:0.83 10:26:32 INFO - PROCESS | 1654 | Values: 104.0 113.0 114.0 112.0 114.0 114.0 114.0 113.0 113.0 112.0 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:118.10 Median:109.50 stddev:17.89 (16.3%) stddev-sans-first:14.48 10:26:32 INFO - PROCESS | 1654 | Values: 151.0 107.0 105.0 144.0 109.0 107.0 105.0 110.0 135.0 108.0 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:182.20 Median:182.00 stddev:1.40 (0.8%) stddev-sans-first:1.32 10:26:32 INFO - PROCESS | 1654 | Values: 184.0 181.0 182.0 185.0 182.0 181.0 181.0 183.0 181.0 182.0 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:71.30 Median:66.50 stddev:17.95 (27.0%) stddev-sans-first:18.76 10:26:32 INFO - PROCESS | 1654 | Values: 80.0 57.0 58.0 114.0 75.0 60.0 73.0 58.0 81.0 57.0 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:79.00 stddev:11.26 (14.3%) stddev-sans-first:11.22 10:26:32 INFO - PROCESS | 1654 | Values: 88.0 68.0 92.0 70.0 68.0 68.0 89.0 67.0 69.0 91.0 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:85.30 Median:86.50 stddev:1.64 (1.9%) stddev-sans-first:1.62 10:26:32 INFO - PROCESS | 1654 | Values: 87.0 84.0 87.0 84.0 86.0 84.0 87.0 84.0 87.0 83.0 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:94.00 stddev:0.71 (0.8%) stddev-sans-first:0.73 10:26:32 INFO - PROCESS | 1654 | Values: 93.0 94.0 94.0 94.0 93.0 92.0 94.0 93.0 94.0 94.0 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:90.50 Median:81.50 stddev:16.41 (20.1%) stddev-sans-first:13.78 10:26:32 INFO - PROCESS | 1654 | Values: 119.0 122.0 94.0 78.0 80.0 81.0 85.0 82.0 83.0 81.0 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:1.43 (2.6%) stddev-sans-first:1.42 10:26:32 INFO - PROCESS | 1654 | Values: 54.0 54.0 55.0 55.0 55.0 59.0 55.0 56.0 56.0 55.0 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:73.60 Median:71.00 stddev:10.72 (15.1%) stddev-sans-first:10.52 10:26:32 INFO - PROCESS | 1654 | Values: 62.0 71.0 68.0 80.0 74.0 71.0 68.0 68.0 73.0 101.0 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:82.00 stddev:5.37 (6.6%) stddev-sans-first:5.59 10:26:32 INFO - PROCESS | 1654 | Values: 81.0 82.0 82.0 88.0 98.0 84.0 81.0 82.0 81.0 81.0 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:148.50 stddev:16.95 (11.4%) stddev-sans-first:17.43 10:26:32 INFO - PROCESS | 1654 | Values: 135.0 153.0 146.0 151.0 131.0 136.0 138.0 156.0 188.0 134.0 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:162.00 stddev:2.25 (1.4%) stddev-sans-first:2.35 10:26:32 INFO - PROCESS | 1654 | Values: 161.0 160.0 162.0 160.0 163.0 161.0 162.0 161.0 165.0 167.0 10:26:32 INFO - PROCESS | 1654 | 10:26:32 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:0.95 (1.5%) stddev-sans-first:1.00 10:26:32 INFO - PROCESS | 1654 | Values: 65.0 66.0 66.0 65.0 65.0 65.0 64.0 64.0 63.0 64.0 10:26:32 INFO - PROCESS | 1654 | -------- Summary: end -------- 10:26:32 INFO - PROCESS | 1654 | 10:26:33 INFO - TEST-INFO | 1654: exit 0 10:26:33 INFO - TEST-OK | kraken | took 58167ms 10:26:33 INFO - SUITE-END | took 1175s 10:26:33 INFO - Completed test suite (00:19:35) 10:26:33 INFO - javascript benchmark 10:26:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2488.2908371114236, 3490.703290220331, 3496.6153723090456, 3503.0, 3553.4669799530066, 5716.22830917826, 5762.423757624236, 5791.449812267828, 5812.651240925542, 5824.737886795099, 5753.367129615739, 5800.53595712343, 5860.326062502802, 5861.501772349356, 5881.176635271055, 5221.973890130544, 5266.7629956652045, 5294.0, 5294.788208471657, 5335.866603334928, 5191.325127733408, 5211.739413029333, 5222.399424066243, 5296.788128474856, 5363.704996225206, 5229.294045303874, 5235.345581802275, 5242.973785131069, 5300.681959082467, 5300.840974770744, 5269.947300526984, 5275.815346462894, 5297.258383826267, 5298.019866324704, 5317.12267475866, 4149.33610622299, 5182.585393168538, 5250.317458730341, 5255.237990491396, 5255.710935898524, 5678.290213723285, 5696.316442026983, 5723.914141287884, 5727.083666613322, 5861.85345366365, 5135.666181698215, 6174.0, 6180.783672571439, 6197.535184861108, 6206.596571222901, 6230.5638605297645, 6263.24841019076, 6269.2476902771505, 6282.497400208018, 6285.560010799246, 5776.306843178845, 5847.766089356378, 5996.430339117776, 6002.729877155539, 6005.1892994445625, 6236.781712640036, 6309.432151106331, 6313.0, 6372.872542549123, 6419.2296924369375, 6218.160548326008, 6222.377762223832, 6227.750889964351, 6233.750649974041, 6237.96881015592, 6088.817335479943, 6103.8902988373275, 6226.533010024175, 6229.4393504584805, 6232.781852635227, 5470.425605311465, 6117.736059405486, 6150.384961503813, 6182.227221597301, 6199.597026193283, 6183.96908015466, 6185.876282474325, 6193.659348735863, 6199.504039676815, 6216.471599914058, 4983.700977941263, 5071.492850714899, 5077.26379674945, 5087.186050231945, 5092.745362731848, 4440.822367105344, 4444.2444784386735, 4444.577765112309, 4500.617447516932, 4504.61710754583, 6024.378692324932, 6058.485028772604, 6078.422549857756, 6093.29927058394, 6123.510119190454, 5210.869728256824, 6219.0982307566055, 6256.468200202943, 6288.088227207029, 6295.087212354183, 5809.6223745457255, 5828.88342233153, 5895.14520394549, 6000.219971403777, 6003.8198854034445, 5496.203050557647, 5526.364468086141, 5531.723413829292, 5554.055810512223, 5567.220589117527, 6417.35734778453, 6434.485241180788, 6438.839029024218, 6456.063870738811, 6477.028445733084, 5864.871603091498, 6099.542534310033, 6195.876082478415, 6254.405831446005, 6341.460975817107, 6116.548817443993, 6300.621962682254, 6332.873342533216, 6340.7463701451425, 6487.578307410192, 5175.896482070413, 6285.779997700059, 6290.968545157428, 6292.433680968735, 6301.306856245901, 6240.095186197885, 6258.155149054819, 6296.118543404019, 6309.3690630936535, 6310.905336419865, 6027.065804800263, 6099.908501372394, 6112.480439162721, 6116.969415152896, 6243.344448832807, 6188.752449901954, 6211.130441738251, 6243.344448832989, 6252.187215661935, 6256.374362563707, 6096.786612468542, 6130.6628135452975, 6140.846478838065, 6149.292831324455, 6157.907631385443, 6043.335233124265, 6101.359357267423, 6131.96934015327, 6136.386361363828, 6224.346443623354, 6035.426634469718, 6144.109104179958, 6150.200473938359, 6159.630422174684, 6165.260168779775], "value": 5745.576494496079, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.17910321108934, 488.6017895415237, 489.06832484117746, 516.7390467813755, 527.3302905310259, 25178.49643007141, 32783.0, 40125.197496050096, 40973.77078687637, 41000.0, 42286.36570451446, 42599.935001624974, 42641.57358426415, 42659.78670106653, 42752.0, 9468.43189408636, 9637.084476974676, 9639.469829159394, 9665.033496650314, 9674.177694895941, 9005.954970225139, 9201.125893040184, 9406.811863762721, 9526.142647161754, 11538.538458461651, 11440.370779607118, 11753.471093800757, 11763.7059073523, 11769.705757356049, 11793.882061179407, 10405.635802746867, 11369.545218191262, 11733.882661173364, 11808.586699465563, 11814.46834892432, 11750.941245293805, 11761.294322340687, 11841.703957401047, 11846.585369512026, 11852.940735296355, 40430.0, 40712.796436017634, 40722.79638601818, 40734.59265407338, 40750.77747667575, 3208.8235147066903, 3278.5737854079057, 3399.473081672345, 3418.9658103418897, 4016.8393264269394, 29647.0, 29869.70130298691, 29917.0, 30514.0, 31692.207694807585, 3182.2839861031316, 3247.9188020299443, 3345.7156141727983, 3413.7951722896705, 3430.879919202816, 487738.0, 490928.0, 493163.0, 493631.0, 495475.0, 59943.70028149831, 60091.0, 60115.0, 60131.0, 60141.69929150326, 62468.68765656234, 62659.6867015662, 62679.0, 62688.37311626917, 62752.37247627557, 15495.457658982106, 15662.295196716175, 15705.371785128467, 15712.135832529091, 15735.763963540556, 12152.635420937386, 12197.08521860864, 12200.511979520898, 12208.206466579644, 12209.0, 14098.647533811532, 14488.855111448962, 14493.565193044225, 15342.616434589001, 16189.109598972169, 5385.084535628953, 5518.365387980353, 5949.137375080589, 6051.697415129314, 6332.525060620472, 834.9540775257419, 848.7156802471242, 994.8259054665405, 995.4574756757585, 1059.782744537368, 28644.14067577976, 29137.980170693925, 29758.1072567819, 30164.24589385283, 30170.24574385614, 1019.5259204469957, 1085.8154113800672, 1093.5407129005837, 1093.814051611228, 1102.8345748137845, 14595.78106328406, 15213.895781637717, 15370.308336124901, 15553.611159720871, 15746.606334841721, 549319.0, 551574.0, 553704.0, 553722.0, 554819.0, 50996.74501627468, 51497.22754158616, 57473.56316092131, 57690.711546442, 58318.0, 1358.280111540885, 1367.3095086981011, 1397.8881689464818, 1401.5725203812935, 1411.456589213181, 28630.856845716473, 30099.09702708922, 30287.699652561154, 30529.847350763102, 31629.051128466184, 56936.71531642315, 57652.0, 57661.13508297295, 57665.13502297385, 57721.0, 677061.6146919234, 678285.0, 692117.0, 713468.0, 715529.0, 25551.6167257495, 25852.741472585785, 25867.482650346512, 26119.73880261173, 26178.952841886112, 45621.54378456173, 45741.771291144665, 45834.77082614566, 45961.0, 46095.0, 31325.843370783, 32615.836920815244, 37024.81487592545, 37237.069073273386, 37591.0, 36828.44757328696, 37407.43888841724, 37639.059023524635, 38276.6172338273, 38316.61683383131, 36669.816650916575, 37082.0, 37640.81179594085, 37682.8115859419, 37879.2424151521, 29508.852455737582, 31480.0, 33810.32379352448, 33963.830180848934, 34009.65990340065, 21489.892550537148, 22534.436639084153, 24786.636734979027, 25055.248342549752, 25356.746432535438], "value": 19868.74754953117, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.7172328338669, 388.39992212032405, 390.7792097464931, 391.44805823788465, 416.895776055986, 17123.82876171238, 19754.70367944482, 19969.800301996976, 20869.269575564856, 21260.14959401624, 20110.59778804423, 20564.0, 21062.789372106276, 21340.786592134074, 21373.358799236008, 5489.34127904652, 5887.205227294303, 5928.762849486037, 5935.9703201483935, 5943.0, 5612.943870561283, 5774.797882074128, 5879.353271140192, 5884.029135192688, 5884.499817515516, 5664.575156863231, 5745.683987380713, 5812.418758124196, 5828.446297601721, 5835.0, 5620.381758006616, 5815.098659707731, 5816.621919575236, 5818.854528636775, 5833.154192642043, 5165.845024649267, 5198.428172900978, 5202.3497062867145, 5210.635255532115, 5219.42586315505, 25146.49707005868, 25253.0, 25419.745802541922, 25496.49007019849, 25674.871625641754, 2135.903884325209, 2356.363781778927, 2471.987640061788, 2830.6461692288462, 2911.126662001412, 15134.545963621109, 15141.015833970867, 15441.150736709476, 16100.355985760556, 16160.111193884331, 1833.3766519383341, 1863.6459072776129, 1914.6457905287566, 1966.193860517181, 1971.0341932452995, 111035.0, 115707.0, 115901.420492897, 116483.0, 116954.0, 10054.949725251474, 10243.539040743184, 10372.636957706594, 11269.887301127048, 11484.081273498266, 14223.146611203361, 14235.430582776573, 14238.501652442115, 14256.786148207786, 14272.35774390155, 8057.194280572013, 8274.875876861852, 8286.668533258602, 8397.076321604618, 8416.452930559493, 6668.533202675863, 8071.313938315191, 8076.4750291230885, 8108.675652973933, 8291.212334828182, 6639.170103737033, 6680.665966701646, 6781.559198652072, 6815.625140617214, 6824.781945867613, 1603.9438619648256, 1874.22219778793, 1877.5212320858093, 1877.6620208362626, 1878.079740926936, 794.1621589223424, 804.6982381606897, 841.3521588376916, 934.72425634438, 957.1863915671623, 18386.172622232032, 21490.892545537485, 22736.431589210402, 22841.771582283964, 23574.29277121689, 959.9712008639752, 961.245422343457, 984.2745209382454, 1011.8330475471465, 1018.4042335233971, 7944.761657150295, 11330.036946859444, 11451.656450306504, 11458.369789661649, 11471.394004839329, 583472.0, 588801.0, 594888.0, 595521.0, 600904.9954750285, 80625.0, 135830.64169358378, 144095.0, 144685.0, 148371.0, 865.4158443050916, 941.9293552983554, 982.4449186209625, 1006.4213077480478, 1007.1640538353149, 19099.0, 19739.506512337306, 19963.90198539094, 20020.499487512345, 20039.899800500905, 54129.94025448186, 56571.434285658266, 56902.715486422305, 57594.0, 57621.711891440274, 78154.43691126259, 82649.0, 85035.0, 85737.57131214305, 86757.56621216853, 6486.967565162144, 8059.395545334006, 8234.794130146794, 8495.065542790164, 8534.359923005924, 10191.643292484727, 12983.415746291628, 13010.284434356201, 13193.0, 13427.395767190696, 9292.95353523228, 11111.055560277468, 11216.887831121585, 11226.66320010401, 11505.367204803817, 11040.668779936615, 11228.93325134111, 11270.100440354392, 11397.658070257905, 11618.419079045845, 11311.660650180507, 11460.82808757886, 11466.426678666201, 11701.122415819018, 11925.463354149259, 8055.113937466756, 8100.35197184212, 8213.917860821315, 8476.872846907425, 8544.74365769028, 8326.542040187605, 10870.239083264096, 11262.04272636835, 11334.94332528332, 11667.066634669376], "value": 9784.841208116875, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.8212732344793, 1505.3978408636544, 1541.2447900528741, 1699.898006119632, 1717.8368055034766, 7516.736914208004, 7901.84196316074, 8099.959500202491, 8374.204450577201, 8374.37192210585, 8295.0, 8341.33269338453, 8348.206920342558, 8349.54077525736, 8358.91641083589, 2343.8007769339583, 2368.4789346343778, 2372.015613520387, 2372.9881350593223, 2376.714794224687, 2348.3659411958847, 2392.736798952114, 2397.892094855727, 2400.663907053014, 2402.0511897800448, 2004.2984955265686, 2321.7910388065156, 2348.4011577047827, 2361.480474295652, 2367.562001029815, 2322.883855807203, 2331.9300420987397, 2355.340504658698, 2358.7641235876445, 2359.2096647623066, 2348.116121062384, 2350.6239001759636, 2378.6432035194684, 2380.702412198475, 2382.6664267002634, 8361.665533378658, 8426.789330266793, 8436.198561136682, 8436.746897593082, 8450.535220562866, 5050.39395272566, 5236.345456817898, 5238.738063096868, 5266.368035835686, 5269.947300526984, 3040.2551374913287, 3460.2041530448137, 3516.7714098583765, 3593.784372937606, 3616.3490571697084, 1070.7804899995483, 1080.4111759091313, 1083.3175099687146, 1100.5762781329165, 1118.5190368141696, 10807.513661885234, 10854.96877796608, 10904.50929708165, 10913.508892099795, 10932.672019839418, 4301.268784306675, 4319.568043195655, 4459.888502787457, 4465.441819772528, 4471.28459446487, 8690.174433428814, 8695.869561956575, 8709.042005379402, 8714.215720585178, 8720.12798720123, 4632.258838585877, 4859.59071869154, 5132.56373208274, 5132.743362831919, 5143.099957507496, 4364.432623758955, 4504.459464864237, 4675.0, 4750.429948406213, 4788.4253889533475, 3002.519596864491, 3280.2783387654677, 3609.5848977367414, 3750.474933509311, 3779.962200378016, 1149.1725957310723, 1154.6189757380043, 1157.8957893789432, 1164.2432418927594, 1167.4571324334056, 759.2710997442517, 853.3301358433724, 892.3708785306344, 934.2199263614822, 958.8274110660009, 5622.24099746529, 5692.9146062809095, 5696.601237913389, 5757.309122905278, 5959.5828292020005, 746.6001247660637, 907.3739120007306, 913.182701482183, 921.1433366968784, 949.5584553182803, 3748.456473811282, 3951.6245956634075, 4030.5163380394542, 4052.0882801369457, 4065.6747460203114, 9898.653547125816, 10250.333728307636, 10253.84619230712, 10272.229582781321, 10288.948555257326, 10096.545655445523, 10209.795804083877, 10217.693469195936, 10227.539760710786, 10248.38509689406, 7528.096628404626, 7845.0, 7923.3661307096445, 8036.156203598655, 8050.677972881136, 5323.281357016753, 5689.857753556029, 5743.511801496919, 5921.319048309328, 5961.823934264049, 8217.83564328722, 9165.679201227926, 9285.767855803659, 9397.0, 9476.715698529055, 9427.3400861939, 9505.334626576074, 9554.808903821746, 9609.519524023632, 9653.1794797443, 6681.33186681328, 6875.724971001104, 7088.255733147946, 7243.0, 7261.056062712025, 6613.470922326299, 7378.372838308589, 7642.5032372895585, 7918.168592297726, 8083.232092951161, 7144.892826607709, 7252.963735181291, 7259.963700181465, 7274.636268186464, 7400.592967386845, 6924.861502769816, 7039.225685174729, 7102.254263302279, 7161.677724502514, 7203.315685009916, 5826.805504871576, 6521.608703477807, 6772.762953296611, 6784.253732089565, 6785.762498312535, 4824.252240902666, 4858.6356023297685, 4884.316195732671, 4940.629452790983, 4957.702537847741, 4858.125537403302, 4864.318995340726, 4922.8769280768265, 5024.472430394756, 5031.622628302819], "value": 4404.270088670057, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.92528979820366, 301.33705847136304, 311.14280158164263, 319.61965261339014, 324.11031717934276, 4113.670906327494, 5178.171492561191, 5222.556082732972, 5246.921296180555, 5259.710715910624, 4909.656324057309, 5036.722980236085, 5051.625735904128, 5134.0, 5168.586513078954, 3185.4743967245377, 3576.2489877125836, 3673.9402959729514, 4022.8189731462153, 4029.2545879012478, 3323.21904352477, 3975.688022952433, 4002.6197511236387, 4019.236345094437, 4020.979895100535, 3867.8259478323403, 3905.047476261869, 3942.6648734857426, 3980.9004774880714, 3996.9400458993136, 3279.8524066417067, 3977.4033894915992, 3992.7604343739176, 4009.238244733506, 4009.5389030261604, 2600.4409052053898, 3248.30161515273, 3276.8033917965, 3362.4620060790403, 3517.9296414071573, 4164.6251837334785, 5090.778213228798, 5118.232265160219, 5127.717975511346, 5157.447063703453, 4489.239117942442, 4510.368548403226, 4549.27211646135, 4601.654875884288, 4663.743494107823, 4738.881527961828, 4781.856544303677, 4909.631777616657, 4926.236433352836, 5093.388793344785, 3704.0, 3788.916096147108, 3900.8882468496627, 3906.109478985559, 3910.667593254577, 5454.809081682161, 5745.396733342981, 5745.425457454263, 5759.769609215668, 5766.452187042224, 3074.938501229963, 3672.6878215351994, 3838.3091043611857, 3847.499825022729, 3851.287511810324, 3875.4768106305287, 3915.960840391617, 3922.882313530599, 3925.076712410898, 3929.7249192556246, 3768.907016965104, 3973.92052158961, 4298.41971333866, 4567.858035491127, 4585.747783871852, 4620.768961551909, 5478.45215478457, 5483.272769077727, 5535.501804837584, 5541.639793413416, 1122.629532254354, 1192.66605350502, 1248.076423446643, 1252.2968762483015, 1264.6332563556466, 736.2894806511742, 780.9535222801474, 810.9959450202712, 839.8782176584361, 845.1506236232547, 3834.654881060718, 4534.59188673021, 5281.55106815925, 5309.230161626542, 5350.438203988603, 4761.976190119027, 4978.859090591008, 5695.145728140812, 5772.451617096369, 5813.069908814654, 4039.777812220297, 4194.49666040071, 5073.11220536412, 5343.332083489564, 5378.327709036371, 2490.5392502387117, 2577.561814491541, 2659.986700066487, 2840.9857950710116, 2848.829070255791, 4750.952490475051, 4771.498992605796, 4807.375041244616, 5586.944130558723, 5654.575906806924, 4786.659735274129, 5582.91625625616, 5804.622699524517, 5852.552060434101, 5885.676287804212, 5180.533751962342, 5899.174115623816, 5936.732847021981, 5951.434613711691, 5965.284165900033, 4817.27740838877, 4933.703977761345, 5309.327561818015, 5516.3380394352935, 5765.798197063083, 5491.078122657038, 5550.69471179089, 5592.748326325406, 5611.3266408031295, 5629.183768353484, 4588.701734387254, 5224.817131400383, 5919.260092488439, 5924.140999554954, 5929.258842644669, 3767.9638099521753, 3935.6064393560414, 3952.9209415810947, 3997.040710229582, 4016.4577781999055, 4638.721676699409, 4751.643626728079, 5615.241942337732, 5621.213030175697, 5634.549236061023, 4613.976930115328, 5421.403645598902, 5503.807366742145, 5534.91697624544, 5557.388687244481, 4740.691855029412, 5221.120396657125, 5291.285676433632, 5409.215663728816, 5519.3652729936575, 5219.608529360237, 5413.052715774802, 5413.669064748107, 5435.0, 5444.972775136099, 4328.61042506176, 5121.874422114781, 5353.2505449237915, 5375.435579264121, 5499.50504454601, 4961.528654777935, 5416.485433883775, 5426.348838139448, 5431.56547476193, 5454.227376102862], "value": 3956.567870254782, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.9642017899104, 717.300631883913, 720.5712601002402, 775.6742168289318, 799.8880156778049, 14545.345459454324, 15486.845131548682, 15493.22533873306, 15501.302441390137, 15501.689966200669, 13827.79258311126, 14037.087589306688, 14041.087329323613, 14054.718905621881, 14055.508057218, 682.0689758479689, 702.2766550453042, 706.6466766616692, 846.1622993236698, 861.4142383179435, 697.8046147078826, 700.1912790726719, 701.9859602807941, 829.701307529289, 859.299670768325, 828.5360198288947, 861.6085022688344, 895.4895709445618, 903.7785742493065, 909.3498148823589, 909.5861383070687, 909.963601455941, 910.235402262103, 912.6714382822179, 914.2137761525083, 677.7153595489906, 678.7285085965603, 679.6194131286495, 680.2823021712092, 680.323078536859, 13873.167609943435, 14094.01341906067, 14117.941154413358, 14123.293835308194, 14946.103233806007, 12760.872391276154, 13877.37551810171, 14096.365663545164, 14203.005789594732, 14244.92877535616, 12097.697557561132, 12561.623151305475, 12723.427445764963, 12911.612651620373, 13595.52415665447, 4454.463210192478, 4464.6874718769695, 4612.884677883047, 4742.9525704742855, 4797.592204662573, 86946.0, 88264.0, 89469.55265223698, 89498.0, 90727.0, 9922.603095876228, 10349.0, 10356.585736570452, 10414.687559373231, 10467.685969420929, 19547.49866485654, 19584.902075489532, 19682.803171968382, 19825.900870495843, 19844.20623175057, 7621.428392870557, 7709.7301594443925, 7751.418643601753, 7853.371730261565, 7853.8821917671285, 4279.572042795696, 4285.142971405669, 4354.455693038371, 4363.36731173978, 4436.401085853433, 2821.3087793490317, 3240.4005259027153, 3322.1362445763793, 3346.0798280473064, 3355.0270421577957, 557.9888402231933, 612.0665984373866, 681.3391010719594, 698.1377998172354, 703.8873780195145, 557.6152454806171, 564.6555601083336, 638.5913015669975, 664.0968283134932, 685.6434653980002, 7991.081025682005, 8616.569171541523, 8769.736907892773, 9058.909410905806, 9226.477631190779, 599.7391134856351, 643.8486955565438, 659.7921654678761, 670.0953712488102, 700.3731660164226, 4344.587264209895, 4393.1872603568445, 4750.881227969328, 4835.8065677373215, 4878.390201224847, 107962.0, 114880.0, 116449.0, 116644.41677791727, 118813.0, 80111.0, 80427.0, 98199.90431385068, 102942.97057029484, 103022.0, 66246.66876665586, 72594.45919392901, 79000.60499697695, 86957.13042869617, 88434.55782721174, 9674.0, 9884.25868059884, 9911.058449447291, 9927.255455840696, 9946.204303655835, 53636.73181634067, 54470.00414977214, 55671.0, 56808.43191568032, 57033.0, 53635.73182134065, 55272.0, 55397.0, 56042.59893502532, 68517.65741171263, 12576.0, 12662.0, 12731.745365092831, 12932.03009774252, 13343.799843002169, 13640.045196836523, 14150.292485375896, 14257.447400867024, 14302.284885755462, 14605.634859128182, 10773.259765703066, 13189.274589897264, 13624.386902589209, 13722.931385343009, 13858.514951976633, 12354.0, 13237.404316805574, 13613.65965850822, 13913.095648782797, 14264.857351426768, 13046.739065218831, 13088.345582721016, 13499.730005400033, 13510.72978540404, 13932.0, 10927.289726167774, 11097.833532497181, 11402.828957565478, 11662.183647144619, 11734.823977640513, 10593.09958653523, 11290.0, 11345.716357091138, 11570.479328430072, 11577.710557236136], "value": 7383.6051811535235, "unit": "score"}], "name": "dromaeo_css", "value": 7237.601187158156, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 114.0, 112.0, 114.0, 114.0, 114.0, 113.0, 113.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 107.0, 105.0, 144.0, 109.0, 107.0, 105.0, 110.0, 135.0, 108.0], "value": 118.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 182.0, 185.0, 182.0, 181.0, 181.0, 183.0, 181.0, 182.0], "value": 182.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 58.0, 114.0, 75.0, 60.0, 73.0, 58.0, 81.0, 57.0], "value": 71.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 68.0, 92.0, 70.0, 68.0, 68.0, 89.0, 67.0, 69.0, 91.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 86.0, 84.0, 87.0, 84.0, 87.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 92.0, 94.0, 93.0, 94.0, 94.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 122.0, 94.0, 78.0, 80.0, 81.0, 85.0, 82.0, 83.0, 81.0], "value": 90.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 55.0, 59.0, 55.0, 56.0, 56.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 71.0, 68.0, 80.0, 74.0, 71.0, 68.0, 68.0, 73.0, 101.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 88.0, 98.0, 84.0, 81.0, 82.0, 81.0, 81.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 153.0, 146.0, 151.0, 131.0, 136.0, 138.0, 156.0, 188.0, 134.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 163.0, 161.0, 162.0, 161.0, 165.0, 167.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 64.0, 64.0, 63.0, 64.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1416.8999999999999, "alertThreshold": 2.0}]} 10:26:33 INFO - Return code: 0 10:26:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:26:33 INFO - # TBPL SUCCESS # 10:26:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:26:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:26:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:26:33 INFO - 2017-02-16 10:26:33.376 screenresolution[1658:9726] starting screenresolution argv=screenresolution get 10:26:33 INFO - 2017-02-16 10:26:33.379 screenresolution[1658:9726] Display 0: 1600x1200x32@60 10:26:33 INFO - 2017-02-16 10:26:33.385 screenresolution[1659:9729] starting screenresolution argv=screenresolution list 10:26:33 INFO - Available Modes on Display 0 10:26:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:26:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:26:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:26:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:26:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:26:33 INFO - Intel Iris: 10:26:33 INFO - Chipset Model: Intel Iris 10:26:33 INFO - Type: GPU 10:26:33 INFO - Bus: Built-In 10:26:33 INFO - VRAM (Dynamic, Max): 1536 MB 10:26:33 INFO - Vendor: Intel (0x8086) 10:26:33 INFO - Device ID: 0x0a2e 10:26:33 INFO - Revision ID: 0x0009 10:26:33 INFO - Displays: 10:26:33 INFO - Display: 10:26:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:26:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:26:33 INFO - Display Serial Number: 1600x1200 60 10:26:33 INFO - Main Display: Yes 10:26:33 INFO - Mirror: Off 10:26:33 INFO - Online: Yes 10:26:33 INFO - Rotation: Supported 10:26:33 INFO - Return code: 0 10:26:33 INFO - Running post-action listener: _resource_record_post_action 10:26:33 INFO - [mozharness: 2017-02-16 18:26:33.625162Z] Finished run-tests step (success) 10:26:33 INFO - Running post-run listener: _resource_record_post_run 10:26:33 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 37975040; Write bytes: 501343232; Read time: 239; Write time: 1562 10:26:33 INFO - TinderboxPrint: CPU usage
53.1% 10:26:33 INFO - TinderboxPrint: I/O read bytes / time
37,975,040 / 239 10:26:33 INFO - TinderboxPrint: I/O write bytes / time
501,343,232 / 1,562 10:26:33 INFO - TinderboxPrint: CPU idle
2,246.8 (46.9%) 10:26:33 INFO - TinderboxPrint: CPU system
951.4 (19.8%) 10:26:33 INFO - TinderboxPrint: CPU user
1,595.4 (33.3%) 10:26:33 INFO - TinderboxPrint: Swap in / out
229,388,288 / 0 10:26:33 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 181484032; Write bytes: 177649152; Read time: 17003; Write time: 382 10:26:33 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 37020672; Write bytes: 305958400; Read time: 227; Write time: 1130 10:26:34 INFO - Running post-run listener: _upload_blobber_files 10:26:34 INFO - Blob upload gear active. 10:26:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:26:34 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:26:34 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:26:34 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:26:34 INFO - (blobuploader) - INFO - Open directory for files ... 10:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:26:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:36 INFO - (blobuploader) - INFO - Done attempting. 10:26:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:26:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:26:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:37 INFO - (blobuploader) - INFO - Done attempting. 10:26:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:26:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:26:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:40 INFO - (blobuploader) - INFO - Done attempting. 10:26:40 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:40 INFO - Return code: 0 10:26:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:26:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c2b2d377d7ceb34a9780d8c574df4e52ac361c2fb610e1b89406f0ba1bd02aa95f6e35d05a4e817af84d351776edbac08e247415ddfccb50e72e206f28e03a6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/41c338b2ce17297ff613926670e766f4fd1609990479ec089f983358bc8977e604993aa6843d5f2abdf81b70ecf01926afa006754762c0e507126b8cf3c24404", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f89a738e7e536d3776553cc6961bba9e25a8c386b49fad1bcc8d5a9a4e0b9723947eb822a778a90b5932e745e12268ffd86d80d910ce0bfc2fca021b4faa56f4"} 10:26:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:40 INFO - Contents: 10:26:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c2b2d377d7ceb34a9780d8c574df4e52ac361c2fb610e1b89406f0ba1bd02aa95f6e35d05a4e817af84d351776edbac08e247415ddfccb50e72e206f28e03a6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/41c338b2ce17297ff613926670e766f4fd1609990479ec089f983358bc8977e604993aa6843d5f2abdf81b70ecf01926afa006754762c0e507126b8cf3c24404", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f89a738e7e536d3776553cc6961bba9e25a8c386b49fad1bcc8d5a9a4e0b9723947eb822a778a90b5932e745e12268ffd86d80d910ce0bfc2fca021b4faa56f4"} 10:26:40 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:40 INFO - Copying logs to upload dir... 10:26:40 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.903489 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-16 10:26:40.322581) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 10:26:40.329769) ========= 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.yCaRkD21fT/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.2dzMZR0hD2/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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/c2b2d377d7ceb34a9780d8c574df4e52ac361c2fb610e1b89406f0ba1bd02aa95f6e35d05a4e817af84d351776edbac08e247415ddfccb50e72e206f28e03a6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/41c338b2ce17297ff613926670e766f4fd1609990479ec089f983358bc8977e604993aa6843d5f2abdf81b70ecf01926afa006754762c0e507126b8cf3c24404", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f89a738e7e536d3776553cc6961bba9e25a8c386b49fad1bcc8d5a9a4e0b9723947eb822a778a90b5932e745e12268ffd86d80d910ce0bfc2fca021b4faa56f4"} build_url:https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/amSeWFEyTlGuE2XIMdEImQ/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/c2b2d377d7ceb34a9780d8c574df4e52ac361c2fb610e1b89406f0ba1bd02aa95f6e35d05a4e817af84d351776edbac08e247415ddfccb50e72e206f28e03a6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/41c338b2ce17297ff613926670e766f4fd1609990479ec089f983358bc8977e604993aa6843d5f2abdf81b70ecf01926afa006754762c0e507126b8cf3c24404", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f89a738e7e536d3776553cc6961bba9e25a8c386b49fad1bcc8d5a9a4e0b9723947eb822a778a90b5932e745e12268ffd86d80d910ce0bfc2fca021b4faa56f4"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 10:26:40.367721) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 10:26:40.368141) ========= 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.yCaRkD21fT/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.2dzMZR0hD2/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.005306 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 10:26:40.417227) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 10:26:40.417592) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 10:26:40.417978) ========= ========= Total master_lag: 0.20 =========