builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0184 starttime: 1489065850.62 results: success (0) buildid: 20170309030823 builduid: db94d04f173a46998f61cb1d99af4a3e revision: 31f757e837abad20e44fff4700b1d3917ef5cd11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 05:24:10.618468) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 05:24:10.619194) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 05:24:10.619667) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 05:24:10.648937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:24:10.649543) ========= 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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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-09 05:24:10-- 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% 168M=0s 2017-03-09 05:24:10 (168 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127321 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:24:10.802285) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:24:10.802631) ========= 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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.028928 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:24:10.853267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-09 05:24:10.853635) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 31f757e837abad20e44fff4700b1d3917ef5cd11 --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 31f757e837abad20e44fff4700b1d3917ef5cd11 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TXxqY1fAfr/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.kDT2OUqAPc/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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-09 05:24:10,958 truncating revision to first 12 chars 2017-03-09 05:24:10,958 Setting DEBUG logging. 2017-03-09 05:24:10,958 attempt 1/10 2017-03-09 05:24:10,958 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/31f757e837ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-09 05:24:12,320 unpacking tar archive at: mozilla-beta-31f757e837ab/testing/mozharness/ program finished with exit code 0 elapsedTime=1.636726 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-09 05:24:12.514235) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 05:24:12.514594) ========= script_repo_revision: 31f757e837abad20e44fff4700b1d3917ef5cd11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 05:24:12.515026) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 05:24:12.515312) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 05:24:12.535063) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-09 05:24:12.535445) ========= /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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:24:12 INFO - MultiFileLogger online at 20170309 05:24:12 in /builds/slave/test 05:24:12 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:24:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:24:12 INFO - {'append_to_log': False, 05:24:12 INFO - 'base_work_dir': '/builds/slave/test', 05:24:12 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:24:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:24:12 INFO - 'branch': 'Mozilla-Beta', 05:24:12 INFO - 'buildbot_json_path': 'buildprops.json', 05:24:12 INFO - 'config_files': ('talos/mac_config.py',), 05:24:12 INFO - 'default_actions': ('clobber', 05:24:12 INFO - 'read-buildbot-config', 05:24:12 INFO - 'download-and-extract', 05:24:12 INFO - 'populate-webroot', 05:24:12 INFO - 'create-virtualenv', 05:24:12 INFO - 'install', 05:24:12 INFO - 'run-tests'), 05:24:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:24:12 INFO - 'download_minidump_stackwalk': True, 05:24:12 INFO - 'download_symbols': 'ondemand', 05:24:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:24:12 INFO - 'tooltool.py': '/tools/tooltool.py', 05:24:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:24:12 INFO - '/tools/misc-python/virtualenv.py')}, 05:24:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:24:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:24:12 INFO - 'installer_path': 'installer.exe', 05:24:12 INFO - 'log_level': 'info', 05:24:12 INFO - 'log_name': 'talos', 05:24:12 INFO - 'log_to_console': True, 05:24:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:24:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:24:12 INFO - 'opt_config_files': (), 05:24:12 INFO - 'pip_index': False, 05:24:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:24:12 INFO - 'cmd': ('bash', 05:24:12 INFO - '-c', 05:24:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:24:12 INFO - 'enabled': True, 05:24:12 INFO - 'halt_on_failure': False, 05:24:12 INFO - 'name': 'check_screen_resolution'},), 05:24:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:24:12 INFO - 'cmd': ('bash', 05:24:12 INFO - '-c', 05:24:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:24:12 INFO - 'enabled': True, 05:24:12 INFO - 'halt_on_failure': False, 05:24:12 INFO - 'name': 'check_screen_resolution'},), 05:24:12 INFO - 'run_cmd_checks_enabled': True, 05:24:12 INFO - 'sps_profile': False, 05:24:12 INFO - 'sps_profile_interval': 0, 05:24:12 INFO - 'suite': 'dromaeojs', 05:24:12 INFO - 'system_bits': '32', 05:24:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:24:12 INFO - 'title': 't-yosemite-r7-0184', 05:24:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:24:12 INFO - 'use_talos_json': True, 05:24:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:24:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:24:12 INFO - 'work_dir': 'build'} 05:24:12 INFO - [mozharness: 2017-03-09 13:24:12.751311Z] Running clobber step. 05:24:12 INFO - Running pre-action listener: _resource_record_pre_action 05:24:12 INFO - Running main action method: clobber 05:24:12 INFO - rmtree: /builds/slave/test/build 05:24:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:24:15 INFO - Running post-action listener: _resource_record_post_action 05:24:15 INFO - [mozharness: 2017-03-09 13:24:15.311293Z] Finished clobber step (success) 05:24:15 INFO - [mozharness: 2017-03-09 13:24:15.311423Z] Running read-buildbot-config step. 05:24:15 INFO - Running pre-action listener: _resource_record_pre_action 05:24:15 INFO - Running main action method: read_buildbot_config 05:24:15 INFO - Using buildbot properties: 05:24:15 INFO - { 05:24:15 INFO - "project": "", 05:24:15 INFO - "product": "firefox", 05:24:15 INFO - "script_repo_revision": "production", 05:24:15 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:24:15 INFO - "repository": "", 05:24:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:24:15 INFO - "buildid": "20170309030823", 05:24:15 INFO - "pgo_build": "False", 05:24:15 INFO - "basedir": "/builds/slave/test", 05:24:15 INFO - "buildnumber": 51, 05:24:15 INFO - "slavename": "t-yosemite-r7-0184", 05:24:15 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:24:15 INFO - "platform": "yosemite_r7", 05:24:15 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:24:15 INFO - "branch": "mozilla-beta", 05:24:15 INFO - "repo_path": "releases/mozilla-beta", 05:24:15 INFO - "revision": "31f757e837abad20e44fff4700b1d3917ef5cd11", 05:24:15 INFO - "stage_platform": "macosx64", 05:24:15 INFO - "builduid": "db94d04f173a46998f61cb1d99af4a3e", 05:24:15 INFO - "slavebuilddir": "test" 05:24:15 INFO - } 05:24:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 05:24:15 INFO - Running post-action listener: _resource_record_post_action 05:24:15 INFO - [mozharness: 2017-03-09 13:24:15.314972Z] Finished read-buildbot-config step (success) 05:24:15 INFO - [mozharness: 2017-03-09 13:24:15.315109Z] Running download-and-extract step. 05:24:15 INFO - Running pre-action listener: _resource_record_pre_action 05:24:15 INFO - Running main action method: download_and_extract 05:24:15 INFO - mkdir: /builds/slave/test/build/tests 05:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:15 INFO - trying https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 05:24:15 INFO - Downloading https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/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:24:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/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:24:16 INFO - Downloaded 1165 bytes. 05:24:16 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 05:24:16 INFO - Using the following test package requirements: 05:24:16 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 05:24:16 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:24:16 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 05:24:16 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:24:16 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 05:24:16 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:24:16 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:24:16 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 05:24:16 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 05:24:16 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:24:16 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 05:24:16 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:24:16 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 05:24:16 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:24:16 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 05:24:16 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:24:16 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 05:24:16 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 05:24:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 05:24:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 05:24:16 INFO - Fetch https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 05:24:17 INFO - Expected file size: 16103545 05:24:17 INFO - Obtained file size: 16103545 05:24:24 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:24:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 05:24:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 05:24:24 INFO - Fetch https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 05:24:25 INFO - Expected file size: 16103545 05:24:25 INFO - Obtained file size: 16103545 05:24:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 05:24:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 05:24:31 INFO - Fetch https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 05:24:32 INFO - Expected file size: 14403650 05:24:32 INFO - Obtained file size: 14403650 05:24: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:24:32 INFO - trying https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:24:32 INFO - Downloading https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 05:24:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/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:24:34 INFO - Downloaded 58690728 bytes. 05:24:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:24:34 INFO - mkdir: /builds/slave/test/properties 05:24:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:24:34 INFO - Writing to file /builds/slave/test/properties/build_url 05:24:34 INFO - Contents: 05:24:34 INFO - build_url:https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:24:35 INFO - Running post-action listener: _resource_record_post_action 05:24:35 INFO - Running post-action listener: set_extra_try_arguments 05:24:35 INFO - [mozharness: 2017-03-09 13:24:35.054138Z] Finished download-and-extract step (success) 05:24:35 INFO - [mozharness: 2017-03-09 13:24:35.054276Z] Running populate-webroot step. 05:24:35 INFO - Running pre-action listener: _resource_record_pre_action 05:24:35 INFO - Running main action method: populate_webroot 05:24:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:24:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:24:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:24:35 INFO - '--tppagecycles', 05:24:35 INFO - '7'], 05:24:35 INFO - 'tests': ['tsvgm']}}, 05:24:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:24:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:24:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:24:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:24:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:24:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:24:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:24:35 INFO - 'talos_options': ['--disable-e10s'], 05:24:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:24:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:24:35 INFO - 'talos_options': ['--disable-e10s'], 05:24:35 INFO - 'tests': ['damp', 'tps']}, 05:24:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:24:35 INFO - 'tests': ['damp', 'tps']}, 05:24:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:24:35 INFO - 'tests': ['dromaeo_dom']}, 05:24:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:24:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:24:35 INFO - 'tests': ['basic_compositor_video']}, 05:24:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:24:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:24:35 INFO - 'tests': ['a11yr', 05:24:35 INFO - 'ts_paint', 05:24:35 INFO - 'tpaint', 05:24:35 INFO - 'sessionrestore', 05:24:35 INFO - 'sessionrestore_no_auto_restore', 05:24:35 INFO - 'tabpaint']}, 05:24:35 INFO - 'other-e10s': {'tests': ['a11yr', 05:24:35 INFO - 'ts_paint', 05:24:35 INFO - 'tpaint', 05:24:35 INFO - 'sessionrestore', 05:24:35 INFO - 'sessionrestore_no_auto_restore', 05:24:35 INFO - 'tabpaint']}, 05:24:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:24:35 INFO - 'ts_paint', 05:24:35 INFO - 'tpaint', 05:24:35 INFO - 'sessionrestore', 05:24:35 INFO - 'sessionrestore_no_auto_restore', 05:24:35 INFO - 'tabpaint']}, 05:24:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:24:35 INFO - 'ts_paint', 05:24:35 INFO - 'tpaint', 05:24:35 INFO - 'sessionrestore', 05:24:35 INFO - 'sessionrestore_no_auto_restore', 05:24:35 INFO - 'tabpaint']}, 05:24:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:24:35 INFO - 'tests': ['a11yr', 05:24:35 INFO - 'ts_paint', 05:24:35 INFO - 'tpaint', 05:24:35 INFO - 'sessionrestore', 05:24:35 INFO - 'sessionrestore_no_auto_restore', 05:24:35 INFO - 'tabpaint']}, 05:24:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:24:35 INFO - 'tests': ['a11yr', 05:24:35 INFO - 'ts_paint', 05:24:35 INFO - 'tpaint', 05:24:35 INFO - 'sessionrestore', 05:24:35 INFO - 'sessionrestore_no_auto_restore', 05:24:35 INFO - 'tabpaint']}, 05:24:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:24:35 INFO - 'tests': ['tsvgx', 05:24:35 INFO - 'tsvgr_opacity', 05:24:35 INFO - 'tart', 05:24:35 INFO - 'tscrollx', 05:24:35 INFO - 'cart', 05:24:35 INFO - 'tsvg_static']}, 05:24:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:24:35 INFO - 'tsvgr_opacity', 05:24:35 INFO - 'tart', 05:24:35 INFO - 'tscrollx', 05:24:35 INFO - 'cart', 05:24:35 INFO - 'tsvg_static']}, 05:24:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:24:35 INFO - 'talos_options': ['--disable-e10s'], 05:24:35 INFO - 'tests': ['tp5o']}, 05:24:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:24:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:24:35 INFO - 'talos_options': ['--disable-e10s', 05:24:35 INFO - '--xperf_path', 05:24:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:35 INFO - 'tests': ['tp5n']}, 05:24:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:24:35 INFO - 'talos_options': ['--xperf_path', 05:24:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:35 INFO - 'tests': ['tp5n']}}, 05:24:35 INFO - 'talos.zip': {'path': '', 05:24:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:24:35 INFO - Running post-action listener: _resource_record_post_action 05:24:35 INFO - [mozharness: 2017-03-09 13:24:35.072974Z] Finished populate-webroot step (success) 05:24:35 INFO - [mozharness: 2017-03-09 13:24:35.073066Z] Running create-virtualenv step. 05:24:35 INFO - Running pre-action listener: _resource_record_pre_action 05:24:35 INFO - Running main action method: create_virtualenv 05:24:35 INFO - Creating virtualenv /builds/slave/test/build/venv 05:24:35 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:24:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:24:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:24:35 INFO - Using real prefix '/tools/python27' 05:24:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:24:35 INFO - Installing distribute.............................................................................................................................................................................................done. 05:24:38 INFO - Installing pip.................done. 05:24:38 INFO - Return code: 0 05:24:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:24:39 INFO - Reading from file tmpfile_stdout 05:24:39 INFO - Output received: 05:24:39 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:24:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b28b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b2b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa683cbb680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108906d30>, '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 0x10882ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fbbe8>, '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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:24:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:24:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TXxqY1fAfr/Render', 05:24:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:39 INFO - 'HOME': '/Users/cltbld', 05:24:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:39 INFO - 'LOGNAME': 'cltbld', 05:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:39 INFO - 'MOZ_NO_REMOTE': '1', 05:24:39 INFO - 'NO_EM_RESTART': '1', 05:24:39 INFO - 'PAGER': '/bin/cat', 05:24:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:39 INFO - 'PWD': '/builds/slave/test', 05:24:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:39 INFO - 'SHELL': '/bin/bash', 05:24:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDT2OUqAPc/Listeners', 05:24:39 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:24:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:39 INFO - 'USER': 'cltbld', 05:24:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:39 INFO - 'XPC_FLAGS': '0x0', 05:24:39 INFO - 'XPC_SERVICE_NAME': '0', 05:24:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:39 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:24:39 INFO - Cleaning up... 05:24:39 INFO - Return code: 0 05:24:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108b28b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b2b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa683cbb680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108906d30>, '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 0x10882ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fbbe8>, '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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:24:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:24:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TXxqY1fAfr/Render', 05:24:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:39 INFO - 'HOME': '/Users/cltbld', 05:24:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:39 INFO - 'LOGNAME': 'cltbld', 05:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:39 INFO - 'MOZ_NO_REMOTE': '1', 05:24:39 INFO - 'NO_EM_RESTART': '1', 05:24:39 INFO - 'PAGER': '/bin/cat', 05:24:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:39 INFO - 'PWD': '/builds/slave/test', 05:24:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:39 INFO - 'SHELL': '/bin/bash', 05:24:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDT2OUqAPc/Listeners', 05:24:39 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:24:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:39 INFO - 'USER': 'cltbld', 05:24:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:39 INFO - 'XPC_FLAGS': '0x0', 05:24:39 INFO - 'XPC_SERVICE_NAME': '0', 05:24:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:39 INFO - Downloading/unpacking psutil>=3.1.1 05:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:24:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:43 INFO - Installing collected packages: psutil 05:24:43 INFO - Running setup.py install for psutil 05:24:43 INFO - building 'psutil._psutil_osx' extension 05:24:43 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:24:43 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:24:43 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:24:43 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:24:44 INFO - building 'psutil._psutil_posix' extension 05:24:44 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:24:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:24:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:24:44 INFO - ^ 05:24:44 INFO - 1 warning generated. 05:24:44 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:24:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:44 INFO - Successfully installed psutil 05:24:44 INFO - Cleaning up... 05:24:44 INFO - Return code: 0 05:24:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:24:44 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:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:44 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:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:44 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 0x108b28b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b2b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa683cbb680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108906d30>, '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 0x10882ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fbbe8>, '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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:24:44 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:24:44 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:24:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TXxqY1fAfr/Render', 05:24:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:44 INFO - 'HOME': '/Users/cltbld', 05:24:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:44 INFO - 'LOGNAME': 'cltbld', 05:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:44 INFO - 'MOZ_NO_REMOTE': '1', 05:24:44 INFO - 'NO_EM_RESTART': '1', 05:24:44 INFO - 'PAGER': '/bin/cat', 05:24:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:44 INFO - 'PWD': '/builds/slave/test', 05:24:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:44 INFO - 'SHELL': '/bin/bash', 05:24:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDT2OUqAPc/Listeners', 05:24:44 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:24:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:44 INFO - 'USER': 'cltbld', 05:24:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:44 INFO - 'XPC_FLAGS': '0x0', 05:24:44 INFO - 'XPC_SERVICE_NAME': '0', 05:24:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:24: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:24: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:24: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:24: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:24: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:24: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:24:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:24:47 INFO - Installing collected packages: mozsystemmonitor 05:24:47 INFO - Running setup.py install for mozsystemmonitor 05:24:47 INFO - Successfully installed mozsystemmonitor 05:24:47 INFO - Cleaning up... 05:24:47 INFO - Return code: 0 05:24:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:24: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:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:47 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 0x108b28b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b2b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa683cbb680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108906d30>, '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 0x10882ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fbbe8>, '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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:24:47 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:24:47 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:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TXxqY1fAfr/Render', 05:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:47 INFO - 'HOME': '/Users/cltbld', 05:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:47 INFO - 'LOGNAME': 'cltbld', 05:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:47 INFO - 'MOZ_NO_REMOTE': '1', 05:24:47 INFO - 'NO_EM_RESTART': '1', 05:24:47 INFO - 'PAGER': '/bin/cat', 05:24:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:47 INFO - 'PWD': '/builds/slave/test', 05:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:47 INFO - 'SHELL': '/bin/bash', 05:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDT2OUqAPc/Listeners', 05:24:47 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:47 INFO - 'USER': 'cltbld', 05:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:47 INFO - 'XPC_FLAGS': '0x0', 05:24:47 INFO - 'XPC_SERVICE_NAME': '0', 05:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:47 INFO - Downloading/unpacking jsonschema==2.5.1 05:24:47 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:24:47 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:24:47 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:24:47 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:24:47 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:24:47 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:24:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:24:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:24:50 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:24:50 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:24:50 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:24:50 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:24:50 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:24:50 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:24:50 INFO - Downloading functools32-3.2.3-2.tar.gz 05:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:24:50 INFO - warning: no files found matching '*.txt' 05:24:50 INFO - no previously-included directories found matching 'build' 05:24:50 INFO - no previously-included directories found matching 'dist' 05:24:50 INFO - no previously-included directories found matching '.git*' 05:24:50 INFO - Installing collected packages: jsonschema, functools32 05:24:50 INFO - Running setup.py install for functools32 05:24:51 INFO - warning: no files found matching '*.txt' 05:24:51 INFO - no previously-included directories found matching 'build' 05:24:51 INFO - no previously-included directories found matching 'dist' 05:24:51 INFO - no previously-included directories found matching '.git*' 05:24:51 INFO - Successfully installed jsonschema functools32 05:24:51 INFO - Cleaning up... 05:24:51 INFO - Return code: 0 05:24:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:24:51 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:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:51 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:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:51 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 0x108b28b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b2b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa683cbb680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108906d30>, '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 0x10882ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fbbe8>, '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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:24:51 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:24:51 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:24:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TXxqY1fAfr/Render', 05:24:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:51 INFO - 'HOME': '/Users/cltbld', 05:24:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:51 INFO - 'LOGNAME': 'cltbld', 05:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:51 INFO - 'MOZ_NO_REMOTE': '1', 05:24:51 INFO - 'NO_EM_RESTART': '1', 05:24:51 INFO - 'PAGER': '/bin/cat', 05:24:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:51 INFO - 'PWD': '/builds/slave/test', 05:24:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:51 INFO - 'SHELL': '/bin/bash', 05:24:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDT2OUqAPc/Listeners', 05:24:51 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:24:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:51 INFO - 'USER': 'cltbld', 05:24:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:51 INFO - 'XPC_FLAGS': '0x0', 05:24:51 INFO - 'XPC_SERVICE_NAME': '0', 05:24:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:24:51 INFO - Cleaning up... 05:24:51 INFO - Return code: 0 05:24:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:24:51 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:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:51 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:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:51 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 0x108b28b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b2b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa683cbb680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108906d30>, '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 0x10882ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fbbe8>, '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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:24:51 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:24:51 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:24:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TXxqY1fAfr/Render', 05:24:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:51 INFO - 'HOME': '/Users/cltbld', 05:24:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:51 INFO - 'LOGNAME': 'cltbld', 05:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:51 INFO - 'MOZ_NO_REMOTE': '1', 05:24:51 INFO - 'NO_EM_RESTART': '1', 05:24:51 INFO - 'PAGER': '/bin/cat', 05:24:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:51 INFO - 'PWD': '/builds/slave/test', 05:24:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:51 INFO - 'SHELL': '/bin/bash', 05:24:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDT2OUqAPc/Listeners', 05:24:51 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:24:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:51 INFO - 'USER': 'cltbld', 05:24:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:51 INFO - 'XPC_FLAGS': '0x0', 05:24:51 INFO - 'XPC_SERVICE_NAME': '0', 05:24:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:51 INFO - Downloading/unpacking blobuploader==1.2.4 05:24:51 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:24:51 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:24:51 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:24:51 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:24:51 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:24:51 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:24:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:24:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:24:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:24:55 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:24:55 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:24:55 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:24:55 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:24:55 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:24:55 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:24:55 INFO - Downloading docopt-0.6.1.tar.gz 05:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:24:55 INFO - Installing collected packages: blobuploader, requests, docopt 05:24:55 INFO - Running setup.py install for blobuploader 05:24:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:24:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:24:55 INFO - Running setup.py install for requests 05:24:56 INFO - Running setup.py install for docopt 05:24:56 INFO - Successfully installed blobuploader requests docopt 05:24:56 INFO - Cleaning up... 05:24:56 INFO - Return code: 0 05:24:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:56 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:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:56 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:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:56 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 0x108b28b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b2b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa683cbb680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108906d30>, '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 0x10882ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fbbe8>, '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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:24:56 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:24:56 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:24:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TXxqY1fAfr/Render', 05:24:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:56 INFO - 'HOME': '/Users/cltbld', 05:24:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:56 INFO - 'LOGNAME': 'cltbld', 05:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:56 INFO - 'MOZ_NO_REMOTE': '1', 05:24:56 INFO - 'NO_EM_RESTART': '1', 05:24:56 INFO - 'PAGER': '/bin/cat', 05:24:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:56 INFO - 'PWD': '/builds/slave/test', 05:24:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:56 INFO - 'SHELL': '/bin/bash', 05:24:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDT2OUqAPc/Listeners', 05:24:56 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:24:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:56 INFO - 'USER': 'cltbld', 05:24:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:56 INFO - 'XPC_FLAGS': '0x0', 05:24:56 INFO - 'XPC_SERVICE_NAME': '0', 05:24:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:56 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-wtHeYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:56 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-9CnKpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:57 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-jxfOPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:57 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-S8jUqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:57 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-uDyzIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:57 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-y5OPT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:57 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-8_JMOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:57 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-2EFUgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:57 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-U6X0aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:57 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-uilRNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:57 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-NRa1qZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:57 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-YNl9_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:58 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-IFLzZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:58 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-4f_L_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:58 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-LM6_7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:58 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-1NrDc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:58 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-sTykFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:24:58 INFO - Running setup.py install for manifestparser 05:24:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:24:58 INFO - Running setup.py install for mozcrash 05:24:58 INFO - Running setup.py install for mozdebug 05:24:59 INFO - Running setup.py install for mozdevice 05:24:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:24:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:24:59 INFO - Running setup.py install for mozfile 05:24:59 INFO - Running setup.py install for mozhttpd 05:24:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:24:59 INFO - Running setup.py install for mozinfo 05:24:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:24:59 INFO - Running setup.py install for mozInstall 05:24:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:24:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:24:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:24:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:24:59 INFO - Running setup.py install for mozleak 05:24:59 INFO - Running setup.py install for mozlog 05:25:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:25:00 INFO - Running setup.py install for moznetwork 05:25:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:25:00 INFO - Running setup.py install for mozprocess 05:25:00 INFO - Running setup.py install for mozprofile 05:25:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:25:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:25:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:25:00 INFO - Running setup.py install for mozrunner 05:25:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:25:00 INFO - Running setup.py install for mozscreenshot 05:25:00 INFO - Running setup.py install for moztest 05:25:01 INFO - Running setup.py install for mozversion 05:25:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:25:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:25:01 INFO - Cleaning up... 05:25:01 INFO - Return code: 0 05:25:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:01 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:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:01 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:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:01 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 0x108b28b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b2b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa683cbb680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108906d30>, '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 0x10882ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fbbe8>, '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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:25:01 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:25:01 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:25:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TXxqY1fAfr/Render', 05:25:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:01 INFO - 'HOME': '/Users/cltbld', 05:25:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:01 INFO - 'LOGNAME': 'cltbld', 05:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:01 INFO - 'MOZ_NO_REMOTE': '1', 05:25:01 INFO - 'NO_EM_RESTART': '1', 05:25:01 INFO - 'PAGER': '/bin/cat', 05:25:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:01 INFO - 'PWD': '/builds/slave/test', 05:25:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:01 INFO - 'SHELL': '/bin/bash', 05:25:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDT2OUqAPc/Listeners', 05:25:01 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:25:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:01 INFO - 'USER': 'cltbld', 05:25:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:01 INFO - 'XPC_FLAGS': '0x0', 05:25:01 INFO - 'XPC_SERVICE_NAME': '0', 05:25:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:01 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-sbfUG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:01 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:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:01 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-mPV5qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:01 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:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:01 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-3ubcTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:01 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:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:01 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-xevY8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:01 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:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:01 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-QHkpwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:01 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:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:01 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Wp2v6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:02 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-IIKNpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:02 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-kf50iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:02 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Qb7nBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:02 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-xJFjQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:02 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-9_FmGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:02 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-cjskU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:02 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-cFoPnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:25:02 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-k_21P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:02 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-1tCH7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:03 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:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:25:03 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-1tSIhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:25:03 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:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:25:03 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-5x7WsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:25:03 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:25:03 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:25:03 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:25:03 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:25:03 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:25:03 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:25:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:25:03 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:25:03 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:25:03 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:25:03 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:25:03 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:25:03 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:25:05 INFO - Downloading blessings-1.6.tar.gz 05:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:25:06 INFO - Installing collected packages: blessings 05:25:06 INFO - Running setup.py install for blessings 05:25:06 INFO - Successfully installed blessings 05:25:06 INFO - Cleaning up... 05:25:06 INFO - Return code: 0 05:25:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:25:06 INFO - Reading from file tmpfile_stdout 05:25:06 INFO - Current package versions: 05:25:06 INFO - blessings == 1.6 05:25:06 INFO - blobuploader == 1.2.4 05:25:06 INFO - docopt == 0.6.1 05:25:06 INFO - functools32 == 3.2.3-2 05:25:06 INFO - jsonschema == 2.5.1 05:25:06 INFO - manifestparser == 1.1 05:25:06 INFO - mozInstall == 1.12 05:25:06 INFO - mozcrash == 1.0 05:25:06 INFO - mozdebug == 0.1 05:25:06 INFO - mozdevice == 0.49 05:25:06 INFO - mozfile == 1.2 05:25:06 INFO - mozhttpd == 0.7 05:25:06 INFO - mozinfo == 0.9 05:25:06 INFO - mozleak == 0.1 05:25:06 INFO - mozlog == 3.4 05:25:06 INFO - moznetwork == 0.27 05:25:06 INFO - mozprocess == 0.24 05:25:06 INFO - mozprofile == 0.28 05:25:06 INFO - mozrunner == 6.13 05:25:06 INFO - mozscreenshot == 0.1 05:25:06 INFO - mozsystemmonitor == 0.3 05:25:06 INFO - moztest == 0.8 05:25:06 INFO - mozversion == 1.4 05:25:06 INFO - psutil == 3.1.1 05:25:06 INFO - requests == 1.2.3 05:25:06 INFO - wsgiref == 0.1.2 05:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:07 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 0x108b28b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b2b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa683cbb680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108906d30>, '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 0x10882ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fbbe8>, '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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:25:07 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:25:07 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:25:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TXxqY1fAfr/Render', 05:25:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:07 INFO - 'HOME': '/Users/cltbld', 05:25:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:07 INFO - 'LOGNAME': 'cltbld', 05:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:07 INFO - 'MOZ_NO_REMOTE': '1', 05:25:07 INFO - 'NO_EM_RESTART': '1', 05:25:07 INFO - 'PAGER': '/bin/cat', 05:25:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:07 INFO - 'PWD': '/builds/slave/test', 05:25:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:07 INFO - 'SHELL': '/bin/bash', 05:25:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDT2OUqAPc/Listeners', 05:25:07 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:25:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:07 INFO - 'USER': 'cltbld', 05:25:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:07 INFO - 'XPC_FLAGS': '0x0', 05:25:07 INFO - 'XPC_SERVICE_NAME': '0', 05:25:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 INFO - Cleaning up... 05:25:07 INFO - Return code: 0 05:25:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:25:07 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:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:07 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:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:07 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 0x108b28b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b2b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa683cbb680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108906d30>, '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 0x10882ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fbbe8>, '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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:25:07 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:25:07 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:25:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TXxqY1fAfr/Render', 05:25:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:07 INFO - 'HOME': '/Users/cltbld', 05:25:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:07 INFO - 'LOGNAME': 'cltbld', 05:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:07 INFO - 'MOZ_NO_REMOTE': '1', 05:25:07 INFO - 'NO_EM_RESTART': '1', 05:25:07 INFO - 'PAGER': '/bin/cat', 05:25:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:07 INFO - 'PWD': '/builds/slave/test', 05:25:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:07 INFO - 'SHELL': '/bin/bash', 05:25:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDT2OUqAPc/Listeners', 05:25:07 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:25:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:07 INFO - 'USER': 'cltbld', 05:25:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:07 INFO - 'XPC_FLAGS': '0x0', 05:25:07 INFO - 'XPC_SERVICE_NAME': '0', 05:25:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:25:08 INFO - Cleaning up... 05:25:08 INFO - Return code: 0 05:25:08 INFO - Running post-action listener: _resource_record_post_action 05:25:08 INFO - Running post-action listener: _start_resource_monitoring 05:25:08 INFO - Starting resource monitoring. 05:25:08 INFO - [mozharness: 2017-03-09 13:25:08.207962Z] Finished create-virtualenv step (success) 05:25:08 INFO - [mozharness: 2017-03-09 13:25:08.208879Z] Running install step. 05:25:08 INFO - Running pre-action listener: _resource_record_pre_action 05:25:08 INFO - Running main action method: install 05:25:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:25:08 INFO - Reading from file tmpfile_stdout 05:25:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:25:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:25:08 INFO - Reading from file tmpfile_stdout 05:25:08 INFO - Output received: 05:25:08 INFO - Usage: mozinstall [options] installer 05:25:08 INFO - Options: 05:25:08 INFO - -h, --help show this help message and exit 05:25:08 INFO - -d DEST, --destination=DEST 05:25:08 INFO - Directory to install application into. [default: 05:25:08 INFO - "/builds/slave/test"] 05:25:08 INFO - --app=APP Application being installed. [default: firefox] 05:25:08 INFO - mkdir: /builds/slave/test/build/application 05:25:08 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:25:08 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:25:23 INFO - Reading from file tmpfile_stdout 05:25:23 INFO - Output received: 05:25:23 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:25:23 INFO - Running post-action listener: _resource_record_post_action 05:25:23 INFO - [mozharness: 2017-03-09 13:25:23.120084Z] Finished install step (success) 05:25:23 INFO - [mozharness: 2017-03-09 13:25:23.120245Z] Running run-tests step. 05:25:23 INFO - Running pre-action listener: _resource_record_pre_action 05:25:23 INFO - Running main action method: run_tests 05:25:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:25:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:25:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:25:23 INFO - 2017-03-09 05:25:23.134 screenresolution[1619:7220] starting screenresolution argv=screenresolution get 05:25:23 INFO - 2017-03-09 05:25:23.137 screenresolution[1619:7220] Display 0: 1600x1200x32@60 05:25:23 INFO - 2017-03-09 05:25:23.143 screenresolution[1620:7222] starting screenresolution argv=screenresolution list 05:25:23 INFO - Available Modes on Display 0 05:25:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:25:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:25:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:25:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:25:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:25:23 INFO - Intel Iris: 05:25:23 INFO - Chipset Model: Intel Iris 05:25:23 INFO - Type: GPU 05:25:23 INFO - Bus: Built-In 05:25:23 INFO - VRAM (Dynamic, Max): 1536 MB 05:25:23 INFO - Vendor: Intel (0x8086) 05:25:23 INFO - Device ID: 0x0a2e 05:25:23 INFO - Revision ID: 0x0009 05:25:23 INFO - Displays: 05:25:23 INFO - Display: 05:25:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:25:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:25:23 INFO - Display Serial Number: 1600x1200 60 05:25:23 INFO - Main Display: Yes 05:25:23 INFO - Mirror: Off 05:25:23 INFO - Online: Yes 05:25:23 INFO - Rotation: Supported 05:25:23 INFO - Return code: 0 05:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:25:23 INFO - Python 2.7.3 05:25:23 INFO - Return code: 0 05:25:23 INFO - grabbing minidump binary from tooltool 05:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:23 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 0x108906d30>, '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 0x10882ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088fbbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:25:23 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:25:23 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:25:23 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:25:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:25:23 INFO - Return code: 0 05:25:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:25:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:25:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:25:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:25:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:25:23 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/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0184', '--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:25:23 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/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0184 --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:25:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TXxqY1fAfr/Render', 05:25:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:23 INFO - 'HOME': '/Users/cltbld', 05:25:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:23 INFO - 'LOGNAME': 'cltbld', 05:25:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:25:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:23 INFO - 'MOZ_NO_REMOTE': '1', 05:25:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:25:23 INFO - 'NO_EM_RESTART': '1', 05:25:23 INFO - 'PAGER': '/bin/cat', 05:25:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:23 INFO - 'PWD': '/builds/slave/test', 05:25:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:25:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:23 INFO - 'SHELL': '/bin/bash', 05:25:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kDT2OUqAPc/Listeners', 05:25:23 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:25:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:23 INFO - 'USER': 'cltbld', 05:25:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:23 INFO - 'XPC_FLAGS': '0x0', 05:25:23 INFO - 'XPC_SERVICE_NAME': '0', 05:25:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:23 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/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0184', '--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:25:23 INFO - mozversion application_buildid: 20170309030823 05:25:23 INFO - mozversion application_changeset: 31f757e837abad20e44fff4700b1d3917ef5cd11 05:25:23 INFO - mozversion application_display_name: Firefox 05:25:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:25:23 INFO - mozversion application_name: Firefox 05:25:23 INFO - mozversion application_remotingname: firefox 05:25:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:25:23 INFO - mozversion application_vendor: Mozilla 05:25:23 INFO - mozversion application_version: 53.0 05:25:23 INFO - mozversion platform_buildid: 20170309030823 05:25:23 INFO - mozversion platform_changeset: 31f757e837abad20e44fff4700b1d3917ef5cd11 05:25:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:25:23 INFO - mozversion platform_version: 53.0 05:25:23 INFO - using testdate: 1489065923 05:25:23 INFO - actual date: 1489065923 05:25:23 INFO - starting webserver on 'localhost:49241' 05:25:23 INFO - SUITE-START | Running 2 tests 05:25:23 INFO - TEST-START | dromaeo_css 05:25:23 INFO - operating with platform_type : mac_ 05:25:23 INFO - Initialising browser for dromaeo_css test... 05:25:23 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpEoHGcv/profile http://localhost:49241/getInfo.html) 05:25:25 INFO - PROCESS | 1630 | __metrics Screen width/height:1600/1200 05:25:25 INFO - PROCESS | 1630 | colorDepth:24 05:25:25 INFO - PROCESS | 1630 | Browser inner width/height: 1024/689 05:25:25 INFO - PROCESS | 1630 | __metrics 05:25:26 INFO - PROCESS | 1630 | 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:25:26 INFO - PROCESS | 1630 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:25:26 INFO - TEST-INFO | 1630: exit 0 05:25:26 INFO - Browser initialized. 05:25:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:25:26 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpEoHGcv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:38 INFO - PROCESS | 1633 | RSS: Main: 166981632 05:25:38 INFO - PROCESS | 1633 | 05:28:41 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 05:28:43 INFO - PROCESS | 1633 | RSS: Main: 370036736 05:28:43 INFO - PROCESS | 1633 | 05:31:46 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 05:31:47 INFO - PROCESS | 1633 | RSS: Main: 309751808 05:31:47 INFO - PROCESS | 1633 | 05:34:49 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 05:34:50 INFO - PROCESS | 1633 | RSS: Main: 281473024 05:34:50 INFO - PROCESS | 1633 | 05:37:52 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 05:37:53 INFO - PROCESS | 1633 | RSS: Main: 265850880 05:37:53 INFO - PROCESS | 1633 | 05:40:56 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:40:57 INFO - PROCESS | 1633 | RSS: Main: 272650240 05:40:57 INFO - PROCESS | 1633 | 05:44:00 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:44:00 INFO - PROCESS | 1633 | RSS: Main: 454393856 05:44:00 INFO - PROCESS | 1633 | 05:44:00 INFO - PROCESS | 1633 | __start_tp_report 05:44:00 INFO - PROCESS | 1633 | _x_x_mozilla_page_load 05:44:00 INFO - PROCESS | 1633 | _x_x_mozilla_page_load_details 05:44:00 INFO - PROCESS | 1633 | |i|pagename|runs| 05:44:00 INFO - PROCESS | 1633 | |0;dojo.html;3405.421078416669;3423.0928803866964;3434.8454319555617;3456.481527770833;3465.6187819339866;5876.882462350761;5882.588218824684;5888.882222355555;5899.498542623876;5926.903522848271;5871.471567558919;5927.40725927407;5934.080217566284;5955.404459554043;5960.970195149018;5273.499017593342;5289.047971365172;5320.281761962125;5374.381946076212;5441.755121019544;4917.237828136645;5278.392984806758;5319.973400132994;5427.375851777037;5434.2935418395555;5312.707801070939;5338.893222135555;5366.490183432567;5385.084535628953;5398.217258497515;5341.599380046512;5358.008768377843;5369;5379.542738867201;5419.701916394597;4549.931751023704;5255.632105752599;5343.064963631387;5346.385165705955;5352.759125839347;5607.719614019324;5695.914561281584;5764.682942438206;5780.0751879699465;5933.2880054393745;5219.451957544441;6247.406496382881;6248.3751624837605;6259.155014073087;6347.365263473662;6290.654014029226;6299.5905266158015;6322.810315690491;6327.14583531222;6330.905036424458;5886.028805247086;5962.612430192024;5985.191999080112;6029.8191054268445;6046.244219472566;6295.370462953668;6322.304546499881;6336.334684858116;6351.237851457855;6358.364163583605;6254.124422580842;6270.153529273581;6279.434850863444;6282.685865706696;6295.842603934847;6161.507079433634;6265.749370025239;6275.874482510324;6284.685765711696;6295.559310848288;6195.721192546346;6223.097650840603;6244.906326405107;6245.594036387621;6247.937520624827;6238.1266622672865;6253.96873015632;6273.780417685359;6273.811785646438;6329.208848893888;5115.309433226541;5118.769655365443;5127.666701664454;5130.410002849645;5146.665466744649;4400.537943515885;4435.977820110943;4497.865064048084;4544.568266014723;4609.216433206296;5750.1949727038245;5807.070868660994;5817.127430885401;5822.941770582324;5830.7959221427045;6174.8147555573405;6232.034034724625;6276.843078923063;6305.085762564402;6310.873782524323;5892.998190307658;5906.586538942232;5917.64494130345;5921.73352199152;5926.377730338339;5474.671519708831;5570.442955704397;5618.887622247532;5634.6337488063145;5636.154576813511;6196.969015154986;6253.530985176221;6280.183576135073;6289.9371006291185;6485.70814313357;6259.3427690091885;6315.494760419064;6330.651814150082;6342.88999425108;6348.396902294459;6321.336259692666;6369.235691717024;6391.808245752635;6393.808185754435;6402.199725034371;6197.225346831646;6241.188645476059;6246.9062964054665;6249;6285.182926219562;6209.192804935329;6213.5339849510565;6222.066689996536;6234.470070043915;6265.906011409741;6197.03945888388;6228.283747369111;6228.875422491616;6249.96875015622;6265.56141070139;4943.555080042814;6310.52671049664;6339;6343.270523889812;6349.777757778455;6019.939800601938;6062.545309101747;6160.383961603804;6185.6080590089905;6212.844678882883;6218.036204388327;6220.129181914626;6252.468540174136;6288.402601752826;6347;6109.34393638171;6143.877122457615;6146.754129834757;6159.414855588712;6168.1056246844855 05:44:00 INFO - PROCESS | 1633 | |1;ext.html;450.50219507444274;527.786246570139;535.9919601205982;538.8652836790802;558.7346010644942;42395.36406953894;44540.77729611351;44948.32577511336;46357.76821115898;46541.301880471736;45276.320855187114;45714.77142614282;45733.08533829321;45771.31343029849;45816.770916145375;8999.910000900005;9499.667511637077;9707.514624268759;9716.31985760997;9742.756431089245;9074.59164337603;11667.474963626657;11959.282443053444;11986.70033249167;12011.099167562425;11616.593419230328;11781.882181178164;11831.230969986966;11868.10989175811;11889.821652675217;11770.941145294262;11859.169858109935;11865.110116741193;11869.872362125627;11874.584389546324;11789.705257368549;11864.288142711379;11882.168248222628;11883.821742673867;11886.167968242227;42501.362479562835;43129.56870431287;43521.69434916926;43586.782066089465;43668.563314366766;4073.287174744408;4089.44792453021;4109.404136400235;4119.97940010298;4130.710850240484;31132.37735245305;31979.840100799578;32885.342293154245;33188.668113318796;33693.663063369546;3333.8333083345738;3360.311136217094;3406.8296585170892;3440.913977150566;3547.2728090741593;367603;367779.16110419814;369244;369438;371024;68735.65632171907;69178.96231556531;69187;69215.30784692088;69240;72574.63712681402;72623.27376726165;72787.63606181936;72873.27126728665;73020.90468642974;17885.195166217552;18122.90938545299;18142.365017224598;18144.09279536018;18156.818431815776;12130.818037729441;12135.393230338625;12693.746125077447;12785.16896401731;12786.232826030468;17507.851906125623;17701.734473982644;17865.017424041544;19464.902675486534;19884.105215265346;5862.325832529228;6713.1272934519175;6771.424428923498;6827.829304267433;6851.931480685129;842.4397775479238;875.6935072724623;885.9911400885909;899.4288626722079;915.1351972386032;24500.74396986276;31029.689703103133;31158.532622010687;31346.21634459157;31389.744410223793;1083.9729006774894;1092.415557676655;1112.4382186995515;1117.1732917640886;1121.4560937945253;15336.769948450783;16346.591335216715;16481.505554833373;16804.655627549768;16956.660866782597;573854;581471;585363;586016;587495;64705;64993.70012599722;65018;65041;65130.674346627966;1478.3569147420906;1509.449051096364;1515.7423238049557;1524.908505489652;1529.724649563067;29837;30900.690993089782;31042.844785775927;31516.527252091695;31741.206469837514;55500.44499554953;56050.43949560452;57493.71253143708;57540.71229643825;59144.40855591389;510921;595189.024054877;595605;596974;599323;23989.88005060033;26317.868410657826;26689.199324020312;26802.195934122006;26837.463250735265;37764.81117594394;38787.61212387953;43165.3525197116;45375.092498150516;48264.758676206395;37152.41687207348;37573;37994.43008354821;39203;39217.6078239214;34981.82509087438;38082;38952.41571376488;39192.804035979636;39408.80295598504;36990.63009369872;37193.628063719014;37218.441723374715;37295.81352093222;37945.81027094847;28032.719672803825;31583;33591;33929.321413571095;34036.82981585076;25101;25211.49577008413;25450.74549254558;25774.613380798928;26161.345966350993 05:44:00 INFO - PROCESS | 1633 | |2;jquery.html;386.3200766650694;401.33779264214024;404.65604236399065;415.61347946409836;433.35862922874145;14610.488632897837;20730.170793168272;21343.679844802322;21868.562628747415;22090.00594973226;21133.471663208427;21854.672179917314;21935.561288774254;22107.889460552717;22226.1109555618;5238.978399212155;5385.973070134663;5589.105743081108;5863.706814659271;5863.853403664921;5721.856953576153;5864.266966629171;5876.5298776098025;5877.617954832944;5877.6473411595225;5620.522255608278;5717.542596592262;5753.367129615739;5829.271341082364;5855.502282306009;5718.285214348207;5782.855428614276;5785.247917770705;5785.942140578582;5786.218860453827;4910.705357678551;5060.898782024376;5112.693238405707;5123.1546794778815;5137.61467889906;26543.336416589547;26610.467790644274;26652.60021099685;26753.19740407791;26954;2809.7471227589413;2847.18855126288;2887.6246088008425;2923.736863682279;2926.7365937065765;15648.374065037386;15802.288896999662;15826.683466330724;15962.36150553988;16365.509034728977;1809.80092189859;1853.2494339792406;1854.4436668999247;1867.2717640120363;1867.9066046697747;123288;126627;127281.36359318237;127971;130748;10473.319234249902;11250.718732031764;11672.241304315192;11704;11729.589464368706;13723.382447789874;13916.791248131287;14512.709745805025;14533.491327803476;14878.92560537212;8700;9100.81798364029;9156.725298241063;9170.587323570455;9203.631854725736;8986.505742184243;9019.954900225457;9024.278057755364;9120.726378208665;9138.63445462174;4483.686141970096;4656.5110663379855;4684.95315046852;4924.803007879645;4925.605951523869;1911.62723268964;1918.7409699690643;1964.8428125749906;2073.2018173003203;2084.666453367454;878.8945326560854;913.6847787513298;914.2503147419186;919.9402038867452;923.5520772425368;19708.50728731793;21120.894395527925;21315.25396611111;21385.037673304738;21387.465313366978;929.2705226397246;931.7916537805445;958.1999030809213;958.7459323279337;958.7794807194244;9137.725868223964;10830.025297723243;11327.716807079889;11380.601678941197;12463.002959763196;628378;630804;664300;804970;806348;158697.61953570705;158900;159888.20055899647;159979;167104;952.1763674421713;1030.7732298894382;1042.95828166874;1099.8680158381046;1106.3693694594003;19739.309124180585;19995.800041999977;20521.38435846927;20542.97285135767;20566.897165514078;60251.79496410135;60615.78768424519;61691.69154154201;61749;62150.68924655348;87349.56325218333;88709;90003.54998224966;91638.58529902843;92803.60794587951;8162.551059691774;8328.167183281867;8412.03261624921;8629.39594228423;8873;10030.448325342177;13130.671733206364;13229.470821167046;13331.266780327174;13571.660708482366;11465.656030319104;11484.425778710864;11570.421478925851;11766.88233117658;11794.587189448328;10787.568497260021;11079.5568177272;11165.162612804235;11258;11589.884101159218;9835.754106147404;11491.482883270106;11561.537538498702;11872.762544748884;11941.880581194424;8340.374471914753;8372.33021358302;8491.532965686947;8627.309815214894;8656.34298416553;9270.907290927275;11509.827352589551;11755.412229388667;11919.821202681793;11973.640790776291 05:44:00 INFO - PROCESS | 1633 | |3;mootools.html;1260.2501511600594;1462.8610282023203;1472.63184203949;1499.430216517723;1508.894377393582;7789.805254868631;8015.198480151982;8287.005559332882;8437.240648341649;8546.10265922077;8416.07423183451;8476.1100084491;8494.447860889039;8495.575221238929;8503.489790612568;2045.478403007231;2431.2098567965395;2432.902683892651;2433.4889673168655;2438.1222759806456;2166.3500949715103;2252.650839119939;2366.9881650591724;2430.7083150021936;2435.0990133650575;2386.868722220277;2392.449736560592;2401.1715957994465;2401.3756423329974;2404.0864471500804;2356.0575769692173;2373.252425485975;2376.1920946878145;2385.093664407514;2390.2351247600773;2371.7548287149384;2375.0381095656285;2438.4391589934417;2439.2804122783646;2443.144899285236;8435.95782021092;8450.746477605682;8521.020082690446;8537.317014638815;8590.699325523577;5165.586753059746;5324.201369794523;5326.414094449608;5333.57331413486;5355.7857685692525;3352.4027459954373;3454.516367708523;3555.2000799820094;3666.431703086026;3685.668289853926;1218.5552273420226;1261.0920137500984;1269.0925987918683;1318.288124412816;1327.3827670133337;10857.945710271477;10981.39602321872;10983.560657573687;10994.175436842268;11006.339619622848;3841.058940559525;4410.25025745624;4777.044591081798;4820.758962051884;4822.541858523435;9636.036396360309;9638.42169469834;9668;9679.274054445945;9680.177184939359;5359.946400536022;5366.490183432567;5368;5381.704006279692;5403.297571315704;4791.712497250176;4867.5132486751045;4880.170371036932;4979.676321039121;4993.625478089158;3737.9626203738158;3834.5206849143856;3926.842926282917;4035.1929614077303;4047.514298284225;1307.5162189989765;1312.5078095714107;1316.8288122544009;1327.9668008299677;1333.9666508337368;915.1671978499534;923.1138107416955;937.2127412973135;957.5355952363099;1009.8586197932295;5618.241537392481;5644.85887852807;5717.285339332583;5868.178455016301;6046.123312119718;985.9852102218473;993.6969224386487;1012.8075665623655;1046.7278507588082;1047.9834560476327;3864.169203621235;3876.1860009398342;3924.843006279774;3939.6454319111417;3996.760194388288;9852.704418867446;10060.597576097021;10114.54484548197;10167.389956602627;10181.847272290921;10133.08802207805;10134.949325253474;10142.543585538668;10150.086492215736;10153.984601539787;7665;7821.335186509211;7969.242921922408;7983.281504664608;7984.640691168911;5088.4148322941855;5303.867403314948;5623.2408624835125;5659.943400565941;5731.770729170787;9128.132827381389;9143.222826059859;9210.217131543894;9343.859842102509;9429.62281508732;9279.907200927904;9482.28882833804;9497.43015419077;9595.376300540442;9599;7221.061262035902;7254.96372518134;7291.34377905991;7303.415726741741;7309.561426314438;7721.150673426031;7869.213078692314;7942.483738556975;7958.641861116148;7960.363170946194;7127.037849890198;7142.9285707144345;7177.6052317120975;7180.102487189101;7232.312930271616;7043.718251269892;7063.82340441493;7104.431645468453;7132.215456299907;7156.821079472847;6311.90532142009;6486.610803351814;6522.412982831568;6522.902156467751;6541.149650545399;5077.136886729339;5092.618053646065;5117.692938423706;5141.691498510101;5152.30443890085;4986.102501549756;5082.669626474268;5128.948710512847;5233.371995360581;5240.973795131 05:44:00 INFO - PROCESS | 1633 | |4;prototype.html;362.430983356131;371.4428357463804;373.53494898850937;378.92989796887576;379.63934262450664;4816.951830481694;5349.38482074561;5380.381256155543;5455.372632147304;5510.448955104487;4988.526090021452;5225.869353266161;5244.659097158691;5410.972945135279;5458.524010311546;3688.8933320004026;4100.5443067710985;4242.618164365206;4244.617984381405;4253.341196933198;3722.7394082414244;4202.495700515942;4219.873403797891;4229.682773791963;4248.723832950848;3692.9630703693024;3888.3972984187353;4203.390508376284;4234.957650423503;4240.809163587646;3317.9004629861142;4064.2887494688457;4111.794410279489;4217.072244106292;4222.87331380056;2965.4217427601625;3415.7532500637335;3570.232400033979;3734.551853777537;3744.326021316162;4788.640851936118;4943.579795717368;4963.677360971526;5265.657732247391;5288.603354748371;4699.754565040267;4830.2513110467935;4831.541003604652;4872.317875497433;4904.877378065541;4504.346869703874;4707.905841883143;5603.299587551556;5655.886882262332;5668.376478587352;3535.3636345457808;4176.331786914109;4177.832886684529;4179.516271723524;4200.243956087903;4795.177832423691;5490.533304669108;5909.4090590941;5971.880562388728;6010.303663247115;3396.4565669492763;4205.789710514523;4211.810468528924;4221.873343799691;4225.239456897788;4292.763897985641;4294.269974104347;4296.505901821268;4302.720323178984;4306.418633484503;4373.950251939512;4444.888877778081;4864.854054378375;4876.805692271568;4916.5820905222745;5655.717214139277;5682;5689.943100568941;5706.658935150236;5788.913166302509;1313.487739781486;1336.2895493767992;1386.682651481097;1399.5374833299227;1413.7949997250341;872.7905302727299;875.1729615513406;902.566767951387;983.4345251480428;987.9950600247097;4750.809967601326;4861.9027619447415;4944.752762361867;4973.6269779765935;4986.080359061715;4812.614990800727;4828.37231159947;5548.116318577012;5567.276254086943;5603.831885043455;4350.282203436397;4624.884377890512;4728.881777955578;4917.631177661689;5000.174936148353;2594.8582623645534;2803.8738256778493;2923.63454568179;2932.208303757973;2951.5425109108123;5067.442581316052;5657.60396772222;5692.48767610917;5697.572682048863;5712.514436272881;5309.602895245711;5659.915101273484;5696.829095127153;5700.232927792397;5746.396628354046;5599.944000559943;5764.596478246483;5794.450441805592;5795.478406943395;5940.79207227745;5367.906516458506;5822.330432000204;5839.131477927022;5860.597155166532;5869.501092407022;4606.953930460652;4698.530146985274;5088.491150884882;5565.719884426524;5793.710314484343;5475.4250803665045;5934.465898069195;5944.53301879715;5956.8808623828145;5977.641341519523;3566.768160069691;3870.845166193321;4199.769012704331;4231.87304380869;4234.4495215623;5333.973330133324;5615.634983726208;5641.464060914206;5785.900678871001;5864.413558644102;4423.867283981485;5005.4744251853035;5006.349174607278;5696.914546281726;5758.366579676316;4836.032793441255;5140.974295128501;5425.674459532441;5492.80775172867;5686.886262274814;4906.362172917497;5180.57534178104;5460.744028873302;5500.669959802424;5534.806281780118;4878.56092951636;5584.609077364546;5644.2380278663495;5655.020742740173;5693.4875861172695;4762.3332733416655;4881.950380668173;5241.981836992709;5431.619786614899;5589.55283577321 05:44:00 INFO - PROCESS | 1633 | |5;yui.html;744.571871174075;775.561807578718;796.1600511460407;810.3071873548116;880.2957633892886;15213.239338033109;15304.846951530495;15489.225538723074;15562.377504899805;15565.766513502307;13404.128731632461;13867.306634668277;14532.20072895993;14593.489227877026;14653.706925861476;899.5322432335182;912.8539433690611;913.7213149989251;914.5198770645432;916.9449833010008;731.9707211711525;750.2797314578012;751.8533885892253;755.7052749427728;907.129156010231;762.5386641082149;921.5254144115752;957.2103015012608;962.5331714118682;974.2108891797632;956.7942892278124;958.9930572898463;960.6397600899662;962.8651988721584;964.8938616752151;721.2102747491489;722.212788061016;722.5195245162014;723.8045727653504;724.3517052238217;15619.453319133776;15836.920815395964;15950.202489875575;15995.040297582182;16031.839681603267;14806.925965370212;14889;15209.771853422208;15261.542153735405;15386.846131538654;11754.23597466162;11846.703832404259;11895;11972.161948663597;12091.93954030233;3751.924961500782;3781.6029316921877;3784.4701741756176;3945.4673619061346;4029.214303210875;91601.54199229028;94714;100475.9952400474;101772.49113754384;104663.47668261686;11205.908190765545;11508.36703981289;11600.593979210857;11725.589604363977;11985.16103872738;24312.756872431404;24375.26874193777;24393;24810.87594562052;24846.37884052913;7897.447178697436;8102.635381407851;8153.714619988272;8163.469374490639;8274.379421543408;4457.68796184264;4469.173202957463;4495.887602809956;4565.726056436624;4613.5386461354265;3698.9445158322646;3718.7396882218527;3770.5286839145106;3795.994061573685;3803.809809509569;638.06523443156;690.7720452250845;691.5919607431639;695.151914664109;709.765777293492;664.9800505984829;691.0187533702154;702.5082442290314;702.9121359830021;761.8742907420325;10255;10434.739131521772;10667.466626668636;10839.729006774736;10981.39602321864;716.5127713155;719.924407937159;743.6653505922249;745.5526683989672;752.8193233623891;4762.4285085789925;4771.761411929389;5052.837847295143;5193.974030129825;5205.245239440335;98169;98554;99618.50190749;102175;105821;76506;95421;95523.0447695528;97889;99810.00189998152;84762.5761871199;86277.1372286269;87015.12984870323;87672.56163719269;89905.55047224853;10033.09702126812;10165.44090075053;10165.79668406613;10189.286749927434;10227.94886025565;47522.28716569185;50389.74805125951;53241;53817;56479.71760141173;62490.32019544564;66543.66728166328;68295.65852170707;69108.6544567294;71153.59617634438;13454.596362109152;13767.724645507235;13803.17180969145;13902.16587004783;13934.651633709238;15019.09885406879;15094.698106038037;15374.308156133224;15507.457238996582;16096.597585059999;13792.793108103186;13933.372998215307;14344.641383965485;14348.856511434751;14394.784078239045;12890.613281601567;13086;13961.162330260217;14035.789463158266;14214.076085054437;12773.61679149627;13068.869311306766;13071.15037522558;13447.991400645187;13464.798028029783;10456.529456174643;10635.564198833059;11256.493457794582;11310.717232068935;11459;10776.407297598707;10887.564497420015;11037.050680233191;11325.263857849213;11326.150538709795 05:44:00 INFO - PROCESS | 1633 | __end_tp_report 05:44:00 INFO - PROCESS | 1633 | __start_cc_report 05:44:00 INFO - PROCESS | 1633 | _x_x_mozilla_cycle_collect,2239 05:44:00 INFO - PROCESS | 1633 | __end_cc_report 05:44:00 INFO - PROCESS | 1633 | __startTimestamp1489067040486__endTimestamp 05:44:00 INFO - PROCESS | 1633 | 05:44:00 INFO - PROCESS | 1633 | ------- Summary: start ------- 05:44:00 INFO - PROCESS | 1633 | Number of tests: 6 05:44:00 INFO - PROCESS | 1633 | 05:44:00 INFO - PROCESS | 1633 | [#0] dojo.html Cycles:165 Average:5841.18 Median:6159.41 stddev:637.87 (10.4%) stddev-sans-first:610.54 05:44:00 INFO - PROCESS | 1633 | Values: 3405.4 3423.1 3434.8 3456.5 3465.6 5876.9 5882.6 5888.9 5899.5 5926.9 5871.5 5927.4 5934.1 5955.4 5961.0 5273.5 5289.0 5320.3 5374.4 5441.8 4917.2 5278.4 5320.0 5427.4 5434.3 5312.7 5338.9 5366.5 5385.1 5398.2 5341.6 5358.0 5369.0 5379.5 5419.7 4549.9 5255.6 5343.1 5346.4 5352.8 5607.7 5695.9 5764.7 5780.1 5933.3 5219.5 6247.4 6248.4 6259.2 6347.4 6290.7 6299.6 6322.8 6327.1 6330.9 5886.0 5962.6 5985.2 6029.8 6046.2 6295.4 6322.3 6336.3 6351.2 6358.4 6254.1 6270.2 6279.4 6282.7 6295.8 6161.5 6265.7 6275.9 6284.7 6295.6 6195.7 6223.1 6244.9 6245.6 6247.9 6238.1 6254.0 6273.8 6273.8 6329.2 5115.3 5118.8 5127.7 5130.4 5146.7 4400.5 4436.0 4497.9 4544.6 4609.2 5750.2 5807.1 5817.1 5822.9 5830.8 6174.8 6232.0 6276.8 6305.1 6310.9 5893.0 5906.6 5917.6 5921.7 5926.4 5474.7 5570.4 5618.9 5634.6 5636.2 6197.0 6253.5 6280.2 6289.9 6485.7 6259.3 6315.5 6330.7 6342.9 6348.4 6321.3 6369.2 6391.8 6393.8 6402.2 6197.2 6241.2 6246.9 6249.0 6285.2 6209.2 6213.5 6222.1 6234.5 6265.9 6197.0 6228.3 6228.9 6250.0 6265.6 4943.6 6310.5 6339.0 6343.3 6349.8 6019.9 6062.5 6160.4 6185.6 6212.8 6218.0 6220.1 6252.5 6288.4 6347.0 6109.3 6143.9 6146.8 6159.4 6168.1 05:44:00 INFO - PROCESS | 1633 | 05:44:00 INFO - PROCESS | 1633 | [#1] ext.html Cycles:180 Average:66752.53 Median:204088.21 stddev:138771.57 (68.0%) stddev-sans-first:139071.57 05:44:00 INFO - PROCESS | 1633 | Values: 450.5 527.8 536.0 538.9 558.7 42395.4 44540.8 44948.3 46357.8 46541.3 45276.3 45714.8 45733.1 45771.3 45816.8 8999.9 9499.7 9707.5 9716.3 9742.8 9074.6 11667.5 11959.3 11986.7 12011.1 11616.6 11781.9 11831.2 11868.1 11889.8 11770.9 11859.2 11865.1 11869.9 11874.6 11789.7 11864.3 11882.2 11883.8 11886.2 42501.4 43129.6 43521.7 43586.8 43668.6 4073.3 4089.4 4109.4 4120.0 4130.7 31132.4 31979.8 32885.3 33188.7 33693.7 3333.8 3360.3 3406.8 3440.9 3547.3 367603.0 367779.2 369244.0 369438.0 371024.0 68735.7 69179.0 69187.0 69215.3 69240.0 72574.6 72623.3 72787.6 72873.3 73020.9 17885.2 18122.9 18142.4 18144.1 18156.8 12130.8 12135.4 12693.7 12785.2 12786.2 17507.9 17701.7 17865.0 19464.9 19884.1 5862.3 6713.1 6771.4 6827.8 6851.9 842.4 875.7 886.0 899.4 915.1 24500.7 31029.7 31158.5 31346.2 31389.7 1084.0 1092.4 1112.4 1117.2 1121.5 15336.8 16346.6 16481.5 16804.7 16956.7 573854.0 581471.0 585363.0 586016.0 587495.0 64705.0 64993.7 65018.0 65041.0 65130.7 1478.4 1509.4 1515.7 1524.9 1529.7 29837.0 30900.7 31042.8 31516.5 31741.2 55500.4 56050.4 57493.7 57540.7 59144.4 510921.0 595189.0 595605.0 596974.0 599323.0 23989.9 26317.9 26689.2 26802.2 26837.5 37764.8 38787.6 43165.4 45375.1 48264.8 37152.4 37573.0 37994.4 39203.0 39217.6 34981.8 38082.0 38952.4 39192.8 39408.8 36990.6 37193.6 37218.4 37295.8 37945.8 28032.7 31583.0 33591.0 33929.3 34036.8 25101.0 25211.5 25450.7 25774.6 26161.3 05:44:00 INFO - PROCESS | 1633 | 05:44:00 INFO - PROCESS | 1633 | [#2] jquery.html Cycles:180 Average:40138.69 Median:14881.87 stddev:118976.63 (799.5%) stddev-sans-first:119272.95 05:44:00 INFO - PROCESS | 1633 | Values: 386.3 401.3 404.7 415.6 433.4 14610.5 20730.2 21343.7 21868.6 22090.0 21133.5 21854.7 21935.6 22107.9 22226.1 5239.0 5386.0 5589.1 5863.7 5863.9 5721.9 5864.3 5876.5 5877.6 5877.6 5620.5 5717.5 5753.4 5829.3 5855.5 5718.3 5782.9 5785.2 5785.9 5786.2 4910.7 5060.9 5112.7 5123.2 5137.6 26543.3 26610.5 26652.6 26753.2 26954.0 2809.7 2847.2 2887.6 2923.7 2926.7 15648.4 15802.3 15826.7 15962.4 16365.5 1809.8 1853.2 1854.4 1867.3 1867.9 123288.0 126627.0 127281.4 127971.0 130748.0 10473.3 11250.7 11672.2 11704.0 11729.6 13723.4 13916.8 14512.7 14533.5 14878.9 8700.0 9100.8 9156.7 9170.6 9203.6 8986.5 9020.0 9024.3 9120.7 9138.6 4483.7 4656.5 4685.0 4924.8 4925.6 1911.6 1918.7 1964.8 2073.2 2084.7 878.9 913.7 914.3 919.9 923.6 19708.5 21120.9 21315.3 21385.0 21387.5 929.3 931.8 958.2 958.7 958.8 9137.7 10830.0 11327.7 11380.6 12463.0 628378.0 630804.0 664300.0 804970.0 806348.0 158697.6 158900.0 159888.2 159979.0 167104.0 952.2 1030.8 1043.0 1099.9 1106.4 19739.3 19995.8 20521.4 20543.0 20566.9 60251.8 60615.8 61691.7 61749.0 62150.7 87349.6 88709.0 90003.5 91638.6 92803.6 8162.6 8328.2 8412.0 8629.4 8873.0 10030.4 13130.7 13229.5 13331.3 13571.7 11465.7 11484.4 11570.4 11766.9 11794.6 10787.6 11079.6 11165.2 11258.0 11589.9 9835.8 11491.5 11561.5 11872.8 11941.9 8340.4 8372.3 8491.5 8627.3 8656.3 9270.9 11509.8 11755.4 11919.8 11973.6 05:44:00 INFO - PROCESS | 1633 | 05:44:00 INFO - PROCESS | 1633 | [#3] mootools.html Cycles:180 Average:5540.79 Median:5147.00 stddev:2981.28 (57.9%) stddev-sans-first:2972.28 05:44:00 INFO - PROCESS | 1633 | Values: 1260.3 1462.9 1472.6 1499.4 1508.9 7789.8 8015.2 8287.0 8437.2 8546.1 8416.1 8476.1 8494.4 8495.6 8503.5 2045.5 2431.2 2432.9 2433.5 2438.1 2166.4 2252.7 2367.0 2430.7 2435.1 2386.9 2392.4 2401.2 2401.4 2404.1 2356.1 2373.3 2376.2 2385.1 2390.2 2371.8 2375.0 2438.4 2439.3 2443.1 8436.0 8450.7 8521.0 8537.3 8590.7 5165.6 5324.2 5326.4 5333.6 5355.8 3352.4 3454.5 3555.2 3666.4 3685.7 1218.6 1261.1 1269.1 1318.3 1327.4 10857.9 10981.4 10983.6 10994.2 11006.3 3841.1 4410.3 4777.0 4820.8 4822.5 9636.0 9638.4 9668.0 9679.3 9680.2 5359.9 5366.5 5368.0 5381.7 5403.3 4791.7 4867.5 4880.2 4979.7 4993.6 3738.0 3834.5 3926.8 4035.2 4047.5 1307.5 1312.5 1316.8 1328.0 1334.0 915.2 923.1 937.2 957.5 1009.9 5618.2 5644.9 5717.3 5868.2 6046.1 986.0 993.7 1012.8 1046.7 1048.0 3864.2 3876.2 3924.8 3939.6 3996.8 9852.7 10060.6 10114.5 10167.4 10181.8 10133.1 10134.9 10142.5 10150.1 10154.0 7665.0 7821.3 7969.2 7983.3 7984.6 5088.4 5303.9 5623.2 5659.9 5731.8 9128.1 9143.2 9210.2 9343.9 9429.6 9279.9 9482.3 9497.4 9595.4 9599.0 7221.1 7255.0 7291.3 7303.4 7309.6 7721.2 7869.2 7942.5 7958.6 7960.4 7127.0 7142.9 7177.6 7180.1 7232.3 7043.7 7063.8 7104.4 7132.2 7156.8 6311.9 6486.6 6522.4 6522.9 6541.1 5077.1 5092.6 5117.7 5141.7 5152.3 4986.1 5082.7 5128.9 5233.4 5241.0 05:44:00 INFO - PROCESS | 1633 | 05:44:00 INFO - PROCESS | 1633 | [#4] prototype.html Cycles:180 Average:4559.97 Median:4930.61 stddev:1351.07 (27.4%) stddev-sans-first:1317.62 05:44:00 INFO - PROCESS | 1633 | Values: 362.4 371.4 373.5 378.9 379.6 4817.0 5349.4 5380.4 5455.4 5510.4 4988.5 5225.9 5244.7 5411.0 5458.5 3688.9 4100.5 4242.6 4244.6 4253.3 3722.7 4202.5 4219.9 4229.7 4248.7 3693.0 3888.4 4203.4 4235.0 4240.8 3317.9 4064.3 4111.8 4217.1 4222.9 2965.4 3415.8 3570.2 3734.6 3744.3 4788.6 4943.6 4963.7 5265.7 5288.6 4699.8 4830.3 4831.5 4872.3 4904.9 4504.3 4707.9 5603.3 5655.9 5668.4 3535.4 4176.3 4177.8 4179.5 4200.2 4795.2 5490.5 5909.4 5971.9 6010.3 3396.5 4205.8 4211.8 4221.9 4225.2 4292.8 4294.3 4296.5 4302.7 4306.4 4374.0 4444.9 4864.9 4876.8 4916.6 5655.7 5682.0 5689.9 5706.7 5788.9 1313.5 1336.3 1386.7 1399.5 1413.8 872.8 875.2 902.6 983.4 988.0 4750.8 4861.9 4944.8 4973.6 4986.1 4812.6 4828.4 5548.1 5567.3 5603.8 4350.3 4624.9 4728.9 4917.6 5000.2 2594.9 2803.9 2923.6 2932.2 2951.5 5067.4 5657.6 5692.5 5697.6 5712.5 5309.6 5659.9 5696.8 5700.2 5746.4 5599.9 5764.6 5794.5 5795.5 5940.8 5367.9 5822.3 5839.1 5860.6 5869.5 4607.0 4698.5 5088.5 5565.7 5793.7 5475.4 5934.5 5944.5 5956.9 5977.6 3566.8 3870.8 4199.8 4231.9 4234.4 5334.0 5615.6 5641.5 5785.9 5864.4 4423.9 5005.5 5006.3 5696.9 5758.4 4836.0 5141.0 5425.7 5492.8 5686.9 4906.4 5180.6 5460.7 5500.7 5534.8 4878.6 5584.6 5644.2 5655.0 5693.5 4762.3 4882.0 5242.0 5431.6 5589.6 05:44:00 INFO - PROCESS | 1633 | 05:44:00 INFO - PROCESS | 1633 | [#5] yui.html Cycles:180 Average:20935.81 Median:3790.23 stddev:29513.01 (778.7%) stddev-sans-first:29556.86 05:44:00 INFO - PROCESS | 1633 | Values: 744.6 775.6 796.2 810.3 880.3 15213.2 15304.8 15489.2 15562.4 15565.8 13404.1 13867.3 14532.2 14593.5 14653.7 899.5 912.9 913.7 914.5 916.9 732.0 750.3 751.9 755.7 907.1 762.5 921.5 957.2 962.5 974.2 956.8 959.0 960.6 962.9 964.9 721.2 722.2 722.5 723.8 724.4 15619.5 15836.9 15950.2 15995.0 16031.8 14806.9 14889.0 15209.8 15261.5 15386.8 11754.2 11846.7 11895.0 11972.2 12091.9 3751.9 3781.6 3784.5 3945.5 4029.2 91601.5 94714.0 100476.0 101772.5 104663.5 11205.9 11508.4 11600.6 11725.6 11985.2 24312.8 24375.3 24393.0 24810.9 24846.4 7897.4 8102.6 8153.7 8163.5 8274.4 4457.7 4469.2 4495.9 4565.7 4613.5 3698.9 3718.7 3770.5 3796.0 3803.8 638.1 690.8 691.6 695.2 709.8 665.0 691.0 702.5 702.9 761.9 10255.0 10434.7 10667.5 10839.7 10981.4 716.5 719.9 743.7 745.6 752.8 4762.4 4771.8 5052.8 5194.0 5205.2 98169.0 98554.0 99618.5 102175.0 105821.0 76506.0 95421.0 95523.0 97889.0 99810.0 84762.6 86277.1 87015.1 87672.6 89905.6 10033.1 10165.4 10165.8 10189.3 10227.9 47522.3 50389.7 53241.0 53817.0 56479.7 62490.3 66543.7 68295.7 69108.7 71153.6 13454.6 13767.7 13803.2 13902.2 13934.7 15019.1 15094.7 15374.3 15507.5 16096.6 13792.8 13933.4 14344.6 14348.9 14394.8 12890.6 13086.0 13961.2 14035.8 14214.1 12773.6 13068.9 13071.2 13448.0 13464.8 10456.5 10635.6 11256.5 11310.7 11459.0 10776.4 10887.6 11037.1 11325.3 11326.2 05:44:00 INFO - PROCESS | 1633 | -------- Summary: end -------- 05:44:00 INFO - PROCESS | 1633 | 05:44:01 INFO - TEST-INFO | 1633: exit 0 05:44:01 INFO - TEST-OK | dromaeo_css | took 1117393ms 05:44:01 INFO - TEST-START | kraken 05:44:01 INFO - operating with platform_type : mac_ 05:44:01 INFO - Initialising browser for kraken test... 05:44:01 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpUDnHf6/profile http://localhost:49241/getInfo.html) 05:44:03 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 05:44:03 INFO - PROCESS | 1643 | colorDepth:24 05:44:03 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 05:44:03 INFO - PROCESS | 1643 | __metrics 05:44:03 INFO - PROCESS | 1643 | 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:44:03 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:44:03 INFO - TEST-INFO | 1643: exit 0 05:44:03 INFO - Browser initialized. 05:44:03 INFO - Running cycle 1/1 for kraken test... 05:44:03 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpUDnHf6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:15 INFO - PROCESS | 1645 | RSS: Main: 163434496 05:44:15 INFO - PROCESS | 1645 | 05:44:18 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:44:19 INFO - PROCESS | 1645 | RSS: Main: 213766144 05:44:19 INFO - PROCESS | 1645 | 05:44:22 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:44:22 INFO - PROCESS | 1645 | RSS: Main: 230125568 05:44:22 INFO - PROCESS | 1645 | 05:44:25 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:44:26 INFO - PROCESS | 1645 | RSS: Main: 327294976 05:44:26 INFO - PROCESS | 1645 | 05:44:28 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:44:29 INFO - PROCESS | 1645 | RSS: Main: 228880384 05:44:29 INFO - PROCESS | 1645 | 05:44:30 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:44:31 INFO - PROCESS | 1645 | RSS: Main: 230559744 05:44:31 INFO - PROCESS | 1645 | 05:44:34 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:44:35 INFO - PROCESS | 1645 | RSS: Main: 271990784 05:44:35 INFO - PROCESS | 1645 | 05:44:37 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:44:38 INFO - PROCESS | 1645 | RSS: Main: 269463552 05:44:38 INFO - PROCESS | 1645 | 05:44:41 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:44:41 INFO - PROCESS | 1645 | RSS: Main: 268324864 05:44:41 INFO - PROCESS | 1645 | 05:44:43 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:44:44 INFO - PROCESS | 1645 | RSS: Main: 244940800 05:44:44 INFO - PROCESS | 1645 | 05:44:45 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:44:46 INFO - PROCESS | 1645 | RSS: Main: 244989952 05:44:46 INFO - PROCESS | 1645 | 05:44:48 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:44:49 INFO - PROCESS | 1645 | RSS: Main: 251191296 05:44:49 INFO - PROCESS | 1645 | 05:44:52 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:44:53 INFO - PROCESS | 1645 | RSS: Main: 268382208 05:44:53 INFO - PROCESS | 1645 | 05:44:55 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:44:56 INFO - PROCESS | 1645 | RSS: Main: 262545408 05:44:56 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:44:58 INFO - PROCESS | 1645 | RSS: Main: 306888704 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | __start_tp_report 05:44:58 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 05:44:58 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 05:44:58 INFO - PROCESS | 1645 | |i|pagename|runs| 05:44:58 INFO - PROCESS | 1645 | |0;ai-astar;102;114;115;114;113;115;112;112;114;114 05:44:58 INFO - PROCESS | 1645 | |1;audio-beat-detection;141;106;114;142;110;106;106;107;127;109 05:44:58 INFO - PROCESS | 1645 | |2;audio-dft;175;184;183;183;184;185;182;181;185;183 05:44:58 INFO - PROCESS | 1645 | |3;audio-fft;78;56;58;87;62;58;56;58;73;57 05:44:58 INFO - PROCESS | 1645 | |4;audio-oscillator;80;70;85;72;66;66;81;66;67;80 05:44:58 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;87;85;87;85;87;87;134;125;86;104 05:44:58 INFO - PROCESS | 1645 | |6;imaging-darkroom;96;95;96;95;95;95;95;96;95;95 05:44:58 INFO - PROCESS | 1645 | |7;imaging-desaturate;88;85;85;85;84;87;86;89;86;84 05:44:58 INFO - PROCESS | 1645 | |8;json-parse-financial;54;52;50;53;55;55;55;55;56;55 05:44:58 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;64;65;71;78;71;66;68;68;67;69 05:44:58 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;81;83;81;93;98;97;97;82;88;82 05:44:58 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;131;130;131;132;136;155;146;143;192;165 05:44:58 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;161;163;163;162;161;162;164;162;160;161 05:44:58 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;65;63;64;63;64;62;62;63;63;63 05:44:58 INFO - PROCESS | 1645 | __end_tp_report 05:44:58 INFO - PROCESS | 1645 | __start_cc_report 05:44:58 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1946 05:44:58 INFO - PROCESS | 1645 | __end_cc_report 05:44:58 INFO - PROCESS | 1645 | __startTimestamp1489067098297__endTimestamp 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | ------- Summary: start ------- 05:44:58 INFO - PROCESS | 1645 | Number of tests: 14 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:3.84 (3.4%) stddev-sans-first:1.12 05:44:58 INFO - PROCESS | 1645 | Values: 102.0 114.0 115.0 114.0 113.0 115.0 112.0 112.0 114.0 114.0 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:116.80 Median:112.00 stddev:14.47 (12.9%) stddev-sans-first:12.42 05:44:58 INFO - PROCESS | 1645 | Values: 141.0 106.0 114.0 142.0 110.0 106.0 106.0 107.0 127.0 109.0 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.50 stddev:2.92 (1.6%) stddev-sans-first:1.32 05:44:58 INFO - PROCESS | 1645 | Values: 175.0 184.0 183.0 183.0 184.0 185.0 182.0 181.0 185.0 183.0 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:64.30 Median:60.00 stddev:11.03 (18.4%) stddev-sans-first:10.52 05:44:58 INFO - PROCESS | 1645 | Values: 78.0 56.0 58.0 87.0 62.0 58.0 56.0 58.0 73.0 57.0 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:73.30 Median:76.00 stddev:7.44 (9.8%) stddev-sans-first:7.49 05:44:58 INFO - PROCESS | 1645 | Values: 80.0 70.0 85.0 72.0 66.0 66.0 81.0 66.0 67.0 80.0 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:96.70 Median:86.50 stddev:18.29 (21.1%) stddev-sans-first:19.06 05:44:58 INFO - PROCESS | 1645 | Values: 87.0 85.0 87.0 85.0 87.0 87.0 134.0 125.0 86.0 104.0 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 05:44:58 INFO - PROCESS | 1645 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:1.66 (1.9%) stddev-sans-first:1.58 05:44:58 INFO - PROCESS | 1645 | Values: 88.0 85.0 85.0 85.0 84.0 87.0 86.0 89.0 86.0 84.0 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:55.00 stddev:1.83 (3.3%) stddev-sans-first:1.94 05:44:58 INFO - PROCESS | 1645 | Values: 54.0 52.0 50.0 53.0 55.0 55.0 55.0 55.0 56.0 55.0 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.50 stddev:4.00 (5.8%) stddev-sans-first:3.87 05:44:58 INFO - PROCESS | 1645 | Values: 64.0 65.0 71.0 78.0 71.0 66.0 68.0 68.0 67.0 69.0 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:90.50 stddev:7.32 (8.1%) stddev-sans-first:7.28 05:44:58 INFO - PROCESS | 1645 | Values: 81.0 83.0 81.0 93.0 98.0 97.0 97.0 82.0 88.0 82.0 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:144.50 stddev:19.91 (13.8%) stddev-sans-first:20.36 05:44:58 INFO - PROCESS | 1645 | Values: 131.0 130.0 131.0 132.0 136.0 155.0 146.0 143.0 192.0 165.0 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 05:44:58 INFO - PROCESS | 1645 | Values: 161.0 163.0 163.0 162.0 161.0 162.0 164.0 162.0 160.0 161.0 05:44:58 INFO - PROCESS | 1645 | 05:44:58 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.71 05:44:58 INFO - PROCESS | 1645 | Values: 65.0 63.0 64.0 63.0 64.0 62.0 62.0 63.0 63.0 63.0 05:44:58 INFO - PROCESS | 1645 | -------- Summary: end -------- 05:44:58 INFO - PROCESS | 1645 | 05:44:59 INFO - TEST-INFO | 1645: exit 0 05:44:59 INFO - TEST-OK | kraken | took 58064ms 05:44:59 INFO - SUITE-END | took 1175s 05:44:59 INFO - Completed test suite (00:19:35) 05:44:59 INFO - javascript benchmark 05:44:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3405.421078416669, 3423.0928803866964, 3434.8454319555617, 3456.481527770833, 3465.6187819339866, 5876.882462350761, 5882.588218824684, 5888.882222355555, 5899.498542623876, 5926.903522848271, 5871.471567558919, 5927.40725927407, 5934.080217566284, 5955.404459554043, 5960.970195149018, 5273.499017593342, 5289.047971365172, 5320.281761962125, 5374.381946076212, 5441.755121019544, 4917.237828136645, 5278.392984806758, 5319.973400132994, 5427.375851777037, 5434.2935418395555, 5312.707801070939, 5338.893222135555, 5366.490183432567, 5385.084535628953, 5398.217258497515, 5341.599380046512, 5358.008768377843, 5369.0, 5379.542738867201, 5419.701916394597, 4549.931751023704, 5255.632105752599, 5343.064963631387, 5346.385165705955, 5352.759125839347, 5607.719614019324, 5695.914561281584, 5764.682942438206, 5780.0751879699465, 5933.2880054393745, 5219.451957544441, 6247.406496382881, 6248.3751624837605, 6259.155014073087, 6347.365263473662, 6290.654014029226, 6299.5905266158015, 6322.810315690491, 6327.14583531222, 6330.905036424458, 5886.028805247086, 5962.612430192024, 5985.191999080112, 6029.8191054268445, 6046.244219472566, 6295.370462953668, 6322.304546499881, 6336.334684858116, 6351.237851457855, 6358.364163583605, 6254.124422580842, 6270.153529273581, 6279.434850863444, 6282.685865706696, 6295.842603934847, 6161.507079433634, 6265.749370025239, 6275.874482510324, 6284.685765711696, 6295.559310848288, 6195.721192546346, 6223.097650840603, 6244.906326405107, 6245.594036387621, 6247.937520624827, 6238.1266622672865, 6253.96873015632, 6273.780417685359, 6273.811785646438, 6329.208848893888, 5115.309433226541, 5118.769655365443, 5127.666701664454, 5130.410002849645, 5146.665466744649, 4400.537943515885, 4435.977820110943, 4497.865064048084, 4544.568266014723, 4609.216433206296, 5750.1949727038245, 5807.070868660994, 5817.127430885401, 5822.941770582324, 5830.7959221427045, 6174.8147555573405, 6232.034034724625, 6276.843078923063, 6305.085762564402, 6310.873782524323, 5892.998190307658, 5906.586538942232, 5917.64494130345, 5921.73352199152, 5926.377730338339, 5474.671519708831, 5570.442955704397, 5618.887622247532, 5634.6337488063145, 5636.154576813511, 6196.969015154986, 6253.530985176221, 6280.183576135073, 6289.9371006291185, 6485.70814313357, 6259.3427690091885, 6315.494760419064, 6330.651814150082, 6342.88999425108, 6348.396902294459, 6321.336259692666, 6369.235691717024, 6391.808245752635, 6393.808185754435, 6402.199725034371, 6197.225346831646, 6241.188645476059, 6246.9062964054665, 6249.0, 6285.182926219562, 6209.192804935329, 6213.5339849510565, 6222.066689996536, 6234.470070043915, 6265.906011409741, 6197.03945888388, 6228.283747369111, 6228.875422491616, 6249.96875015622, 6265.56141070139, 4943.555080042814, 6310.52671049664, 6339.0, 6343.270523889812, 6349.777757778455, 6019.939800601938, 6062.545309101747, 6160.383961603804, 6185.6080590089905, 6212.844678882883, 6218.036204388327, 6220.129181914626, 6252.468540174136, 6288.402601752826, 6347.0, 6109.34393638171, 6143.877122457615, 6146.754129834757, 6159.414855588712, 6168.1056246844855], "value": 5801.5591746808905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.50219507444274, 527.786246570139, 535.9919601205982, 538.8652836790802, 558.7346010644942, 42395.36406953894, 44540.77729611351, 44948.32577511336, 46357.76821115898, 46541.301880471736, 45276.320855187114, 45714.77142614282, 45733.08533829321, 45771.31343029849, 45816.770916145375, 8999.910000900005, 9499.667511637077, 9707.514624268759, 9716.31985760997, 9742.756431089245, 9074.59164337603, 11667.474963626657, 11959.282443053444, 11986.70033249167, 12011.099167562425, 11616.593419230328, 11781.882181178164, 11831.230969986966, 11868.10989175811, 11889.821652675217, 11770.941145294262, 11859.169858109935, 11865.110116741193, 11869.872362125627, 11874.584389546324, 11789.705257368549, 11864.288142711379, 11882.168248222628, 11883.821742673867, 11886.167968242227, 42501.362479562835, 43129.56870431287, 43521.69434916926, 43586.782066089465, 43668.563314366766, 4073.287174744408, 4089.44792453021, 4109.404136400235, 4119.97940010298, 4130.710850240484, 31132.37735245305, 31979.840100799578, 32885.342293154245, 33188.668113318796, 33693.663063369546, 3333.8333083345738, 3360.311136217094, 3406.8296585170892, 3440.913977150566, 3547.2728090741593, 367603.0, 367779.16110419814, 369244.0, 369438.0, 371024.0, 68735.65632171907, 69178.96231556531, 69187.0, 69215.30784692088, 69240.0, 72574.63712681402, 72623.27376726165, 72787.63606181936, 72873.27126728665, 73020.90468642974, 17885.195166217552, 18122.90938545299, 18142.365017224598, 18144.09279536018, 18156.818431815776, 12130.818037729441, 12135.393230338625, 12693.746125077447, 12785.16896401731, 12786.232826030468, 17507.851906125623, 17701.734473982644, 17865.017424041544, 19464.902675486534, 19884.105215265346, 5862.325832529228, 6713.1272934519175, 6771.424428923498, 6827.829304267433, 6851.931480685129, 842.4397775479238, 875.6935072724623, 885.9911400885909, 899.4288626722079, 915.1351972386032, 24500.74396986276, 31029.689703103133, 31158.532622010687, 31346.21634459157, 31389.744410223793, 1083.9729006774894, 1092.415557676655, 1112.4382186995515, 1117.1732917640886, 1121.4560937945253, 15336.769948450783, 16346.591335216715, 16481.505554833373, 16804.655627549768, 16956.660866782597, 573854.0, 581471.0, 585363.0, 586016.0, 587495.0, 64705.0, 64993.70012599722, 65018.0, 65041.0, 65130.674346627966, 1478.3569147420906, 1509.449051096364, 1515.7423238049557, 1524.908505489652, 1529.724649563067, 29837.0, 30900.690993089782, 31042.844785775927, 31516.527252091695, 31741.206469837514, 55500.44499554953, 56050.43949560452, 57493.71253143708, 57540.71229643825, 59144.40855591389, 510921.0, 595189.024054877, 595605.0, 596974.0, 599323.0, 23989.88005060033, 26317.868410657826, 26689.199324020312, 26802.195934122006, 26837.463250735265, 37764.81117594394, 38787.61212387953, 43165.3525197116, 45375.092498150516, 48264.758676206395, 37152.41687207348, 37573.0, 37994.43008354821, 39203.0, 39217.6078239214, 34981.82509087438, 38082.0, 38952.41571376488, 39192.804035979636, 39408.80295598504, 36990.63009369872, 37193.628063719014, 37218.441723374715, 37295.81352093222, 37945.81027094847, 28032.719672803825, 31583.0, 33591.0, 33929.321413571095, 34036.82981585076, 25101.0, 25211.49577008413, 25450.74549254558, 25774.613380798928, 26161.345966350993], "value": 20785.526627193518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3200766650694, 401.33779264214024, 404.65604236399065, 415.61347946409836, 433.35862922874145, 14610.488632897837, 20730.170793168272, 21343.679844802322, 21868.562628747415, 22090.00594973226, 21133.471663208427, 21854.672179917314, 21935.561288774254, 22107.889460552717, 22226.1109555618, 5238.978399212155, 5385.973070134663, 5589.105743081108, 5863.706814659271, 5863.853403664921, 5721.856953576153, 5864.266966629171, 5876.5298776098025, 5877.617954832944, 5877.6473411595225, 5620.522255608278, 5717.542596592262, 5753.367129615739, 5829.271341082364, 5855.502282306009, 5718.285214348207, 5782.855428614276, 5785.247917770705, 5785.942140578582, 5786.218860453827, 4910.705357678551, 5060.898782024376, 5112.693238405707, 5123.1546794778815, 5137.61467889906, 26543.336416589547, 26610.467790644274, 26652.60021099685, 26753.19740407791, 26954.0, 2809.7471227589413, 2847.18855126288, 2887.6246088008425, 2923.736863682279, 2926.7365937065765, 15648.374065037386, 15802.288896999662, 15826.683466330724, 15962.36150553988, 16365.509034728977, 1809.80092189859, 1853.2494339792406, 1854.4436668999247, 1867.2717640120363, 1867.9066046697747, 123288.0, 126627.0, 127281.36359318237, 127971.0, 130748.0, 10473.319234249902, 11250.718732031764, 11672.241304315192, 11704.0, 11729.589464368706, 13723.382447789874, 13916.791248131287, 14512.709745805025, 14533.491327803476, 14878.92560537212, 8700.0, 9100.81798364029, 9156.725298241063, 9170.587323570455, 9203.631854725736, 8986.505742184243, 9019.954900225457, 9024.278057755364, 9120.726378208665, 9138.63445462174, 4483.686141970096, 4656.5110663379855, 4684.95315046852, 4924.803007879645, 4925.605951523869, 1911.62723268964, 1918.7409699690643, 1964.8428125749906, 2073.2018173003203, 2084.666453367454, 878.8945326560854, 913.6847787513298, 914.2503147419186, 919.9402038867452, 923.5520772425368, 19708.50728731793, 21120.894395527925, 21315.25396611111, 21385.037673304738, 21387.465313366978, 929.2705226397246, 931.7916537805445, 958.1999030809213, 958.7459323279337, 958.7794807194244, 9137.725868223964, 10830.025297723243, 11327.716807079889, 11380.601678941197, 12463.002959763196, 628378.0, 630804.0, 664300.0, 804970.0, 806348.0, 158697.61953570705, 158900.0, 159888.20055899647, 159979.0, 167104.0, 952.1763674421713, 1030.7732298894382, 1042.95828166874, 1099.8680158381046, 1106.3693694594003, 19739.309124180585, 19995.800041999977, 20521.38435846927, 20542.97285135767, 20566.897165514078, 60251.79496410135, 60615.78768424519, 61691.69154154201, 61749.0, 62150.68924655348, 87349.56325218333, 88709.0, 90003.54998224966, 91638.58529902843, 92803.60794587951, 8162.551059691774, 8328.167183281867, 8412.03261624921, 8629.39594228423, 8873.0, 10030.448325342177, 13130.671733206364, 13229.470821167046, 13331.266780327174, 13571.660708482366, 11465.656030319104, 11484.425778710864, 11570.421478925851, 11766.88233117658, 11794.587189448328, 10787.568497260021, 11079.5568177272, 11165.162612804235, 11258.0, 11589.884101159218, 9835.754106147404, 11491.482883270106, 11561.537538498702, 11872.762544748884, 11941.880581194424, 8340.374471914753, 8372.33021358302, 8491.532965686947, 8627.309815214894, 8656.34298416553, 9270.907290927275, 11509.827352589551, 11755.412229388667, 11919.821202681793, 11973.640790776291], "value": 10104.194767806144, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1260.2501511600594, 1462.8610282023203, 1472.63184203949, 1499.430216517723, 1508.894377393582, 7789.805254868631, 8015.198480151982, 8287.005559332882, 8437.240648341649, 8546.10265922077, 8416.07423183451, 8476.1100084491, 8494.447860889039, 8495.575221238929, 8503.489790612568, 2045.478403007231, 2431.2098567965395, 2432.902683892651, 2433.4889673168655, 2438.1222759806456, 2166.3500949715103, 2252.650839119939, 2366.9881650591724, 2430.7083150021936, 2435.0990133650575, 2386.868722220277, 2392.449736560592, 2401.1715957994465, 2401.3756423329974, 2404.0864471500804, 2356.0575769692173, 2373.252425485975, 2376.1920946878145, 2385.093664407514, 2390.2351247600773, 2371.7548287149384, 2375.0381095656285, 2438.4391589934417, 2439.2804122783646, 2443.144899285236, 8435.95782021092, 8450.746477605682, 8521.020082690446, 8537.317014638815, 8590.699325523577, 5165.586753059746, 5324.201369794523, 5326.414094449608, 5333.57331413486, 5355.7857685692525, 3352.4027459954373, 3454.516367708523, 3555.2000799820094, 3666.431703086026, 3685.668289853926, 1218.5552273420226, 1261.0920137500984, 1269.0925987918683, 1318.288124412816, 1327.3827670133337, 10857.945710271477, 10981.39602321872, 10983.560657573687, 10994.175436842268, 11006.339619622848, 3841.058940559525, 4410.25025745624, 4777.044591081798, 4820.758962051884, 4822.541858523435, 9636.036396360309, 9638.42169469834, 9668.0, 9679.274054445945, 9680.177184939359, 5359.946400536022, 5366.490183432567, 5368.0, 5381.704006279692, 5403.297571315704, 4791.712497250176, 4867.5132486751045, 4880.170371036932, 4979.676321039121, 4993.625478089158, 3737.9626203738158, 3834.5206849143856, 3926.842926282917, 4035.1929614077303, 4047.514298284225, 1307.5162189989765, 1312.5078095714107, 1316.8288122544009, 1327.9668008299677, 1333.9666508337368, 915.1671978499534, 923.1138107416955, 937.2127412973135, 957.5355952363099, 1009.8586197932295, 5618.241537392481, 5644.85887852807, 5717.285339332583, 5868.178455016301, 6046.123312119718, 985.9852102218473, 993.6969224386487, 1012.8075665623655, 1046.7278507588082, 1047.9834560476327, 3864.169203621235, 3876.1860009398342, 3924.843006279774, 3939.6454319111417, 3996.760194388288, 9852.704418867446, 10060.597576097021, 10114.54484548197, 10167.389956602627, 10181.847272290921, 10133.08802207805, 10134.949325253474, 10142.543585538668, 10150.086492215736, 10153.984601539787, 7665.0, 7821.335186509211, 7969.242921922408, 7983.281504664608, 7984.640691168911, 5088.4148322941855, 5303.867403314948, 5623.2408624835125, 5659.943400565941, 5731.770729170787, 9128.132827381389, 9143.222826059859, 9210.217131543894, 9343.859842102509, 9429.62281508732, 9279.907200927904, 9482.28882833804, 9497.43015419077, 9595.376300540442, 9599.0, 7221.061262035902, 7254.96372518134, 7291.34377905991, 7303.415726741741, 7309.561426314438, 7721.150673426031, 7869.213078692314, 7942.483738556975, 7958.641861116148, 7960.363170946194, 7127.037849890198, 7142.9285707144345, 7177.6052317120975, 7180.102487189101, 7232.312930271616, 7043.718251269892, 7063.82340441493, 7104.431645468453, 7132.215456299907, 7156.821079472847, 6311.90532142009, 6486.610803351814, 6522.412982831568, 6522.902156467751, 6541.149650545399, 5077.136886729339, 5092.618053646065, 5117.692938423706, 5141.691498510101, 5152.30443890085, 4986.102501549756, 5082.669626474268, 5128.948710512847, 5233.371995360581, 5240.973795131], "value": 4533.502894673331, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.430983356131, 371.4428357463804, 373.53494898850937, 378.92989796887576, 379.63934262450664, 4816.951830481694, 5349.38482074561, 5380.381256155543, 5455.372632147304, 5510.448955104487, 4988.526090021452, 5225.869353266161, 5244.659097158691, 5410.972945135279, 5458.524010311546, 3688.8933320004026, 4100.5443067710985, 4242.618164365206, 4244.617984381405, 4253.341196933198, 3722.7394082414244, 4202.495700515942, 4219.873403797891, 4229.682773791963, 4248.723832950848, 3692.9630703693024, 3888.3972984187353, 4203.390508376284, 4234.957650423503, 4240.809163587646, 3317.9004629861142, 4064.2887494688457, 4111.794410279489, 4217.072244106292, 4222.87331380056, 2965.4217427601625, 3415.7532500637335, 3570.232400033979, 3734.551853777537, 3744.326021316162, 4788.640851936118, 4943.579795717368, 4963.677360971526, 5265.657732247391, 5288.603354748371, 4699.754565040267, 4830.2513110467935, 4831.541003604652, 4872.317875497433, 4904.877378065541, 4504.346869703874, 4707.905841883143, 5603.299587551556, 5655.886882262332, 5668.376478587352, 3535.3636345457808, 4176.331786914109, 4177.832886684529, 4179.516271723524, 4200.243956087903, 4795.177832423691, 5490.533304669108, 5909.4090590941, 5971.880562388728, 6010.303663247115, 3396.4565669492763, 4205.789710514523, 4211.810468528924, 4221.873343799691, 4225.239456897788, 4292.763897985641, 4294.269974104347, 4296.505901821268, 4302.720323178984, 4306.418633484503, 4373.950251939512, 4444.888877778081, 4864.854054378375, 4876.805692271568, 4916.5820905222745, 5655.717214139277, 5682.0, 5689.943100568941, 5706.658935150236, 5788.913166302509, 1313.487739781486, 1336.2895493767992, 1386.682651481097, 1399.5374833299227, 1413.7949997250341, 872.7905302727299, 875.1729615513406, 902.566767951387, 983.4345251480428, 987.9950600247097, 4750.809967601326, 4861.9027619447415, 4944.752762361867, 4973.6269779765935, 4986.080359061715, 4812.614990800727, 4828.37231159947, 5548.116318577012, 5567.276254086943, 5603.831885043455, 4350.282203436397, 4624.884377890512, 4728.881777955578, 4917.631177661689, 5000.174936148353, 2594.8582623645534, 2803.8738256778493, 2923.63454568179, 2932.208303757973, 2951.5425109108123, 5067.442581316052, 5657.60396772222, 5692.48767610917, 5697.572682048863, 5712.514436272881, 5309.602895245711, 5659.915101273484, 5696.829095127153, 5700.232927792397, 5746.396628354046, 5599.944000559943, 5764.596478246483, 5794.450441805592, 5795.478406943395, 5940.79207227745, 5367.906516458506, 5822.330432000204, 5839.131477927022, 5860.597155166532, 5869.501092407022, 4606.953930460652, 4698.530146985274, 5088.491150884882, 5565.719884426524, 5793.710314484343, 5475.4250803665045, 5934.465898069195, 5944.53301879715, 5956.8808623828145, 5977.641341519523, 3566.768160069691, 3870.845166193321, 4199.769012704331, 4231.87304380869, 4234.4495215623, 5333.973330133324, 5615.634983726208, 5641.464060914206, 5785.900678871001, 5864.413558644102, 4423.867283981485, 5005.4744251853035, 5006.349174607278, 5696.914546281726, 5758.366579676316, 4836.032793441255, 5140.974295128501, 5425.674459532441, 5492.80775172867, 5686.886262274814, 4906.362172917497, 5180.57534178104, 5460.744028873302, 5500.669959802424, 5534.806281780118, 4878.56092951636, 5584.609077364546, 5644.2380278663495, 5655.020742740173, 5693.4875861172695, 4762.3332733416655, 4881.950380668173, 5241.981836992709, 5431.619786614899, 5589.55283577321], "value": 4149.271318773472, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.571871174075, 775.561807578718, 796.1600511460407, 810.3071873548116, 880.2957633892886, 15213.239338033109, 15304.846951530495, 15489.225538723074, 15562.377504899805, 15565.766513502307, 13404.128731632461, 13867.306634668277, 14532.20072895993, 14593.489227877026, 14653.706925861476, 899.5322432335182, 912.8539433690611, 913.7213149989251, 914.5198770645432, 916.9449833010008, 731.9707211711525, 750.2797314578012, 751.8533885892253, 755.7052749427728, 907.129156010231, 762.5386641082149, 921.5254144115752, 957.2103015012608, 962.5331714118682, 974.2108891797632, 956.7942892278124, 958.9930572898463, 960.6397600899662, 962.8651988721584, 964.8938616752151, 721.2102747491489, 722.212788061016, 722.5195245162014, 723.8045727653504, 724.3517052238217, 15619.453319133776, 15836.920815395964, 15950.202489875575, 15995.040297582182, 16031.839681603267, 14806.925965370212, 14889.0, 15209.771853422208, 15261.542153735405, 15386.846131538654, 11754.23597466162, 11846.703832404259, 11895.0, 11972.161948663597, 12091.93954030233, 3751.924961500782, 3781.6029316921877, 3784.4701741756176, 3945.4673619061346, 4029.214303210875, 91601.54199229028, 94714.0, 100475.9952400474, 101772.49113754384, 104663.47668261686, 11205.908190765545, 11508.36703981289, 11600.593979210857, 11725.589604363977, 11985.16103872738, 24312.756872431404, 24375.26874193777, 24393.0, 24810.87594562052, 24846.37884052913, 7897.447178697436, 8102.635381407851, 8153.714619988272, 8163.469374490639, 8274.379421543408, 4457.68796184264, 4469.173202957463, 4495.887602809956, 4565.726056436624, 4613.5386461354265, 3698.9445158322646, 3718.7396882218527, 3770.5286839145106, 3795.994061573685, 3803.809809509569, 638.06523443156, 690.7720452250845, 691.5919607431639, 695.151914664109, 709.765777293492, 664.9800505984829, 691.0187533702154, 702.5082442290314, 702.9121359830021, 761.8742907420325, 10255.0, 10434.739131521772, 10667.466626668636, 10839.729006774736, 10981.39602321864, 716.5127713155, 719.924407937159, 743.6653505922249, 745.5526683989672, 752.8193233623891, 4762.4285085789925, 4771.761411929389, 5052.837847295143, 5193.974030129825, 5205.245239440335, 98169.0, 98554.0, 99618.50190749, 102175.0, 105821.0, 76506.0, 95421.0, 95523.0447695528, 97889.0, 99810.00189998152, 84762.5761871199, 86277.1372286269, 87015.12984870323, 87672.56163719269, 89905.55047224853, 10033.09702126812, 10165.44090075053, 10165.79668406613, 10189.286749927434, 10227.94886025565, 47522.28716569185, 50389.74805125951, 53241.0, 53817.0, 56479.71760141173, 62490.32019544564, 66543.66728166328, 68295.65852170707, 69108.6544567294, 71153.59617634438, 13454.596362109152, 13767.724645507235, 13803.17180969145, 13902.16587004783, 13934.651633709238, 15019.09885406879, 15094.698106038037, 15374.308156133224, 15507.457238996582, 16096.597585059999, 13792.793108103186, 13933.372998215307, 14344.641383965485, 14348.856511434751, 14394.784078239045, 12890.613281601567, 13086.0, 13961.162330260217, 14035.789463158266, 14214.076085054437, 12773.61679149627, 13068.869311306766, 13071.15037522558, 13447.991400645187, 13464.798028029783, 10456.529456174643, 10635.564198833059, 11256.493457794582, 11310.717232068935, 11459.0, 10776.407297598707, 10887.564497420015, 11037.050680233191, 11325.263857849213, 11326.150538709795], "value": 7790.559297536527, "unit": "score"}], "name": "dromaeo_css", "value": 7504.209003565291, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 115.0, 114.0, 113.0, 115.0, 112.0, 112.0, 114.0, 114.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 106.0, 114.0, 142.0, 110.0, 106.0, 106.0, 107.0, 127.0, 109.0], "value": 116.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 184.0, 183.0, 183.0, 184.0, 185.0, 182.0, 181.0, 185.0, 183.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 56.0, 58.0, 87.0, 62.0, 58.0, 56.0, 58.0, 73.0, 57.0], "value": 64.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 70.0, 85.0, 72.0, 66.0, 66.0, 81.0, 66.0, 67.0, 80.0], "value": 73.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 87.0, 87.0, 134.0, 125.0, 86.0, 104.0], "value": 96.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 85.0, 85.0, 84.0, 87.0, 86.0, 89.0, 86.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 50.0, 53.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 71.0, 78.0, 71.0, 66.0, 68.0, 68.0, 67.0, 69.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 81.0, 93.0, 98.0, 97.0, 97.0, 82.0, 88.0, 82.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 130.0, 131.0, 132.0, 136.0, 155.0, 146.0, 143.0, 192.0, 165.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 162.0, 161.0, 162.0, 164.0, 162.0, 160.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 63.0, 64.0, 62.0, 62.0, 63.0, 63.0, 63.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1409.4, "alertThreshold": 2.0}]} 05:44:59 INFO - Return code: 0 05:44:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:44:59 INFO - # TBPL SUCCESS # 05:44:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:44:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:44:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:44:59 INFO - 2017-03-09 05:44:59.588 screenresolution[1649:9579] starting screenresolution argv=screenresolution get 05:44:59 INFO - 2017-03-09 05:44:59.591 screenresolution[1649:9579] Display 0: 1600x1200x32@60 05:44:59 INFO - 2017-03-09 05:44:59.597 screenresolution[1650:9582] starting screenresolution argv=screenresolution list 05:44:59 INFO - Available Modes on Display 0 05:44:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:44:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:44:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:44:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:44:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:44:59 INFO - Intel Iris: 05:44:59 INFO - Chipset Model: Intel Iris 05:44:59 INFO - Type: GPU 05:44:59 INFO - Bus: Built-In 05:44:59 INFO - VRAM (Dynamic, Max): 1536 MB 05:44:59 INFO - Vendor: Intel (0x8086) 05:44:59 INFO - Device ID: 0x0a2e 05:44:59 INFO - Revision ID: 0x0009 05:44:59 INFO - Displays: 05:44:59 INFO - Display: 05:44:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:44:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:44:59 INFO - Display Serial Number: 1600x1200 60 05:44:59 INFO - Main Display: Yes 05:44:59 INFO - Mirror: Off 05:44:59 INFO - Online: Yes 05:44:59 INFO - Rotation: Supported 05:44:59 INFO - Return code: 0 05:44:59 INFO - Running post-action listener: _resource_record_post_action 05:44:59 INFO - [mozharness: 2017-03-09 13:44:59.836017Z] Finished run-tests step (success) 05:44:59 INFO - Running post-run listener: _resource_record_post_run 05:44:59 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 40133632; Write bytes: 424255488; Read time: 403; Write time: 1518 05:44:59 INFO - TinderboxPrint: CPU usage
53.9% 05:44:59 INFO - TinderboxPrint: I/O read bytes / time
40,133,632 / 403 05:44:59 INFO - TinderboxPrint: I/O write bytes / time
424,255,488 / 1,518 05:44:59 INFO - TinderboxPrint: CPU idle
2,196.8 (46.1%) 05:44:59 INFO - TinderboxPrint: CPU system
957.3 (20.1%) 05:44:59 INFO - TinderboxPrint: CPU user
1,611.5 (33.8%) 05:44:59 INFO - TinderboxPrint: Swap in / out
160,849,920 / 0 05:44:59 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 112040448; Write bytes: 104370176; Read time: 10069; Write time: 189 05:44:59 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 39150592; Write bytes: 297486336; Read time: 389; Write time: 1226 05:45:00 INFO - Running post-run listener: _upload_blobber_files 05:45:00 INFO - Blob upload gear active. 05:45:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:45:00 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:45:00 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:45:00 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:45:00 INFO - (blobuploader) - INFO - Open directory for files ... 05:45:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:45:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:45:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:01 INFO - (blobuploader) - INFO - Done attempting. 05:45:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:45:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:45:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:03 INFO - (blobuploader) - INFO - Done attempting. 05:45:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:45:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:45:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:03 INFO - (blobuploader) - INFO - Done attempting. 05:45:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:45:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:45:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:06 INFO - (blobuploader) - INFO - Done attempting. 05:45:06 INFO - (blobuploader) - INFO - Iteration through files over. 05:45:06 INFO - Return code: 0 05:45:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:45:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:45:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/915f888690865fa9f34aa083c372b6ced47b5f9db093fe3b6da9b23eff3e8faddd920f9349af4c1b36c22852406f688983692ad71abd9f6df71596aa73e56a3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc2f80d54e2b155518d3e4d63ab98d5776951706a2a125baf942de2906f6c290a226849465d393e9b6c3d3118675504d94d3e155639251df4ba2ec48c702220c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6308bbc5de3af9d5eda863df944847dfff9fa6ff24c5b818491dbf764e428af77c652702982a452916a802e29db45d6e867cb5d197bfbb0e06ddadff60fcef18", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62c6285ad85f29c641e722e9df50cc3afcd3e707187f8479f354f733a12879ef42a3847e4dc814c0051e7916fdf7ce4ac9e3ec003a0070e302f6192b024f020a"} 05:45:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:45:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:45:06 INFO - Contents: 05:45:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/915f888690865fa9f34aa083c372b6ced47b5f9db093fe3b6da9b23eff3e8faddd920f9349af4c1b36c22852406f688983692ad71abd9f6df71596aa73e56a3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc2f80d54e2b155518d3e4d63ab98d5776951706a2a125baf942de2906f6c290a226849465d393e9b6c3d3118675504d94d3e155639251df4ba2ec48c702220c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6308bbc5de3af9d5eda863df944847dfff9fa6ff24c5b818491dbf764e428af77c652702982a452916a802e29db45d6e867cb5d197bfbb0e06ddadff60fcef18", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62c6285ad85f29c641e722e9df50cc3afcd3e707187f8479f354f733a12879ef42a3847e4dc814c0051e7916fdf7ce4ac9e3ec003a0070e302f6192b024f020a"} 05:45:06 INFO - Running post-run listener: copy_logs_to_upload_dir 05:45:06 INFO - Copying logs to upload dir... 05:45:06 INFO - mkdir: /builds/slave/test/build/upload/logs 05:45:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.802128 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-09 05:45:06.389733) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 05:45:06.393542) ========= 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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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/915f888690865fa9f34aa083c372b6ced47b5f9db093fe3b6da9b23eff3e8faddd920f9349af4c1b36c22852406f688983692ad71abd9f6df71596aa73e56a3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc2f80d54e2b155518d3e4d63ab98d5776951706a2a125baf942de2906f6c290a226849465d393e9b6c3d3118675504d94d3e155639251df4ba2ec48c702220c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6308bbc5de3af9d5eda863df944847dfff9fa6ff24c5b818491dbf764e428af77c652702982a452916a802e29db45d6e867cb5d197bfbb0e06ddadff60fcef18", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62c6285ad85f29c641e722e9df50cc3afcd3e707187f8479f354f733a12879ef42a3847e4dc814c0051e7916fdf7ce4ac9e3ec003a0070e302f6192b024f020a"} build_url:https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010918 build_url: 'https://queue.taskcluster.net/v1/task/H2UjSFLOR42GnWetahONug/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/915f888690865fa9f34aa083c372b6ced47b5f9db093fe3b6da9b23eff3e8faddd920f9349af4c1b36c22852406f688983692ad71abd9f6df71596aa73e56a3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc2f80d54e2b155518d3e4d63ab98d5776951706a2a125baf942de2906f6c290a226849465d393e9b6c3d3118675504d94d3e155639251df4ba2ec48c702220c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6308bbc5de3af9d5eda863df944847dfff9fa6ff24c5b818491dbf764e428af77c652702982a452916a802e29db45d6e867cb5d197bfbb0e06ddadff60fcef18", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62c6285ad85f29c641e722e9df50cc3afcd3e707187f8479f354f733a12879ef42a3847e4dc814c0051e7916fdf7ce4ac9e3ec003a0070e302f6192b024f020a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 05:45:06.429821) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:45:06.430342) ========= 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.TXxqY1fAfr/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.kDT2OUqAPc/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.005094 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:45:06.481105) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 05:45:06.481643) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 05:45:06.482260) ========= ========= Total master_lag: 0.19 =========