builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0343 starttime: 1490616470.71 results: success (0) buildid: 20170327034016 builduid: b8b71349da0f40b69409c39cdc589a42 revision: 6188b6cab49e2bfa036b24d8112cda5f5f9416f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 05:07:50.712527) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 05:07:50.712967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 05:07:50.713249) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 05:07:50.740180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:07:50.740600) ========= 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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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-03-27 05:07:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2017-03-27 05:07:51 (18.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.259109 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:07:51.024814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:07:51.025276) ========= 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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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.026275 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:07:51.075690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 05:07:51.076223) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6188b6cab49e2bfa036b24d8112cda5f5f9416f0 --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 6188b6cab49e2bfa036b24d8112cda5f5f9416f0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VaLpQUU1UI/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.uHYbDKB4QP/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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-03-27 05:07:51,182 truncating revision to first 12 chars 2017-03-27 05:07:51,182 Setting DEBUG logging. 2017-03-27 05:07:51,182 attempt 1/10 2017-03-27 05:07:51,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6188b6cab49e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-27 05:07:52,660 unpacking tar archive at: mozilla-beta-6188b6cab49e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.749696 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 05:07:52.851019) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 05:07:52.851359) ========= script_repo_revision: 6188b6cab49e2bfa036b24d8112cda5f5f9416f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 05:07:52.851764) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 05:07:52.852075) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 05:07:52.872477) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-27 05:07:52.872924) ========= /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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 05:07:53 INFO - MultiFileLogger online at 20170327 05:07:53 in /builds/slave/test 05:07:53 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 05:07:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:53 INFO - {'append_to_log': False, 05:07:53 INFO - 'base_work_dir': '/builds/slave/test', 05:07:53 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:07:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:53 INFO - 'branch': 'Mozilla-Beta', 05:07:53 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:53 INFO - 'config_files': ('talos/mac_config.py',), 05:07:53 INFO - 'default_actions': ('clobber', 05:07:53 INFO - 'read-buildbot-config', 05:07:53 INFO - 'download-and-extract', 05:07:53 INFO - 'populate-webroot', 05:07:53 INFO - 'create-virtualenv', 05:07:53 INFO - 'install', 05:07:53 INFO - 'run-tests'), 05:07:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:53 INFO - 'download_minidump_stackwalk': True, 05:07:53 INFO - 'download_symbols': 'ondemand', 05:07:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:53 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:53 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:53 INFO - 'installer_path': 'installer.exe', 05:07:53 INFO - 'log_level': 'info', 05:07:53 INFO - 'log_name': 'talos', 05:07:53 INFO - 'log_to_console': True, 05:07:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:07:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:07:53 INFO - 'opt_config_files': (), 05:07:53 INFO - 'pip_index': False, 05:07:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:53 INFO - 'cmd': ('bash', 05:07:53 INFO - '-c', 05:07:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:53 INFO - 'enabled': True, 05:07:53 INFO - 'halt_on_failure': False, 05:07:53 INFO - 'name': 'check_screen_resolution'},), 05:07:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:53 INFO - 'cmd': ('bash', 05:07:53 INFO - '-c', 05:07:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:53 INFO - 'enabled': True, 05:07:53 INFO - 'halt_on_failure': False, 05:07:53 INFO - 'name': 'check_screen_resolution'},), 05:07:53 INFO - 'run_cmd_checks_enabled': True, 05:07:53 INFO - 'sps_profile': False, 05:07:53 INFO - 'sps_profile_interval': 0, 05:07:53 INFO - 'suite': 'dromaeojs', 05:07:53 INFO - 'system_bits': '32', 05:07:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:53 INFO - 'title': 't-yosemite-r7-0343', 05:07:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:53 INFO - 'use_talos_json': True, 05:07:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:53 INFO - 'work_dir': 'build'} 05:07:53 INFO - [mozharness: 2017-03-27 12:07:53.084290Z] Running clobber step. 05:07:53 INFO - Running pre-action listener: _resource_record_pre_action 05:07:53 INFO - Running main action method: clobber 05:07:53 INFO - rmtree: /builds/slave/test/build 05:07:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:55 INFO - Running post-action listener: _resource_record_post_action 05:07:55 INFO - [mozharness: 2017-03-27 12:07:55.603451Z] Finished clobber step (success) 05:07:55 INFO - [mozharness: 2017-03-27 12:07:55.603610Z] Running read-buildbot-config step. 05:07:55 INFO - Running pre-action listener: _resource_record_pre_action 05:07:55 INFO - Running main action method: read_buildbot_config 05:07:55 INFO - Using buildbot properties: 05:07:55 INFO - { 05:07:55 INFO - "project": "", 05:07:55 INFO - "product": "firefox", 05:07:55 INFO - "script_repo_revision": "production", 05:07:55 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:07:55 INFO - "repository": "", 05:07:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:07:55 INFO - "buildid": "20170327034016", 05:07:55 INFO - "pgo_build": "False", 05:07:55 INFO - "basedir": "/builds/slave/test", 05:07:55 INFO - "buildnumber": 3, 05:07:55 INFO - "slavename": "t-yosemite-r7-0343", 05:07:55 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:07:55 INFO - "platform": "yosemite_r7", 05:07:55 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:07:55 INFO - "branch": "mozilla-beta", 05:07:55 INFO - "repo_path": "releases/mozilla-beta", 05:07:55 INFO - "revision": "6188b6cab49e2bfa036b24d8112cda5f5f9416f0", 05:07:55 INFO - "stage_platform": "macosx64", 05:07:55 INFO - "builduid": "b8b71349da0f40b69409c39cdc589a42", 05:07:55 INFO - "slavebuilddir": "test" 05:07:55 INFO - } 05:07:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 05:07:55 INFO - Running post-action listener: _resource_record_post_action 05:07:55 INFO - [mozharness: 2017-03-27 12:07:55.607961Z] Finished read-buildbot-config step (success) 05:07:55 INFO - [mozharness: 2017-03-27 12:07:55.608147Z] Running download-and-extract step. 05:07:55 INFO - Running pre-action listener: _resource_record_pre_action 05:07:55 INFO - Running main action method: download_and_extract 05:07:55 INFO - mkdir: /builds/slave/test/build/tests 05:07:55 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')]} 05:07:55 INFO - trying https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 05:07:55 INFO - Downloading https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 05:07:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 05:07:56 INFO - Downloaded 1165 bytes. 05:07:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 05:07:56 INFO - Using the following test package requirements: 05:07:56 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 05:07:56 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:07:56 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 05:07:56 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:07:56 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 05:07:56 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:07:56 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:07:56 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 05:07:56 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 05:07:56 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:07:56 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 05:07:56 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:07:56 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 05:07:56 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:07:56 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 05:07:56 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:07:56 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 05:07:56 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 05:07:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 05:07:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 05:07:56 INFO - Fetch https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 05:07:57 INFO - Expected file size: 16108482 05:07:57 INFO - Obtained file size: 16108482 05:08:04 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 05:08:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 05:08:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 05:08:04 INFO - Fetch https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 05:08:05 INFO - Expected file size: 16108482 05:08:05 INFO - Obtained file size: 16108482 05:08:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 05:08:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 05:08:11 INFO - Fetch https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 05:08:13 INFO - Expected file size: 14403663 05:08:13 INFO - Obtained file size: 14403663 05:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:13 INFO - trying https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:08:13 INFO - Downloading https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 05:08:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 05:08:15 INFO - Downloaded 58675568 bytes. 05:08:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:08:15 INFO - mkdir: /builds/slave/test/properties 05:08:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:08:15 INFO - Writing to file /builds/slave/test/properties/build_url 05:08:15 INFO - Contents: 05:08:15 INFO - build_url:https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:08:15 INFO - Running post-action listener: _resource_record_post_action 05:08:15 INFO - Running post-action listener: set_extra_try_arguments 05:08:15 INFO - [mozharness: 2017-03-27 12:08:15.797534Z] Finished download-and-extract step (success) 05:08:15 INFO - [mozharness: 2017-03-27 12:08:15.797693Z] Running populate-webroot step. 05:08:15 INFO - Running pre-action listener: _resource_record_pre_action 05:08:15 INFO - Running main action method: populate_webroot 05:08:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:08:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:08:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:08:15 INFO - '--tppagecycles', 05:08:15 INFO - '7'], 05:08:15 INFO - 'tests': ['tsvgm']}}, 05:08:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:08:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:08:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:08:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:08:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:08:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:08:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:08:15 INFO - 'talos_options': ['--disable-e10s'], 05:08:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:08:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:08:15 INFO - 'talos_options': ['--disable-e10s'], 05:08:15 INFO - 'tests': ['damp', 'tps']}, 05:08:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:08:15 INFO - 'tests': ['damp', 'tps']}, 05:08:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:08:15 INFO - 'tests': ['dromaeo_dom']}, 05:08:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:08:15 INFO - 'tests': ['basic_compositor_video']}, 05:08:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:08:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:08:15 INFO - 'tests': ['a11yr', 05:08:15 INFO - 'ts_paint', 05:08:15 INFO - 'tpaint', 05:08:15 INFO - 'sessionrestore', 05:08:15 INFO - 'sessionrestore_no_auto_restore', 05:08:15 INFO - 'tabpaint']}, 05:08:15 INFO - 'other-e10s': {'tests': ['a11yr', 05:08:15 INFO - 'ts_paint', 05:08:15 INFO - 'tpaint', 05:08:15 INFO - 'sessionrestore', 05:08:15 INFO - 'sessionrestore_no_auto_restore', 05:08:15 INFO - 'tabpaint']}, 05:08:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:08:15 INFO - 'ts_paint', 05:08:15 INFO - 'tpaint', 05:08:15 INFO - 'sessionrestore', 05:08:15 INFO - 'sessionrestore_no_auto_restore', 05:08:15 INFO - 'tabpaint']}, 05:08:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:08:15 INFO - 'ts_paint', 05:08:15 INFO - 'tpaint', 05:08:15 INFO - 'sessionrestore', 05:08:15 INFO - 'sessionrestore_no_auto_restore', 05:08:15 INFO - 'tabpaint']}, 05:08:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:08:15 INFO - 'tests': ['a11yr', 05:08:15 INFO - 'ts_paint', 05:08:15 INFO - 'tpaint', 05:08:15 INFO - 'sessionrestore', 05:08:15 INFO - 'sessionrestore_no_auto_restore', 05:08:15 INFO - 'tabpaint']}, 05:08:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:08:15 INFO - 'tests': ['a11yr', 05:08:15 INFO - 'ts_paint', 05:08:15 INFO - 'tpaint', 05:08:15 INFO - 'sessionrestore', 05:08:15 INFO - 'sessionrestore_no_auto_restore', 05:08:15 INFO - 'tabpaint']}, 05:08:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:08:15 INFO - 'tests': ['tsvgx', 05:08:15 INFO - 'tsvgr_opacity', 05:08:15 INFO - 'tart', 05:08:15 INFO - 'tscrollx', 05:08:15 INFO - 'cart', 05:08:15 INFO - 'tsvg_static']}, 05:08:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:08:15 INFO - 'tsvgr_opacity', 05:08:15 INFO - 'tart', 05:08:15 INFO - 'tscrollx', 05:08:15 INFO - 'cart', 05:08:15 INFO - 'tsvg_static']}, 05:08:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:08:15 INFO - 'talos_options': ['--disable-e10s'], 05:08:15 INFO - 'tests': ['tp5o']}, 05:08:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:08:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:08:15 INFO - 'talos_options': ['--disable-e10s', 05:08:15 INFO - '--xperf_path', 05:08:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:15 INFO - 'tests': ['tp5n']}, 05:08:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:08:15 INFO - 'talos_options': ['--xperf_path', 05:08:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:15 INFO - 'tests': ['tp5n']}}, 05:08:15 INFO - 'talos.zip': {'path': '', 05:08:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:08:15 INFO - Running post-action listener: _resource_record_post_action 05:08:15 INFO - [mozharness: 2017-03-27 12:08:15.817379Z] Finished populate-webroot step (success) 05:08:15 INFO - [mozharness: 2017-03-27 12:08:15.817514Z] Running create-virtualenv step. 05:08:15 INFO - Running pre-action listener: _resource_record_pre_action 05:08:15 INFO - Running main action method: create_virtualenv 05:08:15 INFO - Creating virtualenv /builds/slave/test/build/venv 05:08:15 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 05:08:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:08:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:15 INFO - Using real prefix '/tools/python27' 05:08:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:08:16 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:19 INFO - Installing pip.................done. 05:08:19 INFO - Return code: 0 05:08:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:08:19 INFO - Reading from file tmpfile_stdout 05:08:19 INFO - Output received: 05:08:19 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) 05:08:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a147b380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efcfd30>, '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 0x10eef6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc4be8>, '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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 05:08: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', 'pip>=1.5'] in /builds/slave/test/build 05:08: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 pip>=1.5 05:08:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VaLpQUU1UI/Render', 05:08:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:19 INFO - 'HOME': '/Users/cltbld', 05:08:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:19 INFO - 'LOGNAME': 'cltbld', 05:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:19 INFO - 'MOZ_NO_REMOTE': '1', 05:08:19 INFO - 'NO_EM_RESTART': '1', 05:08:19 INFO - 'PAGER': '/bin/cat', 05:08:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:19 INFO - 'PWD': '/builds/slave/test', 05:08:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:19 INFO - 'SHELL': '/bin/bash', 05:08:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uHYbDKB4QP/Listeners', 05:08:19 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 05:08:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:19 INFO - 'USER': 'cltbld', 05:08:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:19 INFO - 'XPC_FLAGS': '0x0', 05:08:19 INFO - 'XPC_SERVICE_NAME': '0', 05:08:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:20 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 05:08:20 INFO - Cleaning up... 05:08:20 INFO - Return code: 0 05:08:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f1f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a147b380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efcfd30>, '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 0x10eef6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc4be8>, '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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 05:08:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:08:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VaLpQUU1UI/Render', 05:08:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:20 INFO - 'HOME': '/Users/cltbld', 05:08:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:20 INFO - 'LOGNAME': 'cltbld', 05:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:20 INFO - 'MOZ_NO_REMOTE': '1', 05:08:20 INFO - 'NO_EM_RESTART': '1', 05:08:20 INFO - 'PAGER': '/bin/cat', 05:08:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:20 INFO - 'PWD': '/builds/slave/test', 05:08:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:20 INFO - 'SHELL': '/bin/bash', 05:08:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uHYbDKB4QP/Listeners', 05:08:20 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 05:08:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:20 INFO - 'USER': 'cltbld', 05:08:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:20 INFO - 'XPC_FLAGS': '0x0', 05:08:20 INFO - 'XPC_SERVICE_NAME': '0', 05:08:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:20 INFO - Downloading/unpacking psutil>=3.1.1 05:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:23 INFO - Installing collected packages: psutil 05:08:23 INFO - Running setup.py install for psutil 05:08:23 INFO - building 'psutil._psutil_osx' extension 05:08:23 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 05:08:24 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 05:08:24 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 05:08:24 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 05:08:24 INFO - building 'psutil._psutil_posix' extension 05:08:24 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 05:08:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:08:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:08:24 INFO - ^ 05:08:24 INFO - 1 warning generated. 05:08:24 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 05:08:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:24 INFO - Successfully installed psutil 05:08:24 INFO - Cleaning up... 05:08:24 INFO - Return code: 0 05:08:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a147b380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efcfd30>, '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 0x10eef6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc4be8>, '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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 05:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:08:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VaLpQUU1UI/Render', 05:08:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:24 INFO - 'HOME': '/Users/cltbld', 05:08:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:24 INFO - 'LOGNAME': 'cltbld', 05:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:24 INFO - 'MOZ_NO_REMOTE': '1', 05:08:24 INFO - 'NO_EM_RESTART': '1', 05:08:24 INFO - 'PAGER': '/bin/cat', 05:08:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:24 INFO - 'PWD': '/builds/slave/test', 05:08:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:24 INFO - 'SHELL': '/bin/bash', 05:08:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uHYbDKB4QP/Listeners', 05:08:24 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 05:08:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:24 INFO - 'USER': 'cltbld', 05:08:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:24 INFO - 'XPC_FLAGS': '0x0', 05:08:24 INFO - 'XPC_SERVICE_NAME': '0', 05:08:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:08:25 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 05:08:25 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 05:08:25 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 05:08:25 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 05:08:25 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 05:08:25 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 05:08:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:08:28 INFO - Installing collected packages: mozsystemmonitor 05:08:28 INFO - Running setup.py install for mozsystemmonitor 05:08:28 INFO - Successfully installed mozsystemmonitor 05:08:28 INFO - Cleaning up... 05:08:28 INFO - Return code: 0 05:08:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f1f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a147b380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efcfd30>, '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 0x10eef6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc4be8>, '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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 05:08:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:08:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VaLpQUU1UI/Render', 05:08:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:28 INFO - 'HOME': '/Users/cltbld', 05:08:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:28 INFO - 'LOGNAME': 'cltbld', 05:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:28 INFO - 'MOZ_NO_REMOTE': '1', 05:08:28 INFO - 'NO_EM_RESTART': '1', 05:08:28 INFO - 'PAGER': '/bin/cat', 05:08:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:28 INFO - 'PWD': '/builds/slave/test', 05:08:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:28 INFO - 'SHELL': '/bin/bash', 05:08:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uHYbDKB4QP/Listeners', 05:08:28 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 05:08:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:28 INFO - 'USER': 'cltbld', 05:08:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:28 INFO - 'XPC_FLAGS': '0x0', 05:08:28 INFO - 'XPC_SERVICE_NAME': '0', 05:08:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:28 INFO - Downloading/unpacking jsonschema==2.5.1 05:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:31 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:31 INFO - warning: no files found matching '*.txt' 05:08:31 INFO - no previously-included directories found matching 'build' 05:08:31 INFO - no previously-included directories found matching 'dist' 05:08:31 INFO - no previously-included directories found matching '.git*' 05:08:31 INFO - Installing collected packages: jsonschema, functools32 05:08:31 INFO - Running setup.py install for functools32 05:08:31 INFO - warning: no files found matching '*.txt' 05:08:31 INFO - no previously-included directories found matching 'build' 05:08:31 INFO - no previously-included directories found matching 'dist' 05:08:31 INFO - no previously-included directories found matching '.git*' 05:08:31 INFO - Successfully installed jsonschema functools32 05:08:31 INFO - Cleaning up... 05:08:32 INFO - Return code: 0 05:08:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:08:32 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')]} 05:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:32 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')]} 05:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:32 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 0x10f1f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a147b380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efcfd30>, '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 0x10eef6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc4be8>, '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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 05:08:32 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 05:08:32 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 05:08:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VaLpQUU1UI/Render', 05:08:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:32 INFO - 'HOME': '/Users/cltbld', 05:08:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:32 INFO - 'LOGNAME': 'cltbld', 05:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:32 INFO - 'MOZ_NO_REMOTE': '1', 05:08:32 INFO - 'NO_EM_RESTART': '1', 05:08:32 INFO - 'PAGER': '/bin/cat', 05:08:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:32 INFO - 'PWD': '/builds/slave/test', 05:08:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:32 INFO - 'SHELL': '/bin/bash', 05:08:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uHYbDKB4QP/Listeners', 05:08:32 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 05:08:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:32 INFO - 'USER': 'cltbld', 05:08:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:32 INFO - 'XPC_FLAGS': '0x0', 05:08:32 INFO - 'XPC_SERVICE_NAME': '0', 05:08:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:08:32 INFO - Cleaning up... 05:08:32 INFO - Return code: 0 05:08:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08:32 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')]} 05:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:32 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')]} 05:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:32 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 0x10f1f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a147b380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efcfd30>, '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 0x10eef6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc4be8>, '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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 05:08:32 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 05:08:32 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 05:08:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VaLpQUU1UI/Render', 05:08:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:32 INFO - 'HOME': '/Users/cltbld', 05:08:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:32 INFO - 'LOGNAME': 'cltbld', 05:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:32 INFO - 'MOZ_NO_REMOTE': '1', 05:08:32 INFO - 'NO_EM_RESTART': '1', 05:08:32 INFO - 'PAGER': '/bin/cat', 05:08:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:32 INFO - 'PWD': '/builds/slave/test', 05:08:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:32 INFO - 'SHELL': '/bin/bash', 05:08:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uHYbDKB4QP/Listeners', 05:08:32 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 05:08:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:32 INFO - 'USER': 'cltbld', 05:08:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:32 INFO - 'XPC_FLAGS': '0x0', 05:08:32 INFO - 'XPC_SERVICE_NAME': '0', 05:08:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:32 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:32 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 05:08:32 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 05:08:32 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 05:08:32 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 05:08:32 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 05:08:32 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 05:08:35 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:35 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 05:08:35 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 05:08:35 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 05:08:35 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 05:08:35 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 05:08:35 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 05:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:36 INFO - Downloading docopt-0.6.1.tar.gz 05:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:36 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:36 INFO - Running setup.py install for blobuploader 05:08:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:36 INFO - Running setup.py install for requests 05:08:37 INFO - Running setup.py install for docopt 05:08:37 INFO - Successfully installed blobuploader requests docopt 05:08:37 INFO - Cleaning up... 05:08:37 INFO - Return code: 0 05:08:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:37 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 0x10f1f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a147b380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efcfd30>, '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 0x10eef6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc4be8>, '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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 05:08:37 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 05:08:37 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 05:08:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VaLpQUU1UI/Render', 05:08:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:37 INFO - 'HOME': '/Users/cltbld', 05:08:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:37 INFO - 'LOGNAME': 'cltbld', 05:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:37 INFO - 'MOZ_NO_REMOTE': '1', 05:08:37 INFO - 'NO_EM_RESTART': '1', 05:08:37 INFO - 'PAGER': '/bin/cat', 05:08:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:37 INFO - 'PWD': '/builds/slave/test', 05:08:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:37 INFO - 'SHELL': '/bin/bash', 05:08:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uHYbDKB4QP/Listeners', 05:08:37 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 05:08:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:37 INFO - 'USER': 'cltbld', 05:08:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:37 INFO - 'XPC_FLAGS': '0x0', 05:08:37 INFO - 'XPC_SERVICE_NAME': '0', 05:08:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:37 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-Bh6P5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:37 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-HwTL_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:37 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-5O4pce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:38 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-jE21DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:38 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-Cl9lG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:38 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-GKjbTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:38 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-RIpg8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:38 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-0bYIEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:38 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-wFxDOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:38 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-5TdbDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:38 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-YX1tUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:38 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-oBWCOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:38 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-d6TSzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:39 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-FkzOUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:39 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-dvqlXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:39 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-EjqYA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:39 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-W8rEkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:39 INFO - Running setup.py install for manifestparser 05:08:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:39 INFO - Running setup.py install for mozcrash 05:08:39 INFO - Running setup.py install for mozdebug 05:08:39 INFO - Running setup.py install for mozdevice 05:08:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Running setup.py install for mozfile 05:08:40 INFO - Running setup.py install for mozhttpd 05:08:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Running setup.py install for mozinfo 05:08:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Running setup.py install for mozInstall 05:08:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Running setup.py install for mozleak 05:08:40 INFO - Running setup.py install for mozlog 05:08:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Running setup.py install for moznetwork 05:08:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:41 INFO - Running setup.py install for mozprocess 05:08:41 INFO - Running setup.py install for mozprofile 05:08:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:41 INFO - Running setup.py install for mozrunner 05:08:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:41 INFO - Running setup.py install for mozscreenshot 05:08:41 INFO - Running setup.py install for moztest 05:08:41 INFO - Running setup.py install for mozversion 05:08:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:42 INFO - Cleaning up... 05:08:42 INFO - Return code: 0 05:08:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:42 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 0x10f1f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a147b380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efcfd30>, '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 0x10eef6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc4be8>, '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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 05:08:42 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 05:08:42 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 05:08:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VaLpQUU1UI/Render', 05:08:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:42 INFO - 'HOME': '/Users/cltbld', 05:08:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:42 INFO - 'LOGNAME': 'cltbld', 05:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:42 INFO - 'MOZ_NO_REMOTE': '1', 05:08:42 INFO - 'NO_EM_RESTART': '1', 05:08:42 INFO - 'PAGER': '/bin/cat', 05:08:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:42 INFO - 'PWD': '/builds/slave/test', 05:08:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:42 INFO - 'SHELL': '/bin/bash', 05:08:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uHYbDKB4QP/Listeners', 05:08:42 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 05:08:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:42 INFO - 'USER': 'cltbld', 05:08:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:42 INFO - 'XPC_FLAGS': '0x0', 05:08:42 INFO - 'XPC_SERVICE_NAME': '0', 05:08:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:42 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-P5nFI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:42 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)) 05:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:42 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-FiiNkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:42 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)) 05:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:42 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-pi51Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:42 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)) 05:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:42 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-aaZp58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:42 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-gml3in-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:42 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)) 05:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:42 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-4EOLcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:42 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)) 05:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:42 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-knvCAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:43 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)) 05:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-Y43LGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:43 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)) 05:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-5krszR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:43 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)) 05:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-BG2WrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:43 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)) 05:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-QsZonj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:43 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)) 05:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-8MOzcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 05:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-LaCexi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:43 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)) 05:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-eTI83f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:43 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)) 05:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-AmH_fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:43 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)) 05:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:43 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-kq0kRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:44 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)) 05:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:44 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-T81hF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:44 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)) 05:08:44 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)) 05:08:44 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)) 05:08:44 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)) 05:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:47 INFO - Downloading blessings-1.6.tar.gz 05:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:47 INFO - Installing collected packages: blessings 05:08:47 INFO - Running setup.py install for blessings 05:08:47 INFO - Successfully installed blessings 05:08:47 INFO - Cleaning up... 05:08:47 INFO - Return code: 0 05:08:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:47 INFO - Reading from file tmpfile_stdout 05:08:47 INFO - Current package versions: 05:08:47 INFO - blessings == 1.6 05:08:47 INFO - blobuploader == 1.2.4 05:08:47 INFO - docopt == 0.6.1 05:08:47 INFO - functools32 == 3.2.3-2 05:08:47 INFO - jsonschema == 2.5.1 05:08:47 INFO - manifestparser == 1.1 05:08:47 INFO - mozInstall == 1.12 05:08:47 INFO - mozcrash == 1.0 05:08:47 INFO - mozdebug == 0.1 05:08:47 INFO - mozdevice == 0.49 05:08:47 INFO - mozfile == 1.2 05:08:47 INFO - mozhttpd == 0.7 05:08:47 INFO - mozinfo == 0.9 05:08:47 INFO - mozleak == 0.1 05:08:47 INFO - mozlog == 3.4 05:08:47 INFO - moznetwork == 0.27 05:08:47 INFO - mozprocess == 0.24 05:08:47 INFO - mozprofile == 0.28 05:08:47 INFO - mozrunner == 6.13 05:08:47 INFO - mozscreenshot == 0.1 05:08:47 INFO - mozsystemmonitor == 0.3 05:08:47 INFO - moztest == 0.8 05:08:47 INFO - mozversion == 1.4 05:08:47 INFO - psutil == 3.1.1 05:08:47 INFO - requests == 1.2.3 05:08:47 INFO - wsgiref == 0.1.2 05:08:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:48 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 0x10f1f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a147b380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efcfd30>, '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 0x10eef6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc4be8>, '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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 05:08:48 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 05:08:48 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 05:08:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VaLpQUU1UI/Render', 05:08:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:48 INFO - 'HOME': '/Users/cltbld', 05:08:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:48 INFO - 'LOGNAME': 'cltbld', 05:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:48 INFO - 'MOZ_NO_REMOTE': '1', 05:08:48 INFO - 'NO_EM_RESTART': '1', 05:08:48 INFO - 'PAGER': '/bin/cat', 05:08:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:48 INFO - 'PWD': '/builds/slave/test', 05:08:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:48 INFO - 'SHELL': '/bin/bash', 05:08:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uHYbDKB4QP/Listeners', 05:08:48 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 05:08:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:48 INFO - 'USER': 'cltbld', 05:08:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:48 INFO - 'XPC_FLAGS': '0x0', 05:08:48 INFO - 'XPC_SERVICE_NAME': '0', 05:08:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:48 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)) 05:08:48 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)) 05:08:48 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)) 05:08:48 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)) 05:08:48 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)) 05:08:48 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)) 05:08:48 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)) 05:08:48 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)) 05:08:48 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)) 05:08:48 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)) 05:08:48 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)) 05:08:48 INFO - Cleaning up... 05:08:48 INFO - Return code: 0 05:08:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:48 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 0x10f1f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2a147b380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efcfd30>, '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 0x10eef6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc4be8>, '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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 05:08:48 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 05:08:48 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 05:08:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VaLpQUU1UI/Render', 05:08:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:48 INFO - 'HOME': '/Users/cltbld', 05:08:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:48 INFO - 'LOGNAME': 'cltbld', 05:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:48 INFO - 'MOZ_NO_REMOTE': '1', 05:08:48 INFO - 'NO_EM_RESTART': '1', 05:08:48 INFO - 'PAGER': '/bin/cat', 05:08:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:48 INFO - 'PWD': '/builds/slave/test', 05:08:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:48 INFO - 'SHELL': '/bin/bash', 05:08:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uHYbDKB4QP/Listeners', 05:08:48 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 05:08:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:48 INFO - 'USER': 'cltbld', 05:08:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:48 INFO - 'XPC_FLAGS': '0x0', 05:08:48 INFO - 'XPC_SERVICE_NAME': '0', 05:08:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:08:48 INFO - Cleaning up... 05:08:48 INFO - Return code: 0 05:08:48 INFO - Running post-action listener: _resource_record_post_action 05:08:48 INFO - Running post-action listener: _start_resource_monitoring 05:08:48 INFO - Starting resource monitoring. 05:08:48 INFO - [mozharness: 2017-03-27 12:08:48.648272Z] Finished create-virtualenv step (success) 05:08:48 INFO - [mozharness: 2017-03-27 12:08:48.649170Z] Running install step. 05:08:48 INFO - Running pre-action listener: _resource_record_pre_action 05:08:48 INFO - Running main action method: install 05:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:48 INFO - Reading from file tmpfile_stdout 05:08:48 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:49 INFO - Reading from file tmpfile_stdout 05:08:49 INFO - Output received: 05:08:49 INFO - Usage: mozinstall [options] installer 05:08:49 INFO - Options: 05:08:49 INFO - -h, --help show this help message and exit 05:08:49 INFO - -d DEST, --destination=DEST 05:08:49 INFO - Directory to install application into. [default: 05:08:49 INFO - "/builds/slave/test"] 05:08:49 INFO - --app=APP Application being installed. [default: firefox] 05:08:49 INFO - mkdir: /builds/slave/test/build/application 05:08:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 05:09:03 INFO - Reading from file tmpfile_stdout 05:09:03 INFO - Output received: 05:09:03 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:09:03 INFO - Running post-action listener: _resource_record_post_action 05:09:03 INFO - [mozharness: 2017-03-27 12:09:03.512501Z] Finished install step (success) 05:09:03 INFO - [mozharness: 2017-03-27 12:09:03.512659Z] Running run-tests step. 05:09:03 INFO - Running pre-action listener: _resource_record_pre_action 05:09:03 INFO - Running main action method: run_tests 05:09:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:03 INFO - 2017-03-27 05:09:03.526 screenresolution[1625:7476] starting screenresolution argv=screenresolution get 05:09:03 INFO - 2017-03-27 05:09:03.529 screenresolution[1625:7476] Display 0: 1600x1200x32@60 05:09:03 INFO - 2017-03-27 05:09:03.535 screenresolution[1626:7478] starting screenresolution argv=screenresolution list 05:09:03 INFO - Available Modes on Display 0 05:09:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:03 INFO - Intel Iris: 05:09:03 INFO - Chipset Model: Intel Iris 05:09:03 INFO - Type: GPU 05:09:03 INFO - Bus: Built-In 05:09:03 INFO - VRAM (Dynamic, Max): 1536 MB 05:09:03 INFO - Vendor: Intel (0x8086) 05:09:03 INFO - Device ID: 0x0a2e 05:09:03 INFO - Revision ID: 0x0009 05:09:03 INFO - Displays: 05:09:03 INFO - Display: 05:09:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:03 INFO - Display Serial Number: 1600x1200 60 05:09:03 INFO - Main Display: Yes 05:09:03 INFO - Mirror: Off 05:09:03 INFO - Online: Yes 05:09:03 INFO - Rotation: Supported 05:09:03 INFO - Return code: 0 05:09:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:03 INFO - Python 2.7.3 05:09:03 INFO - Return code: 0 05:09:03 INFO - grabbing minidump binary from tooltool 05:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:03 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 0x10efcfd30>, '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 0x10eef6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10efc4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:03 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 05:09:03 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 05:09:03 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 05:09:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:03 INFO - Return code: 0 05:09:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:09:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:09:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:03 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/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0343', '--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 05:09:03 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/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0343 --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 05:09:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VaLpQUU1UI/Render', 05:09:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:03 INFO - 'HOME': '/Users/cltbld', 05:09:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:03 INFO - 'LOGNAME': 'cltbld', 05:09:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:03 INFO - 'MOZ_NO_REMOTE': '1', 05:09:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:03 INFO - 'NO_EM_RESTART': '1', 05:09:03 INFO - 'PAGER': '/bin/cat', 05:09:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:03 INFO - 'PWD': '/builds/slave/test', 05:09:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:03 INFO - 'SHELL': '/bin/bash', 05:09:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uHYbDKB4QP/Listeners', 05:09:03 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 05:09:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:03 INFO - 'USER': 'cltbld', 05:09:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:03 INFO - 'XPC_FLAGS': '0x0', 05:09:03 INFO - 'XPC_SERVICE_NAME': '0', 05:09:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:03 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/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0343', '--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 05:09:04 INFO - mozversion application_buildid: 20170327034016 05:09:04 INFO - mozversion application_changeset: 6188b6cab49e2bfa036b24d8112cda5f5f9416f0 05:09:04 INFO - mozversion application_display_name: Firefox 05:09:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:04 INFO - mozversion application_name: Firefox 05:09:04 INFO - mozversion application_remotingname: firefox 05:09:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:09:04 INFO - mozversion application_vendor: Mozilla 05:09:04 INFO - mozversion application_version: 53.0 05:09:04 INFO - mozversion platform_buildid: 20170327034016 05:09:04 INFO - mozversion platform_changeset: 6188b6cab49e2bfa036b24d8112cda5f5f9416f0 05:09:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:09:04 INFO - mozversion platform_version: 53.0 05:09:04 INFO - using testdate: 1490616544 05:09:04 INFO - actual date: 1490616544 05:09:04 INFO - starting webserver on 'localhost:49240' 05:09:04 INFO - SUITE-START | Running 2 tests 05:09:04 INFO - TEST-START | dromaeo_css 05:09:04 INFO - operating with platform_type : mac_ 05:09:04 INFO - Initialising browser for dromaeo_css test... 05:09:04 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpJci0SF/profile http://localhost:49240/getInfo.html) 05:09:06 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 05:09:06 INFO - PROCESS | 1636 | colorDepth:24 05:09:06 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 05:09:06 INFO - PROCESS | 1636 | __metrics 05:09:06 INFO - PROCESS | 1636 | 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" 05:09:06 INFO - PROCESS | 1636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:09:07 INFO - TEST-INFO | 1636: exit 0 05:09:07 INFO - Browser initialized. 05:09:07 INFO - Running cycle 1/1 for dromaeo_css test... 05:09:07 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpJci0SF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:19 INFO - PROCESS | 1639 | RSS: Main: 163348480 05:09:19 INFO - PROCESS | 1639 | 05:12:21 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 05:12:23 INFO - PROCESS | 1639 | RSS: Main: 322396160 05:12:23 INFO - PROCESS | 1639 | 05:15:26 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 05:15:27 INFO - PROCESS | 1639 | RSS: Main: 307986432 05:15:27 INFO - PROCESS | 1639 | 05:18:29 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 05:18:30 INFO - PROCESS | 1639 | RSS: Main: 301322240 05:18:30 INFO - PROCESS | 1639 | 05:21:32 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 05:21:32 INFO - PROCESS | 1639 | RSS: Main: 287748096 05:21:32 INFO - PROCESS | 1639 | 05:24:36 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 05:24:36 INFO - PROCESS | 1639 | RSS: Main: 271319040 05:24:36 INFO - PROCESS | 1639 | 05:27:40 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 05:27:40 INFO - PROCESS | 1639 | RSS: Main: 333459456 05:27:40 INFO - PROCESS | 1639 | 05:27:40 INFO - PROCESS | 1639 | __start_tp_report 05:27:40 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 05:27:40 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 05:27:40 INFO - PROCESS | 1639 | |i|pagename|runs| 05:27:40 INFO - PROCESS | 1639 | |0;dojo.html;3483.1640406302486;3500.2824420993684;3517.630648781879;3529.6470352964725;3566.680328278537;5924.911126333103;5969.910451343233;5974.402559744023;5985.162077309169;5988.1317209004665;5927.703614819253;5993.46058854703;6013.398660133985;6019.277686677605;6021.036634138539;5355.812546560862;5381.650192737459;5413.729313534327;5420.186971954218;5559.16612508125;4354.804033818486;5058.937623099154;5360.249565060894;5372.758225879845;5481.780728770845;5358.437364076754;5400.216968539559;5416.187571864212;5425;5467.015937131335;5456.072467680504;5463.071277882749;5465.808696695636;5472.644278121949;5475.206095116186;5292.100342941709;5330.813421530228;5371.113766228567;5404.648697834628;5459.972700136514;4869.829555965524;5821.922944255284;5881.529477641779;5922.466977972003;5937.643741375531;6249.218847644044;6304.464120549759;6305.716242769086;6305.747770089191;6308.085327627514;6395.8401039973905;6435.099086127946;6436.967815160941;6439.323870993525;6441.259255185667;5925.081612350093;5975.282966044103;6108.572399932051;6135.417135372132;6185.938140618581;6461;6525.1517302750335;6528.249251336062;6568.343165683394;6572.901406478906;6308.558400911892;6324.08300796382;6337.112804207414;6341.3341599132345;6376.1392212051705;6263.31103578606;6282.2147231596055;6365.713542890581;6429.967850160813;6439.64581947988;6213.782517611862;6254.124422580842;6254.186955695731;6259.71831267594;6278.089676996809;6273.686315684197;6274.152989346471;6284.842878928063;6293.96853015732;6302.65335406557;5095.15929871567;5104;5133.178691409356;5147.382314122255;5169.095408303532;4564.817407303737;4588.518205588432;4591.058832939239;4599.885002874888;4637.25803871379;5013.523715247045;6056.697165141725;6066.3630318815885;6081.422264884829;6087.634741915499;6356.078368636522;6408.775692850728;6409.647469389135;6414.102025716404;6428.260750013715;5175.818846340435;5745.798897038667;5904.527637788967;6057.030875059969;6072.36240194782;5519.641223320471;5576.86057848557;5611.9438805612235;5638.689872056994;5657.632253903483;6576.704048317837;6578.8355291118105;6589.47284217271;6593.505487088583;6598.802035938929;6312.9899216125195;6352.587081839665;6375.968120159369;6386.361363863576;6409.487241020801;6260.436560709558;6318.273398559225;6463.418292353711;6600.438962688226;6603.9009414859775;6296.6851657417865;6306.621602703669;6324.083007963727;6344.333844946399;6345.270293916259;6203.658798766111;6328.367163283635;6346.4605508532295;6348.841278968062;6367.490600751836;6226.875462490815;6266.717997690206;6274.215723034621;6342.9682851587295;6353.523485738496;5551.723103686094;6060.818175454743;6316.652584107918;6327.430531252209;6328.746850125944;6303.6532990685955;6304.3380445054445;6304.495640348853;6309.337519560564;6329.556931014785;6179.351168127461;6242.438180563771;6294.905576416449;6297.118403423616;6323;6112.694365281807;6186.381361863778;6189.938100619116;6205.100260462117;6282.4974002080635 05:27:40 INFO - PROCESS | 1639 | |1;ext.html;463.94664613569427;470.4848191230602;475.9785809638566;496.6275293529853;538.9759457031639;28457.28856778579;42749.35875961859;43726.78136609321;43800.780996095054;45047;43279.35080973788;45486.0902781945;45550;45588;45649.08701825961;9516.6193352266;9731.659391921285;9744.415335079882;9748;9752.024797520262;8857.689980850639;9017.008129105792;9591.280653950947;11762.117841161904;11988.880111198907;9994.500274986258;11807.586734464296;11884.227525210834;11892.821607675893;11915.880841191607;11746.236494627821;11824.586139485076;11850.525978960832;11851.881481185164;11860.940695296511;11706.648800535997;11815.172937894351;11815.763684726257;11820.290782553075;11822.822657660143;33958.15104622379;41725.582744172476;42095;42183.7890810544;42280;4041.555428902818;4055.8174882130374;4096.689059500961;4128.174365126986;4164.7709375984305;30440.391192176034;30558.388832223452;31240;31461.685383146105;32304.35391292161;3268.1176082457605;3337.632860385356;3501.107217659506;3526.2771131917893;3533.240353324022;501370;502390;502484;503341;505469.47265263804;59085.409145907994;59304.40695592989;59458.10812837811;59524;59673.70163149157;58520.70739646274;66092.66953665201;66101.6779664404;66305.00542491867;66432.33567664261;17016.064116473714;17592.472225833244;17613.82386176122;17622.854514456518;17632.735508967377;13424.597262081958;13454.798178027337;13516.729665406638;13518.391672374766;13526;14613.634659133606;14816.407343706347;21936;22818.42953926165;22880.65679014816;8307.712304592798;8598.312135029182;8651.221390074797;9102.635894564275;9340.953295233616;806.5241507510597;858.5449711652834;875.7153924974409;897.5960817632092;917.1516347378648;31039;31771.364572708415;31771.52342714861;31858.840705796785;32411.675883240867;1062.5909025025421;1069.3102948598266;1070.6787963610886;1107.678773155792;1110.1673744691482;15822.208889555477;16267.267972941247;16331.83668163327;16345.509634710977;16703.749443758352;673163.4392796326;679984;680959;681855;683524;63769.68115159395;64044.67977660082;64180.67909660422;64201;64241;1265.5064524835323;1328.0703507544565;1378.076688618628;1442.5744405400642;1493.9327730251948;32109.839450802596;34048.99848535642;34867.302653947285;34949.47575786416;34999.65000350066;67655.66172169305;68253.97619035818;68403;68416.63166736538;68530.3146968524;606590;612148;616718;617836;619153;48793;49159.75420122877;50147;50364;50417.74791126168;54145.45854541404;54244.72877635586;54501.182482262004;55836;56126;35878.92363229107;36100.27799444049;36317.27365452623;37416.62583374132;37780.62219377881;31839.88560400375;35556.28887422289;36188.09529761777;36955.260894781415;38200.853974380814;41844.79077604593;42371.364429534195;42567;43041.784791077094;43476.78261608672;33290.833545832116;36067;36330.636693632725;36616;37047.88856334314;25804.09685660993;27812.721872781014;27867;27931.860340698167;27939 05:27:40 INFO - PROCESS | 1639 | |2;jquery.html;401.92162528306994;406.9532003819561;411.7817556694953;416.9395437661539;435.0559286348623;21114.788852111495;21918.23286184984;22120.557588848213;22349.664755028687;22574.871256437174;22636.88681556594;23587.528249435;23617.763822361772;23820.28539143824;23896.40258993526;5932.436418540232;6211.068339749028;6221.471174950135;6223.813285601439;6228.37716228378;5835.79574714883;6103.6032657877095;6188.319284878659;6190.226221722285;6222.377762223764;5925.140854576084;6155.8768824623485;6157.507399408059;6170.413810687977;6172.475339596117;6156.815295541141;6293.5279854010905;6295.622262664232;6299.5275354348605;6300.21247344082;6023.337432882379;6147.8155655329965;6215.87568248637;6244.063390491463;6251.281102673205;26633.46733065347;26744.86627566869;26746.598801018;26805.195844124708;27080.32299192516;2581.4966081614093;2690.636764036869;2748.931276718078;2751.5735061065566;2754.476649436601;9912.504374781303;10323.38059716412;10642.73393165177;10910.890891091067;10921.508532115995;1605.956128516462;1857.498475411645;1859.8512119030581;1904.6571617108914;1916.281394477071;134651.98022029677;137015;137646;141480;145307.99999999895;12065.879341206475;12135.211211271238;12226.083043771752;12266.632001039983;12447.626571202878;16437.917810410872;16446.506604801874;16447.342106315613;16487.17564121789;16519.752203716955;8782.956085219661;8911.73264802057;9045.77385565353;9169.954150229207;9176.08239176077;7314.670839812221;8848.336374771918;8855.424397414148;8869.778255543662;9041.728748137566;4819.7108173509005;4954.108260513142;4958.305837182797;4980.676256043418;4993.675411098267;1749.1382502920037;1812.4834422189613;2018.162462578043;2029.1883246701439;2063.4531849060013;997.4264797741328;1026.2918586175515;1052.910502607287;1057.3285963413289;1087.6030248959073;21557.353279401643;22238.777612223996;23029.387942844176;23361.532769344856;23413.882930585238;1010.5048526222246;1075.1291453922347;1078.8112080385902;1108.51225460797;1115.59838458155;11165.72085697864;11259.380734059541;11883.287002779687;12124.515019399125;12126.27242365461;658229;760966;762694;769882;794014;150924;153294;153844;155219;159481.20259398862;879.3361012435698;985.9654912078042;1050.9264351495322;1086.5490821309227;1088.3469918049107;18653.974031428403;20139.97472262288;20987.160513579285;21391.572168556853;21754.782452175277;54658;60695.69652151711;63183.6840815793;64249.67875160594;65213.10901682298;92985.35073246446;93165.5341723287;96185;97392.51303743436;97999;8519.744407667531;8563.57182140878;8668.30653547702;8786.428882122642;8908.465492070496;9249.398789078688;11460;12482.126251162332;12723.491060357483;13294.335283235607;11629.24409913353;11848.52605895789;11891.76216475683;12002.1598488105;12034.63896083119;9446.669366572138;10835.891641083488;10948.671539853816;11193.888061119285;11197.72005699864;11710.882891170979;11722.413879306172;11775.23460975034;11968.76062478763;12176.75646487083;8292.543910085004;8419.70531031411;8783.385163038525;8799.208071273617;8966.955165224132;10376.584936602452;10711.785764284827;11211.775764484828;11320.509552867017;12044.277343359427 05:27:40 INFO - PROCESS | 1639 | |3;mootools.html;1433.9928300358497;1465.0843222985634;1482.4366740638557;1492.7835463857741;1500.9624759381013;8211.466254693441;8593.097724738898;8594.742157735262;8606.225439710424;8608.397412181133;7530.887036694454;7785.416093792974;8242.752717418487;8442.957785211065;8468;2374.050379848057;2401.9639705404347;2409.590369637166;2410.734819169899;2411.4694767151286;2405.3505553500545;2423.4789520253144;2438.792702620279;2442.743511931248;2445.303088619744;2389.7251816041203;2391.5575618510543;2406.89168987396;2414.1550457339877;2419.1412048722714;2375.0618505690154;2377.2155188787747;2399.7360290368047;2401.2556107606697;2401.3516350585246;2399.5081008393236;2401.6157414813547;2424.0303878448585;2424.5514579802793;2429.356220601542;8571.742847714579;8572.957135214285;8627.396082274181;8657.740267791976;8689.608967596474;5205.193195054772;5356.223347614613;5362.436944120889;5371.919421208685;5371.9524692684945;3544.0608238816735;3599.31612993533;3674.375356189454;3705.0922523981526;3721;1259.4521383198337;1262.9557965471165;1286.7683816912952;1317.7891537353978;1326.1313839435186;11094.833577496343;11147.442627868655;11151.944240278828;11153.944230278797;11164.776704465947;4355.5408938005485;4358.779541728321;4661.790219440133;4807.6298254997155;4888.437829649564;8821.647134114564;9154.40496367734;9690.176335011603;9727.464989425649;9740.269479788902;5415.891682166334;5429.4027656957705;5431.619786614899;5436.130219164915;5438.483344082306;4500.4149460569915;4570.223062079454;4933.45731969483;4968.677035992649;4983.277424773388;3904.9804750976064;3989.401589761501;4021.3163762160502;4045.6763458923215;4065.8170382332864;1306.1248963194682;1306.5296493262417;1308.9018323625767;1315.684235783405;1322.9404676789568;929.3169520402499;936.639393833379;956.8229877472689;956.9377990430739;1001.5042553935848;5633.492985631313;5740.368559458456;5898.705064746746;5987.191729116601;5989.2812862456785;924.191332583989;973.7711637765119;976.545906153642;1009.258195226508;1060.8726952765562;3835.1179228777537;3835.8657446989223;3913.7847418391693;3922.7254092213843;4040.6565441937178;9981.80036399268;10414.218933580012;10427.478626068667;10444.164466842634;10445;10409.583616655249;10412.843807342895;10427.530761115768;10432.634857779942;10440.947795260976;7732.806679833049;7990.320822730133;8201.425900187049;8203.71287004964;8204.671813127408;5675.460831221028;5682.744276507485;5686.886262274648;5768.423157684198;5870.26621672291;9373.578188981375;9496.382735122195;9502.714918552454;9515.238780897651;9517.619295228113;9447.102525260088;9480.051994800464;9524;9628.66299679508;9783.82594088714;6448.580842245239;6613.206415230203;6625.834354141185;6868.347506986828;7009.894851577128;5708.343540492897;6554.606723596599;7731.729389471341;7764.184760600281;7794.337481314152;6856.828579285558;7092.361687448154;7165.068541089625;7165.319294666998;7263.963680181565;7035.261297563887;7065.258147894397;7066.7173313066905;7075.221725610076;7133.82165445868;6414.807555773335;6470.7088181032905;6560.507961902781;6562.048502967138;6565.409113179646;5064.316317297265;5097.515736005073;5113.539781419541;5163.173892177234;5184.637075404686;5018.322526458881;5056.949430505648;5135.8716032098;5209.739513024258;5317.654352467077 05:27:40 INFO - PROCESS | 1639 | |4;prototype.html;333.39156040226584;365.8719448193133;378.61192277915126;383.4057211322451;384.58464857953413;5388.649737767042;5446.91829622556;5469.718169098539;5475.083720697754;5493.176023596463;4657.115148121855;5004.374453193351;5186.299849520314;5203.245529398235;5285.709285989269;3725.993981624953;4243.880747650474;4293.613574778269;4300.451837338555;4333.934990975138;3757.3424650686156;3900.921981560367;4258.936115958263;4284.700070995032;4343.979164896246;3463.636318186592;3585.318789430013;3917.8442359504015;4246.9150616987645;4272.786360681969;4105.809315298589;4117.094239267356;4118.711690181688;4119.567445418233;4155.459790227266;3578.5526809148855;3578.7653259625386;3581.301646178996;3586.444101164324;3616.8914932552066;4396.868093957187;4975;5233.476652334774;5255.474452554752;5272.499112584298;4641.976790116028;4695.765211739399;4698.459677137139;4703.341532185463;4734.076855013273;5369.630744160253;5402.78388864445;5751.424857514257;5781.421857814227;5788.247527821356;3402.1664692150334;3894.357431023878;3921.725479216456;3939.5075615548058;4002.6791158917486;5070.391553013662;5150.407703114152;5217.3391570299045;5619.73555949912;5989.670568118751;3460.740444466675;3643.0892276930767;3731.962680373216;3961.841526338972;3966.3852102924093;3788.8254641060807;3984.6613037891525;4018.216447792652;4030.3349947258375;4032.677385809187;3757.4551690004796;4041.6968727345566;4552.861784553862;4703.071740586343;4713.95286047142;4717.127331443694;5549.445055494499;5666.378720620758;5750.2524671793235;5803.245578074823;1149.0348107589664;1232.6610182199968;1281.6603600045996;1307.2352324362225;1311.341153440898;762.6568044380051;853.317346123099;874.6457684637732;886.4371124335964;891.5809569502323;4904.288878112654;4916.459189489154;4920.4833492483485;4952.870265785747;4969.82605608802;4982.451930287665;5500.339959204921;5504.101085125625;5559.6664200148125;5563.9969610940025;4808.567228949341;4995.450500444948;5007.472720820112;5024.698518088926;5119.59043276537;2558.1685952065654;2606.9348266293496;2691.757741803247;2885.7258560436726;2912.286489809968;5031.597472202215;5163.741812909339;5386.299781028441;5647.983362994701;5802.738876750556;4933.950660493421;4951.430585482643;5340.385855626652;5675.716214189274;5762.3577280474865;4991.975040124777;5341.893162136736;5714.314282286152;5764.27946506695;5769.423057694197;4912.680675756064;4959.479254678206;4967.627427942991;5100.821471248637;5237.450067742984;4993.101241776515;5542.75057622416;5551.361593416808;5596.580256480699;5599.496045355938;5636.4927156556105;5691.459311365414;5762.262925110706;5786.495511167042;5826.659868230246;3294.912678815937;3390.08467713711;3737.177820879402;3745.1162604793612;3888.8833334999995;4725.173094708481;4912.091263116335;5326.881354915511;5865.50429640439;5896.469317761422;5181.430042695376;5476.959377718221;5717.285339332583;5726.885462290814;5741.942580574141;5229.529342359054;5392.325959255093;5647.237622921018;5715.799947001835;5810.215620891126;5409.756560954688;5573.916391254215;5620.803271885465;5635.690037048002;5649.3220813501;5427.402985671652;5621.634593751393;5652.378238393856;5661.264035675335;5696.297406685688;5055;5091.872703182302;5445.945540544544;5550.833474995757;5574.386817450159 05:27:40 INFO - PROCESS | 1639 | |5;yui.html;744.616522490917;764.6711913877031;794.9443538952272;860.857958436858;873.3144481581958;15327.846721532795;16009;16044.438444654439;16057.839421605795;16082.91958540207;14478.782818257734;14719.558413247592;14753.409863605442;14853.851461485381;14925.92537037316;709.9006139140524;731.078840660766;896.9730908072752;901.5266984832949;904.0101089307198;890.536920801183;913.3378300731949;913.5980168725773;915.3180880244228;915.8534634458488;954.3987288008545;965.2471072563412;966.7293157915794;967.6129548180713;970.2044323654607;958.0706714486937;958.9568469418892;960.6301573894032;960.8750862387915;966.8163049020663;714.5319815520791;717.096458462336;718.3427164144802;722.2741145149145;722.8951801988735;15761.448349307719;16047.03717776937;16106.919465402716;16156.75764863528;16394.508164755076;14930.776038359434;15137.016093953858;15416.22918854064;15520.301586428637;15646.452374166849;11722.706932326675;11747.588834390841;11979.700507487383;12125.151239413244;12526.624201273977;3911.8239679214503;3962.1679447316096;3963.7819919904396;4107.609777071173;4134.090500089976;108425.99999999921;109955;110485;111533;112571;10183.18534517237;11470.541178352772;11471;11659;11889.167758257012;21460.14159433605;22207.333779986628;22235.666465003036;23089.7691023091;23104.422389440064;7002.3697867192195;7429;7533.8116547086765;7622.399296147871;7718.459707820399;4022.6710655300976;4128.091819799639;4139.648129908931;4145.3781932709735;4198.832046718097;3702.1114932416026;3728.366177749789;3951.8616848410165;4125.752454852658;4129.380592911088;720.0854914258862;735.7682330066012;737.2627372627372;745.0947099274408;756.9053868266467;537.7983256278895;548.4159370270648;548.7777450132703;551.2172714745071;557.9825258141398;10198.388096714221;10229.488525573692;10852.077573406192;10873.565057397775;11017.008469237808;659.1360538460477;673.188807486977;682.0144890632988;723.4140346319498;741.8405042915799;4981.103401387785;5083.949160508348;5129.333186685707;5142.845714628567;5149.253358263031;110101;112289;112349.06778262721;112351.3147302791;114208;64894.67552662301;80606;81245;81848.36303273901;84831;85613.57193213994;85864.14135858686;86626.56686716778;87134.99999999873;89909;9918.504074796376;10036.749081273027;10041.447720375449;10051;10055.899441005497;46248;46966.530334697585;55543.44456555383;55736.44263557475;58793.11810322763;73203.26796731964;73351.66483351622;74543.62728186324;75490.73527794176;76902.61548692221;11345.659630211107;11455.656330310105;11588.188826782045;12199.634010979686;12370.44333005035;12695.047871409497;13225.470981160646;13273.788599691921;13367.933160334136;13434.462621495031;12252.448639811408;12264.877351226374;12557.686057848627;12664.746705065663;13092;11732.530698772294;12325.445354958869;12378.381080946097;12441.813372799234;12448.688782780502;11695.941520292345;12185.086118541321;12201.633950981484;12481.001519878206;12577.575096659284;8665.870011949952;8696.956515217384;9204.079592041011;9306.581203845708;9587.472689002172;9869.085589463339;10135.034280994767;10343.224258180517;10418;10489.685309440729 05:27:40 INFO - PROCESS | 1639 | __end_tp_report 05:27:40 INFO - PROCESS | 1639 | __start_cc_report 05:27:40 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1566 05:27:40 INFO - PROCESS | 1639 | __end_cc_report 05:27:40 INFO - PROCESS | 1639 | __startTimestamp1490617660493__endTimestamp 05:27:40 INFO - PROCESS | 1639 | 05:27:40 INFO - PROCESS | 1639 | ------- Summary: start ------- 05:27:40 INFO - PROCESS | 1639 | Number of tests: 6 05:27:40 INFO - PROCESS | 1639 | 05:27:40 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5913.28 Median:6205.10 stddev:656.92 (10.6%) stddev-sans-first:630.67 05:27:40 INFO - PROCESS | 1639 | Values: 3483.2 3500.3 3517.6 3529.6 3566.7 5924.9 5969.9 5974.4 5985.2 5988.1 5927.7 5993.5 6013.4 6019.3 6021.0 5355.8 5381.7 5413.7 5420.2 5559.2 4354.8 5058.9 5360.2 5372.8 5481.8 5358.4 5400.2 5416.2 5425.0 5467.0 5456.1 5463.1 5465.8 5472.6 5475.2 5292.1 5330.8 5371.1 5404.6 5460.0 4869.8 5821.9 5881.5 5922.5 5937.6 6249.2 6304.5 6305.7 6305.7 6308.1 6395.8 6435.1 6437.0 6439.3 6441.3 5925.1 5975.3 6108.6 6135.4 6185.9 6461.0 6525.2 6528.2 6568.3 6572.9 6308.6 6324.1 6337.1 6341.3 6376.1 6263.3 6282.2 6365.7 6430.0 6439.6 6213.8 6254.1 6254.2 6259.7 6278.1 6273.7 6274.2 6284.8 6294.0 6302.7 5095.2 5104.0 5133.2 5147.4 5169.1 4564.8 4588.5 4591.1 4599.9 4637.3 5013.5 6056.7 6066.4 6081.4 6087.6 6356.1 6408.8 6409.6 6414.1 6428.3 5175.8 5745.8 5904.5 6057.0 6072.4 5519.6 5576.9 5611.9 5638.7 5657.6 6576.7 6578.8 6589.5 6593.5 6598.8 6313.0 6352.6 6376.0 6386.4 6409.5 6260.4 6318.3 6463.4 6600.4 6603.9 6296.7 6306.6 6324.1 6344.3 6345.3 6203.7 6328.4 6346.5 6348.8 6367.5 6226.9 6266.7 6274.2 6343.0 6353.5 5551.7 6060.8 6316.7 6327.4 6328.7 6303.7 6304.3 6304.5 6309.3 6329.6 6179.4 6242.4 6294.9 6297.1 6323.0 6112.7 6186.4 6189.9 6205.1 6282.5 05:27:40 INFO - PROCESS | 1639 | 05:27:40 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:75067.36 Median:4112.43 stddev:161083.69 (3917.0%) stddev-sans-first:161438.19 05:27:40 INFO - PROCESS | 1639 | Values: 463.9 470.5 476.0 496.6 539.0 28457.3 42749.4 43726.8 43800.8 45047.0 43279.4 45486.1 45550.0 45588.0 45649.1 9516.6 9731.7 9744.4 9748.0 9752.0 8857.7 9017.0 9591.3 11762.1 11988.9 9994.5 11807.6 11884.2 11892.8 11915.9 11746.2 11824.6 11850.5 11851.9 11860.9 11706.6 11815.2 11815.8 11820.3 11822.8 33958.2 41725.6 42095.0 42183.8 42280.0 4041.6 4055.8 4096.7 4128.2 4164.8 30440.4 30558.4 31240.0 31461.7 32304.4 3268.1 3337.6 3501.1 3526.3 3533.2 501370.0 502390.0 502484.0 503341.0 505469.5 59085.4 59304.4 59458.1 59524.0 59673.7 58520.7 66092.7 66101.7 66305.0 66432.3 17016.1 17592.5 17613.8 17622.9 17632.7 13424.6 13454.8 13516.7 13518.4 13526.0 14613.6 14816.4 21936.0 22818.4 22880.7 8307.7 8598.3 8651.2 9102.6 9341.0 806.5 858.5 875.7 897.6 917.2 31039.0 31771.4 31771.5 31858.8 32411.7 1062.6 1069.3 1070.7 1107.7 1110.2 15822.2 16267.3 16331.8 16345.5 16703.7 673163.4 679984.0 680959.0 681855.0 683524.0 63769.7 64044.7 64180.7 64201.0 64241.0 1265.5 1328.1 1378.1 1442.6 1493.9 32109.8 34049.0 34867.3 34949.5 34999.7 67655.7 68254.0 68403.0 68416.6 68530.3 606590.0 612148.0 616718.0 617836.0 619153.0 48793.0 49159.8 50147.0 50364.0 50417.7 54145.5 54244.7 54501.2 55836.0 56126.0 35878.9 36100.3 36317.3 37416.6 37780.6 31839.9 35556.3 36188.1 36955.3 38200.9 41844.8 42371.4 42567.0 43041.8 43476.8 33290.8 36067.0 36330.6 36616.0 37047.9 25804.1 27812.7 27867.0 27931.9 27939.0 05:27:40 INFO - PROCESS | 1639 | 05:27:40 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:41801.53 Median:23602.65 stddev:125219.41 (530.5%) stddev-sans-first:125532.09 05:27:40 INFO - PROCESS | 1639 | Values: 401.9 407.0 411.8 416.9 435.1 21114.8 21918.2 22120.6 22349.7 22574.9 22636.9 23587.5 23617.8 23820.3 23896.4 5932.4 6211.1 6221.5 6223.8 6228.4 5835.8 6103.6 6188.3 6190.2 6222.4 5925.1 6155.9 6157.5 6170.4 6172.5 6156.8 6293.5 6295.6 6299.5 6300.2 6023.3 6147.8 6215.9 6244.1 6251.3 26633.5 26744.9 26746.6 26805.2 27080.3 2581.5 2690.6 2748.9 2751.6 2754.5 9912.5 10323.4 10642.7 10910.9 10921.5 1606.0 1857.5 1859.9 1904.7 1916.3 134652.0 137015.0 137646.0 141480.0 145308.0 12065.9 12135.2 12226.1 12266.6 12447.6 16437.9 16446.5 16447.3 16487.2 16519.8 8783.0 8911.7 9045.8 9170.0 9176.1 7314.7 8848.3 8855.4 8869.8 9041.7 4819.7 4954.1 4958.3 4980.7 4993.7 1749.1 1812.5 2018.2 2029.2 2063.5 997.4 1026.3 1052.9 1057.3 1087.6 21557.4 22238.8 23029.4 23361.5 23413.9 1010.5 1075.1 1078.8 1108.5 1115.6 11165.7 11259.4 11883.3 12124.5 12126.3 658229.0 760966.0 762694.0 769882.0 794014.0 150924.0 153294.0 153844.0 155219.0 159481.2 879.3 986.0 1050.9 1086.5 1088.3 18654.0 20140.0 20987.2 21391.6 21754.8 54658.0 60695.7 63183.7 64249.7 65213.1 92985.4 93165.5 96185.0 97392.5 97999.0 8519.7 8563.6 8668.3 8786.4 8908.5 9249.4 11460.0 12482.1 12723.5 13294.3 11629.2 11848.5 11891.8 12002.2 12034.6 9446.7 10835.9 10948.7 11193.9 11197.7 11710.9 11722.4 11775.2 11968.8 12176.8 8292.5 8419.7 8783.4 8799.2 8967.0 10376.6 10711.8 11211.8 11320.5 12044.3 05:27:40 INFO - PROCESS | 1639 | 05:27:40 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5552.20 Median:5207.47 stddev:2995.27 (57.5%) stddev-sans-first:2987.68 05:27:40 INFO - PROCESS | 1639 | Values: 1434.0 1465.1 1482.4 1492.8 1501.0 8211.5 8593.1 8594.7 8606.2 8608.4 7530.9 7785.4 8242.8 8443.0 8468.0 2374.1 2402.0 2409.6 2410.7 2411.5 2405.4 2423.5 2438.8 2442.7 2445.3 2389.7 2391.6 2406.9 2414.2 2419.1 2375.1 2377.2 2399.7 2401.3 2401.4 2399.5 2401.6 2424.0 2424.6 2429.4 8571.7 8573.0 8627.4 8657.7 8689.6 5205.2 5356.2 5362.4 5371.9 5372.0 3544.1 3599.3 3674.4 3705.1 3721.0 1259.5 1263.0 1286.8 1317.8 1326.1 11094.8 11147.4 11151.9 11153.9 11164.8 4355.5 4358.8 4661.8 4807.6 4888.4 8821.6 9154.4 9690.2 9727.5 9740.3 5415.9 5429.4 5431.6 5436.1 5438.5 4500.4 4570.2 4933.5 4968.7 4983.3 3905.0 3989.4 4021.3 4045.7 4065.8 1306.1 1306.5 1308.9 1315.7 1322.9 929.3 936.6 956.8 956.9 1001.5 5633.5 5740.4 5898.7 5987.2 5989.3 924.2 973.8 976.5 1009.3 1060.9 3835.1 3835.9 3913.8 3922.7 4040.7 9981.8 10414.2 10427.5 10444.2 10445.0 10409.6 10412.8 10427.5 10432.6 10440.9 7732.8 7990.3 8201.4 8203.7 8204.7 5675.5 5682.7 5686.9 5768.4 5870.3 9373.6 9496.4 9502.7 9515.2 9517.6 9447.1 9480.1 9524.0 9628.7 9783.8 6448.6 6613.2 6625.8 6868.3 7009.9 5708.3 6554.6 7731.7 7764.2 7794.3 6856.8 7092.4 7165.1 7165.3 7264.0 7035.3 7065.3 7066.7 7075.2 7133.8 6414.8 6470.7 6560.5 6562.0 6565.4 5064.3 5097.5 5113.5 5163.2 5184.6 5018.3 5056.9 5135.9 5209.7 5317.7 05:27:40 INFO - PROCESS | 1639 | 05:27:40 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4506.64 Median:4999.91 stddev:1366.13 (27.3%) stddev-sans-first:1333.57 05:27:40 INFO - PROCESS | 1639 | Values: 333.4 365.9 378.6 383.4 384.6 5388.6 5446.9 5469.7 5475.1 5493.2 4657.1 5004.4 5186.3 5203.2 5285.7 3726.0 4243.9 4293.6 4300.5 4333.9 3757.3 3900.9 4258.9 4284.7 4344.0 3463.6 3585.3 3917.8 4246.9 4272.8 4105.8 4117.1 4118.7 4119.6 4155.5 3578.6 3578.8 3581.3 3586.4 3616.9 4396.9 4975.0 5233.5 5255.5 5272.5 4642.0 4695.8 4698.5 4703.3 4734.1 5369.6 5402.8 5751.4 5781.4 5788.2 3402.2 3894.4 3921.7 3939.5 4002.7 5070.4 5150.4 5217.3 5619.7 5989.7 3460.7 3643.1 3732.0 3961.8 3966.4 3788.8 3984.7 4018.2 4030.3 4032.7 3757.5 4041.7 4552.9 4703.1 4714.0 4717.1 5549.4 5666.4 5750.3 5803.2 1149.0 1232.7 1281.7 1307.2 1311.3 762.7 853.3 874.6 886.4 891.6 4904.3 4916.5 4920.5 4952.9 4969.8 4982.5 5500.3 5504.1 5559.7 5564.0 4808.6 4995.5 5007.5 5024.7 5119.6 2558.2 2606.9 2691.8 2885.7 2912.3 5031.6 5163.7 5386.3 5648.0 5802.7 4934.0 4951.4 5340.4 5675.7 5762.4 4992.0 5341.9 5714.3 5764.3 5769.4 4912.7 4959.5 4967.6 5100.8 5237.5 4993.1 5542.8 5551.4 5596.6 5599.5 5636.5 5691.5 5762.3 5786.5 5826.7 3294.9 3390.1 3737.2 3745.1 3888.9 4725.2 4912.1 5326.9 5865.5 5896.5 5181.4 5477.0 5717.3 5726.9 5741.9 5229.5 5392.3 5647.2 5715.8 5810.2 5409.8 5573.9 5620.8 5635.7 5649.3 5427.4 5621.6 5652.4 5661.3 5696.3 5055.0 5091.9 5445.9 5550.8 5574.4 05:27:40 INFO - PROCESS | 1639 | 05:27:40 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:21045.16 Median:4116.68 stddev:30881.34 (750.2%) stddev-sans-first:30930.35 05:27:40 INFO - PROCESS | 1639 | Values: 744.6 764.7 794.9 860.9 873.3 15327.8 16009.0 16044.4 16057.8 16082.9 14478.8 14719.6 14753.4 14853.9 14925.9 709.9 731.1 897.0 901.5 904.0 890.5 913.3 913.6 915.3 915.9 954.4 965.2 966.7 967.6 970.2 958.1 959.0 960.6 960.9 966.8 714.5 717.1 718.3 722.3 722.9 15761.4 16047.0 16106.9 16156.8 16394.5 14930.8 15137.0 15416.2 15520.3 15646.5 11722.7 11747.6 11979.7 12125.2 12526.6 3911.8 3962.2 3963.8 4107.6 4134.1 108426.0 109955.0 110485.0 111533.0 112571.0 10183.2 11470.5 11471.0 11659.0 11889.2 21460.1 22207.3 22235.7 23089.8 23104.4 7002.4 7429.0 7533.8 7622.4 7718.5 4022.7 4128.1 4139.6 4145.4 4198.8 3702.1 3728.4 3951.9 4125.8 4129.4 720.1 735.8 737.3 745.1 756.9 537.8 548.4 548.8 551.2 558.0 10198.4 10229.5 10852.1 10873.6 11017.0 659.1 673.2 682.0 723.4 741.8 4981.1 5083.9 5129.3 5142.8 5149.3 110101.0 112289.0 112349.1 112351.3 114208.0 64894.7 80606.0 81245.0 81848.4 84831.0 85613.6 85864.1 86626.6 87135.0 89909.0 9918.5 10036.7 10041.4 10051.0 10055.9 46248.0 46966.5 55543.4 55736.4 58793.1 73203.3 73351.7 74543.6 75490.7 76902.6 11345.7 11455.7 11588.2 12199.6 12370.4 12695.0 13225.5 13273.8 13367.9 13434.5 12252.4 12264.9 12557.7 12664.7 13092.0 11732.5 12325.4 12378.4 12441.8 12448.7 11695.9 12185.1 12201.6 12481.0 12577.6 8665.9 8697.0 9204.1 9306.6 9587.5 9869.1 10135.0 10343.2 10418.0 10489.7 05:27:40 INFO - PROCESS | 1639 | -------- Summary: end -------- 05:27:40 INFO - PROCESS | 1639 | 05:27:41 INFO - TEST-INFO | 1639: exit 0 05:27:41 INFO - TEST-OK | dromaeo_css | took 1117007ms 05:27:41 INFO - TEST-START | kraken 05:27:41 INFO - operating with platform_type : mac_ 05:27:41 INFO - Initialising browser for kraken test... 05:27:41 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmp7cxPvY/profile http://localhost:49240/getInfo.html) 05:27:43 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 05:27:43 INFO - PROCESS | 1648 | colorDepth:24 05:27:43 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 05:27:43 INFO - PROCESS | 1648 | __metrics 05:27:43 INFO - PROCESS | 1648 | 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" 05:27:43 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:27:43 INFO - TEST-INFO | 1648: exit 0 05:27:43 INFO - Browser initialized. 05:27:43 INFO - Running cycle 1/1 for kraken test... 05:27:43 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmp7cxPvY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:55 INFO - PROCESS | 1650 | RSS: Main: 163696640 05:27:55 INFO - PROCESS | 1650 | 05:27:58 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:59 INFO - PROCESS | 1650 | RSS: Main: 214589440 05:27:59 INFO - PROCESS | 1650 | 05:28:01 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 05:28:02 INFO - PROCESS | 1650 | RSS: Main: 228679680 05:28:02 INFO - PROCESS | 1650 | 05:28:05 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 05:28:06 INFO - PROCESS | 1650 | RSS: Main: 327622656 05:28:06 INFO - PROCESS | 1650 | 05:28:08 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 05:28:08 INFO - PROCESS | 1650 | RSS: Main: 228700160 05:28:08 INFO - PROCESS | 1650 | 05:28:10 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:11 INFO - PROCESS | 1650 | RSS: Main: 231407616 05:28:11 INFO - PROCESS | 1650 | 05:28:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:14 INFO - PROCESS | 1650 | RSS: Main: 270532608 05:28:14 INFO - PROCESS | 1650 | 05:28:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:18 INFO - PROCESS | 1650 | RSS: Main: 273121280 05:28:18 INFO - PROCESS | 1650 | 05:28:21 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 05:28:21 INFO - PROCESS | 1650 | RSS: Main: 271183872 05:28:21 INFO - PROCESS | 1650 | 05:28:23 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:23 INFO - PROCESS | 1650 | RSS: Main: 245055488 05:28:23 INFO - PROCESS | 1650 | 05:28:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:26 INFO - PROCESS | 1650 | RSS: Main: 247603200 05:28:26 INFO - PROCESS | 1650 | 05:28:28 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:28:29 INFO - PROCESS | 1650 | RSS: Main: 251920384 05:28:29 INFO - PROCESS | 1650 | 05:28:31 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:32 INFO - PROCESS | 1650 | RSS: Main: 259272704 05:28:32 INFO - PROCESS | 1650 | 05:28:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:36 INFO - PROCESS | 1650 | RSS: Main: 261111808 05:28:36 INFO - PROCESS | 1650 | 05:28:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 05:28:38 INFO - PROCESS | 1650 | RSS: Main: 305278976 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | __start_tp_report 05:28:38 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 05:28:38 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 05:28:38 INFO - PROCESS | 1650 | |i|pagename|runs| 05:28:38 INFO - PROCESS | 1650 | |0;ai-astar;102;112;113;114;113;111;104;113;112;113 05:28:38 INFO - PROCESS | 1650 | |1;audio-beat-detection;142;110;131;173;139;107;107;106;124;110 05:28:38 INFO - PROCESS | 1650 | |2;audio-dft;183;184;181;181;183;180;183;182;183;184 05:28:38 INFO - PROCESS | 1650 | |3;audio-fft;79;58;59;89;59;59;57;61;74;57 05:28:38 INFO - PROCESS | 1650 | |4;audio-oscillator;88;69;87;94;96;99;89;67;68;81 05:28:38 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;88;85;88;85;88;84;89;85;87;84 05:28:38 INFO - PROCESS | 1650 | |6;imaging-darkroom;93;93;93;93;92;93;93;94;93;93 05:28:38 INFO - PROCESS | 1650 | |7;imaging-desaturate;86;88;86;87;88;86;87;86;87;86 05:28:38 INFO - PROCESS | 1650 | |8;json-parse-financial;55;53;52;51;54;56;55;55;56;54 05:28:38 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;63;67;74;74;71;68;69;69;68;69 05:28:38 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;83;83;84;83;82;83;81;81;85;88 05:28:38 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;127;146;142;123;130;131;144;139;152;142 05:28:38 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;165;160;205;160;162;161;163;161;161;216 05:28:38 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;65;64;64;64;66;62;63;63;62;62 05:28:38 INFO - PROCESS | 1650 | __end_tp_report 05:28:38 INFO - PROCESS | 1650 | __start_cc_report 05:28:38 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1915 05:28:38 INFO - PROCESS | 1650 | __end_cc_report 05:28:38 INFO - PROCESS | 1650 | __startTimestamp1490617718027__endTimestamp 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | ------- Summary: start ------- 05:28:38 INFO - PROCESS | 1650 | Number of tests: 14 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:110.70 Median:113.00 stddev:4.16 (3.7%) stddev-sans-first:3.00 05:28:38 INFO - PROCESS | 1650 | Values: 102.0 112.0 113.0 114.0 113.0 111.0 104.0 113.0 112.0 113.0 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:124.90 Median:127.50 stddev:21.82 (17.1%) stddev-sans-first:22.25 05:28:38 INFO - PROCESS | 1650 | Values: 142.0 110.0 131.0 173.0 139.0 107.0 107.0 106.0 124.0 110.0 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:182.40 Median:183.00 stddev:1.35 (0.7%) stddev-sans-first:1.41 05:28:38 INFO - PROCESS | 1650 | Values: 183.0 184.0 181.0 181.0 183.0 180.0 183.0 182.0 183.0 184.0 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:65.20 Median:60.00 stddev:11.32 (18.9%) stddev-sans-first:10.85 05:28:38 INFO - PROCESS | 1650 | Values: 79.0 58.0 59.0 89.0 59.0 59.0 57.0 61.0 74.0 57.0 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:83.80 Median:88.50 stddev:12.01 (13.6%) stddev-sans-first:12.64 05:28:38 INFO - PROCESS | 1650 | Values: 88.0 69.0 87.0 94.0 96.0 99.0 89.0 67.0 68.0 81.0 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.50 stddev:1.89 (2.2%) stddev-sans-first:1.90 05:28:38 INFO - PROCESS | 1650 | Values: 88.0 85.0 88.0 85.0 88.0 84.0 89.0 85.0 87.0 84.0 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 05:28:38 INFO - PROCESS | 1650 | Values: 93.0 93.0 93.0 93.0 92.0 93.0 93.0 94.0 93.0 93.0 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:87.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 05:28:38 INFO - PROCESS | 1650 | Values: 86.0 88.0 86.0 87.0 88.0 86.0 87.0 86.0 87.0 86.0 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:55.00 stddev:1.66 (3.0%) stddev-sans-first:1.73 05:28:38 INFO - PROCESS | 1650 | Values: 55.0 53.0 52.0 51.0 54.0 56.0 55.0 55.0 56.0 54.0 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:3.26 (4.7%) stddev-sans-first:2.57 05:28:38 INFO - PROCESS | 1650 | Values: 63.0 67.0 74.0 74.0 71.0 68.0 69.0 69.0 68.0 69.0 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:2.06 (2.5%) stddev-sans-first:2.18 05:28:38 INFO - PROCESS | 1650 | Values: 83.0 83.0 84.0 83.0 82.0 83.0 81.0 81.0 85.0 88.0 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:142.00 stddev:9.35 (6.6%) stddev-sans-first:9.09 05:28:38 INFO - PROCESS | 1650 | Values: 127.0 146.0 142.0 123.0 130.0 131.0 144.0 139.0 152.0 142.0 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:162.50 stddev:20.82 (12.8%) stddev-sans-first:21.96 05:28:38 INFO - PROCESS | 1650 | Values: 165.0 160.0 205.0 160.0 162.0 161.0 163.0 161.0 161.0 216.0 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.35 (2.1%) stddev-sans-first:1.32 05:28:38 INFO - PROCESS | 1650 | Values: 65.0 64.0 64.0 64.0 66.0 62.0 63.0 63.0 62.0 62.0 05:28:38 INFO - PROCESS | 1650 | -------- Summary: end -------- 05:28:38 INFO - PROCESS | 1650 | 05:28:38 INFO - TEST-INFO | 1650: exit 0 05:28:38 INFO - TEST-OK | kraken | took 57726ms 05:28:38 INFO - SUITE-END | took 1174s 05:28:39 INFO - Completed test suite (00:19:35) 05:28:39 INFO - javascript benchmark 05:28:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3483.1640406302486, 3500.2824420993684, 3517.630648781879, 3529.6470352964725, 3566.680328278537, 5924.911126333103, 5969.910451343233, 5974.402559744023, 5985.162077309169, 5988.1317209004665, 5927.703614819253, 5993.46058854703, 6013.398660133985, 6019.277686677605, 6021.036634138539, 5355.812546560862, 5381.650192737459, 5413.729313534327, 5420.186971954218, 5559.16612508125, 4354.804033818486, 5058.937623099154, 5360.249565060894, 5372.758225879845, 5481.780728770845, 5358.437364076754, 5400.216968539559, 5416.187571864212, 5425.0, 5467.015937131335, 5456.072467680504, 5463.071277882749, 5465.808696695636, 5472.644278121949, 5475.206095116186, 5292.100342941709, 5330.813421530228, 5371.113766228567, 5404.648697834628, 5459.972700136514, 4869.829555965524, 5821.922944255284, 5881.529477641779, 5922.466977972003, 5937.643741375531, 6249.218847644044, 6304.464120549759, 6305.716242769086, 6305.747770089191, 6308.085327627514, 6395.8401039973905, 6435.099086127946, 6436.967815160941, 6439.323870993525, 6441.259255185667, 5925.081612350093, 5975.282966044103, 6108.572399932051, 6135.417135372132, 6185.938140618581, 6461.0, 6525.1517302750335, 6528.249251336062, 6568.343165683394, 6572.901406478906, 6308.558400911892, 6324.08300796382, 6337.112804207414, 6341.3341599132345, 6376.1392212051705, 6263.31103578606, 6282.2147231596055, 6365.713542890581, 6429.967850160813, 6439.64581947988, 6213.782517611862, 6254.124422580842, 6254.186955695731, 6259.71831267594, 6278.089676996809, 6273.686315684197, 6274.152989346471, 6284.842878928063, 6293.96853015732, 6302.65335406557, 5095.15929871567, 5104.0, 5133.178691409356, 5147.382314122255, 5169.095408303532, 4564.817407303737, 4588.518205588432, 4591.058832939239, 4599.885002874888, 4637.25803871379, 5013.523715247045, 6056.697165141725, 6066.3630318815885, 6081.422264884829, 6087.634741915499, 6356.078368636522, 6408.775692850728, 6409.647469389135, 6414.102025716404, 6428.260750013715, 5175.818846340435, 5745.798897038667, 5904.527637788967, 6057.030875059969, 6072.36240194782, 5519.641223320471, 5576.86057848557, 5611.9438805612235, 5638.689872056994, 5657.632253903483, 6576.704048317837, 6578.8355291118105, 6589.47284217271, 6593.505487088583, 6598.802035938929, 6312.9899216125195, 6352.587081839665, 6375.968120159369, 6386.361363863576, 6409.487241020801, 6260.436560709558, 6318.273398559225, 6463.418292353711, 6600.438962688226, 6603.9009414859775, 6296.6851657417865, 6306.621602703669, 6324.083007963727, 6344.333844946399, 6345.270293916259, 6203.658798766111, 6328.367163283635, 6346.4605508532295, 6348.841278968062, 6367.490600751836, 6226.875462490815, 6266.717997690206, 6274.215723034621, 6342.9682851587295, 6353.523485738496, 5551.723103686094, 6060.818175454743, 6316.652584107918, 6327.430531252209, 6328.746850125944, 6303.6532990685955, 6304.3380445054445, 6304.495640348853, 6309.337519560564, 6329.556931014785, 6179.351168127461, 6242.438180563771, 6294.905576416449, 6297.118403423616, 6323.0, 6112.694365281807, 6186.381361863778, 6189.938100619116, 6205.100260462117, 6282.4974002080635], "value": 5872.59894978827, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.94664613569427, 470.4848191230602, 475.9785809638566, 496.6275293529853, 538.9759457031639, 28457.28856778579, 42749.35875961859, 43726.78136609321, 43800.780996095054, 45047.0, 43279.35080973788, 45486.0902781945, 45550.0, 45588.0, 45649.08701825961, 9516.6193352266, 9731.659391921285, 9744.415335079882, 9748.0, 9752.024797520262, 8857.689980850639, 9017.008129105792, 9591.280653950947, 11762.117841161904, 11988.880111198907, 9994.500274986258, 11807.586734464296, 11884.227525210834, 11892.821607675893, 11915.880841191607, 11746.236494627821, 11824.586139485076, 11850.525978960832, 11851.881481185164, 11860.940695296511, 11706.648800535997, 11815.172937894351, 11815.763684726257, 11820.290782553075, 11822.822657660143, 33958.15104622379, 41725.582744172476, 42095.0, 42183.7890810544, 42280.0, 4041.555428902818, 4055.8174882130374, 4096.689059500961, 4128.174365126986, 4164.7709375984305, 30440.391192176034, 30558.388832223452, 31240.0, 31461.685383146105, 32304.35391292161, 3268.1176082457605, 3337.632860385356, 3501.107217659506, 3526.2771131917893, 3533.240353324022, 501370.0, 502390.0, 502484.0, 503341.0, 505469.47265263804, 59085.409145907994, 59304.40695592989, 59458.10812837811, 59524.0, 59673.70163149157, 58520.70739646274, 66092.66953665201, 66101.6779664404, 66305.00542491867, 66432.33567664261, 17016.064116473714, 17592.472225833244, 17613.82386176122, 17622.854514456518, 17632.735508967377, 13424.597262081958, 13454.798178027337, 13516.729665406638, 13518.391672374766, 13526.0, 14613.634659133606, 14816.407343706347, 21936.0, 22818.42953926165, 22880.65679014816, 8307.712304592798, 8598.312135029182, 8651.221390074797, 9102.635894564275, 9340.953295233616, 806.5241507510597, 858.5449711652834, 875.7153924974409, 897.5960817632092, 917.1516347378648, 31039.0, 31771.364572708415, 31771.52342714861, 31858.840705796785, 32411.675883240867, 1062.5909025025421, 1069.3102948598266, 1070.6787963610886, 1107.678773155792, 1110.1673744691482, 15822.208889555477, 16267.267972941247, 16331.83668163327, 16345.509634710977, 16703.749443758352, 673163.4392796326, 679984.0, 680959.0, 681855.0, 683524.0, 63769.68115159395, 64044.67977660082, 64180.67909660422, 64201.0, 64241.0, 1265.5064524835323, 1328.0703507544565, 1378.076688618628, 1442.5744405400642, 1493.9327730251948, 32109.839450802596, 34048.99848535642, 34867.302653947285, 34949.47575786416, 34999.65000350066, 67655.66172169305, 68253.97619035818, 68403.0, 68416.63166736538, 68530.3146968524, 606590.0, 612148.0, 616718.0, 617836.0, 619153.0, 48793.0, 49159.75420122877, 50147.0, 50364.0, 50417.74791126168, 54145.45854541404, 54244.72877635586, 54501.182482262004, 55836.0, 56126.0, 35878.92363229107, 36100.27799444049, 36317.27365452623, 37416.62583374132, 37780.62219377881, 31839.88560400375, 35556.28887422289, 36188.09529761777, 36955.260894781415, 38200.853974380814, 41844.79077604593, 42371.364429534195, 42567.0, 43041.784791077094, 43476.78261608672, 33290.833545832116, 36067.0, 36330.636693632725, 36616.0, 37047.88856334314, 25804.09685660993, 27812.721872781014, 27867.0, 27931.860340698167, 27939.0], "value": 21687.620694929836, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.92162528306994, 406.9532003819561, 411.7817556694953, 416.9395437661539, 435.0559286348623, 21114.788852111495, 21918.23286184984, 22120.557588848213, 22349.664755028687, 22574.871256437174, 22636.88681556594, 23587.528249435, 23617.763822361772, 23820.28539143824, 23896.40258993526, 5932.436418540232, 6211.068339749028, 6221.471174950135, 6223.813285601439, 6228.37716228378, 5835.79574714883, 6103.6032657877095, 6188.319284878659, 6190.226221722285, 6222.377762223764, 5925.140854576084, 6155.8768824623485, 6157.507399408059, 6170.413810687977, 6172.475339596117, 6156.815295541141, 6293.5279854010905, 6295.622262664232, 6299.5275354348605, 6300.21247344082, 6023.337432882379, 6147.8155655329965, 6215.87568248637, 6244.063390491463, 6251.281102673205, 26633.46733065347, 26744.86627566869, 26746.598801018, 26805.195844124708, 27080.32299192516, 2581.4966081614093, 2690.636764036869, 2748.931276718078, 2751.5735061065566, 2754.476649436601, 9912.504374781303, 10323.38059716412, 10642.73393165177, 10910.890891091067, 10921.508532115995, 1605.956128516462, 1857.498475411645, 1859.8512119030581, 1904.6571617108914, 1916.281394477071, 134651.98022029677, 137015.0, 137646.0, 141480.0, 145307.99999999895, 12065.879341206475, 12135.211211271238, 12226.083043771752, 12266.632001039983, 12447.626571202878, 16437.917810410872, 16446.506604801874, 16447.342106315613, 16487.17564121789, 16519.752203716955, 8782.956085219661, 8911.73264802057, 9045.77385565353, 9169.954150229207, 9176.08239176077, 7314.670839812221, 8848.336374771918, 8855.424397414148, 8869.778255543662, 9041.728748137566, 4819.7108173509005, 4954.108260513142, 4958.305837182797, 4980.676256043418, 4993.675411098267, 1749.1382502920037, 1812.4834422189613, 2018.162462578043, 2029.1883246701439, 2063.4531849060013, 997.4264797741328, 1026.2918586175515, 1052.910502607287, 1057.3285963413289, 1087.6030248959073, 21557.353279401643, 22238.777612223996, 23029.387942844176, 23361.532769344856, 23413.882930585238, 1010.5048526222246, 1075.1291453922347, 1078.8112080385902, 1108.51225460797, 1115.59838458155, 11165.72085697864, 11259.380734059541, 11883.287002779687, 12124.515019399125, 12126.27242365461, 658229.0, 760966.0, 762694.0, 769882.0, 794014.0, 150924.0, 153294.0, 153844.0, 155219.0, 159481.20259398862, 879.3361012435698, 985.9654912078042, 1050.9264351495322, 1086.5490821309227, 1088.3469918049107, 18653.974031428403, 20139.97472262288, 20987.160513579285, 21391.572168556853, 21754.782452175277, 54658.0, 60695.69652151711, 63183.6840815793, 64249.67875160594, 65213.10901682298, 92985.35073246446, 93165.5341723287, 96185.0, 97392.51303743436, 97999.0, 8519.744407667531, 8563.57182140878, 8668.30653547702, 8786.428882122642, 8908.465492070496, 9249.398789078688, 11460.0, 12482.126251162332, 12723.491060357483, 13294.335283235607, 11629.24409913353, 11848.52605895789, 11891.76216475683, 12002.1598488105, 12034.63896083119, 9446.669366572138, 10835.891641083488, 10948.671539853816, 11193.888061119285, 11197.72005699864, 11710.882891170979, 11722.413879306172, 11775.23460975034, 11968.76062478763, 12176.75646487083, 8292.543910085004, 8419.70531031411, 8783.385163038525, 8799.208071273617, 8966.955165224132, 10376.584936602452, 10711.785764284827, 11211.775764484828, 11320.509552867017, 12044.277343359427], "value": 10360.560834535208, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.9928300358497, 1465.0843222985634, 1482.4366740638557, 1492.7835463857741, 1500.9624759381013, 8211.466254693441, 8593.097724738898, 8594.742157735262, 8606.225439710424, 8608.397412181133, 7530.887036694454, 7785.416093792974, 8242.752717418487, 8442.957785211065, 8468.0, 2374.050379848057, 2401.9639705404347, 2409.590369637166, 2410.734819169899, 2411.4694767151286, 2405.3505553500545, 2423.4789520253144, 2438.792702620279, 2442.743511931248, 2445.303088619744, 2389.7251816041203, 2391.5575618510543, 2406.89168987396, 2414.1550457339877, 2419.1412048722714, 2375.0618505690154, 2377.2155188787747, 2399.7360290368047, 2401.2556107606697, 2401.3516350585246, 2399.5081008393236, 2401.6157414813547, 2424.0303878448585, 2424.5514579802793, 2429.356220601542, 8571.742847714579, 8572.957135214285, 8627.396082274181, 8657.740267791976, 8689.608967596474, 5205.193195054772, 5356.223347614613, 5362.436944120889, 5371.919421208685, 5371.9524692684945, 3544.0608238816735, 3599.31612993533, 3674.375356189454, 3705.0922523981526, 3721.0, 1259.4521383198337, 1262.9557965471165, 1286.7683816912952, 1317.7891537353978, 1326.1313839435186, 11094.833577496343, 11147.442627868655, 11151.944240278828, 11153.944230278797, 11164.776704465947, 4355.5408938005485, 4358.779541728321, 4661.790219440133, 4807.6298254997155, 4888.437829649564, 8821.647134114564, 9154.40496367734, 9690.176335011603, 9727.464989425649, 9740.269479788902, 5415.891682166334, 5429.4027656957705, 5431.619786614899, 5436.130219164915, 5438.483344082306, 4500.4149460569915, 4570.223062079454, 4933.45731969483, 4968.677035992649, 4983.277424773388, 3904.9804750976064, 3989.401589761501, 4021.3163762160502, 4045.6763458923215, 4065.8170382332864, 1306.1248963194682, 1306.5296493262417, 1308.9018323625767, 1315.684235783405, 1322.9404676789568, 929.3169520402499, 936.639393833379, 956.8229877472689, 956.9377990430739, 1001.5042553935848, 5633.492985631313, 5740.368559458456, 5898.705064746746, 5987.191729116601, 5989.2812862456785, 924.191332583989, 973.7711637765119, 976.545906153642, 1009.258195226508, 1060.8726952765562, 3835.1179228777537, 3835.8657446989223, 3913.7847418391693, 3922.7254092213843, 4040.6565441937178, 9981.80036399268, 10414.218933580012, 10427.478626068667, 10444.164466842634, 10445.0, 10409.583616655249, 10412.843807342895, 10427.530761115768, 10432.634857779942, 10440.947795260976, 7732.806679833049, 7990.320822730133, 8201.425900187049, 8203.71287004964, 8204.671813127408, 5675.460831221028, 5682.744276507485, 5686.886262274648, 5768.423157684198, 5870.26621672291, 9373.578188981375, 9496.382735122195, 9502.714918552454, 9515.238780897651, 9517.619295228113, 9447.102525260088, 9480.051994800464, 9524.0, 9628.66299679508, 9783.82594088714, 6448.580842245239, 6613.206415230203, 6625.834354141185, 6868.347506986828, 7009.894851577128, 5708.343540492897, 6554.606723596599, 7731.729389471341, 7764.184760600281, 7794.337481314152, 6856.828579285558, 7092.361687448154, 7165.068541089625, 7165.319294666998, 7263.963680181565, 7035.261297563887, 7065.258147894397, 7066.7173313066905, 7075.221725610076, 7133.82165445868, 6414.807555773335, 6470.7088181032905, 6560.507961902781, 6562.048502967138, 6565.409113179646, 5064.316317297265, 5097.515736005073, 5113.539781419541, 5163.173892177234, 5184.637075404686, 5018.322526458881, 5056.949430505648, 5135.8716032098, 5209.739513024258, 5317.654352467077], "value": 4547.863667411244, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.39156040226584, 365.8719448193133, 378.61192277915126, 383.4057211322451, 384.58464857953413, 5388.649737767042, 5446.91829622556, 5469.718169098539, 5475.083720697754, 5493.176023596463, 4657.115148121855, 5004.374453193351, 5186.299849520314, 5203.245529398235, 5285.709285989269, 3725.993981624953, 4243.880747650474, 4293.613574778269, 4300.451837338555, 4333.934990975138, 3757.3424650686156, 3900.921981560367, 4258.936115958263, 4284.700070995032, 4343.979164896246, 3463.636318186592, 3585.318789430013, 3917.8442359504015, 4246.9150616987645, 4272.786360681969, 4105.809315298589, 4117.094239267356, 4118.711690181688, 4119.567445418233, 4155.459790227266, 3578.5526809148855, 3578.7653259625386, 3581.301646178996, 3586.444101164324, 3616.8914932552066, 4396.868093957187, 4975.0, 5233.476652334774, 5255.474452554752, 5272.499112584298, 4641.976790116028, 4695.765211739399, 4698.459677137139, 4703.341532185463, 4734.076855013273, 5369.630744160253, 5402.78388864445, 5751.424857514257, 5781.421857814227, 5788.247527821356, 3402.1664692150334, 3894.357431023878, 3921.725479216456, 3939.5075615548058, 4002.6791158917486, 5070.391553013662, 5150.407703114152, 5217.3391570299045, 5619.73555949912, 5989.670568118751, 3460.740444466675, 3643.0892276930767, 3731.962680373216, 3961.841526338972, 3966.3852102924093, 3788.8254641060807, 3984.6613037891525, 4018.216447792652, 4030.3349947258375, 4032.677385809187, 3757.4551690004796, 4041.6968727345566, 4552.861784553862, 4703.071740586343, 4713.95286047142, 4717.127331443694, 5549.445055494499, 5666.378720620758, 5750.2524671793235, 5803.245578074823, 1149.0348107589664, 1232.6610182199968, 1281.6603600045996, 1307.2352324362225, 1311.341153440898, 762.6568044380051, 853.317346123099, 874.6457684637732, 886.4371124335964, 891.5809569502323, 4904.288878112654, 4916.459189489154, 4920.4833492483485, 4952.870265785747, 4969.82605608802, 4982.451930287665, 5500.339959204921, 5504.101085125625, 5559.6664200148125, 5563.9969610940025, 4808.567228949341, 4995.450500444948, 5007.472720820112, 5024.698518088926, 5119.59043276537, 2558.1685952065654, 2606.9348266293496, 2691.757741803247, 2885.7258560436726, 2912.286489809968, 5031.597472202215, 5163.741812909339, 5386.299781028441, 5647.983362994701, 5802.738876750556, 4933.950660493421, 4951.430585482643, 5340.385855626652, 5675.716214189274, 5762.3577280474865, 4991.975040124777, 5341.893162136736, 5714.314282286152, 5764.27946506695, 5769.423057694197, 4912.680675756064, 4959.479254678206, 4967.627427942991, 5100.821471248637, 5237.450067742984, 4993.101241776515, 5542.75057622416, 5551.361593416808, 5596.580256480699, 5599.496045355938, 5636.4927156556105, 5691.459311365414, 5762.262925110706, 5786.495511167042, 5826.659868230246, 3294.912678815937, 3390.08467713711, 3737.177820879402, 3745.1162604793612, 3888.8833334999995, 4725.173094708481, 4912.091263116335, 5326.881354915511, 5865.50429640439, 5896.469317761422, 5181.430042695376, 5476.959377718221, 5717.285339332583, 5726.885462290814, 5741.942580574141, 5229.529342359054, 5392.325959255093, 5647.237622921018, 5715.799947001835, 5810.215620891126, 5409.756560954688, 5573.916391254215, 5620.803271885465, 5635.690037048002, 5649.3220813501, 5427.402985671652, 5621.634593751393, 5652.378238393856, 5661.264035675335, 5696.297406685688, 5055.0, 5091.872703182302, 5445.945540544544, 5550.833474995757, 5574.386817450159], "value": 4081.288636579954, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.616522490917, 764.6711913877031, 794.9443538952272, 860.857958436858, 873.3144481581958, 15327.846721532795, 16009.0, 16044.438444654439, 16057.839421605795, 16082.91958540207, 14478.782818257734, 14719.558413247592, 14753.409863605442, 14853.851461485381, 14925.92537037316, 709.9006139140524, 731.078840660766, 896.9730908072752, 901.5266984832949, 904.0101089307198, 890.536920801183, 913.3378300731949, 913.5980168725773, 915.3180880244228, 915.8534634458488, 954.3987288008545, 965.2471072563412, 966.7293157915794, 967.6129548180713, 970.2044323654607, 958.0706714486937, 958.9568469418892, 960.6301573894032, 960.8750862387915, 966.8163049020663, 714.5319815520791, 717.096458462336, 718.3427164144802, 722.2741145149145, 722.8951801988735, 15761.448349307719, 16047.03717776937, 16106.919465402716, 16156.75764863528, 16394.508164755076, 14930.776038359434, 15137.016093953858, 15416.22918854064, 15520.301586428637, 15646.452374166849, 11722.706932326675, 11747.588834390841, 11979.700507487383, 12125.151239413244, 12526.624201273977, 3911.8239679214503, 3962.1679447316096, 3963.7819919904396, 4107.609777071173, 4134.090500089976, 108425.99999999921, 109955.0, 110485.0, 111533.0, 112571.0, 10183.18534517237, 11470.541178352772, 11471.0, 11659.0, 11889.167758257012, 21460.14159433605, 22207.333779986628, 22235.666465003036, 23089.7691023091, 23104.422389440064, 7002.3697867192195, 7429.0, 7533.8116547086765, 7622.399296147871, 7718.459707820399, 4022.6710655300976, 4128.091819799639, 4139.648129908931, 4145.3781932709735, 4198.832046718097, 3702.1114932416026, 3728.366177749789, 3951.8616848410165, 4125.752454852658, 4129.380592911088, 720.0854914258862, 735.7682330066012, 737.2627372627372, 745.0947099274408, 756.9053868266467, 537.7983256278895, 548.4159370270648, 548.7777450132703, 551.2172714745071, 557.9825258141398, 10198.388096714221, 10229.488525573692, 10852.077573406192, 10873.565057397775, 11017.008469237808, 659.1360538460477, 673.188807486977, 682.0144890632988, 723.4140346319498, 741.8405042915799, 4981.103401387785, 5083.949160508348, 5129.333186685707, 5142.845714628567, 5149.253358263031, 110101.0, 112289.0, 112349.06778262721, 112351.3147302791, 114208.0, 64894.67552662301, 80606.0, 81245.0, 81848.36303273901, 84831.0, 85613.57193213994, 85864.14135858686, 86626.56686716778, 87134.99999999873, 89909.0, 9918.504074796376, 10036.749081273027, 10041.447720375449, 10051.0, 10055.899441005497, 46248.0, 46966.530334697585, 55543.44456555383, 55736.44263557475, 58793.11810322763, 73203.26796731964, 73351.66483351622, 74543.62728186324, 75490.73527794176, 76902.61548692221, 11345.659630211107, 11455.656330310105, 11588.188826782045, 12199.634010979686, 12370.44333005035, 12695.047871409497, 13225.470981160646, 13273.788599691921, 13367.933160334136, 13434.462621495031, 12252.448639811408, 12264.877351226374, 12557.686057848627, 12664.746705065663, 13092.0, 11732.530698772294, 12325.445354958869, 12378.381080946097, 12441.813372799234, 12448.688782780502, 11695.941520292345, 12185.086118541321, 12201.633950981484, 12481.001519878206, 12577.575096659284, 8665.870011949952, 8696.956515217384, 9204.079592041011, 9306.581203845708, 9587.472689002172, 9869.085589463339, 10135.034280994767, 10343.224258180517, 10418.0, 10489.685309440729], "value": 7592.052802707925, "unit": "score"}], "name": "dromaeo_css", "value": 7555.094989018658, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 113.0, 114.0, 113.0, 111.0, 104.0, 113.0, 112.0, 113.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 131.0, 173.0, 139.0, 107.0, 107.0, 106.0, 124.0, 110.0], "value": 124.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 181.0, 181.0, 183.0, 180.0, 183.0, 182.0, 183.0, 184.0], "value": 182.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 89.0, 59.0, 59.0, 57.0, 61.0, 74.0, 57.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 87.0, 94.0, 96.0, 99.0, 89.0, 67.0, 68.0, 81.0], "value": 83.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 88.0, 84.0, 89.0, 85.0, 87.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 92.0, 93.0, 93.0, 94.0, 93.0, 93.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 86.0, 87.0, 88.0, 86.0, 87.0, 86.0, 87.0, 86.0], "value": 86.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 51.0, 54.0, 56.0, 55.0, 55.0, 56.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 74.0, 74.0, 71.0, 68.0, 69.0, 69.0, 68.0, 69.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 83.0, 82.0, 83.0, 81.0, 81.0, 85.0, 88.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 146.0, 142.0, 123.0, 130.0, 131.0, 144.0, 139.0, 152.0, 142.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 160.0, 205.0, 160.0, 162.0, 161.0, 163.0, 161.0, 161.0, 216.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 66.0, 62.0, 63.0, 63.0, 62.0, 62.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1412.1000000000001, "alertThreshold": 2.0}]} 05:28:39 INFO - Return code: 0 05:28:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:28:39 INFO - # TBPL SUCCESS # 05:28:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:28:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:28:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:28:39 INFO - 2017-03-27 05:28:39.362 screenresolution[1654:9905] starting screenresolution argv=screenresolution get 05:28:39 INFO - 2017-03-27 05:28:39.365 screenresolution[1654:9905] Display 0: 1600x1200x32@60 05:28:39 INFO - 2017-03-27 05:28:39.371 screenresolution[1655:9908] starting screenresolution argv=screenresolution list 05:28:39 INFO - Available Modes on Display 0 05:28:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:28:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:28:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:28:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:28:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:28:39 INFO - Intel Iris: 05:28:39 INFO - Chipset Model: Intel Iris 05:28:39 INFO - Type: GPU 05:28:39 INFO - Bus: Built-In 05:28:39 INFO - VRAM (Dynamic, Max): 1536 MB 05:28:39 INFO - Vendor: Intel (0x8086) 05:28:39 INFO - Device ID: 0x0a2e 05:28:39 INFO - Revision ID: 0x0009 05:28:39 INFO - Displays: 05:28:39 INFO - Display: 05:28:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:28:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:28:39 INFO - Display Serial Number: 1600x1200 60 05:28:39 INFO - Main Display: Yes 05:28:39 INFO - Mirror: Off 05:28:39 INFO - Online: Yes 05:28:39 INFO - Rotation: Supported 05:28:39 INFO - Return code: 0 05:28:39 INFO - Running post-action listener: _resource_record_post_action 05:28:39 INFO - [mozharness: 2017-03-27 12:28:39.606484Z] Finished run-tests step (success) 05:28:39 INFO - Running post-run listener: _resource_record_post_run 05:28:39 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 38388736; Write bytes: 420831232; Read time: 246; Write time: 1389 05:28:39 INFO - TinderboxPrint: CPU usage
53.5% 05:28:39 INFO - TinderboxPrint: I/O read bytes / time
38,388,736 / 246 05:28:39 INFO - TinderboxPrint: I/O write bytes / time
420,831,232 / 1,389 05:28:39 INFO - TinderboxPrint: CPU idle
2,212.3 (46.5%) 05:28:39 INFO - TinderboxPrint: CPU system
947.0 (19.9%) 05:28:39 INFO - TinderboxPrint: CPU user
1,602.4 (33.7%) 05:28:39 INFO - TinderboxPrint: Swap in / out
159,883,264 / 0 05:28:39 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 113191424; Write bytes: 112726016; Read time: 10065; Write time: 248 05:28:39 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 37454848; Write bytes: 298270720; Read time: 233; Write time: 1111 05:28:40 INFO - Running post-run listener: _upload_blobber_files 05:28:40 INFO - Blob upload gear active. 05:28:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:40 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 05:28:40 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'] 05:28:40 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 05:28:40 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:28:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:28:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:41 INFO - (blobuploader) - INFO - Done attempting. 05:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:42 INFO - (blobuploader) - INFO - Done attempting. 05:28:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:28:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:28:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:44 INFO - (blobuploader) - INFO - Done attempting. 05:28:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:28:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:28:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:46 INFO - (blobuploader) - INFO - Done attempting. 05:28:46 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:46 INFO - Return code: 0 05:28:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/334d3cac4b13dc420cbef95d938bb64759dfa2a7e757b116b883044b2c9033d5e0bec7a88aa647f484732f4d763e814a2be4c641ecdb3cb9350891dbc5f6d009", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a898dab9ada1242c69817e6c8f23caab0677cef3f920d90e018c122e6d7ee14d27356ab275c3f3c05a29f679af88f00b86e2f489f6c19f01025fd44415d62f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/907869814cce898a6eabaaa02780d62b64f928287e0413bb7116fe5f00db90dfdd539f5a612ce2a07d526b55ac100c1599a104fd52ec94b6ea00a18e037ee514", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e337a367f4d0aa8d1a61cd54cd7771ec5f7c3eb46a019d50c7af9d636589937f1f5f7a1077cd8b32c0473fdbda9666ff12eb97d75824074d097fafb872ba408d"} 05:28:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:46 INFO - Contents: 05:28:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/334d3cac4b13dc420cbef95d938bb64759dfa2a7e757b116b883044b2c9033d5e0bec7a88aa647f484732f4d763e814a2be4c641ecdb3cb9350891dbc5f6d009", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a898dab9ada1242c69817e6c8f23caab0677cef3f920d90e018c122e6d7ee14d27356ab275c3f3c05a29f679af88f00b86e2f489f6c19f01025fd44415d62f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/907869814cce898a6eabaaa02780d62b64f928287e0413bb7116fe5f00db90dfdd539f5a612ce2a07d526b55ac100c1599a104fd52ec94b6ea00a18e037ee514", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e337a367f4d0aa8d1a61cd54cd7771ec5f7c3eb46a019d50c7af9d636589937f1f5f7a1077cd8b32c0473fdbda9666ff12eb97d75824074d097fafb872ba408d"} 05:28:46 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:46 INFO - Copying logs to upload dir... 05:28:46 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.431499 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-27 05:28:46.347801) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 05:28:46.351885) ========= 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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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/334d3cac4b13dc420cbef95d938bb64759dfa2a7e757b116b883044b2c9033d5e0bec7a88aa647f484732f4d763e814a2be4c641ecdb3cb9350891dbc5f6d009", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a898dab9ada1242c69817e6c8f23caab0677cef3f920d90e018c122e6d7ee14d27356ab275c3f3c05a29f679af88f00b86e2f489f6c19f01025fd44415d62f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/907869814cce898a6eabaaa02780d62b64f928287e0413bb7116fe5f00db90dfdd539f5a612ce2a07d526b55ac100c1599a104fd52ec94b6ea00a18e037ee514", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e337a367f4d0aa8d1a61cd54cd7771ec5f7c3eb46a019d50c7af9d636589937f1f5f7a1077cd8b32c0473fdbda9666ff12eb97d75824074d097fafb872ba408d"} build_url:https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010704 build_url: 'https://queue.taskcluster.net/v1/task/X-R8vEb_RxOXAe7sA6T-_g/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/334d3cac4b13dc420cbef95d938bb64759dfa2a7e757b116b883044b2c9033d5e0bec7a88aa647f484732f4d763e814a2be4c641ecdb3cb9350891dbc5f6d009", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a898dab9ada1242c69817e6c8f23caab0677cef3f920d90e018c122e6d7ee14d27356ab275c3f3c05a29f679af88f00b86e2f489f6c19f01025fd44415d62f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/907869814cce898a6eabaaa02780d62b64f928287e0413bb7116fe5f00db90dfdd539f5a612ce2a07d526b55ac100c1599a104fd52ec94b6ea00a18e037ee514", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e337a367f4d0aa8d1a61cd54cd7771ec5f7c3eb46a019d50c7af9d636589937f1f5f7a1077cd8b32c0473fdbda9666ff12eb97d75824074d097fafb872ba408d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 05:28:46.386654) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:28:46.386983) ========= 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.VaLpQUU1UI/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.uHYbDKB4QP/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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.005003 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 05:28:46.436317) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 05:28:46.436660) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 05:28:46.437046) ========= ========= Total master_lag: 0.19 =========