builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0061 starttime: 1489015461.04 results: success (0) buildid: 20170308135723 builduid: 09decd5b7b484d8ba73eb7a1dfdd27cf revision: fb836ee72ce6953b44ec4538d72a2cf27c106fc7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 15:24:21.040752) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 15:24:21.041226) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 15:24:21.041510) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 15:24:21.066515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 15:24:21.066870) ========= 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.YxyPCOJLTh/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.gbvrO39Cis/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-08 15:24:21-- 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% 1.31M=0.009s 2017-03-08 15:24:21 (1.31 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087373 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 15:24:21.178783) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 15:24:21.179151) ========= 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.YxyPCOJLTh/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.gbvrO39Cis/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.019562 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 15:24:21.332513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-08 15:24:21.332892) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fb836ee72ce6953b44ec4538d72a2cf27c106fc7 --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 fb836ee72ce6953b44ec4538d72a2cf27c106fc7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YxyPCOJLTh/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.gbvrO39Cis/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-08 15:24:21,418 truncating revision to first 12 chars 2017-03-08 15:24:21,418 Setting DEBUG logging. 2017-03-08 15:24:21,418 attempt 1/10 2017-03-08 15:24:21,419 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fb836ee72ce6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-08 15:24:22,520 unpacking tar archive at: mozilla-beta-fb836ee72ce6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.349441 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-08 15:24:22.707484) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 15:24:22.707842) ========= script_repo_revision: fb836ee72ce6953b44ec4538d72a2cf27c106fc7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 15:24:22.708243) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 15:24:22.708531) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 15:24:22.729018) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-08 15:24:22.729430) ========= /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.YxyPCOJLTh/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.gbvrO39Cis/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 15:24:22 INFO - MultiFileLogger online at 20170308 15:24:22 in /builds/slave/test 15:24:22 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 15:24:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:24:22 INFO - {'append_to_log': False, 15:24:22 INFO - 'base_work_dir': '/builds/slave/test', 15:24:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:24:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:24:22 INFO - 'branch': 'Mozilla-Beta', 15:24:22 INFO - 'buildbot_json_path': 'buildprops.json', 15:24:22 INFO - 'config_files': ('talos/mac_config.py',), 15:24:22 INFO - 'default_actions': ('clobber', 15:24:22 INFO - 'read-buildbot-config', 15:24:22 INFO - 'download-and-extract', 15:24:22 INFO - 'populate-webroot', 15:24:22 INFO - 'create-virtualenv', 15:24:22 INFO - 'install', 15:24:22 INFO - 'run-tests'), 15:24:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:24:22 INFO - 'download_minidump_stackwalk': True, 15:24:22 INFO - 'download_symbols': 'ondemand', 15:24:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:24:22 INFO - 'tooltool.py': '/tools/tooltool.py', 15:24:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:24:22 INFO - '/tools/misc-python/virtualenv.py')}, 15:24:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:24:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:24:22 INFO - 'installer_path': 'installer.exe', 15:24:22 INFO - 'log_level': 'info', 15:24:22 INFO - 'log_name': 'talos', 15:24:22 INFO - 'log_to_console': True, 15:24:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:24:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:24:22 INFO - 'opt_config_files': (), 15:24:22 INFO - 'pip_index': False, 15:24:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:24:22 INFO - 'cmd': ('bash', 15:24:22 INFO - '-c', 15:24:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:24:22 INFO - 'enabled': True, 15:24:22 INFO - 'halt_on_failure': False, 15:24:22 INFO - 'name': 'check_screen_resolution'},), 15:24:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:24:22 INFO - 'cmd': ('bash', 15:24:22 INFO - '-c', 15:24:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:24:22 INFO - 'enabled': True, 15:24:22 INFO - 'halt_on_failure': False, 15:24:22 INFO - 'name': 'check_screen_resolution'},), 15:24:22 INFO - 'run_cmd_checks_enabled': True, 15:24:22 INFO - 'sps_profile': False, 15:24:22 INFO - 'sps_profile_interval': 0, 15:24:22 INFO - 'suite': 'dromaeojs', 15:24:22 INFO - 'system_bits': '32', 15:24:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:24:22 INFO - 'title': 't-yosemite-r7-0061', 15:24:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:24:22 INFO - 'use_talos_json': True, 15:24:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:24:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:24:22 INFO - 'work_dir': 'build'} 15:24:22 INFO - [mozharness: 2017-03-08 23:24:22.942237Z] Running clobber step. 15:24:22 INFO - Running pre-action listener: _resource_record_pre_action 15:24:22 INFO - Running main action method: clobber 15:24:22 INFO - rmtree: /builds/slave/test/build 15:24:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:24:24 INFO - Running post-action listener: _resource_record_post_action 15:24:24 INFO - [mozharness: 2017-03-08 23:24:24.407328Z] Finished clobber step (success) 15:24:24 INFO - [mozharness: 2017-03-08 23:24:24.407478Z] Running read-buildbot-config step. 15:24:24 INFO - Running pre-action listener: _resource_record_pre_action 15:24:24 INFO - Running main action method: read_buildbot_config 15:24:24 INFO - Using buildbot properties: 15:24:24 INFO - { 15:24:24 INFO - "project": "", 15:24:24 INFO - "product": "firefox", 15:24:24 INFO - "script_repo_revision": "production", 15:24:24 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:24:24 INFO - "repository": "", 15:24:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:24:24 INFO - "buildid": "20170308135723", 15:24:24 INFO - "pgo_build": "False", 15:24:24 INFO - "basedir": "/builds/slave/test", 15:24:24 INFO - "buildnumber": 0, 15:24:24 INFO - "slavename": "t-yosemite-r7-0061", 15:24:24 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 15:24:24 INFO - "platform": "yosemite_r7", 15:24:24 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:24:24 INFO - "branch": "mozilla-beta", 15:24:24 INFO - "repo_path": "releases/mozilla-beta", 15:24:24 INFO - "revision": "fb836ee72ce6953b44ec4538d72a2cf27c106fc7", 15:24:24 INFO - "stage_platform": "macosx64", 15:24:24 INFO - "builduid": "09decd5b7b484d8ba73eb7a1dfdd27cf", 15:24:24 INFO - "slavebuilddir": "test" 15:24:24 INFO - } 15:24:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 15:24:24 INFO - Running post-action listener: _resource_record_post_action 15:24:24 INFO - [mozharness: 2017-03-08 23:24:24.410694Z] Finished read-buildbot-config step (success) 15:24:24 INFO - [mozharness: 2017-03-08 23:24:24.410805Z] Running download-and-extract step. 15:24:24 INFO - Running pre-action listener: _resource_record_pre_action 15:24:24 INFO - Running main action method: download_and_extract 15:24:24 INFO - mkdir: /builds/slave/test/build/tests 15:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:24 INFO - trying https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 15:24:24 INFO - Downloading https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/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 15:24:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/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 15:24:25 INFO - Downloaded 1165 bytes. 15:24:25 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:24:25 INFO - Using the following test package requirements: 15:24:25 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:24:25 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:24:25 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 15:24:25 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:24:25 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 15:24:25 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:24:25 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:24:25 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 15:24:25 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:24:25 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:24:25 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 15:24:25 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:24:25 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 15:24:25 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:24:25 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 15:24:25 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:24:25 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 15:24:25 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 15:24:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:24:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:24:25 INFO - Fetch https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:24:26 INFO - Expected file size: 16103538 15:24:26 INFO - Obtained file size: 16103538 15:24:33 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 15:24:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:24:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:24:33 INFO - Fetch https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:24:34 INFO - Expected file size: 16103538 15:24:34 INFO - Obtained file size: 16103538 15:24:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 15:24:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 15:24:40 INFO - Fetch https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 15:24:41 INFO - Expected file size: 14403650 15:24:41 INFO - Obtained file size: 14403650 15:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:42 INFO - trying https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:24:42 INFO - Downloading https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 15:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/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 15:24:43 INFO - Downloaded 58693073 bytes. 15:24:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:24:43 INFO - mkdir: /builds/slave/test/properties 15:24:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:24:43 INFO - Writing to file /builds/slave/test/properties/build_url 15:24:43 INFO - Contents: 15:24:43 INFO - build_url:https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:24:44 INFO - Running post-action listener: _resource_record_post_action 15:24:44 INFO - Running post-action listener: set_extra_try_arguments 15:24:44 INFO - [mozharness: 2017-03-08 23:24:44.446689Z] Finished download-and-extract step (success) 15:24:44 INFO - [mozharness: 2017-03-08 23:24:44.446831Z] Running populate-webroot step. 15:24:44 INFO - Running pre-action listener: _resource_record_pre_action 15:24:44 INFO - Running main action method: populate_webroot 15:24:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:24:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:24:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:24:44 INFO - '--tppagecycles', 15:24:44 INFO - '7'], 15:24:44 INFO - 'tests': ['tsvgm']}}, 15:24:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:24:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:24:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:24:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:24:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:24:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:24:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:24:44 INFO - 'talos_options': ['--disable-e10s'], 15:24:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:24:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:24:44 INFO - 'talos_options': ['--disable-e10s'], 15:24:44 INFO - 'tests': ['damp', 'tps']}, 15:24:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:24:44 INFO - 'tests': ['damp', 'tps']}, 15:24:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:24:44 INFO - 'tests': ['dromaeo_dom']}, 15:24:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:24:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:24:44 INFO - 'tests': ['basic_compositor_video']}, 15:24:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:24:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:24:44 INFO - 'tests': ['a11yr', 15:24:44 INFO - 'ts_paint', 15:24:44 INFO - 'tpaint', 15:24:44 INFO - 'sessionrestore', 15:24:44 INFO - 'sessionrestore_no_auto_restore', 15:24:44 INFO - 'tabpaint']}, 15:24:44 INFO - 'other-e10s': {'tests': ['a11yr', 15:24:44 INFO - 'ts_paint', 15:24:44 INFO - 'tpaint', 15:24:44 INFO - 'sessionrestore', 15:24:44 INFO - 'sessionrestore_no_auto_restore', 15:24:44 INFO - 'tabpaint']}, 15:24:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:24:44 INFO - 'ts_paint', 15:24:44 INFO - 'tpaint', 15:24:44 INFO - 'sessionrestore', 15:24:44 INFO - 'sessionrestore_no_auto_restore', 15:24:44 INFO - 'tabpaint']}, 15:24:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:24:44 INFO - 'ts_paint', 15:24:44 INFO - 'tpaint', 15:24:44 INFO - 'sessionrestore', 15:24:44 INFO - 'sessionrestore_no_auto_restore', 15:24:44 INFO - 'tabpaint']}, 15:24:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:24:44 INFO - 'tests': ['a11yr', 15:24:44 INFO - 'ts_paint', 15:24:44 INFO - 'tpaint', 15:24:44 INFO - 'sessionrestore', 15:24:44 INFO - 'sessionrestore_no_auto_restore', 15:24:44 INFO - 'tabpaint']}, 15:24:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:24:44 INFO - 'tests': ['a11yr', 15:24:44 INFO - 'ts_paint', 15:24:44 INFO - 'tpaint', 15:24:44 INFO - 'sessionrestore', 15:24:44 INFO - 'sessionrestore_no_auto_restore', 15:24:44 INFO - 'tabpaint']}, 15:24:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:24:44 INFO - 'tests': ['tsvgx', 15:24:44 INFO - 'tsvgr_opacity', 15:24:44 INFO - 'tart', 15:24:44 INFO - 'tscrollx', 15:24:44 INFO - 'cart', 15:24:44 INFO - 'tsvg_static']}, 15:24:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:24:44 INFO - 'tsvgr_opacity', 15:24:44 INFO - 'tart', 15:24:44 INFO - 'tscrollx', 15:24:44 INFO - 'cart', 15:24:44 INFO - 'tsvg_static']}, 15:24:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:24:44 INFO - 'talos_options': ['--disable-e10s'], 15:24:44 INFO - 'tests': ['tp5o']}, 15:24:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:24:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:24:44 INFO - 'talos_options': ['--disable-e10s', 15:24:44 INFO - '--xperf_path', 15:24:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:44 INFO - 'tests': ['tp5n']}, 15:24:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:24:44 INFO - 'talos_options': ['--xperf_path', 15:24:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:44 INFO - 'tests': ['tp5n']}}, 15:24:44 INFO - 'talos.zip': {'path': '', 15:24:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:24:44 INFO - Running post-action listener: _resource_record_post_action 15:24:44 INFO - [mozharness: 2017-03-08 23:24:44.465691Z] Finished populate-webroot step (success) 15:24:44 INFO - [mozharness: 2017-03-08 23:24:44.465833Z] Running create-virtualenv step. 15:24:44 INFO - Running pre-action listener: _resource_record_pre_action 15:24:44 INFO - Running main action method: create_virtualenv 15:24:44 INFO - Creating virtualenv /builds/slave/test/build/venv 15:24:44 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 15:24:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:24:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:24:44 INFO - Using real prefix '/tools/python27' 15:24:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:24:45 INFO - Installing distribute.............................................................................................................................................................................................done. 15:24:48 INFO - Installing pip.................done. 15:24:48 INFO - Return code: 0 15:24:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:24:48 INFO - Reading from file tmpfile_stdout 15:24:48 INFO - Output received: 15:24:48 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) 15:24:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106b97b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b9a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0256f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106975d30>, '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 0x10689cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10696abe8>, '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.YxyPCOJLTh/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.gbvrO39Cis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 15:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:24:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxyPCOJLTh/Render', 15:24:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:24:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:24:48 INFO - 'HOME': '/Users/cltbld', 15:24:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:24:48 INFO - 'LOGNAME': 'cltbld', 15:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:48 INFO - 'MOZ_NO_REMOTE': '1', 15:24:48 INFO - 'NO_EM_RESTART': '1', 15:24:48 INFO - 'PAGER': '/bin/cat', 15:24:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:48 INFO - 'PWD': '/builds/slave/test', 15:24:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:24:48 INFO - 'SHELL': '/bin/bash', 15:24:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gbvrO39Cis/Listeners', 15:24:48 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 15:24:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:24:48 INFO - 'USER': 'cltbld', 15:24:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:24:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:48 INFO - 'XPC_FLAGS': '0x0', 15:24:48 INFO - 'XPC_SERVICE_NAME': '0', 15:24:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:48 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 15:24:48 INFO - Cleaning up... 15:24:48 INFO - Return code: 0 15:24:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106b97b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b9a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0256f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106975d30>, '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 0x10689cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10696abe8>, '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.YxyPCOJLTh/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.gbvrO39Cis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 15:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:24:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxyPCOJLTh/Render', 15:24:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:24:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:24:48 INFO - 'HOME': '/Users/cltbld', 15:24:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:24:48 INFO - 'LOGNAME': 'cltbld', 15:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:48 INFO - 'MOZ_NO_REMOTE': '1', 15:24:48 INFO - 'NO_EM_RESTART': '1', 15:24:48 INFO - 'PAGER': '/bin/cat', 15:24:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:48 INFO - 'PWD': '/builds/slave/test', 15:24:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:24:48 INFO - 'SHELL': '/bin/bash', 15:24:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gbvrO39Cis/Listeners', 15:24:48 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 15:24:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:24:48 INFO - 'USER': 'cltbld', 15:24:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:24:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:48 INFO - 'XPC_FLAGS': '0x0', 15:24:48 INFO - 'XPC_SERVICE_NAME': '0', 15:24:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:48 INFO - Downloading/unpacking psutil>=3.1.1 15:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:24:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:52 INFO - Installing collected packages: psutil 15:24:52 INFO - Running setup.py install for psutil 15:24:52 INFO - building 'psutil._psutil_osx' extension 15:24:52 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 15:24:53 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 15:24:53 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 15:24:53 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 15:24:53 INFO - building 'psutil._psutil_posix' extension 15:24:53 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 15:24:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:24:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:24:53 INFO - ^ 15:24:53 INFO - 1 warning generated. 15:24:53 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 15:24:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:53 INFO - Successfully installed psutil 15:24:53 INFO - Cleaning up... 15:24:53 INFO - Return code: 0 15:24:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106b97b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b9a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0256f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106975d30>, '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 0x10689cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10696abe8>, '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.YxyPCOJLTh/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.gbvrO39Cis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 15:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:24:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxyPCOJLTh/Render', 15:24:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:24:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:24:53 INFO - 'HOME': '/Users/cltbld', 15:24:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:24:53 INFO - 'LOGNAME': 'cltbld', 15:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:53 INFO - 'MOZ_NO_REMOTE': '1', 15:24:53 INFO - 'NO_EM_RESTART': '1', 15:24:53 INFO - 'PAGER': '/bin/cat', 15:24:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:53 INFO - 'PWD': '/builds/slave/test', 15:24:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:24:53 INFO - 'SHELL': '/bin/bash', 15:24:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gbvrO39Cis/Listeners', 15:24:53 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 15:24:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:24:53 INFO - 'USER': 'cltbld', 15:24:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:24:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:53 INFO - 'XPC_FLAGS': '0x0', 15:24:53 INFO - 'XPC_SERVICE_NAME': '0', 15:24:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:24:53 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 15:24:53 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 15:24:53 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 15:24:53 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 15:24:53 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 15:24:53 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 15:24:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:24:56 INFO - Installing collected packages: mozsystemmonitor 15:24:56 INFO - Running setup.py install for mozsystemmonitor 15:24:56 INFO - Successfully installed mozsystemmonitor 15:24:56 INFO - Cleaning up... 15:24:56 INFO - Return code: 0 15:24:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15: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')]} 15:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:56 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 0x106b97b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b9a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0256f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106975d30>, '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 0x10689cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10696abe8>, '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.YxyPCOJLTh/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.gbvrO39Cis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 15:24:56 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 15:24:56 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 15:24:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxyPCOJLTh/Render', 15:24:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:24:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:24:56 INFO - 'HOME': '/Users/cltbld', 15:24:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:24:56 INFO - 'LOGNAME': 'cltbld', 15:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:56 INFO - 'MOZ_NO_REMOTE': '1', 15:24:56 INFO - 'NO_EM_RESTART': '1', 15:24:56 INFO - 'PAGER': '/bin/cat', 15:24:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:56 INFO - 'PWD': '/builds/slave/test', 15:24:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:24:56 INFO - 'SHELL': '/bin/bash', 15:24:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gbvrO39Cis/Listeners', 15:24:56 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 15:24:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:24:56 INFO - 'USER': 'cltbld', 15:24:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:24:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:56 INFO - 'XPC_FLAGS': '0x0', 15:24:56 INFO - 'XPC_SERVICE_NAME': '0', 15:24:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:57 INFO - Downloading/unpacking jsonschema==2.5.1 15:24:57 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 15:24:57 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 15:24:57 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 15:24:57 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 15:24:57 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 15:24:57 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 15:24:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:24:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:24:59 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 15:24:59 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 15:24:59 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 15:24:59 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 15:24:59 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 15:24:59 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 15:25:00 INFO - Downloading functools32-3.2.3-2.tar.gz 15:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:25:00 INFO - warning: no files found matching '*.txt' 15:25:00 INFO - no previously-included directories found matching 'build' 15:25:00 INFO - no previously-included directories found matching 'dist' 15:25:00 INFO - no previously-included directories found matching '.git*' 15:25:00 INFO - Installing collected packages: jsonschema, functools32 15:25:00 INFO - Running setup.py install for functools32 15:25:00 INFO - warning: no files found matching '*.txt' 15:25:00 INFO - no previously-included directories found matching 'build' 15:25:00 INFO - no previously-included directories found matching 'dist' 15:25:00 INFO - no previously-included directories found matching '.git*' 15:25:00 INFO - Successfully installed jsonschema functools32 15:25:00 INFO - Cleaning up... 15:25:00 INFO - Return code: 0 15:25:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:25:00 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')]} 15:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:00 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')]} 15:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:00 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 0x106b97b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b9a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0256f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106975d30>, '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 0x10689cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10696abe8>, '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.YxyPCOJLTh/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.gbvrO39Cis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 15:25:00 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 15:25:00 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 15:25:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxyPCOJLTh/Render', 15:25:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:00 INFO - 'HOME': '/Users/cltbld', 15:25:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:00 INFO - 'LOGNAME': 'cltbld', 15:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:00 INFO - 'MOZ_NO_REMOTE': '1', 15:25:00 INFO - 'NO_EM_RESTART': '1', 15:25:00 INFO - 'PAGER': '/bin/cat', 15:25:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:00 INFO - 'PWD': '/builds/slave/test', 15:25:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:00 INFO - 'SHELL': '/bin/bash', 15:25:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gbvrO39Cis/Listeners', 15:25:00 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 15:25:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:00 INFO - 'USER': 'cltbld', 15:25:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:00 INFO - 'XPC_FLAGS': '0x0', 15:25:00 INFO - 'XPC_SERVICE_NAME': '0', 15:25:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:25:00 INFO - Cleaning up... 15:25:00 INFO - Return code: 0 15:25:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:25:00 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')]} 15:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:00 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')]} 15:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:00 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 0x106b97b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b9a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0256f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106975d30>, '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 0x10689cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10696abe8>, '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.YxyPCOJLTh/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.gbvrO39Cis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 15:25:00 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 15:25:00 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 15:25:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxyPCOJLTh/Render', 15:25:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:00 INFO - 'HOME': '/Users/cltbld', 15:25:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:00 INFO - 'LOGNAME': 'cltbld', 15:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:00 INFO - 'MOZ_NO_REMOTE': '1', 15:25:00 INFO - 'NO_EM_RESTART': '1', 15:25:00 INFO - 'PAGER': '/bin/cat', 15:25:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:00 INFO - 'PWD': '/builds/slave/test', 15:25:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:00 INFO - 'SHELL': '/bin/bash', 15:25:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gbvrO39Cis/Listeners', 15:25:00 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 15:25:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:00 INFO - 'USER': 'cltbld', 15:25:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:00 INFO - 'XPC_FLAGS': '0x0', 15:25:00 INFO - 'XPC_SERVICE_NAME': '0', 15:25:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:01 INFO - Downloading/unpacking blobuploader==1.2.4 15:25:01 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 15:25:01 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 15:25:01 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 15:25:01 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 15:25:01 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 15:25:01 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 15:25:03 INFO - Downloading blobuploader-1.2.4.tar.gz 15:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:25:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15: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 15: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 15: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 15: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 15: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 15: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 15:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:25:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:25:04 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 15:25:04 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 15:25:04 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 15:25:04 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 15:25:04 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 15:25:04 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 15:25:04 INFO - Downloading docopt-0.6.1.tar.gz 15:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:25:04 INFO - Installing collected packages: blobuploader, requests, docopt 15:25:04 INFO - Running setup.py install for blobuploader 15:25:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:25:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:25:05 INFO - Running setup.py install for requests 15:25:05 INFO - Running setup.py install for docopt 15:25:05 INFO - Successfully installed blobuploader requests docopt 15:25:05 INFO - Cleaning up... 15:25:05 INFO - Return code: 0 15:25:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:05 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 0x106b97b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b9a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0256f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106975d30>, '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 0x10689cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10696abe8>, '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.YxyPCOJLTh/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.gbvrO39Cis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 15:25:05 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 15:25:05 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 15:25:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxyPCOJLTh/Render', 15:25:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:05 INFO - 'HOME': '/Users/cltbld', 15:25:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:05 INFO - 'LOGNAME': 'cltbld', 15:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:05 INFO - 'MOZ_NO_REMOTE': '1', 15:25:05 INFO - 'NO_EM_RESTART': '1', 15:25:05 INFO - 'PAGER': '/bin/cat', 15:25:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:05 INFO - 'PWD': '/builds/slave/test', 15:25:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:05 INFO - 'SHELL': '/bin/bash', 15:25:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gbvrO39Cis/Listeners', 15:25:05 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 15:25:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:05 INFO - 'USER': 'cltbld', 15:25:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:05 INFO - 'XPC_FLAGS': '0x0', 15:25:05 INFO - 'XPC_SERVICE_NAME': '0', 15:25:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Ey9dH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-QPWzh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-0Nvcku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-g2XPmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-JjmeNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-YDQJ0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-EbZGQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-2Q78rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:06 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-2QdK0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-nNbuun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-SRwzBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-HPW81C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Tq4zt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-_piUtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-NOFoaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-zpRkIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:07 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-8HdHGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:25:07 INFO - Running setup.py install for manifestparser 15:25:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:25:08 INFO - Running setup.py install for mozcrash 15:25:08 INFO - Running setup.py install for mozdebug 15:25:08 INFO - Running setup.py install for mozdevice 15:25:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:25:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:25:08 INFO - Running setup.py install for mozfile 15:25:08 INFO - Running setup.py install for mozhttpd 15:25:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:25:08 INFO - Running setup.py install for mozinfo 15:25:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:25:08 INFO - Running setup.py install for mozInstall 15:25:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:25:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:25:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:25:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:25:09 INFO - Running setup.py install for mozleak 15:25:09 INFO - Running setup.py install for mozlog 15:25:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:25:09 INFO - Running setup.py install for moznetwork 15:25:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:25:09 INFO - Running setup.py install for mozprocess 15:25:09 INFO - Running setup.py install for mozprofile 15:25:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:25:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:25:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:25:09 INFO - Running setup.py install for mozrunner 15:25:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:25:10 INFO - Running setup.py install for mozscreenshot 15:25:10 INFO - Running setup.py install for moztest 15:25:10 INFO - Running setup.py install for mozversion 15:25:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:25:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:25:10 INFO - Cleaning up... 15:25:10 INFO - Return code: 0 15:25:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:10 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')]} 15:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:10 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')]} 15:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:10 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 0x106b97b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b9a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0256f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106975d30>, '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 0x10689cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10696abe8>, '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.YxyPCOJLTh/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.gbvrO39Cis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 15:25:10 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 15:25:10 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 15:25:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxyPCOJLTh/Render', 15:25:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:10 INFO - 'HOME': '/Users/cltbld', 15:25:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:10 INFO - 'LOGNAME': 'cltbld', 15:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:10 INFO - 'MOZ_NO_REMOTE': '1', 15:25:10 INFO - 'NO_EM_RESTART': '1', 15:25:10 INFO - 'PAGER': '/bin/cat', 15:25:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:10 INFO - 'PWD': '/builds/slave/test', 15:25:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:10 INFO - 'SHELL': '/bin/bash', 15:25:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gbvrO39Cis/Listeners', 15:25:10 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 15:25:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:10 INFO - 'USER': 'cltbld', 15:25:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:10 INFO - 'XPC_FLAGS': '0x0', 15:25:10 INFO - 'XPC_SERVICE_NAME': '0', 15:25:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-bHYDEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:10 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)) 15:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-SAK5Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:10 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)) 15:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-sLv6vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:11 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)) 15:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-T0D8nN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:11 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)) 15:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-gn3kkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:11 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)) 15:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-eKe4pA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:11 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)) 15:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-p7vkFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:11 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)) 15:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-xa4YxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:11 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)) 15:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-8r9wRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:11 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)) 15:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-_QK97j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:11 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)) 15:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-NvGyvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:11 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)) 15:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-eCuOa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:12 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)) 15:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:12 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-9qyDEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:12 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)) 15:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:12 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-kSX1UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:12 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)) 15:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:12 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-mpvZty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:12 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)) 15:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:12 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Asy4hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:12 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)) 15:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:12 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-LFsur1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:12 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)) 15:25:12 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)) 15:25:12 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)) 15:25:12 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)) 15:25:12 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)) 15:25:12 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)) 15:25:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:15 INFO - Downloading blessings-1.6.tar.gz 15:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:25:15 INFO - Installing collected packages: blessings 15:25:15 INFO - Running setup.py install for blessings 15:25:15 INFO - Successfully installed blessings 15:25:15 INFO - Cleaning up... 15:25:15 INFO - Return code: 0 15:25:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:25:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:15 INFO - Reading from file tmpfile_stdout 15:25:15 INFO - Current package versions: 15:25:15 INFO - blessings == 1.6 15:25:15 INFO - blobuploader == 1.2.4 15:25:15 INFO - docopt == 0.6.1 15:25:15 INFO - functools32 == 3.2.3-2 15:25:15 INFO - jsonschema == 2.5.1 15:25:15 INFO - manifestparser == 1.1 15:25:15 INFO - mozInstall == 1.12 15:25:15 INFO - mozcrash == 1.0 15:25:15 INFO - mozdebug == 0.1 15:25:15 INFO - mozdevice == 0.49 15:25:15 INFO - mozfile == 1.2 15:25:15 INFO - mozhttpd == 0.7 15:25:15 INFO - mozinfo == 0.9 15:25:15 INFO - mozleak == 0.1 15:25:15 INFO - mozlog == 3.4 15:25:15 INFO - moznetwork == 0.27 15:25:15 INFO - mozprocess == 0.24 15:25:15 INFO - mozprofile == 0.28 15:25:15 INFO - mozrunner == 6.13 15:25:15 INFO - mozscreenshot == 0.1 15:25:15 INFO - mozsystemmonitor == 0.3 15:25:15 INFO - moztest == 0.8 15:25:15 INFO - mozversion == 1.4 15:25:15 INFO - psutil == 3.1.1 15:25:15 INFO - requests == 1.2.3 15:25:15 INFO - wsgiref == 0.1.2 15:25:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25: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')]} 15:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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')]} 15:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:15 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 0x106b97b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b9a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0256f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106975d30>, '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 0x10689cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10696abe8>, '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.YxyPCOJLTh/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.gbvrO39Cis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 15:25:15 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 15:25:15 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 15:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxyPCOJLTh/Render', 15:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:15 INFO - 'HOME': '/Users/cltbld', 15:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:15 INFO - 'LOGNAME': 'cltbld', 15:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:15 INFO - 'MOZ_NO_REMOTE': '1', 15:25:15 INFO - 'NO_EM_RESTART': '1', 15:25:15 INFO - 'PAGER': '/bin/cat', 15:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:15 INFO - 'PWD': '/builds/slave/test', 15:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:15 INFO - 'SHELL': '/bin/bash', 15:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gbvrO39Cis/Listeners', 15:25:15 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 15:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:15 INFO - 'USER': 'cltbld', 15:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:15 INFO - 'XPC_FLAGS': '0x0', 15:25:15 INFO - 'XPC_SERVICE_NAME': '0', 15:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:16 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)) 15:25:16 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)) 15:25:16 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)) 15:25:16 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)) 15:25:16 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)) 15:25:16 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)) 15:25:16 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)) 15:25:16 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)) 15:25:16 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)) 15:25:16 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)) 15:25:16 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)) 15:25:16 INFO - Cleaning up... 15:25:16 INFO - Return code: 0 15:25:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:16 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 0x106b97b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b9a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0256f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106975d30>, '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 0x10689cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10696abe8>, '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.YxyPCOJLTh/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.gbvrO39Cis/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 15:25:16 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 15:25:16 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 15:25:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxyPCOJLTh/Render', 15:25:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:16 INFO - 'HOME': '/Users/cltbld', 15:25:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:16 INFO - 'LOGNAME': 'cltbld', 15:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:16 INFO - 'MOZ_NO_REMOTE': '1', 15:25:16 INFO - 'NO_EM_RESTART': '1', 15:25:16 INFO - 'PAGER': '/bin/cat', 15:25:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:16 INFO - 'PWD': '/builds/slave/test', 15:25:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:16 INFO - 'SHELL': '/bin/bash', 15:25:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gbvrO39Cis/Listeners', 15:25:16 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 15:25:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:16 INFO - 'USER': 'cltbld', 15:25:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:16 INFO - 'XPC_FLAGS': '0x0', 15:25:16 INFO - 'XPC_SERVICE_NAME': '0', 15:25:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:25:16 INFO - Cleaning up... 15:25:16 INFO - Return code: 0 15:25:16 INFO - Running post-action listener: _resource_record_post_action 15:25:16 INFO - Running post-action listener: _start_resource_monitoring 15:25:16 INFO - Starting resource monitoring. 15:25:16 INFO - [mozharness: 2017-03-08 23:25:16.463333Z] Finished create-virtualenv step (success) 15:25:16 INFO - [mozharness: 2017-03-08 23:25:16.464303Z] Running install step. 15:25:16 INFO - Running pre-action listener: _resource_record_pre_action 15:25:16 INFO - Running main action method: install 15:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:16 INFO - Reading from file tmpfile_stdout 15:25:16 INFO - Detecting whether we're running mozinstall >=1.0... 15:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:25:16 INFO - Reading from file tmpfile_stdout 15:25:16 INFO - Output received: 15:25:16 INFO - Usage: mozinstall [options] installer 15:25:16 INFO - Options: 15:25:16 INFO - -h, --help show this help message and exit 15:25:16 INFO - -d DEST, --destination=DEST 15:25:16 INFO - Directory to install application into. [default: 15:25:16 INFO - "/builds/slave/test"] 15:25:16 INFO - --app=APP Application being installed. [default: firefox] 15:25:16 INFO - mkdir: /builds/slave/test/build/application 15:25:16 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'] 15:25:16 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 15:25:31 INFO - Reading from file tmpfile_stdout 15:25:31 INFO - Output received: 15:25:31 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:25:31 INFO - Running post-action listener: _resource_record_post_action 15:25:31 INFO - [mozharness: 2017-03-08 23:25:31.192318Z] Finished install step (success) 15:25:31 INFO - [mozharness: 2017-03-08 23:25:31.192456Z] Running run-tests step. 15:25:31 INFO - Running pre-action listener: _resource_record_pre_action 15:25:31 INFO - Running main action method: run_tests 15:25:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:25:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:25:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:25:31 INFO - 2017-03-08 15:25:31.207 screenresolution[2179:24609] starting screenresolution argv=screenresolution get 15:25:31 INFO - 2017-03-08 15:25:31.210 screenresolution[2179:24609] Display 0: 1600x1200x32@60 15:25:31 INFO - 2017-03-08 15:25:31.216 screenresolution[2180:24611] starting screenresolution argv=screenresolution list 15:25:31 INFO - Available Modes on Display 0 15:25:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:25:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:25:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:25:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:25:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:25:31 INFO - Intel Iris: 15:25:31 INFO - Chipset Model: Intel Iris 15:25:31 INFO - Type: GPU 15:25:31 INFO - Bus: Built-In 15:25:31 INFO - VRAM (Dynamic, Max): 1536 MB 15:25:31 INFO - Vendor: Intel (0x8086) 15:25:31 INFO - Device ID: 0x0a2e 15:25:31 INFO - Revision ID: 0x0009 15:25:31 INFO - Displays: 15:25:31 INFO - Display: 15:25:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:25:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:25:31 INFO - Display Serial Number: 1600x1200 60 15:25:31 INFO - Main Display: Yes 15:25:31 INFO - Mirror: Off 15:25:31 INFO - Online: Yes 15:25:31 INFO - Rotation: Supported 15:25:31 INFO - Return code: 0 15:25:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:25:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:25:31 INFO - Python 2.7.3 15:25:31 INFO - Return code: 0 15:25:31 INFO - grabbing minidump binary from tooltool 15:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:31 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 0x106975d30>, '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 0x10689cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10696abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:25:31 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 15:25:31 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 15:25:31 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 15:25:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:25:31 INFO - Return code: 0 15:25:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:25:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:25:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:25:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:25:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:25:31 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/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 15:25:31 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/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0061 --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 15:25:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxyPCOJLTh/Render', 15:25:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:31 INFO - 'HOME': '/Users/cltbld', 15:25:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:31 INFO - 'LOGNAME': 'cltbld', 15:25:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:31 INFO - 'MOZ_NO_REMOTE': '1', 15:25:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:31 INFO - 'NO_EM_RESTART': '1', 15:25:31 INFO - 'PAGER': '/bin/cat', 15:25:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:31 INFO - 'PWD': '/builds/slave/test', 15:25:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:31 INFO - 'SHELL': '/bin/bash', 15:25:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gbvrO39Cis/Listeners', 15:25:31 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 15:25:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:31 INFO - 'USER': 'cltbld', 15:25:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:31 INFO - 'XPC_FLAGS': '0x0', 15:25:31 INFO - 'XPC_SERVICE_NAME': '0', 15:25:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:31 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/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 15:25:31 INFO - mozversion application_buildid: 20170308135723 15:25:31 INFO - mozversion application_changeset: fb836ee72ce6953b44ec4538d72a2cf27c106fc7 15:25:31 INFO - mozversion application_display_name: Firefox 15:25:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:25:31 INFO - mozversion application_name: Firefox 15:25:31 INFO - mozversion application_remotingname: firefox 15:25:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:25:31 INFO - mozversion application_vendor: Mozilla 15:25:31 INFO - mozversion application_version: 53.0 15:25:31 INFO - mozversion platform_buildid: 20170308135723 15:25:31 INFO - mozversion platform_changeset: fb836ee72ce6953b44ec4538d72a2cf27c106fc7 15:25:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:25:31 INFO - mozversion platform_version: 53.0 15:25:31 INFO - using testdate: 1489015531 15:25:31 INFO - actual date: 1489015531 15:25:31 INFO - starting webserver on 'localhost:54532' 15:25:31 INFO - SUITE-START | Running 2 tests 15:25:31 INFO - TEST-START | dromaeo_css 15:25:31 INFO - operating with platform_type : mac_ 15:25:31 INFO - Initialising browser for dromaeo_css test... 15:25:31 INFO - TEST-INFO | started process 2190 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpVTxS2Y/profile http://localhost:54532/getInfo.html) 15:25:33 INFO - PROCESS | 2190 | __metrics Screen width/height:1600/1200 15:25:33 INFO - PROCESS | 2190 | colorDepth:24 15:25:33 INFO - PROCESS | 2190 | Browser inner width/height: 1024/689 15:25:33 INFO - PROCESS | 2190 | __metrics 15:25:33 INFO - PROCESS | 2190 | 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" 15:25:33 INFO - PROCESS | 2190 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:25:34 INFO - TEST-INFO | 2190: exit 0 15:25:34 INFO - Browser initialized. 15:25:34 INFO - Running cycle 1/1 for dromaeo_css test... 15:25:34 INFO - TEST-INFO | started process 2192 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpVTxS2Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:46 INFO - PROCESS | 2192 | RSS: Main: 182263808 15:25:46 INFO - PROCESS | 2192 | 15:28:49 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54532/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54532/tests/dromaeo/cssquery-ext.html) 15:28:51 INFO - PROCESS | 2192 | RSS: Main: 337608704 15:28:51 INFO - PROCESS | 2192 | 15:31:54 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54532/tests/dromaeo/cssquery-ext.html (next: http://localhost:54532/tests/dromaeo/cssquery-jquery.html) 15:31:54 INFO - PROCESS | 2192 | RSS: Main: 323756032 15:31:54 INFO - PROCESS | 2192 | 15:34:57 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54532/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54532/tests/dromaeo/cssquery-mootools.html) 15:34:57 INFO - PROCESS | 2192 | RSS: Main: 305397760 15:34:57 INFO - PROCESS | 2192 | 15:37:59 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54532/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54532/tests/dromaeo/cssquery-prototype.html) 15:38:00 INFO - PROCESS | 2192 | RSS: Main: 315650048 15:38:00 INFO - PROCESS | 2192 | 15:41:03 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54532/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54532/tests/dromaeo/cssquery-yui.html) 15:41:04 INFO - PROCESS | 2192 | RSS: Main: 279306240 15:41:04 INFO - PROCESS | 2192 | 15:44:07 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54532/tests/dromaeo/cssquery-yui.html (next: http://localhost:54532/tests/dromaeo/cssquery-dojo.html) 15:44:07 INFO - PROCESS | 2192 | RSS: Main: 330231808 15:44:07 INFO - PROCESS | 2192 | 15:44:07 INFO - PROCESS | 2192 | __start_tp_report 15:44:07 INFO - PROCESS | 2192 | _x_x_mozilla_page_load 15:44:07 INFO - PROCESS | 2192 | _x_x_mozilla_page_load_details 15:44:07 INFO - PROCESS | 2192 | |i|pagename|runs| 15:44:07 INFO - PROCESS | 2192 | |0;dojo.html;3387.1532116970757;3389.4746314321287;3428.40002999475;3438.4670376091713;3485.1984043669954;5763.193152958589;5871.031279838827;5927.2590926134235;5960.850978725529;5979.581429299951;5826.941730582693;5840.503557197632;5905.881882362361;5905.9409405906035;5922.111683247515;5255.658382205154;5258.421573626898;5338.866528336784;5360.2763626910455;5368.0605893968595;5305.151175811871;5306.946930530684;5359.624826262163;5370.43610420906;5401.540869026137;5323.733813309338;5341.866453338659;5346.973265133669;5357.464253574651;5372.516473517383;5355.98236335097;5361.705106219157;5372.167314066326;5378.112611419131;5387.218853266294;5003.624728145403;5229.163333866563;5287.86780330491;5318.654287471302;5368.62419630626;5035.244713293036;5762.222100016486;5780.3063632363965;5820.417958204146;5891.764329426818;6286.4342209201395;6291.559590828644;6304.085907543381;6305.211848518935;6307.9684601577155;5574.554035677136;6328.1773369462135;6335.651539165344;6354.841128971766;6361.141245931786;5911.733971971272;6004.909926351108;6026.9095963560585;6098.847528811771;6138.7237574309265;5385.6230063895155;6321.367863213642;6383.521235907326;6453.193350831146;6467.611943283418;6358.268799088071;6362.045693145972;6365.172527571479;6370.235571731422;6370.522210834206;6258.718357673915;6291.96854015727;6329.461995730415;6331.5251356147555;6339.4611458025665;6303.905441418382;6329.113924050636;6329.746810127635;6355.3644635536075;6355.491560675135;6311.779087731908;6313.2424109107205;6314.116023756677;6321.273053598803;6323.715432805535;5083.135866902636;5099.464556221617;5139.665921715151;5143.922841157386;5156.9742151289;4511.323301504735;4529.796159172845;4542.636589072867;4550.089982003613;4610.9308360374625;4920.8769780755765;5985.461308482258;5985.880282394328;6000.399960003964;6041.818745437644;6296.842578935563;6335.144755458046;6336.049592561153;6341.6195028297525;6349.904751428732;5647.661140331593;5743.684097374685;5967.641941483438;5979.521638268928;5988.371221021817;5518.2826232590305;5537.833864984057;5543.695096769717;5556.444355564411;5623.072193088176;6347.587406818542;6377.681115944091;6383.170187875547;6391.169148010729;6392.872142557216;6274.372562743872;6312.810615681537;6319.368063193644;6337.524685648687;6340.017297318923;6230.59501132425;6266.404691554295;6268.717907694256;6315.747370105144;6356.3325850785;6309.589876658002;6318.4313411793155;6344.429001389897;6351.809445716636;6361.268454127835;6238.875222495615;6253.09330147117;6314.305426403183;6329.715162817776;6337.271213810471;6200.689965501797;6267.435930766253;6276.560640755286;6373.075903993988;6384.010478375859;6225.066240064027;6335.588186767845;6364.681765911779;6366.490680745622;6383.872322553616;6270.247570291412;6270.7805226816845;6273.3099359071375;6274.341194174728;6274.749010039547;6183.690815459299;6236.251649802053;6301.842453938505;6345.841353966188;6381.266154392304;5101.923471147861;5177.4822517747925;6106.419890110433;6200.627962322275;6244.687765611792 15:44:07 INFO - PROCESS | 2192 | |1;ext.html;493.9530744579266;509.0531611203162;524.6642149024623;531.0494215354515;577.62454404637;32776.016719498424;43352;44564.66306010817;44711.77644111779;44878.32682509765;43013.7849310753;43431.56568434315;43498.782506087424;43564.128717425636;43579;8288.502689838599;9387.999999999984;9622.855657165148;9626.98916613756;9691.321607487478;7787.221277872224;9240.075992400773;11685.649430517098;11911.702207444796;11924.224925379822;11824.11319151067;11847.466863991142;11936.7612647747;11959.760804783898;12000.63998080059;9983.400995940267;11861.110416718695;11864.288142711379;11891.524339026428;11899.286042837413;11471.713207169803;11573.53705851765;11600.187986840925;11618.244814087057;11657.533698652129;34173.658263417296;41214.79392603018;41542.1691566167;41587.1682566347;41646.37530437046;3616.8372423240753;4064.9390259146135;4085.9559628076977;4094.6724262058965;4153.397757325201;30644.233894152603;30715.078547643607;31216.687833121832;31338.843305783324;31569.684303157133;3127.5777770000986;3193.5529025936157;3201.631812341564;3228.2252259457796;3318.4192766266046;497662;498619;499385.9999999964;500824;500886.49556751986;62230.37769622336;62445;62505.68747156326;62595.061074083926;62653;64305;64411;64490;64496.677516612115;64516.03225951614;16927.407540736014;17407.825921740874;17446.302147913942;17453.12734363277;17486.91256543709;12344.506219751109;13346.13250138738;13465.865341346462;13488.190708557519;13503.257320847251;14130.717385652435;15894.60263493422;16021.759673604905;16134.273957671932;16334.18329083541;6240.812775616739;6983.6731021105825;7182.389496892718;7232.034865705035;7312.341889229995;770.857391382596;882.8808110904946;903.846346121161;914.6432891172448;923.7782932096248;29524;29678.961236356623;30474.08577742627;30560.93036743703;31399.686003140134;909.0182602788972;966.5167416291854;1112.671761830262;1205.8311836342918;1271.1229251816217;15521.611959701098;16385.50843474698;16647.33410663584;16734.74897876533;16748.330066797193;660110;664512;667227;667358;669275;63233;63828;63916;64034.67982660057;64193.35806641967;1303.5372442783055;1328.4022190014339;1428.5285855667396;1526.900751451152;1546.1109861829493;30795.538066928566;32217.838910806233;32677.019689408404;33505.83247083847;34012.82993585016;53786.19320710114;54943.45056549383;55020;57657.42342576689;57696;607159;613777;614757;615318;615583;35060.9481715549;35340.93977180689;35745;40630.59369406268;41352.37971430371;43286.56713432825;43350.56649433466;44219.55780442154;44854;45599.31601026054;35887.82056089703;36103.09742256465;36744.81627591952;37652.435213471275;37947.430788538746;36196.81901590475;36224;36935.261294773416;37272.06819829526;37408.06479837917;35099.29801404009;35575.46636800502;36117.73587924515;36446.63553364432;36531.634683652825;30874;32658.83670581632;32756.508652369757;33231.33537329288;33421;20486;24603.630945536188;24682.382940426633;25022.499550009263;25054.123105691215 15:44:07 INFO - PROCESS | 2192 | |2;jquery.html;404.9534303555092;408.4771492489613;408.84668249406474;419.2244347956281;438.20684560944693;20227.39317820466;20475.18099276031;21354;21469.785302146975;21475.926203689793;21581.568368632656;21757.564848703056;21812;21848.781512184873;21956.8902155489;5819.883602327951;6221.968890155543;6254;6265.655388953629;6273.529485288599;5941.85145371367;6149.477294429978;6210.534209934251;6212.347703491136;6232.906506402408;6169.876602467971;6181.81454556364;6193.102000209967;6194.907076393858;6198.256209254896;5931.851703707399;6121.938780612181;6183.567150299481;6196.101565273033;6197.783077592308;5266.8683282917855;5364.1444070556145;5427.402985671573;5439;5446.863828404282;26390.208293751217;26893.193204203708;26913.92344306245;27144.1856744298;27264.72735272642;3083.429565530384;3126.89055883043;3190.808551486918;3251.2847173621767;3327.9833600832085;15045.473408430653;15461.072335659785;15535.067895926168;15564.221788910623;16562;1806.358742646368;1840.7054871220541;1863.3943968210385;1888.4712280561464;1894.0624390926441;114751.13122171929;132781;132864.67135328715;133644.9953250702;134216.32891835575;11351.60269390584;11505.408355661275;11609.187356885106;11760.941195293968;11822.231554949072;12304.81542776859;14790.482333118289;14796.038257513228;14846.554603361916;14863.70272594542;8840.823183536293;8955;8962.775930601787;9077.001529831714;9092.36353455265;7771.572563509061;8969.596368163448;8984.8652270216;9130.543472826332;9187.356885017985;5775.740091695884;6100.664463454553;7165.498415110892;7171.89242161368;7224;1899.886006839594;1924.393815947972;1945.3580318494862;1946.153423260886;1946.6593346164364;715.6178372966006;1058.502219359613;1145.7078444996473;1160.8391608391607;1178.4873579992732;22078.448038798837;23355.88322058379;23552.528949420917;24180.153694620603;24224.636630450204;1106.6237479256931;1133.631569739838;1134.489479734123;1169.257521473853;1172.5837327748698;11731.530738770354;12256.693582660504;12552.246865188117;12555.93722031384;12707.745845083047;584566;585707;593005;746639;792394;129488;138999;140933;146486;154824.3552693421;444.2913552883146;478.92097803861975;480.67074054272933;482.3295619089398;482.642844295219;11179.66461006171;11294.378809165575;11894.226875253082;11955.043596512085;11979.580714674945;56490.71754641201;58305.3355731532;58325.70837145957;60002.799944000006;60885.69557152186;86453.56773216094;87144.56427717821;88264.55867720621;90540.09459905316;90599.54700226456;8318.71059985679;8632.136786321318;8652.956735216536;8857.911420885708;8885;11221.102311815199;12899.613011609667;13140.408681609542;13309.933450332686;13763.862361376257;10352.948235258775;11454.255473394203;11477.36874471912;11669.35818529955;11712.765744685228;4716.64625153108;10453.006964338376;10611.257211995086;11753.588624398106;12054.698632534257;10697.037266646039;10955.671329860117;11630;11977.580784672495;12049.939750301543;8562.058173601023;8617.439866408664;8782.29741620656;8814.471131732116;8815.206631403205;9886;11064.28082174656;11305.908406944412;11624.291610583277;11680.299182049104 15:44:07 INFO - PROCESS | 2192 | |3;mootools.html;1468.3832790228103;1470.6543962168896;1493.6863258715669;1499.8725108365784;1500.9324580393875;8039.8794018089775;8423.705170319041;8432.662693492253;8440.240378365947;8450.281726053277;7435.814104647387;7717.652705628247;7968.840623187532;8180.550069746161;8181.91818081819;2350.682657841195;2392.2225276785116;2393.3179043972473;2393.5452264069772;2397.0891061396646;2037.154580848946;2367.822413318999;2401.3036219496325;2401.627747699101;2411.2886698423918;2332.1837356925025;2359.245041586693;2364.5625559271502;2395.101836811196;2400.219928523237;2348.495073559184;2348.8825558721996;2359.728631207399;2383.785459308653;2388.1402695029774;2211.579799838026;2240.5630901974123;2344.0389440329554;2419.5644783938883;2426.793722533587;8167.183281671844;8373.665053397857;8377.078521362646;8381.245687888118;8382.958085209535;5095.821646242363;5257.421683614799;5258.447862974409;5259.815906443295;5264.815731449419;3454.7063499602564;3487.7558570900046;3489.319582681378;3557.3774589447003;3571.5178450909316;1250.1498980693125;1253.4986005597834;1283.5379263465145;1299.9675008124777;1309.3911331231022;10607.204459665556;10659.200559958033;10673;10691.198160138021;10697.625583104631;4368.4321038264825;4695.178343789823;4752.7623618818925;4757.072370887644;4783.473817880031;9468.57391417388;9490.288228382899;9515.143637072697;9515.286353523514;9526.571304291323;5290.232916227203;5294.602904782157;5301.098813201688;5301.496357845998;5306.124489459273;4355.60799528044;4384.56154384559;4760.95239047612;4763.857084287408;4851.151048566487;3889.4943657324366;3897.337452633059;4029.516458024997;4034.253663072341;4058;1255.4664267686196;1289.149161553389;1300.9804852927214;1303.328785675378;1310.9344532773323;899.6356475627381;921.2767977137914;924.8751418558409;929.5166513412987;952.8523078922778;5101.413337466239;5628.437156284339;5677.403872593401;5782.392848750821;5963.463288304073;972.4165500699523;975.7316737897135;1018.3940555369543;1026.6612018034032;1043.087298613713;3297.7526685498683;3733.8506459741848;3763.1532905096133;3875.0699832040673;3877.1470276539117;9611.086946740048;9856.310058295994;9862.112409883002;9863;9882.209423246122;9720.854187187198;9808.558614862348;9823.36148150368;9823.557939892722;9824.65613703517;7538.434617403716;7539.509931854522;7568.886466703004;7782;7785.18255583167;4466.883279180205;5246.055709972089;5351.1973204019705;5406.0809662356705;5520.282363292907;8903.643854246016;9014.549272536216;9158.725238242863;9242.815143697222;9270.768230794283;8843.91156088431;9111.362204645611;9215.078492150731;9385.436873787594;9408.95295523518;7150.392216661642;7180;7205.819854503679;7242.456815738946;7302.196758356683;7773.37812974972;7838.176991415819;7838.608069596611;7839.176886426843;7844.84310313802;6914.861702765816;7032.367086962198;7048.224695283618;7092.787216383516;7159.534630249017;6951.44388448933;6969.616671083139;7005.824854378681;7021.43828493709;7050.823729406806;6260.186175797117;6370.203724534434;6377.8724425512155;6441.903371449338;6449.097126402214;4913.975430122827;4968;4969.801207951641;5002.399712034579;5019.422766381913;4208.642265407475;4916.532929371704;4969.975150124371;5104.2088476286235;5155.149400348901 15:44:07 INFO - PROCESS | 2192 | |4;prototype.html;367.86572900891184;371.5504239869758;380.46164676982073;380.5376467591875;389.6454226653744;5300.773675056475;5416.593755468336;5504.779808807648;5528.668279903209;5574.303212098488;4529.456465224178;4932.9753351233285;5456.727163641812;5478.342598888129;5479.890402191953;3446.0899557259295;3670.339338919007;3706.9629303707025;4267.359896015591;4336.696431249814;3727.366347720894;4055.1484188320487;4265.395740599189;4296.957030429687;4300.612944834964;3746.6253374662588;4029.1538776856896;4104.774237416941;4238.533761286256;4260.531341552427;3404.472306792451;3999.960000399988;4105.568915263884;4292.29177185764;4293.3989241506215;3303.9834800826084;3553.982230088833;3708.61059588742;3767.4537192107264;3800.8669696560764;4865.854024379274;5335.33308336458;5342.328835582209;5343.423690011417;5359.383670877821;4583.587477127075;4935.90128197434;4941;4962.950370496285;4969.652124351297;5537.446255374471;5627.015272327327;5685.085897771038;5766.790243122544;5817.767289308423;3406.403879321134;3853.556840963269;3909.179072394772;4161.52142503613;4175.498940127174;5171.870703232412;5718.59969802114;5940.524758019348;6081.361457046991;6086.543509236825;3887.863924762676;4172;4244.596763307481;4252.682907332286;4254.680898932593;4084.4281800547947;4158.022864626811;4314.203500919171;4315.597430834991;4319.632831209383;4879.26810978349;4883.951160488421;4892.902141957141;4960.975195124001;4966.503349665077;4666.789994450258;5252.133397989365;5407.0267351876255;5456.563474921997;5602.551795856321;1248.2759999200441;1408.8309402871516;1426.6504706347012;1428.2715814934459;1431.7279716853764;813.4915677701437;951.757301888028;988.619381538113;996.5216695985968;1011.9392836429838;4575.771211439414;4733.13645244629;5005.549500544968;5057.802024319806;5077.441481437039;5063.278485315011;5066.620003499752;5578.330600327987;5596.27248457706;5686.943130568724;4198.475190601175;4668.906621867543;4949;4998.550130488274;5050.3434553507805;2713.945721085567;2718.646575945154;2875.7124287571496;3002.264445210937;3014.623172103487;5465.344158700981;5818.7672493100645;5843.853903652443;5900.43945825146;5914.733836977346;5717.399673034354;5891.641764194368;6210.596311239755;6210.689465526796;6252.5610913998025;5812.285375814145;5975.163477113208;6031.601716463741;6153.261608606996;6176.294223465885;5338.75975581092;6053.4551890330085;6070.298717070861;6074.848128796815;6111.266648002268;5112.590992720499;5499.340079190522;5771.671246565076;5861.472467477777;5992.250968628921;4995.975020124876;5246.422893481637;5748.240844394798;5905.936931352398;5909.23179986599;3959.7822119783687;3990.8204130814765;3996.960030399659;4010.7794071326357;4015.277250095011;4957.752112394293;5297.311349524537;5333.466653334635;5965.731542080704;6078.538192032234;5048.192289233705;5306.257124002565;5752.252207213036;5759.222504961944;5829.59192856496;5175;5554.250176226158;5817.189740719835;5822.57346949983;5829.358770535153;4554.4495082753765;4688.460827004802;5594.552435805207;5627.634203776742;5637.8590535236945;4897.1107046842535;4913.7543122843;5704;5706.657600543981;5853.707314634166;5449.373322067854;5629.971850140723;5657.15142728594;5674.886502270014;5679.943200567942 15:44:07 INFO - PROCESS | 2192 | |5;yui.html;751.6504825256254;777.6150805351352;805.8791181322797;849.9830003399932;860.3332417376535;15230.77153842692;15238.847611523881;15622.687546249068;15741.370345186193;15790.842091579081;14208.857911420908;14443.133411995288;14473.203973781438;14606.853931460682;14609.634759131028;900.9324300677459;906.7778394293407;913.4199783137689;914.5930061122802;915.2129168914728;718.2637796258824;749.6851322444586;887.5163036145316;907.7821322882494;919.6965001549506;945.8297506448871;973.7662960889406;974.4835237324229;975.4488713876673;977.8288799460101;966.3332300712486;968.3705591365633;968.7578105473632;969.3795970578835;970.553545369131;709.6309918842225;722.8409749855024;726.3317747672102;727.0475676863326;728.5919884864493;15446.768298475532;15834.683306333924;15863.286152123183;15925.974064927626;16135.273912673958;12798.48806047757;14521.419143234258;14783.277097849665;15171.393144274216;15219.61950951224;11853.703657408547;11928.46321915516;11942.283462992249;11949.641510754604;12042.759144817142;3691.483192353073;3754.047895094563;3758.8120593970193;3839.17457746583;3868.3423817951016;96524;100491;100640.49039264416;110398.44800776025;114245.42877285644;10491.370517768959;11349.375784331776;11377.715557110972;11420.371879546705;11474.311541307548;22752.20367287137;22771.658425123638;23110.537789244456;23157.88421057884;23162.884185578965;7971.800704982422;8233.79415514605;8382;8517.318614510825;8537.359698022674;4495.145922274757;4602.953970460252;4605.078984203173;4788.712677239377;4791.6406269529225;3729.310077635646;3760.4547340636;3835.5972622874756;3844.442555829389;3983.880483585497;637.3085202555279;699.2867275379085;718.7340683946973;758.5941521286086;759.2673070487007;690.1649004704263;708.890122031086;715.4383808710138;731.4002517935348;763.2024534361606;10306.536205870603;10597.364158150536;10692;11013.118950483942;11053.28153670025;717.9512606292072;724.2757242757243;738.1621859189859;743.6170372258291;744.0884915977883;4082.9387559186634;5200.739963001834;5203.037438073969;5210.947890521122;5225.059489291964;87845.56077219702;96984;107008.46495767627;109332.45333773439;113612;83849.58075209585;85943;88965.55517222502;89639.55180224057;91090.45725646123;65924;70375.64812175906;70411.64794175996;78633.60683196547;79631;11052.226344156154;11085.722856928642;11121.221514494231;11191.66425007251;11488.483018264365;42590.148197036506;44038.55961440344;49224.50775492199;52139.21791173059;52163;52859.20711189258;64349.67825160844;64976;66888.33111669015;68048;12435.626931192079;13050.738985220432;13084.345782711016;13289.867101328862;13616.591502254949;13427.943808914592;13583.86416135826;13881.305934703023;14061.929690351892;14196.219207943663;12848.935755321163;13672.589822305346;14288.35702393374;14325.713485730435;14341.713165736835;13594.388252528463;14042.929785351007;14064.929675351557;14082.507112251022;14346.713065738835;12608.243505389706;13926.51257205993;13937.303134843014;14042.2978851055;14058.297085145497;10990.285631433931;11220.551177953117;11409.486573104396;11411.947207477995;11581;9089.272858171462;10871.836922446011;11225.382603956534;11440.313581185155;11552.94223528877 15:44:07 INFO - PROCESS | 2192 | __end_tp_report 15:44:07 INFO - PROCESS | 2192 | __start_cc_report 15:44:07 INFO - PROCESS | 2192 | _x_x_mozilla_cycle_collect,1572 15:44:07 INFO - PROCESS | 2192 | __end_cc_report 15:44:07 INFO - PROCESS | 2192 | __startTimestamp1489016647941__endTimestamp 15:44:07 INFO - PROCESS | 2192 | 15:44:07 INFO - PROCESS | 2192 | ------- Summary: start ------- 15:44:07 INFO - PROCESS | 2192 | Number of tests: 6 15:44:07 INFO - PROCESS | 2192 | 15:44:07 INFO - PROCESS | 2192 | [#0] dojo.html Cycles:165 Average:5858.74 Median:6200.69 stddev:655.32 (10.6%) stddev-sans-first:628.00 15:44:07 INFO - PROCESS | 2192 | Values: 3387.2 3389.5 3428.4 3438.5 3485.2 5763.2 5871.0 5927.3 5960.9 5979.6 5826.9 5840.5 5905.9 5905.9 5922.1 5255.7 5258.4 5338.9 5360.3 5368.1 5305.2 5306.9 5359.6 5370.4 5401.5 5323.7 5341.9 5347.0 5357.5 5372.5 5356.0 5361.7 5372.2 5378.1 5387.2 5003.6 5229.2 5287.9 5318.7 5368.6 5035.2 5762.2 5780.3 5820.4 5891.8 6286.4 6291.6 6304.1 6305.2 6308.0 5574.6 6328.2 6335.7 6354.8 6361.1 5911.7 6004.9 6026.9 6098.8 6138.7 5385.6 6321.4 6383.5 6453.2 6467.6 6358.3 6362.0 6365.2 6370.2 6370.5 6258.7 6292.0 6329.5 6331.5 6339.5 6303.9 6329.1 6329.7 6355.4 6355.5 6311.8 6313.2 6314.1 6321.3 6323.7 5083.1 5099.5 5139.7 5143.9 5157.0 4511.3 4529.8 4542.6 4550.1 4610.9 4920.9 5985.5 5985.9 6000.4 6041.8 6296.8 6335.1 6336.0 6341.6 6349.9 5647.7 5743.7 5967.6 5979.5 5988.4 5518.3 5537.8 5543.7 5556.4 5623.1 6347.6 6377.7 6383.2 6391.2 6392.9 6274.4 6312.8 6319.4 6337.5 6340.0 6230.6 6266.4 6268.7 6315.7 6356.3 6309.6 6318.4 6344.4 6351.8 6361.3 6238.9 6253.1 6314.3 6329.7 6337.3 6200.7 6267.4 6276.6 6373.1 6384.0 6225.1 6335.6 6364.7 6366.5 6383.9 6270.2 6270.8 6273.3 6274.3 6274.7 6183.7 6236.3 6301.8 6345.8 6381.3 5101.9 5177.5 6106.4 6200.6 6244.7 15:44:07 INFO - PROCESS | 2192 | 15:44:07 INFO - PROCESS | 2192 | [#1] ext.html Cycles:180 Average:73010.52 Median:36840.04 stddev:159531.08 (433.0%) stddev-sans-first:159885.70 15:44:07 INFO - PROCESS | 2192 | Values: 494.0 509.1 524.7 531.0 577.6 32776.0 43352.0 44564.7 44711.8 44878.3 43013.8 43431.6 43498.8 43564.1 43579.0 8288.5 9388.0 9622.9 9627.0 9691.3 7787.2 9240.1 11685.6 11911.7 11924.2 11824.1 11847.5 11936.8 11959.8 12000.6 9983.4 11861.1 11864.3 11891.5 11899.3 11471.7 11573.5 11600.2 11618.2 11657.5 34173.7 41214.8 41542.2 41587.2 41646.4 3616.8 4064.9 4086.0 4094.7 4153.4 30644.2 30715.1 31216.7 31338.8 31569.7 3127.6 3193.6 3201.6 3228.2 3318.4 497662.0 498619.0 499386.0 500824.0 500886.5 62230.4 62445.0 62505.7 62595.1 62653.0 64305.0 64411.0 64490.0 64496.7 64516.0 16927.4 17407.8 17446.3 17453.1 17486.9 12344.5 13346.1 13465.9 13488.2 13503.3 14130.7 15894.6 16021.8 16134.3 16334.2 6240.8 6983.7 7182.4 7232.0 7312.3 770.9 882.9 903.8 914.6 923.8 29524.0 29679.0 30474.1 30560.9 31399.7 909.0 966.5 1112.7 1205.8 1271.1 15521.6 16385.5 16647.3 16734.7 16748.3 660110.0 664512.0 667227.0 667358.0 669275.0 63233.0 63828.0 63916.0 64034.7 64193.4 1303.5 1328.4 1428.5 1526.9 1546.1 30795.5 32217.8 32677.0 33505.8 34012.8 53786.2 54943.5 55020.0 57657.4 57696.0 607159.0 613777.0 614757.0 615318.0 615583.0 35060.9 35340.9 35745.0 40630.6 41352.4 43286.6 43350.6 44219.6 44854.0 45599.3 35887.8 36103.1 36744.8 37652.4 37947.4 36196.8 36224.0 36935.3 37272.1 37408.1 35099.3 35575.5 36117.7 36446.6 36531.6 30874.0 32658.8 32756.5 33231.3 33421.0 20486.0 24603.6 24682.4 25022.5 25054.1 15:44:07 INFO - PROCESS | 2192 | 15:44:07 INFO - PROCESS | 2192 | [#2] jquery.html Cycles:180 Average:38252.56 Median:24202.40 stddev:111417.09 (460.4%) stddev-sans-first:111693.40 15:44:07 INFO - PROCESS | 2192 | Values: 405.0 408.5 408.8 419.2 438.2 20227.4 20475.2 21354.0 21469.8 21475.9 21581.6 21757.6 21812.0 21848.8 21956.9 5819.9 6222.0 6254.0 6265.7 6273.5 5941.9 6149.5 6210.5 6212.3 6232.9 6169.9 6181.8 6193.1 6194.9 6198.3 5931.9 6121.9 6183.6 6196.1 6197.8 5266.9 5364.1 5427.4 5439.0 5446.9 26390.2 26893.2 26913.9 27144.2 27264.7 3083.4 3126.9 3190.8 3251.3 3328.0 15045.5 15461.1 15535.1 15564.2 16562.0 1806.4 1840.7 1863.4 1888.5 1894.1 114751.1 132781.0 132864.7 133645.0 134216.3 11351.6 11505.4 11609.2 11760.9 11822.2 12304.8 14790.5 14796.0 14846.6 14863.7 8840.8 8955.0 8962.8 9077.0 9092.4 7771.6 8969.6 8984.9 9130.5 9187.4 5775.7 6100.7 7165.5 7171.9 7224.0 1899.9 1924.4 1945.4 1946.2 1946.7 715.6 1058.5 1145.7 1160.8 1178.5 22078.4 23355.9 23552.5 24180.2 24224.6 1106.6 1133.6 1134.5 1169.3 1172.6 11731.5 12256.7 12552.2 12555.9 12707.7 584566.0 585707.0 593005.0 746639.0 792394.0 129488.0 138999.0 140933.0 146486.0 154824.4 444.3 478.9 480.7 482.3 482.6 11179.7 11294.4 11894.2 11955.0 11979.6 56490.7 58305.3 58325.7 60002.8 60885.7 86453.6 87144.6 88264.6 90540.1 90599.5 8318.7 8632.1 8653.0 8857.9 8885.0 11221.1 12899.6 13140.4 13309.9 13763.9 10352.9 11454.3 11477.4 11669.4 11712.8 4716.6 10453.0 10611.3 11753.6 12054.7 10697.0 10955.7 11630.0 11977.6 12049.9 8562.1 8617.4 8782.3 8814.5 8815.2 9886.0 11064.3 11305.9 11624.3 11680.3 15:44:07 INFO - PROCESS | 2192 | 15:44:07 INFO - PROCESS | 2192 | [#3] mootools.html Cycles:180 Average:5423.99 Median:5277.52 stddev:2901.59 (55.0%) stddev-sans-first:2894.50 15:44:07 INFO - PROCESS | 2192 | Values: 1468.4 1470.7 1493.7 1499.9 1500.9 8039.9 8423.7 8432.7 8440.2 8450.3 7435.8 7717.7 7968.8 8180.6 8181.9 2350.7 2392.2 2393.3 2393.5 2397.1 2037.2 2367.8 2401.3 2401.6 2411.3 2332.2 2359.2 2364.6 2395.1 2400.2 2348.5 2348.9 2359.7 2383.8 2388.1 2211.6 2240.6 2344.0 2419.6 2426.8 8167.2 8373.7 8377.1 8381.2 8383.0 5095.8 5257.4 5258.4 5259.8 5264.8 3454.7 3487.8 3489.3 3557.4 3571.5 1250.1 1253.5 1283.5 1300.0 1309.4 10607.2 10659.2 10673.0 10691.2 10697.6 4368.4 4695.2 4752.8 4757.1 4783.5 9468.6 9490.3 9515.1 9515.3 9526.6 5290.2 5294.6 5301.1 5301.5 5306.1 4355.6 4384.6 4761.0 4763.9 4851.2 3889.5 3897.3 4029.5 4034.3 4058.0 1255.5 1289.1 1301.0 1303.3 1310.9 899.6 921.3 924.9 929.5 952.9 5101.4 5628.4 5677.4 5782.4 5963.5 972.4 975.7 1018.4 1026.7 1043.1 3297.8 3733.9 3763.2 3875.1 3877.1 9611.1 9856.3 9862.1 9863.0 9882.2 9720.9 9808.6 9823.4 9823.6 9824.7 7538.4 7539.5 7568.9 7782.0 7785.2 4466.9 5246.1 5351.2 5406.1 5520.3 8903.6 9014.5 9158.7 9242.8 9270.8 8843.9 9111.4 9215.1 9385.4 9409.0 7150.4 7180.0 7205.8 7242.5 7302.2 7773.4 7838.2 7838.6 7839.2 7844.8 6914.9 7032.4 7048.2 7092.8 7159.5 6951.4 6969.6 7005.8 7021.4 7050.8 6260.2 6370.2 6377.9 6441.9 6449.1 4914.0 4968.0 4969.8 5002.4 5019.4 4208.6 4916.5 4970.0 5104.2 5155.1 15:44:07 INFO - PROCESS | 2192 | 15:44:07 INFO - PROCESS | 2192 | [#4] prototype.html Cycles:180 Average:4641.67 Median:5060.54 stddev:1398.03 (27.6%) stddev-sans-first:1364.65 15:44:07 INFO - PROCESS | 2192 | Values: 367.9 371.6 380.5 380.5 389.6 5300.8 5416.6 5504.8 5528.7 5574.3 4529.5 4933.0 5456.7 5478.3 5479.9 3446.1 3670.3 3707.0 4267.4 4336.7 3727.4 4055.1 4265.4 4297.0 4300.6 3746.6 4029.2 4104.8 4238.5 4260.5 3404.5 4000.0 4105.6 4292.3 4293.4 3304.0 3554.0 3708.6 3767.5 3800.9 4865.9 5335.3 5342.3 5343.4 5359.4 4583.6 4935.9 4941.0 4963.0 4969.7 5537.4 5627.0 5685.1 5766.8 5817.8 3406.4 3853.6 3909.2 4161.5 4175.5 5171.9 5718.6 5940.5 6081.4 6086.5 3887.9 4172.0 4244.6 4252.7 4254.7 4084.4 4158.0 4314.2 4315.6 4319.6 4879.3 4884.0 4892.9 4961.0 4966.5 4666.8 5252.1 5407.0 5456.6 5602.6 1248.3 1408.8 1426.7 1428.3 1431.7 813.5 951.8 988.6 996.5 1011.9 4575.8 4733.1 5005.5 5057.8 5077.4 5063.3 5066.6 5578.3 5596.3 5686.9 4198.5 4668.9 4949.0 4998.6 5050.3 2713.9 2718.6 2875.7 3002.3 3014.6 5465.3 5818.8 5843.9 5900.4 5914.7 5717.4 5891.6 6210.6 6210.7 6252.6 5812.3 5975.2 6031.6 6153.3 6176.3 5338.8 6053.5 6070.3 6074.8 6111.3 5112.6 5499.3 5771.7 5861.5 5992.3 4996.0 5246.4 5748.2 5905.9 5909.2 3959.8 3990.8 3997.0 4010.8 4015.3 4957.8 5297.3 5333.5 5965.7 6078.5 5048.2 5306.3 5752.3 5759.2 5829.6 5175.0 5554.3 5817.2 5822.6 5829.4 4554.4 4688.5 5594.6 5627.6 5637.9 4897.1 4913.8 5704.0 5706.7 5853.7 5449.4 5630.0 5657.2 5674.9 5679.9 15:44:07 INFO - PROCESS | 2192 | 15:44:07 INFO - PROCESS | 2192 | [#5] yui.html Cycles:180 Average:20329.60 Median:3798.03 stddev:28715.20 (756.1%) stddev-sans-first:28758.12 15:44:07 INFO - PROCESS | 2192 | Values: 751.7 777.6 805.9 850.0 860.3 15230.8 15238.8 15622.7 15741.4 15790.8 14208.9 14443.1 14473.2 14606.9 14609.6 900.9 906.8 913.4 914.6 915.2 718.3 749.7 887.5 907.8 919.7 945.8 973.8 974.5 975.4 977.8 966.3 968.4 968.8 969.4 970.6 709.6 722.8 726.3 727.0 728.6 15446.8 15834.7 15863.3 15926.0 16135.3 12798.5 14521.4 14783.3 15171.4 15219.6 11853.7 11928.5 11942.3 11949.6 12042.8 3691.5 3754.0 3758.8 3839.2 3868.3 96524.0 100491.0 100640.5 110398.4 114245.4 10491.4 11349.4 11377.7 11420.4 11474.3 22752.2 22771.7 23110.5 23157.9 23162.9 7971.8 8233.8 8382.0 8517.3 8537.4 4495.1 4603.0 4605.1 4788.7 4791.6 3729.3 3760.5 3835.6 3844.4 3983.9 637.3 699.3 718.7 758.6 759.3 690.2 708.9 715.4 731.4 763.2 10306.5 10597.4 10692.0 11013.1 11053.3 718.0 724.3 738.2 743.6 744.1 4082.9 5200.7 5203.0 5210.9 5225.1 87845.6 96984.0 107008.5 109332.5 113612.0 83849.6 85943.0 88965.6 89639.6 91090.5 65924.0 70375.6 70411.6 78633.6 79631.0 11052.2 11085.7 11121.2 11191.7 11488.5 42590.1 44038.6 49224.5 52139.2 52163.0 52859.2 64349.7 64976.0 66888.3 68048.0 12435.6 13050.7 13084.3 13289.9 13616.6 13427.9 13583.9 13881.3 14061.9 14196.2 12848.9 13672.6 14288.4 14325.7 14341.7 13594.4 14042.9 14064.9 14082.5 14346.7 12608.2 13926.5 13937.3 14042.3 14058.3 10990.3 11220.6 11409.5 11411.9 11581.0 9089.3 10871.8 11225.4 11440.3 11552.9 15:44:07 INFO - PROCESS | 2192 | -------- Summary: end -------- 15:44:07 INFO - PROCESS | 2192 | 15:44:08 INFO - TEST-INFO | 2192: exit 0 15:44:08 INFO - TEST-OK | dromaeo_css | took 1116711ms 15:44:08 INFO - TEST-START | kraken 15:44:08 INFO - operating with platform_type : mac_ 15:44:08 INFO - Initialising browser for kraken test... 15:44:08 INFO - TEST-INFO | started process 2195 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpz1YXM1/profile http://localhost:54532/getInfo.html) 15:44:10 INFO - PROCESS | 2195 | __metrics Screen width/height:1600/1200 15:44:10 INFO - PROCESS | 2195 | colorDepth:24 15:44:10 INFO - PROCESS | 2195 | Browser inner width/height: 1024/689 15:44:10 INFO - PROCESS | 2195 | __metrics 15:44:10 INFO - PROCESS | 2195 | 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" 15:44:10 INFO - PROCESS | 2195 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:44:11 INFO - TEST-INFO | 2195: exit 0 15:44:11 INFO - Browser initialized. 15:44:11 INFO - Running cycle 1/1 for kraken test... 15:44:11 INFO - TEST-INFO | started process 2197 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpz1YXM1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:23 INFO - PROCESS | 2197 | RSS: Main: 185315328 15:44:23 INFO - PROCESS | 2197 | 15:44:26 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:54532/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54532/tests/kraken/driver.html?testName=audio-beat-detection) 15:44:27 INFO - PROCESS | 2197 | RSS: Main: 231444480 15:44:27 INFO - PROCESS | 2197 | 15:44:29 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:54532/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54532/tests/kraken/driver.html?testName=audio-dft) 15:44:30 INFO - PROCESS | 2197 | RSS: Main: 245604352 15:44:30 INFO - PROCESS | 2197 | 15:44:33 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:54532/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54532/tests/kraken/driver.html?testName=audio-fft) 15:44:34 INFO - PROCESS | 2197 | RSS: Main: 338481152 15:44:34 INFO - PROCESS | 2197 | 15:44:36 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:54532/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54532/tests/kraken/driver.html?testName=audio-oscillator) 15:44:36 INFO - PROCESS | 2197 | RSS: Main: 240865280 15:44:36 INFO - PROCESS | 2197 | 15:44:38 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:54532/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54532/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:44:39 INFO - PROCESS | 2197 | RSS: Main: 242409472 15:44:39 INFO - PROCESS | 2197 | 15:44:42 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:54532/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54532/tests/kraken/driver.html?testName=imaging-darkroom) 15:44:42 INFO - PROCESS | 2197 | RSS: Main: 282611712 15:44:42 INFO - PROCESS | 2197 | 15:44:45 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:54532/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54532/tests/kraken/driver.html?testName=imaging-desaturate) 15:44:46 INFO - PROCESS | 2197 | RSS: Main: 284549120 15:44:46 INFO - PROCESS | 2197 | 15:44:49 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:54532/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54532/tests/kraken/driver.html?testName=json-parse-financial) 15:44:49 INFO - PROCESS | 2197 | RSS: Main: 281255936 15:44:49 INFO - PROCESS | 2197 | 15:44:51 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:54532/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54532/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:44:52 INFO - PROCESS | 2197 | RSS: Main: 260071424 15:44:52 INFO - PROCESS | 2197 | 15:44:53 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:54532/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54532/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:44:54 INFO - PROCESS | 2197 | RSS: Main: 259342336 15:44:54 INFO - PROCESS | 2197 | 15:44:56 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:54532/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54532/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:44:57 INFO - PROCESS | 2197 | RSS: Main: 266579968 15:44:57 INFO - PROCESS | 2197 | 15:45:00 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:54532/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:45:00 INFO - PROCESS | 2197 | RSS: Main: 269623296 15:45:00 INFO - PROCESS | 2197 | 15:45:03 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:54532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:45:04 INFO - PROCESS | 2197 | RSS: Main: 271167488 15:45:04 INFO - PROCESS | 2197 | 15:45:05 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:54532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54532/tests/kraken/driver.html?testName=ai-astar) 15:45:06 INFO - PROCESS | 2197 | RSS: Main: 315793408 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | __start_tp_report 15:45:06 INFO - PROCESS | 2197 | _x_x_mozilla_page_load 15:45:06 INFO - PROCESS | 2197 | _x_x_mozilla_page_load_details 15:45:06 INFO - PROCESS | 2197 | |i|pagename|runs| 15:45:06 INFO - PROCESS | 2197 | |0;ai-astar;112;115;117;114;114;115;115;113;116;147 15:45:06 INFO - PROCESS | 2197 | |1;audio-beat-detection;148;102;93;163;139;137;113;106;127;109 15:45:06 INFO - PROCESS | 2197 | |2;audio-dft;182;184;183;182;183;180;183;183;183;183 15:45:06 INFO - PROCESS | 2197 | |3;audio-fft;81;58;57;88;58;58;58;65;91;80 15:45:06 INFO - PROCESS | 2197 | |4;audio-oscillator;82;69;87;70;68;68;81;91;100;112 15:45:06 INFO - PROCESS | 2197 | |5;imaging-gaussian-blur;91;84;86;83;86;84;87;85;86;84 15:45:06 INFO - PROCESS | 2197 | |6;imaging-darkroom;102;135;93;93;92;93;93;94;92;92 15:45:06 INFO - PROCESS | 2197 | |7;imaging-desaturate;85;84;87;88;98;131;132;85;85;84 15:45:06 INFO - PROCESS | 2197 | |8;json-parse-financial;54;53;52;54;54;54;59;55;56;55 15:45:06 INFO - PROCESS | 2197 | |9;json-stringify-tinderbox;65;73;66;76;71;67;70;71;68;68 15:45:06 INFO - PROCESS | 2197 | |10;stanford-crypto-aes;83;84;84;82;84;80;85;82;88;108 15:45:06 INFO - PROCESS | 2197 | |11;stanford-crypto-ccm;133;127;144;139;136;123;132;135;152;133 15:45:06 INFO - PROCESS | 2197 | |12;stanford-crypto-pbkdf2;165;165;164;164;169;164;167;163;153;165 15:45:06 INFO - PROCESS | 2197 | |13;stanford-crypto-sha256-iterative;64;65;64;64;65;65;64;63;62;64 15:45:06 INFO - PROCESS | 2197 | __end_tp_report 15:45:06 INFO - PROCESS | 2197 | __start_cc_report 15:45:06 INFO - PROCESS | 2197 | _x_x_mozilla_cycle_collect,1954 15:45:06 INFO - PROCESS | 2197 | __end_cc_report 15:45:06 INFO - PROCESS | 2197 | __startTimestamp1489016706221__endTimestamp 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | ------- Summary: start ------- 15:45:06 INFO - PROCESS | 2197 | Number of tests: 14 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | [#0] ai-astar Cycles:10 Average:117.80 Median:115.00 stddev:10.36 (9.0%) stddev-sans-first:10.77 15:45:06 INFO - PROCESS | 2197 | Values: 112.0 115.0 117.0 114.0 114.0 115.0 115.0 113.0 116.0 147.0 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | [#1] audio-beat-detection Cycles:10 Average:123.70 Median:138.00 stddev:22.64 (16.4%) stddev-sans-first:22.24 15:45:06 INFO - PROCESS | 2197 | Values: 148.0 102.0 93.0 163.0 139.0 137.0 113.0 106.0 127.0 109.0 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:1.07 (0.6%) stddev-sans-first:1.12 15:45:06 INFO - PROCESS | 2197 | Values: 182.0 184.0 183.0 182.0 183.0 180.0 183.0 183.0 183.0 183.0 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | [#3] audio-fft Cycles:10 Average:69.40 Median:72.50 stddev:13.95 (19.2%) stddev-sans-first:14.15 15:45:06 INFO - PROCESS | 2197 | Values: 81.0 58.0 57.0 88.0 58.0 58.0 58.0 65.0 91.0 80.0 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | [#4] audio-oscillator Cycles:10 Average:82.80 Median:75.50 stddev:15.02 (19.9%) stddev-sans-first:15.93 15:45:06 INFO - PROCESS | 2197 | Values: 82.0 69.0 87.0 70.0 68.0 68.0 81.0 91.0 100.0 112.0 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.00 stddev:2.27 (2.6%) stddev-sans-first:1.32 15:45:06 INFO - PROCESS | 2197 | Values: 91.0 84.0 86.0 83.0 86.0 84.0 87.0 85.0 86.0 84.0 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | [#6] imaging-darkroom Cycles:10 Average:97.90 Median:93.00 stddev:13.37 (14.4%) stddev-sans-first:14.10 15:45:06 INFO - PROCESS | 2197 | Values: 102.0 135.0 93.0 93.0 92.0 93.0 93.0 94.0 92.0 92.0 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:85.00 stddev:19.21 (22.6%) stddev-sans-first:19.97 15:45:06 INFO - PROCESS | 2197 | Values: 85.0 84.0 87.0 88.0 98.0 131.0 132.0 85.0 85.0 84.0 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:1.90 (3.5%) stddev-sans-first:2.00 15:45:06 INFO - PROCESS | 2197 | Values: 54.0 53.0 52.0 54.0 54.0 54.0 59.0 55.0 56.0 55.0 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.50 stddev:3.37 (4.8%) stddev-sans-first:3.16 15:45:06 INFO - PROCESS | 2197 | Values: 65.0 73.0 66.0 76.0 71.0 67.0 70.0 71.0 68.0 68.0 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:84.00 stddev:8.01 (9.5%) stddev-sans-first:8.43 15:45:06 INFO - PROCESS | 2197 | Values: 83.0 84.0 84.0 82.0 84.0 80.0 85.0 82.0 88.0 108.0 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:135.50 stddev:8.24 (6.1%) stddev-sans-first:8.69 15:45:06 INFO - PROCESS | 2197 | Values: 133.0 127.0 144.0 139.0 136.0 123.0 132.0 135.0 152.0 133.0 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:165.00 stddev:4.20 (2.5%) stddev-sans-first:4.44 15:45:06 INFO - PROCESS | 2197 | Values: 165.0 165.0 164.0 164.0 169.0 164.0 167.0 163.0 153.0 165.0 15:45:06 INFO - PROCESS | 2197 | 15:45:06 INFO - PROCESS | 2197 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 15:45:06 INFO - PROCESS | 2197 | Values: 64.0 65.0 64.0 64.0 65.0 65.0 64.0 63.0 62.0 64.0 15:45:06 INFO - PROCESS | 2197 | -------- Summary: end -------- 15:45:06 INFO - PROCESS | 2197 | 15:45:07 INFO - TEST-INFO | 2197: exit 0 15:45:07 INFO - TEST-OK | kraken | took 58610ms 15:45:07 INFO - SUITE-END | took 1175s 15:45:07 INFO - Completed test suite (00:19:35) 15:45:07 INFO - javascript benchmark 15:45:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3387.1532116970757, 3389.4746314321287, 3428.40002999475, 3438.4670376091713, 3485.1984043669954, 5763.193152958589, 5871.031279838827, 5927.2590926134235, 5960.850978725529, 5979.581429299951, 5826.941730582693, 5840.503557197632, 5905.881882362361, 5905.9409405906035, 5922.111683247515, 5255.658382205154, 5258.421573626898, 5338.866528336784, 5360.2763626910455, 5368.0605893968595, 5305.151175811871, 5306.946930530684, 5359.624826262163, 5370.43610420906, 5401.540869026137, 5323.733813309338, 5341.866453338659, 5346.973265133669, 5357.464253574651, 5372.516473517383, 5355.98236335097, 5361.705106219157, 5372.167314066326, 5378.112611419131, 5387.218853266294, 5003.624728145403, 5229.163333866563, 5287.86780330491, 5318.654287471302, 5368.62419630626, 5035.244713293036, 5762.222100016486, 5780.3063632363965, 5820.417958204146, 5891.764329426818, 6286.4342209201395, 6291.559590828644, 6304.085907543381, 6305.211848518935, 6307.9684601577155, 5574.554035677136, 6328.1773369462135, 6335.651539165344, 6354.841128971766, 6361.141245931786, 5911.733971971272, 6004.909926351108, 6026.9095963560585, 6098.847528811771, 6138.7237574309265, 5385.6230063895155, 6321.367863213642, 6383.521235907326, 6453.193350831146, 6467.611943283418, 6358.268799088071, 6362.045693145972, 6365.172527571479, 6370.235571731422, 6370.522210834206, 6258.718357673915, 6291.96854015727, 6329.461995730415, 6331.5251356147555, 6339.4611458025665, 6303.905441418382, 6329.113924050636, 6329.746810127635, 6355.3644635536075, 6355.491560675135, 6311.779087731908, 6313.2424109107205, 6314.116023756677, 6321.273053598803, 6323.715432805535, 5083.135866902636, 5099.464556221617, 5139.665921715151, 5143.922841157386, 5156.9742151289, 4511.323301504735, 4529.796159172845, 4542.636589072867, 4550.089982003613, 4610.9308360374625, 4920.8769780755765, 5985.461308482258, 5985.880282394328, 6000.399960003964, 6041.818745437644, 6296.842578935563, 6335.144755458046, 6336.049592561153, 6341.6195028297525, 6349.904751428732, 5647.661140331593, 5743.684097374685, 5967.641941483438, 5979.521638268928, 5988.371221021817, 5518.2826232590305, 5537.833864984057, 5543.695096769717, 5556.444355564411, 5623.072193088176, 6347.587406818542, 6377.681115944091, 6383.170187875547, 6391.169148010729, 6392.872142557216, 6274.372562743872, 6312.810615681537, 6319.368063193644, 6337.524685648687, 6340.017297318923, 6230.59501132425, 6266.404691554295, 6268.717907694256, 6315.747370105144, 6356.3325850785, 6309.589876658002, 6318.4313411793155, 6344.429001389897, 6351.809445716636, 6361.268454127835, 6238.875222495615, 6253.09330147117, 6314.305426403183, 6329.715162817776, 6337.271213810471, 6200.689965501797, 6267.435930766253, 6276.560640755286, 6373.075903993988, 6384.010478375859, 6225.066240064027, 6335.588186767845, 6364.681765911779, 6366.490680745622, 6383.872322553616, 6270.247570291412, 6270.7805226816845, 6273.3099359071375, 6274.341194174728, 6274.749010039547, 6183.690815459299, 6236.251649802053, 6301.842453938505, 6345.841353966188, 6381.266154392304, 5101.923471147861, 5177.4822517747925, 6106.419890110433, 6200.627962322275, 6244.687765611792], "value": 5817.792722282284, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.9530744579266, 509.0531611203162, 524.6642149024623, 531.0494215354515, 577.62454404637, 32776.016719498424, 43352.0, 44564.66306010817, 44711.77644111779, 44878.32682509765, 43013.7849310753, 43431.56568434315, 43498.782506087424, 43564.128717425636, 43579.0, 8288.502689838599, 9387.999999999984, 9622.855657165148, 9626.98916613756, 9691.321607487478, 7787.221277872224, 9240.075992400773, 11685.649430517098, 11911.702207444796, 11924.224925379822, 11824.11319151067, 11847.466863991142, 11936.7612647747, 11959.760804783898, 12000.63998080059, 9983.400995940267, 11861.110416718695, 11864.288142711379, 11891.524339026428, 11899.286042837413, 11471.713207169803, 11573.53705851765, 11600.187986840925, 11618.244814087057, 11657.533698652129, 34173.658263417296, 41214.79392603018, 41542.1691566167, 41587.1682566347, 41646.37530437046, 3616.8372423240753, 4064.9390259146135, 4085.9559628076977, 4094.6724262058965, 4153.397757325201, 30644.233894152603, 30715.078547643607, 31216.687833121832, 31338.843305783324, 31569.684303157133, 3127.5777770000986, 3193.5529025936157, 3201.631812341564, 3228.2252259457796, 3318.4192766266046, 497662.0, 498619.0, 499385.9999999964, 500824.0, 500886.49556751986, 62230.37769622336, 62445.0, 62505.68747156326, 62595.061074083926, 62653.0, 64305.0, 64411.0, 64490.0, 64496.677516612115, 64516.03225951614, 16927.407540736014, 17407.825921740874, 17446.302147913942, 17453.12734363277, 17486.91256543709, 12344.506219751109, 13346.13250138738, 13465.865341346462, 13488.190708557519, 13503.257320847251, 14130.717385652435, 15894.60263493422, 16021.759673604905, 16134.273957671932, 16334.18329083541, 6240.812775616739, 6983.6731021105825, 7182.389496892718, 7232.034865705035, 7312.341889229995, 770.857391382596, 882.8808110904946, 903.846346121161, 914.6432891172448, 923.7782932096248, 29524.0, 29678.961236356623, 30474.08577742627, 30560.93036743703, 31399.686003140134, 909.0182602788972, 966.5167416291854, 1112.671761830262, 1205.8311836342918, 1271.1229251816217, 15521.611959701098, 16385.50843474698, 16647.33410663584, 16734.74897876533, 16748.330066797193, 660110.0, 664512.0, 667227.0, 667358.0, 669275.0, 63233.0, 63828.0, 63916.0, 64034.67982660057, 64193.35806641967, 1303.5372442783055, 1328.4022190014339, 1428.5285855667396, 1526.900751451152, 1546.1109861829493, 30795.538066928566, 32217.838910806233, 32677.019689408404, 33505.83247083847, 34012.82993585016, 53786.19320710114, 54943.45056549383, 55020.0, 57657.42342576689, 57696.0, 607159.0, 613777.0, 614757.0, 615318.0, 615583.0, 35060.9481715549, 35340.93977180689, 35745.0, 40630.59369406268, 41352.37971430371, 43286.56713432825, 43350.56649433466, 44219.55780442154, 44854.0, 45599.31601026054, 35887.82056089703, 36103.09742256465, 36744.81627591952, 37652.435213471275, 37947.430788538746, 36196.81901590475, 36224.0, 36935.261294773416, 37272.06819829526, 37408.06479837917, 35099.29801404009, 35575.46636800502, 36117.73587924515, 36446.63553364432, 36531.634683652825, 30874.0, 32658.83670581632, 32756.508652369757, 33231.33537329288, 33421.0, 20486.0, 24603.630945536188, 24682.382940426633, 25022.499550009263, 25054.123105691215], "value": 20732.873386226674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.9534303555092, 408.4771492489613, 408.84668249406474, 419.2244347956281, 438.20684560944693, 20227.39317820466, 20475.18099276031, 21354.0, 21469.785302146975, 21475.926203689793, 21581.568368632656, 21757.564848703056, 21812.0, 21848.781512184873, 21956.8902155489, 5819.883602327951, 6221.968890155543, 6254.0, 6265.655388953629, 6273.529485288599, 5941.85145371367, 6149.477294429978, 6210.534209934251, 6212.347703491136, 6232.906506402408, 6169.876602467971, 6181.81454556364, 6193.102000209967, 6194.907076393858, 6198.256209254896, 5931.851703707399, 6121.938780612181, 6183.567150299481, 6196.101565273033, 6197.783077592308, 5266.8683282917855, 5364.1444070556145, 5427.402985671573, 5439.0, 5446.863828404282, 26390.208293751217, 26893.193204203708, 26913.92344306245, 27144.1856744298, 27264.72735272642, 3083.429565530384, 3126.89055883043, 3190.808551486918, 3251.2847173621767, 3327.9833600832085, 15045.473408430653, 15461.072335659785, 15535.067895926168, 15564.221788910623, 16562.0, 1806.358742646368, 1840.7054871220541, 1863.3943968210385, 1888.4712280561464, 1894.0624390926441, 114751.13122171929, 132781.0, 132864.67135328715, 133644.9953250702, 134216.32891835575, 11351.60269390584, 11505.408355661275, 11609.187356885106, 11760.941195293968, 11822.231554949072, 12304.81542776859, 14790.482333118289, 14796.038257513228, 14846.554603361916, 14863.70272594542, 8840.823183536293, 8955.0, 8962.775930601787, 9077.001529831714, 9092.36353455265, 7771.572563509061, 8969.596368163448, 8984.8652270216, 9130.543472826332, 9187.356885017985, 5775.740091695884, 6100.664463454553, 7165.498415110892, 7171.89242161368, 7224.0, 1899.886006839594, 1924.393815947972, 1945.3580318494862, 1946.153423260886, 1946.6593346164364, 715.6178372966006, 1058.502219359613, 1145.7078444996473, 1160.8391608391607, 1178.4873579992732, 22078.448038798837, 23355.88322058379, 23552.528949420917, 24180.153694620603, 24224.636630450204, 1106.6237479256931, 1133.631569739838, 1134.489479734123, 1169.257521473853, 1172.5837327748698, 11731.530738770354, 12256.693582660504, 12552.246865188117, 12555.93722031384, 12707.745845083047, 584566.0, 585707.0, 593005.0, 746639.0, 792394.0, 129488.0, 138999.0, 140933.0, 146486.0, 154824.3552693421, 444.2913552883146, 478.92097803861975, 480.67074054272933, 482.3295619089398, 482.642844295219, 11179.66461006171, 11294.378809165575, 11894.226875253082, 11955.043596512085, 11979.580714674945, 56490.71754641201, 58305.3355731532, 58325.70837145957, 60002.799944000006, 60885.69557152186, 86453.56773216094, 87144.56427717821, 88264.55867720621, 90540.09459905316, 90599.54700226456, 8318.71059985679, 8632.136786321318, 8652.956735216536, 8857.911420885708, 8885.0, 11221.102311815199, 12899.613011609667, 13140.408681609542, 13309.933450332686, 13763.862361376257, 10352.948235258775, 11454.255473394203, 11477.36874471912, 11669.35818529955, 11712.765744685228, 4716.64625153108, 10453.006964338376, 10611.257211995086, 11753.588624398106, 12054.698632534257, 10697.037266646039, 10955.671329860117, 11630.0, 11977.580784672495, 12049.939750301543, 8562.058173601023, 8617.439866408664, 8782.29741620656, 8814.471131732116, 8815.206631403205, 9886.0, 11064.28082174656, 11305.908406944412, 11624.291610583277, 11680.299182049104], "value": 10019.945086241825, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.3832790228103, 1470.6543962168896, 1493.6863258715669, 1499.8725108365784, 1500.9324580393875, 8039.8794018089775, 8423.705170319041, 8432.662693492253, 8440.240378365947, 8450.281726053277, 7435.814104647387, 7717.652705628247, 7968.840623187532, 8180.550069746161, 8181.91818081819, 2350.682657841195, 2392.2225276785116, 2393.3179043972473, 2393.5452264069772, 2397.0891061396646, 2037.154580848946, 2367.822413318999, 2401.3036219496325, 2401.627747699101, 2411.2886698423918, 2332.1837356925025, 2359.245041586693, 2364.5625559271502, 2395.101836811196, 2400.219928523237, 2348.495073559184, 2348.8825558721996, 2359.728631207399, 2383.785459308653, 2388.1402695029774, 2211.579799838026, 2240.5630901974123, 2344.0389440329554, 2419.5644783938883, 2426.793722533587, 8167.183281671844, 8373.665053397857, 8377.078521362646, 8381.245687888118, 8382.958085209535, 5095.821646242363, 5257.421683614799, 5258.447862974409, 5259.815906443295, 5264.815731449419, 3454.7063499602564, 3487.7558570900046, 3489.319582681378, 3557.3774589447003, 3571.5178450909316, 1250.1498980693125, 1253.4986005597834, 1283.5379263465145, 1299.9675008124777, 1309.3911331231022, 10607.204459665556, 10659.200559958033, 10673.0, 10691.198160138021, 10697.625583104631, 4368.4321038264825, 4695.178343789823, 4752.7623618818925, 4757.072370887644, 4783.473817880031, 9468.57391417388, 9490.288228382899, 9515.143637072697, 9515.286353523514, 9526.571304291323, 5290.232916227203, 5294.602904782157, 5301.098813201688, 5301.496357845998, 5306.124489459273, 4355.60799528044, 4384.56154384559, 4760.95239047612, 4763.857084287408, 4851.151048566487, 3889.4943657324366, 3897.337452633059, 4029.516458024997, 4034.253663072341, 4058.0, 1255.4664267686196, 1289.149161553389, 1300.9804852927214, 1303.328785675378, 1310.9344532773323, 899.6356475627381, 921.2767977137914, 924.8751418558409, 929.5166513412987, 952.8523078922778, 5101.413337466239, 5628.437156284339, 5677.403872593401, 5782.392848750821, 5963.463288304073, 972.4165500699523, 975.7316737897135, 1018.3940555369543, 1026.6612018034032, 1043.087298613713, 3297.7526685498683, 3733.8506459741848, 3763.1532905096133, 3875.0699832040673, 3877.1470276539117, 9611.086946740048, 9856.310058295994, 9862.112409883002, 9863.0, 9882.209423246122, 9720.854187187198, 9808.558614862348, 9823.36148150368, 9823.557939892722, 9824.65613703517, 7538.434617403716, 7539.509931854522, 7568.886466703004, 7782.0, 7785.18255583167, 4466.883279180205, 5246.055709972089, 5351.1973204019705, 5406.0809662356705, 5520.282363292907, 8903.643854246016, 9014.549272536216, 9158.725238242863, 9242.815143697222, 9270.768230794283, 8843.91156088431, 9111.362204645611, 9215.078492150731, 9385.436873787594, 9408.95295523518, 7150.392216661642, 7180.0, 7205.819854503679, 7242.456815738946, 7302.196758356683, 7773.37812974972, 7838.176991415819, 7838.608069596611, 7839.176886426843, 7844.84310313802, 6914.861702765816, 7032.367086962198, 7048.224695283618, 7092.787216383516, 7159.534630249017, 6951.44388448933, 6969.616671083139, 7005.824854378681, 7021.43828493709, 7050.823729406806, 6260.186175797117, 6370.203724534434, 6377.8724425512155, 6441.903371449338, 6449.097126402214, 4913.975430122827, 4968.0, 4969.801207951641, 5002.399712034579, 5019.422766381913, 4208.642265407475, 4916.532929371704, 4969.975150124371, 5104.2088476286235, 5155.149400348901], "value": 4452.393978185963, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.86572900891184, 371.5504239869758, 380.46164676982073, 380.5376467591875, 389.6454226653744, 5300.773675056475, 5416.593755468336, 5504.779808807648, 5528.668279903209, 5574.303212098488, 4529.456465224178, 4932.9753351233285, 5456.727163641812, 5478.342598888129, 5479.890402191953, 3446.0899557259295, 3670.339338919007, 3706.9629303707025, 4267.359896015591, 4336.696431249814, 3727.366347720894, 4055.1484188320487, 4265.395740599189, 4296.957030429687, 4300.612944834964, 3746.6253374662588, 4029.1538776856896, 4104.774237416941, 4238.533761286256, 4260.531341552427, 3404.472306792451, 3999.960000399988, 4105.568915263884, 4292.29177185764, 4293.3989241506215, 3303.9834800826084, 3553.982230088833, 3708.61059588742, 3767.4537192107264, 3800.8669696560764, 4865.854024379274, 5335.33308336458, 5342.328835582209, 5343.423690011417, 5359.383670877821, 4583.587477127075, 4935.90128197434, 4941.0, 4962.950370496285, 4969.652124351297, 5537.446255374471, 5627.015272327327, 5685.085897771038, 5766.790243122544, 5817.767289308423, 3406.403879321134, 3853.556840963269, 3909.179072394772, 4161.52142503613, 4175.498940127174, 5171.870703232412, 5718.59969802114, 5940.524758019348, 6081.361457046991, 6086.543509236825, 3887.863924762676, 4172.0, 4244.596763307481, 4252.682907332286, 4254.680898932593, 4084.4281800547947, 4158.022864626811, 4314.203500919171, 4315.597430834991, 4319.632831209383, 4879.26810978349, 4883.951160488421, 4892.902141957141, 4960.975195124001, 4966.503349665077, 4666.789994450258, 5252.133397989365, 5407.0267351876255, 5456.563474921997, 5602.551795856321, 1248.2759999200441, 1408.8309402871516, 1426.6504706347012, 1428.2715814934459, 1431.7279716853764, 813.4915677701437, 951.757301888028, 988.619381538113, 996.5216695985968, 1011.9392836429838, 4575.771211439414, 4733.13645244629, 5005.549500544968, 5057.802024319806, 5077.441481437039, 5063.278485315011, 5066.620003499752, 5578.330600327987, 5596.27248457706, 5686.943130568724, 4198.475190601175, 4668.906621867543, 4949.0, 4998.550130488274, 5050.3434553507805, 2713.945721085567, 2718.646575945154, 2875.7124287571496, 3002.264445210937, 3014.623172103487, 5465.344158700981, 5818.7672493100645, 5843.853903652443, 5900.43945825146, 5914.733836977346, 5717.399673034354, 5891.641764194368, 6210.596311239755, 6210.689465526796, 6252.5610913998025, 5812.285375814145, 5975.163477113208, 6031.601716463741, 6153.261608606996, 6176.294223465885, 5338.75975581092, 6053.4551890330085, 6070.298717070861, 6074.848128796815, 6111.266648002268, 5112.590992720499, 5499.340079190522, 5771.671246565076, 5861.472467477777, 5992.250968628921, 4995.975020124876, 5246.422893481637, 5748.240844394798, 5905.936931352398, 5909.23179986599, 3959.7822119783687, 3990.8204130814765, 3996.960030399659, 4010.7794071326357, 4015.277250095011, 4957.752112394293, 5297.311349524537, 5333.466653334635, 5965.731542080704, 6078.538192032234, 5048.192289233705, 5306.257124002565, 5752.252207213036, 5759.222504961944, 5829.59192856496, 5175.0, 5554.250176226158, 5817.189740719835, 5822.57346949983, 5829.358770535153, 4554.4495082753765, 4688.460827004802, 5594.552435805207, 5627.634203776742, 5637.8590535236945, 4897.1107046842535, 4913.7543122843, 5704.0, 5706.657600543981, 5853.707314634166, 5449.373322067854, 5629.971850140723, 5657.15142728594, 5674.886502270014, 5679.943200567942], "value": 4217.39272296534, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.6504825256254, 777.6150805351352, 805.8791181322797, 849.9830003399932, 860.3332417376535, 15230.77153842692, 15238.847611523881, 15622.687546249068, 15741.370345186193, 15790.842091579081, 14208.857911420908, 14443.133411995288, 14473.203973781438, 14606.853931460682, 14609.634759131028, 900.9324300677459, 906.7778394293407, 913.4199783137689, 914.5930061122802, 915.2129168914728, 718.2637796258824, 749.6851322444586, 887.5163036145316, 907.7821322882494, 919.6965001549506, 945.8297506448871, 973.7662960889406, 974.4835237324229, 975.4488713876673, 977.8288799460101, 966.3332300712486, 968.3705591365633, 968.7578105473632, 969.3795970578835, 970.553545369131, 709.6309918842225, 722.8409749855024, 726.3317747672102, 727.0475676863326, 728.5919884864493, 15446.768298475532, 15834.683306333924, 15863.286152123183, 15925.974064927626, 16135.273912673958, 12798.48806047757, 14521.419143234258, 14783.277097849665, 15171.393144274216, 15219.61950951224, 11853.703657408547, 11928.46321915516, 11942.283462992249, 11949.641510754604, 12042.759144817142, 3691.483192353073, 3754.047895094563, 3758.8120593970193, 3839.17457746583, 3868.3423817951016, 96524.0, 100491.0, 100640.49039264416, 110398.44800776025, 114245.42877285644, 10491.370517768959, 11349.375784331776, 11377.715557110972, 11420.371879546705, 11474.311541307548, 22752.20367287137, 22771.658425123638, 23110.537789244456, 23157.88421057884, 23162.884185578965, 7971.800704982422, 8233.79415514605, 8382.0, 8517.318614510825, 8537.359698022674, 4495.145922274757, 4602.953970460252, 4605.078984203173, 4788.712677239377, 4791.6406269529225, 3729.310077635646, 3760.4547340636, 3835.5972622874756, 3844.442555829389, 3983.880483585497, 637.3085202555279, 699.2867275379085, 718.7340683946973, 758.5941521286086, 759.2673070487007, 690.1649004704263, 708.890122031086, 715.4383808710138, 731.4002517935348, 763.2024534361606, 10306.536205870603, 10597.364158150536, 10692.0, 11013.118950483942, 11053.28153670025, 717.9512606292072, 724.2757242757243, 738.1621859189859, 743.6170372258291, 744.0884915977883, 4082.9387559186634, 5200.739963001834, 5203.037438073969, 5210.947890521122, 5225.059489291964, 87845.56077219702, 96984.0, 107008.46495767627, 109332.45333773439, 113612.0, 83849.58075209585, 85943.0, 88965.55517222502, 89639.55180224057, 91090.45725646123, 65924.0, 70375.64812175906, 70411.64794175996, 78633.60683196547, 79631.0, 11052.226344156154, 11085.722856928642, 11121.221514494231, 11191.66425007251, 11488.483018264365, 42590.148197036506, 44038.55961440344, 49224.50775492199, 52139.21791173059, 52163.0, 52859.20711189258, 64349.67825160844, 64976.0, 66888.33111669015, 68048.0, 12435.626931192079, 13050.738985220432, 13084.345782711016, 13289.867101328862, 13616.591502254949, 13427.943808914592, 13583.86416135826, 13881.305934703023, 14061.929690351892, 14196.219207943663, 12848.935755321163, 13672.589822305346, 14288.35702393374, 14325.713485730435, 14341.713165736835, 13594.388252528463, 14042.929785351007, 14064.929675351557, 14082.507112251022, 14346.713065738835, 12608.243505389706, 13926.51257205993, 13937.303134843014, 14042.2978851055, 14058.297085145497, 10990.285631433931, 11220.551177953117, 11409.486573104396, 11411.947207477995, 11581.0, 9089.272858171462, 10871.836922446011, 11225.382603956534, 11440.313581185155, 11552.94223528877], "value": 7756.402133305707, "unit": "score"}], "name": "dromaeo_css", "value": 7486.371934790209, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 117.0, 114.0, 114.0, 115.0, 115.0, 113.0, 116.0, 147.0], "value": 117.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 102.0, 93.0, 163.0, 139.0, 137.0, 113.0, 106.0, 127.0, 109.0], "value": 123.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 183.0, 182.0, 183.0, 180.0, 183.0, 183.0, 183.0, 183.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 57.0, 88.0, 58.0, 58.0, 58.0, 65.0, 91.0, 80.0], "value": 69.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 69.0, 87.0, 70.0, 68.0, 68.0, 81.0, 91.0, 100.0, 112.0], "value": 82.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 84.0, 86.0, 83.0, 86.0, 84.0, 87.0, 85.0, 86.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 135.0, 93.0, 93.0, 92.0, 93.0, 93.0, 94.0, 92.0, 92.0], "value": 97.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 87.0, 88.0, 98.0, 131.0, 132.0, 85.0, 85.0, 84.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 54.0, 54.0, 54.0, 59.0, 55.0, 56.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 66.0, 76.0, 71.0, 67.0, 70.0, 71.0, 68.0, 68.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 82.0, 84.0, 80.0, 85.0, 82.0, 88.0, 108.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 127.0, 144.0, 139.0, 136.0, 123.0, 132.0, 135.0, 152.0, 133.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 164.0, 169.0, 164.0, 167.0, 163.0, 153.0, 165.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 63.0, 62.0, 64.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1429.1000000000001, "alertThreshold": 2.0}]} 15:45:07 INFO - Return code: 0 15:45:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:45:07 INFO - # TBPL SUCCESS # 15:45:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:45:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:45:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:45:07 INFO - 2017-03-08 15:45:07.527 screenresolution[2201:26669] starting screenresolution argv=screenresolution get 15:45:07 INFO - 2017-03-08 15:45:07.530 screenresolution[2201:26669] Display 0: 1600x1200x32@60 15:45:07 INFO - 2017-03-08 15:45:07.537 screenresolution[2202:26672] starting screenresolution argv=screenresolution list 15:45:07 INFO - Available Modes on Display 0 15:45:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:45:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:45:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:45:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:45:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:45:07 INFO - Intel Iris: 15:45:07 INFO - Chipset Model: Intel Iris 15:45:07 INFO - Type: GPU 15:45:07 INFO - Bus: Built-In 15:45:07 INFO - VRAM (Dynamic, Max): 1536 MB 15:45:07 INFO - Vendor: Intel (0x8086) 15:45:07 INFO - Device ID: 0x0a2e 15:45:07 INFO - Revision ID: 0x0009 15:45:07 INFO - Displays: 15:45:07 INFO - Display: 15:45:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:45:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:45:07 INFO - Display Serial Number: 1600x1200 60 15:45:07 INFO - Main Display: Yes 15:45:07 INFO - Mirror: Off 15:45:07 INFO - Online: Yes 15:45:07 INFO - Rotation: Supported 15:45:07 INFO - Return code: 0 15:45:07 INFO - Running post-action listener: _resource_record_post_action 15:45:07 INFO - [mozharness: 2017-03-08 23:45:07.772399Z] Finished run-tests step (success) 15:45:07 INFO - Running post-run listener: _resource_record_post_run 15:45:07 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 487424; Write bytes: 418459648; Read time: 5; Write time: 1539 15:45:07 INFO - TinderboxPrint: CPU usage
53.6% 15:45:07 INFO - TinderboxPrint: I/O read bytes / time
487,424 / 5 15:45:07 INFO - TinderboxPrint: I/O write bytes / time
418,459,648 / 1,539 15:45:07 INFO - TinderboxPrint: CPU idle
2,210.2 (46.4%) 15:45:07 INFO - TinderboxPrint: CPU system
951.1 (20.0%) 15:45:07 INFO - TinderboxPrint: CPU user
1,600.4 (33.6%) 15:45:07 INFO - TinderboxPrint: Swap in / out
121,806,848 / 0 15:45:07 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 114022912; Write bytes: 114529792; Read time: 10067; Write time: 281 15:45:07 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 487424; Write bytes: 294099456; Read time: 5; Write time: 1230 15:45:08 INFO - Running post-run listener: _upload_blobber_files 15:45:08 INFO - Blob upload gear active. 15:45:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:45:08 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 15:45:08 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'] 15:45:08 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 15:45:08 INFO - (blobuploader) - INFO - Open directory for files ... 15:45:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:45:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:09 INFO - (blobuploader) - INFO - Done attempting. 15:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:45:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:11 INFO - (blobuploader) - INFO - Done attempting. 15:45:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:45:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:45:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:12 INFO - (blobuploader) - INFO - Done attempting. 15:45:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:45:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:45:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:14 INFO - (blobuploader) - INFO - Done attempting. 15:45:14 INFO - (blobuploader) - INFO - Iteration through files over. 15:45:14 INFO - Return code: 0 15:45:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:45:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:45:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f52ebff4bc225bf073895406fa4ffb8e35eeb63571f8326adf622fe4b48d9ac26b5552e0c5f21e98ecb359a271f3a00b76cd954594481b6c9e9d6b7b21b4807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c36397f62ea1c3274beda0d6a47ba783d3b137d98584a85275d69433c5b3bc7968b2fb9f1d086e2837452adc32a86e30017f8ac966988522118986570936420b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd407da8f0be64562148d1cb5474a584111f5e6ab1b2d582865d1d1800933c6f80f176e07a9e544bd39e4e1c8c1dfa9bcf39647810abdb9bb9a01317b9084ecb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03da1b8a3dc80b10d9caa93db6996b302e251fdce8aed61d84270ec9acd1cbc87bc0cbb72b34fa43412bfbbb194cd82fdbd031317e935b8b9ece1709144596c9"} 15:45:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:45:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:45:14 INFO - Contents: 15:45:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f52ebff4bc225bf073895406fa4ffb8e35eeb63571f8326adf622fe4b48d9ac26b5552e0c5f21e98ecb359a271f3a00b76cd954594481b6c9e9d6b7b21b4807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c36397f62ea1c3274beda0d6a47ba783d3b137d98584a85275d69433c5b3bc7968b2fb9f1d086e2837452adc32a86e30017f8ac966988522118986570936420b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd407da8f0be64562148d1cb5474a584111f5e6ab1b2d582865d1d1800933c6f80f176e07a9e544bd39e4e1c8c1dfa9bcf39647810abdb9bb9a01317b9084ecb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03da1b8a3dc80b10d9caa93db6996b302e251fdce8aed61d84270ec9acd1cbc87bc0cbb72b34fa43412bfbbb194cd82fdbd031317e935b8b9ece1709144596c9"} 15:45:14 INFO - Running post-run listener: copy_logs_to_upload_dir 15:45:14 INFO - Copying logs to upload dir... 15:45:14 INFO - mkdir: /builds/slave/test/build/upload/logs 15:45:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.866400 ========= master_lag: 2.55 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-08 15:45:17.145746) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 15:45:17.149241) ========= 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.YxyPCOJLTh/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.gbvrO39Cis/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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/0f52ebff4bc225bf073895406fa4ffb8e35eeb63571f8326adf622fe4b48d9ac26b5552e0c5f21e98ecb359a271f3a00b76cd954594481b6c9e9d6b7b21b4807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c36397f62ea1c3274beda0d6a47ba783d3b137d98584a85275d69433c5b3bc7968b2fb9f1d086e2837452adc32a86e30017f8ac966988522118986570936420b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd407da8f0be64562148d1cb5474a584111f5e6ab1b2d582865d1d1800933c6f80f176e07a9e544bd39e4e1c8c1dfa9bcf39647810abdb9bb9a01317b9084ecb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03da1b8a3dc80b10d9caa93db6996b302e251fdce8aed61d84270ec9acd1cbc87bc0cbb72b34fa43412bfbbb194cd82fdbd031317e935b8b9ece1709144596c9"} build_url:https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011422 build_url: 'https://queue.taskcluster.net/v1/task/ALwn6zGcR7mIAxR4HlUq6A/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/0f52ebff4bc225bf073895406fa4ffb8e35eeb63571f8326adf622fe4b48d9ac26b5552e0c5f21e98ecb359a271f3a00b76cd954594481b6c9e9d6b7b21b4807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c36397f62ea1c3274beda0d6a47ba783d3b137d98584a85275d69433c5b3bc7968b2fb9f1d086e2837452adc32a86e30017f8ac966988522118986570936420b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd407da8f0be64562148d1cb5474a584111f5e6ab1b2d582865d1d1800933c6f80f176e07a9e544bd39e4e1c8c1dfa9bcf39647810abdb9bb9a01317b9084ecb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03da1b8a3dc80b10d9caa93db6996b302e251fdce8aed61d84270ec9acd1cbc87bc0cbb72b34fa43412bfbbb194cd82fdbd031317e935b8b9ece1709144596c9"}' ========= master_lag: 0.46 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 15:45:17.623029) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 15:45:17.623355) ========= 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.YxyPCOJLTh/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.gbvrO39Cis/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.005386 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 15:45:17.651222) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 15:45:17.651509) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 15:45:17.651813) ========= ========= Total master_lag: 3.22 =========