builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0163 starttime: 1491832744.26 results: success (0) buildid: 20170410045748 builduid: 62d43592062c4f1c916b99308730d2aa revision: 4f39d509a2e8d0173aa6bff8cf8ecd9d87fac7e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:04.256328) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:04.256838) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:04.257124) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:04.284294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:04.284610) ========= 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.WOav0JLAQy/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.weAFMh06wH/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-04-10 06:59:04-- 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% 204M=0s 2017-04-10 06:59:04 (204 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097092 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:04.406326) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:04.406756) ========= 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.WOav0JLAQy/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.weAFMh06wH/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.028522 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:04.457517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-10 06:59:04.457877) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4f39d509a2e8d0173aa6bff8cf8ecd9d87fac7e4 --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 4f39d509a2e8d0173aa6bff8cf8ecd9d87fac7e4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WOav0JLAQy/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.weAFMh06wH/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-04-10 06:59:04,561 truncating revision to first 12 chars 2017-04-10 06:59:04,561 Setting DEBUG logging. 2017-04-10 06:59:04,561 attempt 1/10 2017-04-10 06:59:04,561 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4f39d509a2e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 06:59:06,197 unpacking tar archive at: mozilla-beta-4f39d509a2e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.992189 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-10 06:59:06.474025) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:06.474350) ========= script_repo_revision: 4f39d509a2e8d0173aa6bff8cf8ecd9d87fac7e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:06.474763) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:06.475094) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:06.496429) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-04-10 06:59:06.496877) ========= /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.WOav0JLAQy/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.weAFMh06wH/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:59:06 INFO - MultiFileLogger online at 20170410 06:59:06 in /builds/slave/test 06:59:06 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 06:59:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:59:06 INFO - {'append_to_log': False, 06:59:06 INFO - 'base_work_dir': '/builds/slave/test', 06:59:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:59:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:59:06 INFO - 'branch': 'Mozilla-Beta', 06:59:06 INFO - 'buildbot_json_path': 'buildprops.json', 06:59:06 INFO - 'config_files': ('talos/mac_config.py',), 06:59:06 INFO - 'default_actions': ('clobber', 06:59:06 INFO - 'read-buildbot-config', 06:59:06 INFO - 'download-and-extract', 06:59:06 INFO - 'populate-webroot', 06:59:06 INFO - 'create-virtualenv', 06:59:06 INFO - 'install', 06:59:06 INFO - 'run-tests'), 06:59:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:59:06 INFO - 'download_minidump_stackwalk': True, 06:59:06 INFO - 'download_symbols': 'ondemand', 06:59:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:59:06 INFO - 'tooltool.py': '/tools/tooltool.py', 06:59:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:59:06 INFO - '/tools/misc-python/virtualenv.py')}, 06:59:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:59:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:59:06 INFO - 'installer_path': 'installer.exe', 06:59:06 INFO - 'log_level': 'info', 06:59:06 INFO - 'log_name': 'talos', 06:59:06 INFO - 'log_to_console': True, 06:59:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:59:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:59:06 INFO - 'opt_config_files': (), 06:59:06 INFO - 'pip_index': False, 06:59:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:59:06 INFO - 'cmd': ('bash', 06:59:06 INFO - '-c', 06:59:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:59:06 INFO - 'enabled': True, 06:59:06 INFO - 'halt_on_failure': False, 06:59:06 INFO - 'name': 'check_screen_resolution'},), 06:59:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:59:06 INFO - 'cmd': ('bash', 06:59:06 INFO - '-c', 06:59:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:59:06 INFO - 'enabled': True, 06:59:06 INFO - 'halt_on_failure': False, 06:59:06 INFO - 'name': 'check_screen_resolution'},), 06:59:06 INFO - 'run_cmd_checks_enabled': True, 06:59:06 INFO - 'sps_profile': False, 06:59:06 INFO - 'sps_profile_interval': 0, 06:59:06 INFO - 'suite': 'dromaeojs', 06:59:06 INFO - 'system_bits': '32', 06:59:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:59:06 INFO - 'title': 't-yosemite-r7-0163', 06:59:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:59:06 INFO - 'use_talos_json': True, 06:59:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:59:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:59:06 INFO - 'work_dir': 'build'} 06:59:06 INFO - [mozharness: 2017-04-10 13:59:06.714673Z] Running clobber step. 06:59:06 INFO - Running pre-action listener: _resource_record_pre_action 06:59:06 INFO - Running main action method: clobber 06:59:06 INFO - rmtree: /builds/slave/test/build 06:59:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:59:09 INFO - Running post-action listener: _resource_record_post_action 06:59:09 INFO - [mozharness: 2017-04-10 13:59:09.244148Z] Finished clobber step (success) 06:59:09 INFO - [mozharness: 2017-04-10 13:59:09.244456Z] Running read-buildbot-config step. 06:59:09 INFO - Running pre-action listener: _resource_record_pre_action 06:59:09 INFO - Running main action method: read_buildbot_config 06:59:09 INFO - Using buildbot properties: 06:59:09 INFO - { 06:59:09 INFO - "project": "", 06:59:09 INFO - "product": "firefox", 06:59:09 INFO - "script_repo_revision": "production", 06:59:09 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 06:59:09 INFO - "repository": "", 06:59:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 06:59:09 INFO - "buildid": "20170410045748", 06:59:09 INFO - "pgo_build": "False", 06:59:09 INFO - "basedir": "/builds/slave/test", 06:59:09 INFO - "buildnumber": 77, 06:59:09 INFO - "slavename": "t-yosemite-r7-0163", 06:59:09 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 06:59:09 INFO - "platform": "yosemite_r7", 06:59:09 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:59:09 INFO - "branch": "mozilla-beta", 06:59:09 INFO - "repo_path": "releases/mozilla-beta", 06:59:09 INFO - "revision": "4f39d509a2e8d0173aa6bff8cf8ecd9d87fac7e4", 06:59:09 INFO - "stage_platform": "macosx64", 06:59:09 INFO - "builduid": "62d43592062c4f1c916b99308730d2aa", 06:59:09 INFO - "slavebuilddir": "test" 06:59:09 INFO - } 06:59:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 06:59:09 INFO - Running post-action listener: _resource_record_post_action 06:59:09 INFO - [mozharness: 2017-04-10 13:59:09.250110Z] Finished read-buildbot-config step (success) 06:59:09 INFO - [mozharness: 2017-04-10 13:59:09.250281Z] Running download-and-extract step. 06:59:09 INFO - Running pre-action listener: _resource_record_pre_action 06:59:09 INFO - Running main action method: download_and_extract 06:59:09 INFO - mkdir: /builds/slave/test/build/tests 06:59:09 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')]} 06:59:09 INFO - trying https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 06:59:09 INFO - Downloading https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/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 06:59:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/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 06:59:09 INFO - Downloaded 1165 bytes. 06:59:09 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 06:59:09 INFO - Using the following test package requirements: 06:59:09 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 06:59:09 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:59:09 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 06:59:09 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:59:09 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 06:59:09 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:59:09 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:59:09 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 06:59:09 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 06:59:09 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:59:09 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 06:59:09 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:59:09 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 06:59:09 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:59:09 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 06:59:09 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:59:09 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 06:59:09 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 06:59:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 06:59:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 06:59:09 INFO - Fetch https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 06:59:10 INFO - Expected file size: 16116454 06:59:10 INFO - Obtained file size: 16116454 06:59:17 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 06:59:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 06:59:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 06:59:17 INFO - Fetch https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 06:59:18 INFO - Expected file size: 16116454 06:59:18 INFO - Obtained file size: 16116454 06:59:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 06:59:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 06:59:24 INFO - Fetch https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 06:59:25 INFO - Expected file size: 14403650 06:59:25 INFO - Obtained file size: 14403650 06:59:26 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')]} 06:59:26 INFO - trying https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 06:59:26 INFO - Downloading https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 06:59:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/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 06:59:27 INFO - Downloaded 58735592 bytes. 06:59:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 06:59:27 INFO - mkdir: /builds/slave/test/properties 06:59:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:59:27 INFO - Writing to file /builds/slave/test/properties/build_url 06:59:27 INFO - Contents: 06:59:27 INFO - build_url:https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 06:59:28 INFO - Running post-action listener: _resource_record_post_action 06:59:28 INFO - Running post-action listener: set_extra_try_arguments 06:59:28 INFO - [mozharness: 2017-04-10 13:59:28.448108Z] Finished download-and-extract step (success) 06:59:28 INFO - [mozharness: 2017-04-10 13:59:28.448240Z] Running populate-webroot step. 06:59:28 INFO - Running pre-action listener: _resource_record_pre_action 06:59:28 INFO - Running main action method: populate_webroot 06:59:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:59:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:59:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:59:28 INFO - '--tppagecycles', 06:59:28 INFO - '7'], 06:59:28 INFO - 'tests': ['tsvgm']}}, 06:59:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:59:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:59:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:59:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:59:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:59:28 INFO - 'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:59:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:59:28 INFO - 'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['damp', 'tps']}, 06:59:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:59:28 INFO - 'tests': ['damp', 'tps']}, 06:59:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['dromaeo_dom']}, 06:59:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:59:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['basic_compositor_video']}, 06:59:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:59:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['a11yr', 06:59:28 INFO - 'ts_paint', 06:59:28 INFO - 'tpaint', 06:59:28 INFO - 'sessionrestore', 06:59:28 INFO - 'sessionrestore_no_auto_restore', 06:59:28 INFO - 'tabpaint']}, 06:59:28 INFO - 'other-e10s': {'tests': ['a11yr', 06:59:28 INFO - 'ts_paint', 06:59:28 INFO - 'tpaint', 06:59:28 INFO - 'sessionrestore', 06:59:28 INFO - 'sessionrestore_no_auto_restore', 06:59:28 INFO - 'tabpaint']}, 06:59:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:59:28 INFO - 'ts_paint', 06:59:28 INFO - 'tpaint', 06:59:28 INFO - 'sessionrestore', 06:59:28 INFO - 'sessionrestore_no_auto_restore', 06:59:28 INFO - 'tabpaint']}, 06:59:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:59:28 INFO - 'ts_paint', 06:59:28 INFO - 'tpaint', 06:59:28 INFO - 'sessionrestore', 06:59:28 INFO - 'sessionrestore_no_auto_restore', 06:59:28 INFO - 'tabpaint']}, 06:59:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['a11yr', 06:59:28 INFO - 'ts_paint', 06:59:28 INFO - 'tpaint', 06:59:28 INFO - 'sessionrestore', 06:59:28 INFO - 'sessionrestore_no_auto_restore', 06:59:28 INFO - 'tabpaint']}, 06:59:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['a11yr', 06:59:28 INFO - 'ts_paint', 06:59:28 INFO - 'tpaint', 06:59:28 INFO - 'sessionrestore', 06:59:28 INFO - 'sessionrestore_no_auto_restore', 06:59:28 INFO - 'tabpaint']}, 06:59:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['tsvgx', 06:59:28 INFO - 'tsvgr_opacity', 06:59:28 INFO - 'tart', 06:59:28 INFO - 'tscrollx', 06:59:28 INFO - 'cart', 06:59:28 INFO - 'tsvg_static']}, 06:59:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:59:28 INFO - 'tsvgr_opacity', 06:59:28 INFO - 'tart', 06:59:28 INFO - 'tscrollx', 06:59:28 INFO - 'cart', 06:59:28 INFO - 'tsvg_static']}, 06:59:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:59:28 INFO - 'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['tp5o']}, 06:59:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:59:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:59:28 INFO - 'talos_options': ['--disable-e10s', 06:59:28 INFO - '--xperf_path', 06:59:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:28 INFO - 'tests': ['tp5n']}, 06:59:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:59:28 INFO - 'talos_options': ['--xperf_path', 06:59:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:28 INFO - 'tests': ['tp5n']}}, 06:59:28 INFO - 'talos.zip': {'path': '', 06:59:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:59:28 INFO - Running post-action listener: _resource_record_post_action 06:59:28 INFO - [mozharness: 2017-04-10 13:59:28.467234Z] Finished populate-webroot step (success) 06:59:28 INFO - [mozharness: 2017-04-10 13:59:28.467363Z] Running create-virtualenv step. 06:59:28 INFO - Running pre-action listener: _resource_record_pre_action 06:59:28 INFO - Running main action method: create_virtualenv 06:59:28 INFO - Creating virtualenv /builds/slave/test/build/venv 06:59:28 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 06:59:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:59:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:59:28 INFO - Using real prefix '/tools/python27' 06:59:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:59:29 INFO - Installing distribute.............................................................................................................................................................................................done. 06:59:32 INFO - Installing pip.................done. 06:59:32 INFO - Return code: 0 06:59:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:59:32 INFO - Reading from file tmpfile_stdout 06:59:32 INFO - Output received: 06:59:32 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) 06:59:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8057a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849d30>, '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 0x100770db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10083ebe8>, '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.WOav0JLAQy/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.weAFMh06wH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:59:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WOav0JLAQy/Render', 06:59:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:32 INFO - 'HOME': '/Users/cltbld', 06:59:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:32 INFO - 'LOGNAME': 'cltbld', 06:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:32 INFO - 'MOZ_NO_REMOTE': '1', 06:59:32 INFO - 'NO_EM_RESTART': '1', 06:59:32 INFO - 'PAGER': '/bin/cat', 06:59:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:32 INFO - 'PWD': '/builds/slave/test', 06:59:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:32 INFO - 'SHELL': '/bin/bash', 06:59:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weAFMh06wH/Listeners', 06:59:32 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:59:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:32 INFO - 'USER': 'cltbld', 06:59:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:32 INFO - 'XPC_FLAGS': '0x0', 06:59:32 INFO - 'XPC_SERVICE_NAME': '0', 06:59:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:32 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 06:59:32 INFO - Cleaning up... 06:59:32 INFO - Return code: 0 06:59:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100a6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8057a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849d30>, '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 0x100770db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10083ebe8>, '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.WOav0JLAQy/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.weAFMh06wH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:59:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WOav0JLAQy/Render', 06:59:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:32 INFO - 'HOME': '/Users/cltbld', 06:59:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:32 INFO - 'LOGNAME': 'cltbld', 06:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:32 INFO - 'MOZ_NO_REMOTE': '1', 06:59:32 INFO - 'NO_EM_RESTART': '1', 06:59:32 INFO - 'PAGER': '/bin/cat', 06:59:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:32 INFO - 'PWD': '/builds/slave/test', 06:59:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:32 INFO - 'SHELL': '/bin/bash', 06:59:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weAFMh06wH/Listeners', 06:59:32 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:59:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:32 INFO - 'USER': 'cltbld', 06:59:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:32 INFO - 'XPC_FLAGS': '0x0', 06:59:32 INFO - 'XPC_SERVICE_NAME': '0', 06:59:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:33 INFO - Downloading/unpacking psutil>=3.1.1 06:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:59:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:36 INFO - Installing collected packages: psutil 06:59:36 INFO - Running setup.py install for psutil 06:59:36 INFO - building 'psutil._psutil_osx' extension 06:59:36 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 06:59:37 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 06:59:37 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 06:59:37 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 06:59:37 INFO - building 'psutil._psutil_posix' extension 06:59:37 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 06:59:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:59:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:59:37 INFO - ^ 06:59:37 INFO - 1 warning generated. 06:59:37 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 06:59:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:37 INFO - Successfully installed psutil 06:59:37 INFO - Cleaning up... 06:59:37 INFO - Return code: 0 06:59:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8057a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849d30>, '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 0x100770db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10083ebe8>, '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.WOav0JLAQy/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.weAFMh06wH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:59:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WOav0JLAQy/Render', 06:59:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:37 INFO - 'HOME': '/Users/cltbld', 06:59:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:37 INFO - 'LOGNAME': 'cltbld', 06:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:37 INFO - 'MOZ_NO_REMOTE': '1', 06:59:37 INFO - 'NO_EM_RESTART': '1', 06:59:37 INFO - 'PAGER': '/bin/cat', 06:59:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:37 INFO - 'PWD': '/builds/slave/test', 06:59:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:37 INFO - 'SHELL': '/bin/bash', 06:59:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weAFMh06wH/Listeners', 06:59:37 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:59:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:37 INFO - 'USER': 'cltbld', 06:59:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:37 INFO - 'XPC_FLAGS': '0x0', 06:59:37 INFO - 'XPC_SERVICE_NAME': '0', 06:59:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:59:38 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 06:59:38 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 06:59:38 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 06:59:38 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 06:59:38 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 06:59:38 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 06:59:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:59:40 INFO - Installing collected packages: mozsystemmonitor 06:59:40 INFO - Running setup.py install for mozsystemmonitor 06:59:40 INFO - Successfully installed mozsystemmonitor 06:59:40 INFO - Cleaning up... 06:59:41 INFO - Return code: 0 06:59:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:41 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 0x100a6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8057a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849d30>, '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 0x100770db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10083ebe8>, '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.WOav0JLAQy/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.weAFMh06wH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:59:41 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 06:59:41 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 06:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WOav0JLAQy/Render', 06:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:41 INFO - 'HOME': '/Users/cltbld', 06:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:41 INFO - 'LOGNAME': 'cltbld', 06:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:41 INFO - 'MOZ_NO_REMOTE': '1', 06:59:41 INFO - 'NO_EM_RESTART': '1', 06:59:41 INFO - 'PAGER': '/bin/cat', 06:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:41 INFO - 'PWD': '/builds/slave/test', 06:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:41 INFO - 'SHELL': '/bin/bash', 06:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weAFMh06wH/Listeners', 06:59:41 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:41 INFO - 'USER': 'cltbld', 06:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:41 INFO - 'XPC_FLAGS': '0x0', 06:59:41 INFO - 'XPC_SERVICE_NAME': '0', 06:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:41 INFO - Downloading/unpacking jsonschema==2.5.1 06:59:41 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 06:59:41 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 06:59:41 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 06:59:41 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 06:59:41 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 06:59:41 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 06:59:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:59:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:59:43 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 06:59:43 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 06:59:43 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 06:59:43 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 06:59:43 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 06:59:43 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 06:59:44 INFO - Downloading functools32-3.2.3-2.tar.gz 06:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:59:44 INFO - warning: no files found matching '*.txt' 06:59:44 INFO - no previously-included directories found matching 'build' 06:59:44 INFO - no previously-included directories found matching 'dist' 06:59:44 INFO - no previously-included directories found matching '.git*' 06:59:44 INFO - Installing collected packages: jsonschema, functools32 06:59:44 INFO - Running setup.py install for functools32 06:59:44 INFO - warning: no files found matching '*.txt' 06:59:44 INFO - no previously-included directories found matching 'build' 06:59:44 INFO - no previously-included directories found matching 'dist' 06:59:44 INFO - no previously-included directories found matching '.git*' 06:59:44 INFO - Successfully installed jsonschema functools32 06:59:44 INFO - Cleaning up... 06:59:44 INFO - Return code: 0 06:59:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100a6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8057a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849d30>, '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 0x100770db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10083ebe8>, '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.WOav0JLAQy/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.weAFMh06wH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WOav0JLAQy/Render', 06:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:44 INFO - 'HOME': '/Users/cltbld', 06:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:44 INFO - 'LOGNAME': 'cltbld', 06:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:44 INFO - 'MOZ_NO_REMOTE': '1', 06:59:44 INFO - 'NO_EM_RESTART': '1', 06:59:44 INFO - 'PAGER': '/bin/cat', 06:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:44 INFO - 'PWD': '/builds/slave/test', 06:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:44 INFO - 'SHELL': '/bin/bash', 06:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weAFMh06wH/Listeners', 06:59:44 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:44 INFO - 'USER': 'cltbld', 06:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:44 INFO - 'XPC_FLAGS': '0x0', 06:59:44 INFO - 'XPC_SERVICE_NAME': '0', 06:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:59:45 INFO - Cleaning up... 06:59:45 INFO - Return code: 0 06:59:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:59:45 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')]} 06:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:45 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')]} 06:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:45 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 0x100a6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8057a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849d30>, '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 0x100770db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10083ebe8>, '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.WOav0JLAQy/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.weAFMh06wH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:59:45 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 06:59:45 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 06:59:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WOav0JLAQy/Render', 06:59:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:45 INFO - 'HOME': '/Users/cltbld', 06:59:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:45 INFO - 'LOGNAME': 'cltbld', 06:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:45 INFO - 'MOZ_NO_REMOTE': '1', 06:59:45 INFO - 'NO_EM_RESTART': '1', 06:59:45 INFO - 'PAGER': '/bin/cat', 06:59:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:45 INFO - 'PWD': '/builds/slave/test', 06:59:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:45 INFO - 'SHELL': '/bin/bash', 06:59:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weAFMh06wH/Listeners', 06:59:45 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:59:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:45 INFO - 'USER': 'cltbld', 06:59:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:45 INFO - 'XPC_FLAGS': '0x0', 06:59:45 INFO - 'XPC_SERVICE_NAME': '0', 06:59:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:45 INFO - Downloading/unpacking blobuploader==1.2.4 06:59:45 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 06:59:45 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 06:59:45 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 06:59:45 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 06:59:45 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 06:59:45 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 06:59:48 INFO - Downloading blobuploader-1.2.4.tar.gz 06:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:59:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:59:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59:49 INFO - Downloading docopt-0.6.1.tar.gz 06:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:59:49 INFO - Installing collected packages: blobuploader, requests, docopt 06:59:49 INFO - Running setup.py install for blobuploader 06:59:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:59:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:59:49 INFO - Running setup.py install for requests 06:59:50 INFO - Running setup.py install for docopt 06:59:50 INFO - Successfully installed blobuploader requests docopt 06:59:50 INFO - Cleaning up... 06:59:50 INFO - Return code: 0 06:59:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59:50 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')]} 06:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:50 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')]} 06:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:50 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 0x100a6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8057a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849d30>, '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 0x100770db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10083ebe8>, '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.WOav0JLAQy/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.weAFMh06wH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:59:50 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 06:59:50 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 06:59:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WOav0JLAQy/Render', 06:59:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:50 INFO - 'HOME': '/Users/cltbld', 06:59:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:50 INFO - 'LOGNAME': 'cltbld', 06:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:50 INFO - 'MOZ_NO_REMOTE': '1', 06:59:50 INFO - 'NO_EM_RESTART': '1', 06:59:50 INFO - 'PAGER': '/bin/cat', 06:59:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:50 INFO - 'PWD': '/builds/slave/test', 06:59:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:50 INFO - 'SHELL': '/bin/bash', 06:59:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weAFMh06wH/Listeners', 06:59:50 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:59:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:50 INFO - 'USER': 'cltbld', 06:59:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:50 INFO - 'XPC_FLAGS': '0x0', 06:59:50 INFO - 'XPC_SERVICE_NAME': '0', 06:59:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:59:50 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-rFoxHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:59:50 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-JRWvMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:59:50 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Sn8BAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:59:50 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-UgfYCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:59:51 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-T5zybL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:59:51 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-fxRJAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:59:51 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-DbnHmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:59:51 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-cmolBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:59:51 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-0kWC9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:59:51 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-KDXq6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:59:51 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-qSMWmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:59:51 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-xhnHIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:59:51 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-hV4MqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:59:51 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-EJEFER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-rzSHAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:59:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ERkaVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:59:52 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-m0Zm4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:59:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:59:52 INFO - Running setup.py install for manifestparser 06:59:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:59:52 INFO - Running setup.py install for mozcrash 06:59:52 INFO - Running setup.py install for mozdebug 06:59:52 INFO - Running setup.py install for mozdevice 06:59:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:59:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:59:52 INFO - Running setup.py install for mozfile 06:59:53 INFO - Running setup.py install for mozhttpd 06:59:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Running setup.py install for mozinfo 06:59:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Running setup.py install for mozInstall 06:59:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Running setup.py install for mozleak 06:59:53 INFO - Running setup.py install for mozlog 06:59:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Running setup.py install for moznetwork 06:59:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:59:54 INFO - Running setup.py install for mozprocess 06:59:54 INFO - Running setup.py install for mozprofile 06:59:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:59:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:59:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:59:54 INFO - Running setup.py install for mozrunner 06:59:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:59:54 INFO - Running setup.py install for mozscreenshot 06:59:54 INFO - Running setup.py install for moztest 06:59:54 INFO - Running setup.py install for mozversion 06:59:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:59:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:59:54 INFO - Cleaning up... 06:59:54 INFO - Return code: 0 06:59:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59:54 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')]} 06:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:54 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')]} 06:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:54 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 0x100a6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8057a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849d30>, '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 0x100770db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10083ebe8>, '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.WOav0JLAQy/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.weAFMh06wH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:59:54 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 06:59:54 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 06:59:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WOav0JLAQy/Render', 06:59:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:54 INFO - 'HOME': '/Users/cltbld', 06:59:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:54 INFO - 'LOGNAME': 'cltbld', 06:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:54 INFO - 'MOZ_NO_REMOTE': '1', 06:59:54 INFO - 'NO_EM_RESTART': '1', 06:59:54 INFO - 'PAGER': '/bin/cat', 06:59:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:54 INFO - 'PWD': '/builds/slave/test', 06:59:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:54 INFO - 'SHELL': '/bin/bash', 06:59:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weAFMh06wH/Listeners', 06:59:54 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:59:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:54 INFO - 'USER': 'cltbld', 06:59:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:54 INFO - 'XPC_FLAGS': '0x0', 06:59:54 INFO - 'XPC_SERVICE_NAME': '0', 06:59:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:59:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Mm47BW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:59:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-e7m33f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:59:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-xFi348-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:59:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-7_z3l6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:59:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-0YIoES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:59:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-NDXzWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:59:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ztZw3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:59:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-MvNukL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:59:56 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)) 06:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:59:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-1pMqhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:59:56 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)) 06:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:59:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-WknYxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:59:56 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)) 06:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:59:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Kutn0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:59:56 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)) 06:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:59:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-BpqPR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:59:56 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)) 06:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:59:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-8edlZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:59:56 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)) 06:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:59:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Yrth9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:59:56 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)) 06:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-V_CV_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:56 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)) 06:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:59:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-w3s85q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:59:56 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)) 06:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:59:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-HPT0Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:59:57 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)) 06:59:57 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)) 06:59:57 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)) 06:59:57 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)) 06:59:57 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)) 06:59:57 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)) 06:59:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59:59 INFO - Downloading blessings-1.6.tar.gz 06:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:59:59 INFO - Installing collected packages: blessings 06:59:59 INFO - Running setup.py install for blessings 07:00:00 INFO - Successfully installed blessings 07:00:00 INFO - Cleaning up... 07:00:00 INFO - Return code: 0 07:00:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:00 INFO - Reading from file tmpfile_stdout 07:00:00 INFO - Current package versions: 07:00:00 INFO - blessings == 1.6 07:00:00 INFO - blobuploader == 1.2.4 07:00:00 INFO - docopt == 0.6.1 07:00:00 INFO - functools32 == 3.2.3-2 07:00:00 INFO - jsonschema == 2.5.1 07:00:00 INFO - manifestparser == 1.1 07:00:00 INFO - mozInstall == 1.12 07:00:00 INFO - mozcrash == 1.0 07:00:00 INFO - mozdebug == 0.1 07:00:00 INFO - mozdevice == 0.49 07:00:00 INFO - mozfile == 1.2 07:00:00 INFO - mozhttpd == 0.7 07:00:00 INFO - mozinfo == 0.9 07:00:00 INFO - mozleak == 0.1 07:00:00 INFO - mozlog == 3.4 07:00:00 INFO - moznetwork == 0.27 07:00:00 INFO - mozprocess == 0.24 07:00:00 INFO - mozprofile == 0.28 07:00:00 INFO - mozrunner == 6.13 07:00:00 INFO - mozscreenshot == 0.1 07:00:00 INFO - mozsystemmonitor == 0.3 07:00:00 INFO - moztest == 0.8 07:00:00 INFO - mozversion == 1.4 07:00:00 INFO - psutil == 3.1.1 07:00:00 INFO - requests == 1.2.3 07:00:00 INFO - wsgiref == 0.1.2 07:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:01 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 0x100a6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8057a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849d30>, '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 0x100770db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10083ebe8>, '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.WOav0JLAQy/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.weAFMh06wH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 07:00:01 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 07:00:01 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 07:00:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WOav0JLAQy/Render', 07:00:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:01 INFO - 'HOME': '/Users/cltbld', 07:00:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:01 INFO - 'LOGNAME': 'cltbld', 07:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:01 INFO - 'MOZ_NO_REMOTE': '1', 07:00:01 INFO - 'NO_EM_RESTART': '1', 07:00:01 INFO - 'PAGER': '/bin/cat', 07:00:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:01 INFO - 'PWD': '/builds/slave/test', 07:00:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:01 INFO - 'SHELL': '/bin/bash', 07:00:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weAFMh06wH/Listeners', 07:00:01 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:00:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:01 INFO - 'USER': 'cltbld', 07:00:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:01 INFO - 'XPC_FLAGS': '0x0', 07:00:01 INFO - 'XPC_SERVICE_NAME': '0', 07:00:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:01 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)) 07:00:01 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)) 07:00:01 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)) 07:00:01 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)) 07:00:01 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)) 07:00:01 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)) 07:00:01 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)) 07:00:01 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)) 07:00:01 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)) 07:00:01 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)) 07:00:01 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)) 07:00:01 INFO - Cleaning up... 07:00:01 INFO - Return code: 0 07:00:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:01 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 0x100a6bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a6e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8057a980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100849d30>, '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 0x100770db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10083ebe8>, '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.WOav0JLAQy/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.weAFMh06wH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 07:00:01 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 07:00:01 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 07:00:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WOav0JLAQy/Render', 07:00:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:01 INFO - 'HOME': '/Users/cltbld', 07:00:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:01 INFO - 'LOGNAME': 'cltbld', 07:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:01 INFO - 'MOZ_NO_REMOTE': '1', 07:00:01 INFO - 'NO_EM_RESTART': '1', 07:00:01 INFO - 'PAGER': '/bin/cat', 07:00:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:01 INFO - 'PWD': '/builds/slave/test', 07:00:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:01 INFO - 'SHELL': '/bin/bash', 07:00:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weAFMh06wH/Listeners', 07:00:01 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:00:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:01 INFO - 'USER': 'cltbld', 07:00:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:01 INFO - 'XPC_FLAGS': '0x0', 07:00:01 INFO - 'XPC_SERVICE_NAME': '0', 07:00:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:00:02 INFO - Cleaning up... 07:00:02 INFO - Return code: 0 07:00:02 INFO - Running post-action listener: _resource_record_post_action 07:00:02 INFO - Running post-action listener: _start_resource_monitoring 07:00:02 INFO - Starting resource monitoring. 07:00:02 INFO - [mozharness: 2017-04-10 14:00:02.060982Z] Finished create-virtualenv step (success) 07:00:02 INFO - [mozharness: 2017-04-10 14:00:02.061981Z] Running install step. 07:00:02 INFO - Running pre-action listener: _resource_record_pre_action 07:00:02 INFO - Running main action method: install 07:00:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:02 INFO - Reading from file tmpfile_stdout 07:00:02 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:00:02 INFO - Reading from file tmpfile_stdout 07:00:02 INFO - Output received: 07:00:02 INFO - Usage: mozinstall [options] installer 07:00:02 INFO - Options: 07:00:02 INFO - -h, --help show this help message and exit 07:00:02 INFO - -d DEST, --destination=DEST 07:00:02 INFO - Directory to install application into. [default: 07:00:02 INFO - "/builds/slave/test"] 07:00:02 INFO - --app=APP Application being installed. [default: firefox] 07:00:02 INFO - mkdir: /builds/slave/test/build/application 07:00:02 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'] 07:00:02 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 07:00:17 INFO - Reading from file tmpfile_stdout 07:00:17 INFO - Output received: 07:00:17 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:00:17 INFO - Running post-action listener: _resource_record_post_action 07:00:17 INFO - [mozharness: 2017-04-10 14:00:17.224900Z] Finished install step (success) 07:00:17 INFO - [mozharness: 2017-04-10 14:00:17.225035Z] Running run-tests step. 07:00:17 INFO - Running pre-action listener: _resource_record_pre_action 07:00:17 INFO - Running main action method: run_tests 07:00:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:00:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:00:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:00:17 INFO - 2017-04-10 07:00:17.239 screenresolution[1626:7244] starting screenresolution argv=screenresolution get 07:00:17 INFO - 2017-04-10 07:00:17.242 screenresolution[1626:7244] Display 0: 1600x1200x32@60 07:00:17 INFO - 2017-04-10 07:00:17.248 screenresolution[1627:7246] starting screenresolution argv=screenresolution list 07:00:17 INFO - Available Modes on Display 0 07:00:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:00:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:00:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:00:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:00:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:00:17 INFO - Intel Iris: 07:00:17 INFO - Chipset Model: Intel Iris 07:00:17 INFO - Type: GPU 07:00:17 INFO - Bus: Built-In 07:00:17 INFO - VRAM (Dynamic, Max): 1536 MB 07:00:17 INFO - Vendor: Intel (0x8086) 07:00:17 INFO - Device ID: 0x0a2e 07:00:17 INFO - Revision ID: 0x0009 07:00:17 INFO - Displays: 07:00:17 INFO - Display: 07:00:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:00:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:00:17 INFO - Display Serial Number: 1600x1200 60 07:00:17 INFO - Main Display: Yes 07:00:17 INFO - Mirror: Off 07:00:17 INFO - Online: Yes 07:00:17 INFO - Rotation: Supported 07:00:17 INFO - Return code: 0 07:00:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:00:17 INFO - Python 2.7.3 07:00:17 INFO - Return code: 0 07:00:17 INFO - grabbing minidump binary from tooltool 07:00:17 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')]} 07:00:17 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 0x100849d30>, '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 0x100770db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10083ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:00:17 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 07:00:17 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 07:00:17 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 07:00:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:00:17 INFO - Return code: 0 07:00:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:00:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:00:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:00:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:00:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:00:17 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/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 07:00:17 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/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --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 07:00:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WOav0JLAQy/Render', 07:00:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:17 INFO - 'HOME': '/Users/cltbld', 07:00:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:17 INFO - 'LOGNAME': 'cltbld', 07:00:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:00:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:17 INFO - 'MOZ_NO_REMOTE': '1', 07:00:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:00:17 INFO - 'NO_EM_RESTART': '1', 07:00:17 INFO - 'PAGER': '/bin/cat', 07:00:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:17 INFO - 'PWD': '/builds/slave/test', 07:00:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:00:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:17 INFO - 'SHELL': '/bin/bash', 07:00:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weAFMh06wH/Listeners', 07:00:17 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 07:00:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:17 INFO - 'USER': 'cltbld', 07:00:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:17 INFO - 'XPC_FLAGS': '0x0', 07:00:17 INFO - 'XPC_SERVICE_NAME': '0', 07:00:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:17 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/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 07:00:17 INFO - mozversion application_buildid: 20170410045748 07:00:17 INFO - mozversion application_changeset: 4f39d509a2e8d0173aa6bff8cf8ecd9d87fac7e4 07:00:17 INFO - mozversion application_display_name: Firefox 07:00:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:00:17 INFO - mozversion application_name: Firefox 07:00:17 INFO - mozversion application_remotingname: firefox 07:00:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:00:17 INFO - mozversion application_vendor: Mozilla 07:00:17 INFO - mozversion application_version: 53.0 07:00:17 INFO - mozversion platform_buildid: 20170410045748 07:00:17 INFO - mozversion platform_changeset: 4f39d509a2e8d0173aa6bff8cf8ecd9d87fac7e4 07:00:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:00:17 INFO - mozversion platform_version: 53.0 07:00:17 INFO - using testdate: 1491832817 07:00:17 INFO - actual date: 1491832817 07:00:17 INFO - starting webserver on 'localhost:49243' 07:00:17 INFO - SUITE-START | Running 2 tests 07:00:17 INFO - TEST-START | dromaeo_css 07:00:17 INFO - operating with platform_type : mac_ 07:00:17 INFO - Initialising browser for dromaeo_css test... 07:00:17 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpCBkOhL/profile http://localhost:49243/getInfo.html) 07:00:20 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 07:00:20 INFO - PROCESS | 1637 | colorDepth:24 07:00:20 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 07:00:20 INFO - PROCESS | 1637 | __metrics 07:00:20 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:00:20 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:00:20 INFO - TEST-INFO | 1637: exit 0 07:00:20 INFO - Browser initialized. 07:00:20 INFO - Running cycle 1/1 for dromaeo_css test... 07:00:21 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpCBkOhL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:32 INFO - PROCESS | 1640 | RSS: Main: 163598336 07:00:32 INFO - PROCESS | 1640 | 07:03:36 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 07:03:38 INFO - PROCESS | 1640 | RSS: Main: 329547776 07:03:38 INFO - PROCESS | 1640 | 07:06:41 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 07:06:41 INFO - PROCESS | 1640 | RSS: Main: 305856512 07:06:41 INFO - PROCESS | 1640 | 07:09:44 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 07:09:44 INFO - PROCESS | 1640 | RSS: Main: 303304704 07:09:44 INFO - PROCESS | 1640 | 07:12:47 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 07:12:47 INFO - PROCESS | 1640 | RSS: Main: 290197504 07:12:47 INFO - PROCESS | 1640 | 07:15:51 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 07:15:51 INFO - PROCESS | 1640 | RSS: Main: 269410304 07:15:51 INFO - PROCESS | 1640 | 07:18:54 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 07:18:55 INFO - PROCESS | 1640 | RSS: Main: 320360448 07:18:55 INFO - PROCESS | 1640 | 07:18:55 INFO - PROCESS | 1640 | __start_tp_report 07:18:55 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 07:18:55 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 07:18:55 INFO - PROCESS | 1640 | |i|pagename|runs| 07:18:55 INFO - PROCESS | 1640 | |0;dojo.html;3425.5204271402004;3467.809270490122;3482.181687303483;3497.5977762557313;3537.292541491702;4849.36958195435;5837;5866.384029676881;5878.412158784119;5882.176495290662;5809.9709501452535;5901.822945311647;5906;5926.140709597106;5928.6739229342365;5244.711540865261;5291.365036195662;5296.92054619181;5336.519713225809;5342.572594192475;4141.7100802943805;4757.024809913976;5259.973700131494;5394.514493695567;5401.972990135044;4704.20028595138;5107.821226257081;5363.892722145555;5365.114756065244;5378.704171270579;5354.812581559646;5359.08895487768;5365.570754339683;5372.247885296042;5376.973115134439;5217.686938783647;5311.389190243133;5313.654612450178;5317.521423071942;5337.4662533746705;6003.7898673546215;6005.099235114724;6006.279246490449;6012.248468941382;6014.548908831812;6190.84522886927;6230.501559875199;6245.968770156165;6247.781327653511;6282.465990390822;6296.433321001132;6317.4946004319545;6320.494360451153;6322.841928951813;6326.968365158191;5943.851403714942;5964.105384192362;5980;5997.340292567814;6003.399660034005;6266.091416744546;6309.558330916791;6324.652144132025;6377.266614339317;6435.131257280301;6242.469390101802;6267.9373206268265;6283.183186185858;6290.056491526216;6296.496280297565;6309.432151106423;6310.274318453345;6314.968425157845;6331.018692102732;6344.175257216624;5892.086726557391;6151.446369826737;6209.348018458088;6234.9688251559355;6269.310375858652;6240.063990401385;6263.71813268404;6273.7176827042895;6289.654069026247;6294.716737746812;5140.665856719302;5145.15105007677;5147.536721695065;5152.793888244503;5167.302414174113;4479.3057076153245;4506.278995360726;4533.977330113328;4547.954520454753;4583.472900616405;4986.700797952134;5975.701214939322;6024.8795024100145;6048.727807248684;6106.511479081662;6268.701227695232;6288;6320.273168585672;6330.493560515148;6346.777862774781;5885.588008839426;5948.851278718067;6050.455459008623;6059.333473317932;6065.848353791102;5472.753726082336;5546.584006199551;5579.776808927679;5585.720713964285;5587.860303492445;5452.591055670761;6523.608583484816;6525.575837570543;6537.215534135934;6545.476361890942;6282.591631543935;6288.937110629018;6292.27638821523;6293.150424692608;6323.114763933145;6335.3981371769605;6363.745450181941;6465.77369792055;6466.644334561456;6529.67351632407;6250.531210159165;6288.213973253343;6292.811215663537;6297.275813281532;6315.5263355247625;6207.16203312547;6326.367363263636;6332.683365831598;6333.619982801047;6346.238451385863;6132.110769107885;6178.505719542516;6298.905516417349;6320.241571011508;6322.462590679844;6187.597806142587;6205.379462053758;6210.161628180319;6265.686715664107;6303.369663033844;6204.689765511796;6211.81364559064;6217.689115544295;6233.501319894488;6233.96883015582;6250.156228909039;6272.5922815016875;6304.621722696653;6319;6329.019002054689;6066.666333351708;6119.296280927751;6120.081987701702;6152.569320147726;6155.938440615716 07:18:55 INFO - PROCESS | 1640 | |1;ext.html;470.76697034967674;473.5832467428663;500.4570041504967;536.0030343560977;546.9206964990077;32777.836110819444;41513.37729934054;43188;43241.13517729643;43349.34975975355;45168.54831451685;45608.771956140255;45638.31542526865;45731.77134114325;45750.313745293846;9609.23126149908;9819.116279534841;9828.754281142992;9837.90162098377;9839.114479696826;9081.636734530644;9294.907050929472;9577.80844383112;11717.296962182254;11993.280403175793;10763.031327180552;11340.60307889224;11831.704207394798;11913.344766037864;11940.462679179414;11853.585124520643;11913.702157446047;11924.165308428413;11926.821097683542;11958.7608247835;11672.649820505398;11810.232334898204;11906.464209110523;11945.044396448264;11958;41366.586334136875;41539.1692166158;41648.58351416478;41667.7916610418;41732;3985.561588225293;4043;4052.250333688277;4058.898527536806;4060.8984775380554;30655;31402.528962065586;31634.36731265385;32528;32693.50959735606;3189;3218.0828463887915;3244.1727359523406;3255.6744325567493;3463.688268055887;497416;498912.5054374741;499091;499249;500090;67419.94350423738;67554;67661;67759.3224067763;67821.98267025998;70749;70807.64596177089;70924;70978.2902170982;71044;17281.740773888152;17412.47762567125;17626.823731762517;17637.559061023578;17647.823521764618;13334.933325333312;13397.464101436028;13444.798328025088;13460.057795954384;13467.730645387233;16176.514704558882;16547.007179569024;16578.6684266314;18132.456026319232;18227.997460139555;6352.7141278642575;6375.649339286291;6785.1518560179975;7743.419243556756;7848.0974687910475;859.2696208223085;863.9093393986442;875.7941883657336;880.4453194487432;898.1916275352236;27653.861730691217;30987.14077155378;31097.53353699696;31311.37377252442;31768.523472147936;1064.7284942339654;1064.755106325534;1107.307932542161;1110.2228440091806;1122.6126986189915;16312.429064982669;16452;16460.012399256084;16491;16768.993860368417;641937;644951;645448;645830;646746;56773;57568.71215643895;57655;60313.39686603165;64968;1332;1355.356205802236;1426.664733787559;1445.04626946215;1473.7052589481932;26371;31272.530912036793;32439.351212975136;32616.34767304688;32909.61436925322;53736.462635373144;54238.91522169614;54281;54355.91288174294;54461.91076178534;529843;533220;534215;535165;535576;30590;36480.81759591185;38386.42420363753;42690.359644605975;43070.56929430791;45645.77177114226;49157.75421122871;49324;49902;50834;33266.334673305915;33315;33607.495887561214;33640.49539256962;34866.65133348634;29461.26346841346;31606.367872641957;32064.679353207102;33560.83219583886;34730.305393891475;36320;37659;39519.81440556788;40102.59897400989;40635.98410039773;33255.833720831244;33707.49438758371;33841.153971149935;34722;34777.13057173591;25918.870405647853;25928.8703556481;26078.86960565261;26082.60876086822;27049 07:18:55 INFO - PROCESS | 1640 | |2;jquery.html;397.2591117565739;404.68636806474996;404.82794812204816;411.53291014698306;427.5766990679227;20545.486362840937;21608.56782864342;22024.449388765268;22303;22554.54890902181;18774.62450750984;22288.888555557198;22521.09915603378;23094.72978986155;23189.420264493398;5811.6803575803315;5993.670348130851;6125.540584456161;6127.540434467411;6150.66171360575;5450.972745136269;5709.172170035343;5915.201447804556;5970.910436343458;5977.760889564434;5253.79162792558;5484.725763711818;5906.084556893688;5915.142304365864;5916.408359164071;5686.402927692595;5884.882302353951;5948.553858460633;5950.285965684124;5954.702264886781;5108.6168537359845;5163.225516172567;5239.633225674204;5249.685018898878;5264.31563896691;26802.927882884855;27318;27332.59001114985;27433.765480553422;27739.167824965283;2518.382996165951;2722.1425251045857;2741.7943654226015;2753.6695596528543;2818.0982085732576;9058.954705226432;10373.688789336333;10723.302985306009;10904.945475272572;11015.173861960386;1850.8519318454491;1922.3848368522079;1925.2876435718733;1926.6435709393807;1960.9117589708496;101561;116021;118531;120579.19131212951;138005.85982420543;9858.901410985942;11628.592999244986;11875.88124118765;11886.940565297118;11901.285922844658;15204.847951520564;16411.261493232832;16641.91679041597;16758;16773.32906683719;7685.692572297157;8492.447990880573;9334.673286434941;9339.766505837408;9476.573554190078;8555.957220213859;8797.516136612549;8816.250618697482;8826.161514656098;9144.679936202201;4123.8969025774595;4998.550130488274;5003.949960500421;5015.82444614444;5098.872528186825;1896.2225487550038;2061.7835127311714;2086.6661334186456;2098.5173410115453;2104.7789982051972;984.837501812193;999.6701088640731;1039.111559616532;1040.4641609571077;1080.1250986700798;21645.35063948084;22724.545509089727;22769.772302277095;22781.860906954586;22885.771142288697;1014.3558840136567;1017.4861694844204;1042.723678225271;1042.801867645145;1042.9165666746642;9150.588223529958;10889.074428673493;11917.523299068114;11938.22401543897;11955.701107472383;761815;763564;772605;778586;795680;139697.30151349178;143871;156416;165642;167491.1625441865;1032.3238278927315;1033.5245786937942;1059.6344261229863;1060.3107979813183;1067.631667074858;15891.761623575425;18661.720074198627;20015.899920500306;20062.29781957683;20062.79937200609;45697;53744;60499;61435.69282153561;61979.690101549204;64755;87328.56335718535;88129.55935220284;88828.34877106555;89581;6843;8425.241728244488;8662;8749.125087491455;8774.254188393803;11678.824817627912;13027.348632568523;13048.347582621022;13300.334983250605;13305.068645194744;9272.6290948364;10889.074428673652;11388.94305528467;11675.416229188677;11679.824802627798;10570.630027949292;10634.255602107778;10648.680539583826;11019.504122314675;11052.171087168334;9723.46520941355;11467;11859.229150105215;11934.820977685167;11948.462319195483;8428.747137585882;8610.311175105851;8733.475991440533;8786.736397908073;8920.687775927812;8571.614277357408;10772.946135269274;11408.201425900439;11601.767964640829;11871.287722736663 07:18:55 INFO - PROCESS | 1640 | |3;mootools.html;1395.7836535337015;1482.125545927903;1507.0204367161346;1513.6594266290085;1516.196415899573;7745.380369570435;8141.267285944264;8425.873611895826;8573.485590864553;8674.828898098755;8554.016288126868;8575.185357391054;8626.525541095238;8646.005709343428;8647.351448641346;2375.3705268103968;2410.144398738449;2418.1657328221736;2419.0565679385054;2424.260600516842;2149.258505815491;2238.6194346961056;2373.6083546214854;2439.256026911791;2449.632555116729;2384.3800611840875;2393.700787401575;2394.8084153267696;2395.281415575329;2396.6405039244078;2313.4332088638225;2334.8248881333798;2334.9299521014395;2340.3914982104607;2343.7304709958403;2281.0533628544135;2309.515001849614;2333.4749681321737;2334.2763743239652;2381.2856143156982;8554.35842311829;8628.568571571459;8645.049044605088;8656.09111043344;8657.826843463095;5261.1319132343115;5413.242146099549;5424;5426.728663566806;5439.48324909133;2814.7044560321283;2903.129061281607;3390;3563.4120370138894;3601.2797440512004;1209.9455524501418;1253.8871501564904;1282.1025282302332;1292.7802273613509;1300.4473098932915;10695.251332406735;10992.065674417685;11050.060744836699;11096.833547496793;11117.277376970553;4560.042391097841;4636.907261854744;4685.531446855355;4690.15577196108;4695.201815691341;8943.5975381108;8954.2836573074;8961.731148065568;8966.282697384193;8986.55067246635;4921.630877684188;5298.443663415286;5301.840944771663;5302.628815982921;5308.575313974873;4953.25701144824;4958.380202474691;4962.5533701967;4967.726775027409;4968.6025117990475;3531.717462603037;3661.3043521730788;3755.1550901047044;3844.7116466265143;3870.4968354113785;1171.6367925942984;1171.812509998396;1176.1649229047473;1185.2829038431626;1187.7861984842812;956.5599824080862;960.9567569459391;965.7971825916495;982.4301904895144;999.3803841618243;5744.454276843693;5751.482366587027;5786.768529258867;5883;5932.7033648318275;806.8184658451919;1007.49882674814;1043.6242952537082;1059.592057058038;1107.5182295701395;3949.8420063197723;3965.167314863911;3965.8413663453716;4031.294523458383;4097.242010228118;10127.341722787995;10393.16854651626;10512.947435262775;10519.684409467729;10520.579176832995;10081.546330415149;10184.541695623566;10447.216458765623;10450.68647940563;10462.006109419744;7807.921920780719;8053.15441878606;8229.300509456643;8239.917600824036;8256.958715206385;5910.202122713378;5956.642601443928;6039.396060393926;6134.355892631388;6239.1577137087725;7726.845463090819;9494.192993595345;9508.524573771421;9620.95189524076;9703.514824258618;9202.769930751785;9492.05079492073;9606;9809.215262779104;9835.60657573689;6546.8363290918105;7343.8531229376185;7403.888941665771;7436.96281518589;7569.1673915870315;7349;7592.658330375257;7593.772186834404;7874.251946065115;8019.478733882279;6118.724657390339;7046.506744527834;7073.752418665322;7081.398081163159;7140.500164988401;6832.897506537306;6966.407855332353;7025.437964962893;7052.9647351762915;7130.322619351154;6489.675516224264;6540.607563546202;6594.90107648376;6607.603543787388;6612.933870661232;4915.852524424273;5083.745812709423;5154.14956532183;5177.637565370388;5321.5476684482255;5120.590352771844;5161.66449180802;5174.068667639711;5216.878371150221;5263.315768950165 07:18:55 INFO - PROCESS | 1640 | |4;prototype.html;362.2194171560288;367.1885133854182;370.97959612221337;382.6364953294371;383.4918732679199;4149.626533611974;4495.86512404628;5316.813911513098;5386.434424385437;5408.486193811586;4440.555944405558;5069.898602027966;5188.351456067991;5195.908859139576;5342.412334643186;4150.501939767217;4182.330827067677;4206.221848957937;4217.493900731901;4224.493060832704;3515.859365625372;3871.4192871069286;4187.7176938568555;4214.262504061792;4215.515215750182;3141.879231518727;3987.342088555399;4000.379941109118;4035.59644035597;4174.603412675791;3320.966790332114;4000.8399664013696;4011.3180759270995;4020.517537895457;4038.547042278868;3486.860525578974;3497.2306092659574;3498.8425520851624;3517.595476520182;3518.894433167009;5000.549950504435;5123.487651234884;5188.169892817131;5193.117170081057;5197.570668066274;4565.383673204141;4624.745638989854;4634.513376095495;4634.728982798438;4676.672632915697;4652.55800698933;5495.313085864267;5565.666060036411;5579.302587176603;5595.580331475156;3305.7190138838228;3431.107911942913;3886.3393223152134;3888.844446222148;3940.310445671996;5761.9135712964335;5891.882162356772;5968.940310596882;5987.580869339148;6038.637681739066;3940.7438516496336;3971.781552014667;3979.900502487403;3982.542007669097;3982.880513584597;3693.171879919457;3735.7198210134347;4042.9892526868284;4058.7564746115327;4065.207284579538;4260.701750877409;4585.721209335341;4592.425946756655;4635.3278774578175;4643.628509719214;5395.3525576931015;5659.773609055674;5677.318721753416;5682.460166284196;5693.373728889819;1179.339569840892;1247.8502579690496;1263.6335462715892;1270.434656577814;1292.5992942187952;761.3186198352554;835.7805504623543;837.2715737308581;839.995800020996;857.7905153733207;4278.07486631011;4790.664653474293;4910.950890491121;4913.616895805531;4942.184539551005;4692.976535117303;5440.347158341025;5443.652153925307;5471.917921231185;5488.862778430571;4108.979455102705;4682.0881059457715;4883.804647814048;4930.5069493050405;4954.844642580489;2406.4344878953434;2823.7035111313426;2828.660560732725;2841.957370639442;2844.5306524423654;4996.752760153913;5001.974595207974;5140.408852981955;5273.235380869753;5364.758585863646;4583.702059366131;5141.76862041209;5452;5485.61600687948;5559.471850174227;4989.5758860496535;5372.892542149213;5561.416051314634;5602.543338731877;5614.129809879475;4768.976155119341;4842.7820748065715;5312.335958005249;5371.060064488621;5429.511343979061;4631.791569379318;4913.680610760289;5341.839744807662;5372.5701943843615;5409.323834520685;5566.805161819317;5573.526250268773;5579.8884022320135;5597.944020559742;5606.775728970795;3541.2386336937684;3584.084535503182;3656.542932133483;3682.834272457799;3686.631336866292;4862.489438608895;4908.601048701103;5171.45699701541;5206.927912531624;5345.022341733584;4549.294859296814;5217.991073436679;5243.5542978847225;5250;5284.128118860345;4209.34755112958;4640.445450774028;4845.442774080885;4913.560507644592;5195.3246078009615;4855.393075865517;5255.290535777621;5441.809806449091;5542.251796007487;5560.638558493847;5277.102892508359;5537.179346251074;5539.612227144061;5565.443455654402;5576.972115139399;4910.263460480956;5213.530782229466;5515.200295957144;5545.833624991256;5625.296837895263 07:18:55 INFO - PROCESS | 1640 | |5;yui.html;713.2072472981569;739.3863093632285;767.1024900865987;847.2205570874795;870.212457725758;13687.384067716965;15465;15839.287232074556;16136.757948630751;16178.433754818554;14210.573682789533;14670.779938300933;14692.853071469282;14763.483278085268;14851.331690073946;702.7891632510252;724.1889084225675;877.2105105405138;890.1276748786194;894.4454438248296;641.9582727122745;853.8164294676643;882.7307671160294;887.7558671365362;889.4352086425134;903.8373092843285;929.4980710416366;936.4615346175942;945.42801605029;949.2168960607491;901.9594118264661;925.3938670171015;941.1717688434134;942.6323733743845;942.6606421688186;697.9302069793031;697.9879175195986;698.0018573439979;698.5983059740619;699.3286445012794;15254.161021143833;15430;15654.373825046985;15970.600734981603;16217.594560135973;14617.269136543131;14879.404823807035;14945.103293802407;14969.326380312803;15215.61960950974;11546.134039947037;11567.884321156766;11761.588344407905;11806.704832379259;12168;4585.36681944624;4601.378813860119;4639.350490931272;4650.372199753024;4714.151452738506;97116.51441742817;100671.48992765041;102067.48966255196;103059;103319;10984.615538456115;11067.944660276647;11164.665060048212;11180.38507882058;11692.356920369291;21533.24633637815;21555.56888862214;21567.13731450756;22136.66794998076;22182.55634887293;7774.455788094892;7883.369330453665;7898.01274840645;7937.007874015748;8019.35845132388;4403.097365040159;4415.116976604692;4516.525764794715;4568.543145685471;4637.1653102441205;3565.2691198304287;3666.6150054244454;3667.064898450878;3922.86269980555;4152.37714342851;740.3965767899145;743.4015617427914;755.2145768400911;755.7090520149782;770.5453782268488;553.4299671338528;575.9971200143973;578.7019684862299;587.2981786764775;597.3518732175552;9471.857922131174;10340.172786177087;10531.420771857622;10634.574617015232;10931.726706832234;687.9002544631;710.1159056974101;718.4324383736789;723.3345322303494;725.4849057169469;4756.265147540178;4954.6437358649855;5422.40353561108;5549.500544950974;5799.9130013049835;88423.55788221018;106383.46808266063;107802.9219707793;108059.45970270099;115024.84975150309;86349.13650863411;92290.53854730817;97893;99613.50193248987;100910;82171.17828821755;83454.23730508209;84613.57693211494;85726;87190.99999999873;10904.34573925567;11046.558137674403;11179.508038154521;11275.379854108103;11295.830562541732;53096.73451632717;53818.19272710834;54057.91884162216;54970.62573435536;56414;48247.75876120597;73466.63266683846;75505.24494754981;76352.23647763673;77696;11110.666679999613;13536.255505947267;13703.383347749575;13824.930875345559;13849.238291894042;14667.071211495773;14858.331375087932;15150.3182356792;15293.847061529243;15624.140672263135;13922.791158132839;14064.578062658136;14409.495667651581;14416.351264192926;14441.927790360982;13785.241811700453;13964.623619906206;14027.438902443788;14052.578422647337;14204.431822726976;13628.795568066686;13978.44086236539;14098.577042688736;14190.92904535512;14695.92652036733;9575.425474471554;10094.19246460296;10174.03346682064;10378.273520853469;10534.893836147094;10944.398058106563;11175.72060698489;11343;11364.829527557258;11420.257683250562 07:18:55 INFO - PROCESS | 1640 | __end_tp_report 07:18:55 INFO - PROCESS | 1640 | __start_cc_report 07:18:55 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1552 07:18:55 INFO - PROCESS | 1640 | __end_cc_report 07:18:55 INFO - PROCESS | 1640 | __startTimestamp1491833935209__endTimestamp 07:18:55 INFO - PROCESS | 1640 | 07:18:55 INFO - PROCESS | 1640 | ------- Summary: start ------- 07:18:55 INFO - PROCESS | 1640 | Number of tests: 6 07:18:55 INFO - PROCESS | 1640 | 07:18:55 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5855.52 Median:6152.57 stddev:660.61 (10.7%) stddev-sans-first:634.54 07:18:55 INFO - PROCESS | 1640 | Values: 3425.5 3467.8 3482.2 3497.6 3537.3 4849.4 5837.0 5866.4 5878.4 5882.2 5810.0 5901.8 5906.0 5926.1 5928.7 5244.7 5291.4 5296.9 5336.5 5342.6 4141.7 4757.0 5260.0 5394.5 5402.0 4704.2 5107.8 5363.9 5365.1 5378.7 5354.8 5359.1 5365.6 5372.2 5377.0 5217.7 5311.4 5313.7 5317.5 5337.5 6003.8 6005.1 6006.3 6012.2 6014.5 6190.8 6230.5 6246.0 6247.8 6282.5 6296.4 6317.5 6320.5 6322.8 6327.0 5943.9 5964.1 5980.0 5997.3 6003.4 6266.1 6309.6 6324.7 6377.3 6435.1 6242.5 6267.9 6283.2 6290.1 6296.5 6309.4 6310.3 6315.0 6331.0 6344.2 5892.1 6151.4 6209.3 6235.0 6269.3 6240.1 6263.7 6273.7 6289.7 6294.7 5140.7 5145.2 5147.5 5152.8 5167.3 4479.3 4506.3 4534.0 4548.0 4583.5 4986.7 5975.7 6024.9 6048.7 6106.5 6268.7 6288.0 6320.3 6330.5 6346.8 5885.6 5948.9 6050.5 6059.3 6065.8 5472.8 5546.6 5579.8 5585.7 5587.9 5452.6 6523.6 6525.6 6537.2 6545.5 6282.6 6288.9 6292.3 6293.2 6323.1 6335.4 6363.7 6465.8 6466.6 6529.7 6250.5 6288.2 6292.8 6297.3 6315.5 6207.2 6326.4 6332.7 6333.6 6346.2 6132.1 6178.5 6298.9 6320.2 6322.5 6187.6 6205.4 6210.2 6265.7 6303.4 6204.7 6211.8 6217.7 6233.5 6234.0 6250.2 6272.6 6304.6 6319.0 6329.0 6066.7 6119.3 6120.1 6152.6 6155.9 07:18:55 INFO - PROCESS | 1640 | 07:18:55 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:70605.69 Median:37069.91 stddev:150038.23 (404.7%) stddev-sans-first:150366.73 07:18:55 INFO - PROCESS | 1640 | Values: 470.8 473.6 500.5 536.0 546.9 32777.8 41513.4 43188.0 43241.1 43349.3 45168.5 45608.8 45638.3 45731.8 45750.3 9609.2 9819.1 9828.8 9837.9 9839.1 9081.6 9294.9 9577.8 11717.3 11993.3 10763.0 11340.6 11831.7 11913.3 11940.5 11853.6 11913.7 11924.2 11926.8 11958.8 11672.6 11810.2 11906.5 11945.0 11958.0 41366.6 41539.2 41648.6 41667.8 41732.0 3985.6 4043.0 4052.3 4058.9 4060.9 30655.0 31402.5 31634.4 32528.0 32693.5 3189.0 3218.1 3244.2 3255.7 3463.7 497416.0 498912.5 499091.0 499249.0 500090.0 67419.9 67554.0 67661.0 67759.3 67822.0 70749.0 70807.6 70924.0 70978.3 71044.0 17281.7 17412.5 17626.8 17637.6 17647.8 13334.9 13397.5 13444.8 13460.1 13467.7 16176.5 16547.0 16578.7 18132.5 18228.0 6352.7 6375.6 6785.2 7743.4 7848.1 859.3 863.9 875.8 880.4 898.2 27653.9 30987.1 31097.5 31311.4 31768.5 1064.7 1064.8 1107.3 1110.2 1122.6 16312.4 16452.0 16460.0 16491.0 16769.0 641937.0 644951.0 645448.0 645830.0 646746.0 56773.0 57568.7 57655.0 60313.4 64968.0 1332.0 1355.4 1426.7 1445.0 1473.7 26371.0 31272.5 32439.4 32616.3 32909.6 53736.5 54238.9 54281.0 54355.9 54461.9 529843.0 533220.0 534215.0 535165.0 535576.0 30590.0 36480.8 38386.4 42690.4 43070.6 45645.8 49157.8 49324.0 49902.0 50834.0 33266.3 33315.0 33607.5 33640.5 34866.7 29461.3 31606.4 32064.7 33560.8 34730.3 36320.0 37659.0 39519.8 40102.6 40636.0 33255.8 33707.5 33841.2 34722.0 34777.1 25918.9 25928.9 26078.9 26082.6 27049.0 07:18:55 INFO - PROCESS | 1640 | 07:18:55 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:41267.17 Median:23142.08 stddev:128556.38 (555.5%) stddev-sans-first:128880.38 07:18:55 INFO - PROCESS | 1640 | Values: 397.3 404.7 404.8 411.5 427.6 20545.5 21608.6 22024.4 22303.0 22554.5 18774.6 22288.9 22521.1 23094.7 23189.4 5811.7 5993.7 6125.5 6127.5 6150.7 5451.0 5709.2 5915.2 5970.9 5977.8 5253.8 5484.7 5906.1 5915.1 5916.4 5686.4 5884.9 5948.6 5950.3 5954.7 5108.6 5163.2 5239.6 5249.7 5264.3 26802.9 27318.0 27332.6 27433.8 27739.2 2518.4 2722.1 2741.8 2753.7 2818.1 9059.0 10373.7 10723.3 10904.9 11015.2 1850.9 1922.4 1925.3 1926.6 1960.9 101561.0 116021.0 118531.0 120579.2 138005.9 9858.9 11628.6 11875.9 11886.9 11901.3 15204.8 16411.3 16641.9 16758.0 16773.3 7685.7 8492.4 9334.7 9339.8 9476.6 8556.0 8797.5 8816.3 8826.2 9144.7 4123.9 4998.6 5003.9 5015.8 5098.9 1896.2 2061.8 2086.7 2098.5 2104.8 984.8 999.7 1039.1 1040.5 1080.1 21645.4 22724.5 22769.8 22781.9 22885.8 1014.4 1017.5 1042.7 1042.8 1042.9 9150.6 10889.1 11917.5 11938.2 11955.7 761815.0 763564.0 772605.0 778586.0 795680.0 139697.3 143871.0 156416.0 165642.0 167491.2 1032.3 1033.5 1059.6 1060.3 1067.6 15891.8 18661.7 20015.9 20062.3 20062.8 45697.0 53744.0 60499.0 61435.7 61979.7 64755.0 87328.6 88129.6 88828.3 89581.0 6843.0 8425.2 8662.0 8749.1 8774.3 11678.8 13027.3 13048.3 13300.3 13305.1 9272.6 10889.1 11388.9 11675.4 11679.8 10570.6 10634.3 10648.7 11019.5 11052.2 9723.5 11467.0 11859.2 11934.8 11948.5 8428.7 8610.3 8733.5 8786.7 8920.7 8571.6 10772.9 11408.2 11601.8 11871.3 07:18:55 INFO - PROCESS | 1640 | 07:18:55 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5546.90 Median:5175.85 stddev:3007.11 (58.1%) stddev-sans-first:2999.36 07:18:55 INFO - PROCESS | 1640 | Values: 1395.8 1482.1 1507.0 1513.7 1516.2 7745.4 8141.3 8425.9 8573.5 8674.8 8554.0 8575.2 8626.5 8646.0 8647.4 2375.4 2410.1 2418.2 2419.1 2424.3 2149.3 2238.6 2373.6 2439.3 2449.6 2384.4 2393.7 2394.8 2395.3 2396.6 2313.4 2334.8 2334.9 2340.4 2343.7 2281.1 2309.5 2333.5 2334.3 2381.3 8554.4 8628.6 8645.0 8656.1 8657.8 5261.1 5413.2 5424.0 5426.7 5439.5 2814.7 2903.1 3390.0 3563.4 3601.3 1209.9 1253.9 1282.1 1292.8 1300.4 10695.3 10992.1 11050.1 11096.8 11117.3 4560.0 4636.9 4685.5 4690.2 4695.2 8943.6 8954.3 8961.7 8966.3 8986.6 4921.6 5298.4 5301.8 5302.6 5308.6 4953.3 4958.4 4962.6 4967.7 4968.6 3531.7 3661.3 3755.2 3844.7 3870.5 1171.6 1171.8 1176.2 1185.3 1187.8 956.6 961.0 965.8 982.4 999.4 5744.5 5751.5 5786.8 5883.0 5932.7 806.8 1007.5 1043.6 1059.6 1107.5 3949.8 3965.2 3965.8 4031.3 4097.2 10127.3 10393.2 10512.9 10519.7 10520.6 10081.5 10184.5 10447.2 10450.7 10462.0 7807.9 8053.2 8229.3 8239.9 8257.0 5910.2 5956.6 6039.4 6134.4 6239.2 7726.8 9494.2 9508.5 9621.0 9703.5 9202.8 9492.1 9606.0 9809.2 9835.6 6546.8 7343.9 7403.9 7437.0 7569.2 7349.0 7592.7 7593.8 7874.3 8019.5 6118.7 7046.5 7073.8 7081.4 7140.5 6832.9 6966.4 7025.4 7053.0 7130.3 6489.7 6540.6 6594.9 6607.6 6612.9 4915.9 5083.7 5154.1 5177.6 5321.5 5120.6 5161.7 5174.1 5216.9 5263.3 07:18:55 INFO - PROCESS | 1640 | 07:18:55 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4409.37 Median:4909.43 stddev:1324.85 (27.0%) stddev-sans-first:1293.27 07:18:55 INFO - PROCESS | 1640 | Values: 362.2 367.2 371.0 382.6 383.5 4149.6 4495.9 5316.8 5386.4 5408.5 4440.6 5069.9 5188.4 5195.9 5342.4 4150.5 4182.3 4206.2 4217.5 4224.5 3515.9 3871.4 4187.7 4214.3 4215.5 3141.9 3987.3 4000.4 4035.6 4174.6 3321.0 4000.8 4011.3 4020.5 4038.5 3486.9 3497.2 3498.8 3517.6 3518.9 5000.5 5123.5 5188.2 5193.1 5197.6 4565.4 4624.7 4634.5 4634.7 4676.7 4652.6 5495.3 5565.7 5579.3 5595.6 3305.7 3431.1 3886.3 3888.8 3940.3 5761.9 5891.9 5968.9 5987.6 6038.6 3940.7 3971.8 3979.9 3982.5 3982.9 3693.2 3735.7 4043.0 4058.8 4065.2 4260.7 4585.7 4592.4 4635.3 4643.6 5395.4 5659.8 5677.3 5682.5 5693.4 1179.3 1247.9 1263.6 1270.4 1292.6 761.3 835.8 837.3 840.0 857.8 4278.1 4790.7 4911.0 4913.6 4942.2 4693.0 5440.3 5443.7 5471.9 5488.9 4109.0 4682.1 4883.8 4930.5 4954.8 2406.4 2823.7 2828.7 2842.0 2844.5 4996.8 5002.0 5140.4 5273.2 5364.8 4583.7 5141.8 5452.0 5485.6 5559.5 4989.6 5372.9 5561.4 5602.5 5614.1 4769.0 4842.8 5312.3 5371.1 5429.5 4631.8 4913.7 5341.8 5372.6 5409.3 5566.8 5573.5 5579.9 5597.9 5606.8 3541.2 3584.1 3656.5 3682.8 3686.6 4862.5 4908.6 5171.5 5206.9 5345.0 4549.3 5218.0 5243.6 5250.0 5284.1 4209.3 4640.4 4845.4 4913.6 5195.3 4855.4 5255.3 5441.8 5542.3 5560.6 5277.1 5537.2 5539.6 5565.4 5577.0 4910.3 5213.5 5515.2 5545.8 5625.3 07:18:55 INFO - PROCESS | 1640 | 07:18:55 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:21207.57 Median:4037.62 stddev:30270.41 (749.7%) stddev-sans-first:30316.21 07:18:55 INFO - PROCESS | 1640 | Values: 713.2 739.4 767.1 847.2 870.2 13687.4 15465.0 15839.3 16136.8 16178.4 14210.6 14670.8 14692.9 14763.5 14851.3 702.8 724.2 877.2 890.1 894.4 642.0 853.8 882.7 887.8 889.4 903.8 929.5 936.5 945.4 949.2 902.0 925.4 941.2 942.6 942.7 697.9 698.0 698.0 698.6 699.3 15254.2 15430.0 15654.4 15970.6 16217.6 14617.3 14879.4 14945.1 14969.3 15215.6 11546.1 11567.9 11761.6 11806.7 12168.0 4585.4 4601.4 4639.4 4650.4 4714.2 97116.5 100671.5 102067.5 103059.0 103319.0 10984.6 11067.9 11164.7 11180.4 11692.4 21533.2 21555.6 21567.1 22136.7 22182.6 7774.5 7883.4 7898.0 7937.0 8019.4 4403.1 4415.1 4516.5 4568.5 4637.2 3565.3 3666.6 3667.1 3922.9 4152.4 740.4 743.4 755.2 755.7 770.5 553.4 576.0 578.7 587.3 597.4 9471.9 10340.2 10531.4 10634.6 10931.7 687.9 710.1 718.4 723.3 725.5 4756.3 4954.6 5422.4 5549.5 5799.9 88423.6 106383.5 107802.9 108059.5 115024.8 86349.1 92290.5 97893.0 99613.5 100910.0 82171.2 83454.2 84613.6 85726.0 87191.0 10904.3 11046.6 11179.5 11275.4 11295.8 53096.7 53818.2 54057.9 54970.6 56414.0 48247.8 73466.6 75505.2 76352.2 77696.0 11110.7 13536.3 13703.4 13824.9 13849.2 14667.1 14858.3 15150.3 15293.8 15624.1 13922.8 14064.6 14409.5 14416.4 14441.9 13785.2 13964.6 14027.4 14052.6 14204.4 13628.8 13978.4 14098.6 14190.9 14695.9 9575.4 10094.2 10174.0 10378.3 10534.9 10944.4 11175.7 11343.0 11364.8 11420.3 07:18:55 INFO - PROCESS | 1640 | -------- Summary: end -------- 07:18:55 INFO - PROCESS | 1640 | 07:18:55 INFO - TEST-INFO | 1640: exit 0 07:18:55 INFO - TEST-OK | dromaeo_css | took 1117972ms 07:18:55 INFO - TEST-START | kraken 07:18:55 INFO - operating with platform_type : mac_ 07:18:55 INFO - Initialising browser for kraken test... 07:18:55 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpiuvggb/profile http://localhost:49243/getInfo.html) 07:18:58 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 07:18:58 INFO - PROCESS | 1649 | colorDepth:24 07:18:58 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 07:18:58 INFO - PROCESS | 1649 | __metrics 07:18:58 INFO - PROCESS | 1649 | 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" 07:18:58 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:18:58 INFO - TEST-INFO | 1649: exit 0 07:18:58 INFO - Browser initialized. 07:18:58 INFO - Running cycle 1/1 for kraken test... 07:18:58 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpiuvggb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:10 INFO - PROCESS | 1651 | RSS: Main: 167493632 07:19:10 INFO - PROCESS | 1651 | 07:19:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 07:19:14 INFO - PROCESS | 1651 | RSS: Main: 215703552 07:19:14 INFO - PROCESS | 1651 | 07:19:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 07:19:17 INFO - PROCESS | 1651 | RSS: Main: 229580800 07:19:17 INFO - PROCESS | 1651 | 07:19:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 07:19:21 INFO - PROCESS | 1651 | RSS: Main: 327110656 07:19:21 INFO - PROCESS | 1651 | 07:19:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 07:19:23 INFO - PROCESS | 1651 | RSS: Main: 230633472 07:19:23 INFO - PROCESS | 1651 | 07:19:25 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:19:26 INFO - PROCESS | 1651 | RSS: Main: 232648704 07:19:26 INFO - PROCESS | 1651 | 07:19:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 07:19:29 INFO - PROCESS | 1651 | RSS: Main: 272441344 07:19:29 INFO - PROCESS | 1651 | 07:19:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 07:19:33 INFO - PROCESS | 1651 | RSS: Main: 274079744 07:19:33 INFO - PROCESS | 1651 | 07:19:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 07:19:37 INFO - PROCESS | 1651 | RSS: Main: 270270464 07:19:37 INFO - PROCESS | 1651 | 07:19:38 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:19:39 INFO - PROCESS | 1651 | RSS: Main: 245465088 07:19:39 INFO - PROCESS | 1651 | 07:19:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:19:41 INFO - PROCESS | 1651 | RSS: Main: 251314176 07:19:41 INFO - PROCESS | 1651 | 07:19:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:19:44 INFO - PROCESS | 1651 | RSS: Main: 252153856 07:19:44 INFO - PROCESS | 1651 | 07:19:47 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:19:48 INFO - PROCESS | 1651 | RSS: Main: 271994880 07:19:48 INFO - PROCESS | 1651 | 07:19:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:19:51 INFO - PROCESS | 1651 | RSS: Main: 266387456 07:19:51 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 07:19:53 INFO - PROCESS | 1651 | RSS: Main: 310300672 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | __start_tp_report 07:19:53 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 07:19:53 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 07:19:53 INFO - PROCESS | 1651 | |i|pagename|runs| 07:19:53 INFO - PROCESS | 1651 | |0;ai-astar;111;113;114;113;112;114;113;112;113;113 07:19:53 INFO - PROCESS | 1651 | |1;audio-beat-detection;140;107;109;143;107;106;102;108;151;136 07:19:53 INFO - PROCESS | 1651 | |2;audio-dft;186;183;187;185;183;180;185;184;182;183 07:19:53 INFO - PROCESS | 1651 | |3;audio-fft;81;57;58;91;61;59;59;58;72;58 07:19:53 INFO - PROCESS | 1651 | |4;audio-oscillator;85;69;109;99;96;69;81;68;68;82 07:19:53 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;90;87;89;88;89;87;91;87;90;86 07:19:53 INFO - PROCESS | 1651 | |6;imaging-darkroom;98;96;98;123;98;98;97;98;98;96 07:19:53 INFO - PROCESS | 1651 | |7;imaging-desaturate;85;85;88;85;100;138;134;85;84;88 07:19:53 INFO - PROCESS | 1651 | |8;json-parse-financial;53;52;52;53;56;56;56;56;56;57 07:19:53 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;69;67;66;73;69;67;68;68;69;69 07:19:53 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;81;83;83;84;69;80;79;98;97;78 07:19:53 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;133;127;138;119;142;143;133;136;171;167 07:19:53 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;164;167;164;165;162;160;162;163;166;163 07:19:53 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;64;65;64;64;62;63;70;69;83;81 07:19:53 INFO - PROCESS | 1651 | __end_tp_report 07:19:53 INFO - PROCESS | 1651 | __start_cc_report 07:19:53 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2047 07:19:53 INFO - PROCESS | 1651 | __end_cc_report 07:19:53 INFO - PROCESS | 1651 | __startTimestamp1491833993631__endTimestamp 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | ------- Summary: start ------- 07:19:53 INFO - PROCESS | 1651 | Number of tests: 14 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:0.92 (0.8%) stddev-sans-first:0.71 07:19:53 INFO - PROCESS | 1651 | Values: 111.0 113.0 114.0 113.0 112.0 114.0 113.0 112.0 113.0 113.0 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:120.90 Median:122.50 stddev:19.03 (15.5%) stddev-sans-first:18.89 07:19:53 INFO - PROCESS | 1651 | Values: 140.0 107.0 109.0 143.0 107.0 106.0 102.0 108.0 151.0 136.0 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.50 stddev:2.04 (1.1%) stddev-sans-first:2.01 07:19:53 INFO - PROCESS | 1651 | Values: 186.0 183.0 187.0 185.0 183.0 180.0 185.0 184.0 182.0 183.0 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:65.40 Median:60.00 stddev:11.92 (19.9%) stddev-sans-first:11.22 07:19:53 INFO - PROCESS | 1651 | Values: 81.0 57.0 58.0 91.0 61.0 59.0 59.0 58.0 72.0 58.0 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:82.60 Median:81.50 stddev:14.72 (18.1%) stddev-sans-first:15.59 07:19:53 INFO - PROCESS | 1651 | Values: 85.0 69.0 109.0 99.0 96.0 69.0 81.0 68.0 68.0 82.0 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:89.00 stddev:1.65 (1.9%) stddev-sans-first:1.64 07:19:53 INFO - PROCESS | 1651 | Values: 90.0 87.0 89.0 88.0 89.0 87.0 91.0 87.0 90.0 86.0 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:100.00 Median:98.00 stddev:8.12 (8.3%) stddev-sans-first:8.58 07:19:53 INFO - PROCESS | 1651 | Values: 98.0 96.0 98.0 123.0 98.0 98.0 97.0 98.0 98.0 96.0 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:85.00 stddev:20.99 (24.7%) stddev-sans-first:21.80 07:19:53 INFO - PROCESS | 1651 | Values: 85.0 85.0 88.0 85.0 100.0 138.0 134.0 85.0 84.0 88.0 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:56.00 stddev:1.95 (3.5%) stddev-sans-first:1.96 07:19:53 INFO - PROCESS | 1651 | Values: 53.0 52.0 52.0 53.0 56.0 56.0 56.0 56.0 56.0 57.0 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:1.90 (2.8%) stddev-sans-first:2.01 07:19:53 INFO - PROCESS | 1651 | Values: 69.0 67.0 66.0 73.0 69.0 67.0 68.0 68.0 69.0 69.0 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:8.64 (10.4%) stddev-sans-first:9.13 07:19:53 INFO - PROCESS | 1651 | Values: 81.0 83.0 83.0 84.0 69.0 80.0 79.0 98.0 97.0 78.0 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:140.00 stddev:16.41 (11.7%) stddev-sans-first:17.15 07:19:53 INFO - PROCESS | 1651 | Values: 133.0 127.0 138.0 119.0 142.0 143.0 133.0 136.0 171.0 167.0 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:164.00 stddev:2.07 (1.3%) stddev-sans-first:2.19 07:19:53 INFO - PROCESS | 1651 | Values: 164.0 167.0 164.0 165.0 162.0 160.0 162.0 163.0 166.0 163.0 07:19:53 INFO - PROCESS | 1651 | 07:19:53 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:67.00 stddev:7.56 (11.3%) stddev-sans-first:7.84 07:19:53 INFO - PROCESS | 1651 | Values: 64.0 65.0 64.0 64.0 62.0 63.0 70.0 69.0 83.0 81.0 07:19:53 INFO - PROCESS | 1651 | -------- Summary: end -------- 07:19:53 INFO - PROCESS | 1651 | 07:19:54 INFO - TEST-INFO | 1651: exit 0 07:19:54 INFO - TEST-OK | kraken | took 58726ms 07:19:54 INFO - SUITE-END | took 1176s 07:19:54 INFO - Completed test suite (00:19:36) 07:19:54 INFO - javascript benchmark 07:19:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3425.5204271402004, 3467.809270490122, 3482.181687303483, 3497.5977762557313, 3537.292541491702, 4849.36958195435, 5837.0, 5866.384029676881, 5878.412158784119, 5882.176495290662, 5809.9709501452535, 5901.822945311647, 5906.0, 5926.140709597106, 5928.6739229342365, 5244.711540865261, 5291.365036195662, 5296.92054619181, 5336.519713225809, 5342.572594192475, 4141.7100802943805, 4757.024809913976, 5259.973700131494, 5394.514493695567, 5401.972990135044, 4704.20028595138, 5107.821226257081, 5363.892722145555, 5365.114756065244, 5378.704171270579, 5354.812581559646, 5359.08895487768, 5365.570754339683, 5372.247885296042, 5376.973115134439, 5217.686938783647, 5311.389190243133, 5313.654612450178, 5317.521423071942, 5337.4662533746705, 6003.7898673546215, 6005.099235114724, 6006.279246490449, 6012.248468941382, 6014.548908831812, 6190.84522886927, 6230.501559875199, 6245.968770156165, 6247.781327653511, 6282.465990390822, 6296.433321001132, 6317.4946004319545, 6320.494360451153, 6322.841928951813, 6326.968365158191, 5943.851403714942, 5964.105384192362, 5980.0, 5997.340292567814, 6003.399660034005, 6266.091416744546, 6309.558330916791, 6324.652144132025, 6377.266614339317, 6435.131257280301, 6242.469390101802, 6267.9373206268265, 6283.183186185858, 6290.056491526216, 6296.496280297565, 6309.432151106423, 6310.274318453345, 6314.968425157845, 6331.018692102732, 6344.175257216624, 5892.086726557391, 6151.446369826737, 6209.348018458088, 6234.9688251559355, 6269.310375858652, 6240.063990401385, 6263.71813268404, 6273.7176827042895, 6289.654069026247, 6294.716737746812, 5140.665856719302, 5145.15105007677, 5147.536721695065, 5152.793888244503, 5167.302414174113, 4479.3057076153245, 4506.278995360726, 4533.977330113328, 4547.954520454753, 4583.472900616405, 4986.700797952134, 5975.701214939322, 6024.8795024100145, 6048.727807248684, 6106.511479081662, 6268.701227695232, 6288.0, 6320.273168585672, 6330.493560515148, 6346.777862774781, 5885.588008839426, 5948.851278718067, 6050.455459008623, 6059.333473317932, 6065.848353791102, 5472.753726082336, 5546.584006199551, 5579.776808927679, 5585.720713964285, 5587.860303492445, 5452.591055670761, 6523.608583484816, 6525.575837570543, 6537.215534135934, 6545.476361890942, 6282.591631543935, 6288.937110629018, 6292.27638821523, 6293.150424692608, 6323.114763933145, 6335.3981371769605, 6363.745450181941, 6465.77369792055, 6466.644334561456, 6529.67351632407, 6250.531210159165, 6288.213973253343, 6292.811215663537, 6297.275813281532, 6315.5263355247625, 6207.16203312547, 6326.367363263636, 6332.683365831598, 6333.619982801047, 6346.238451385863, 6132.110769107885, 6178.505719542516, 6298.905516417349, 6320.241571011508, 6322.462590679844, 6187.597806142587, 6205.379462053758, 6210.161628180319, 6265.686715664107, 6303.369663033844, 6204.689765511796, 6211.81364559064, 6217.689115544295, 6233.501319894488, 6233.96883015582, 6250.156228909039, 6272.5922815016875, 6304.621722696653, 6319.0, 6329.019002054689, 6066.666333351708, 6119.296280927751, 6120.081987701702, 6152.569320147726, 6155.938440615716], "value": 5814.217522181673, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.76697034967674, 473.5832467428663, 500.4570041504967, 536.0030343560977, 546.9206964990077, 32777.836110819444, 41513.37729934054, 43188.0, 43241.13517729643, 43349.34975975355, 45168.54831451685, 45608.771956140255, 45638.31542526865, 45731.77134114325, 45750.313745293846, 9609.23126149908, 9819.116279534841, 9828.754281142992, 9837.90162098377, 9839.114479696826, 9081.636734530644, 9294.907050929472, 9577.80844383112, 11717.296962182254, 11993.280403175793, 10763.031327180552, 11340.60307889224, 11831.704207394798, 11913.344766037864, 11940.462679179414, 11853.585124520643, 11913.702157446047, 11924.165308428413, 11926.821097683542, 11958.7608247835, 11672.649820505398, 11810.232334898204, 11906.464209110523, 11945.044396448264, 11958.0, 41366.586334136875, 41539.1692166158, 41648.58351416478, 41667.7916610418, 41732.0, 3985.561588225293, 4043.0, 4052.250333688277, 4058.898527536806, 4060.8984775380554, 30655.0, 31402.528962065586, 31634.36731265385, 32528.0, 32693.50959735606, 3189.0, 3218.0828463887915, 3244.1727359523406, 3255.6744325567493, 3463.688268055887, 497416.0, 498912.5054374741, 499091.0, 499249.0, 500090.0, 67419.94350423738, 67554.0, 67661.0, 67759.3224067763, 67821.98267025998, 70749.0, 70807.64596177089, 70924.0, 70978.2902170982, 71044.0, 17281.740773888152, 17412.47762567125, 17626.823731762517, 17637.559061023578, 17647.823521764618, 13334.933325333312, 13397.464101436028, 13444.798328025088, 13460.057795954384, 13467.730645387233, 16176.514704558882, 16547.007179569024, 16578.6684266314, 18132.456026319232, 18227.997460139555, 6352.7141278642575, 6375.649339286291, 6785.1518560179975, 7743.419243556756, 7848.0974687910475, 859.2696208223085, 863.9093393986442, 875.7941883657336, 880.4453194487432, 898.1916275352236, 27653.861730691217, 30987.14077155378, 31097.53353699696, 31311.37377252442, 31768.523472147936, 1064.7284942339654, 1064.755106325534, 1107.307932542161, 1110.2228440091806, 1122.6126986189915, 16312.429064982669, 16452.0, 16460.012399256084, 16491.0, 16768.993860368417, 641937.0, 644951.0, 645448.0, 645830.0, 646746.0, 56773.0, 57568.71215643895, 57655.0, 60313.39686603165, 64968.0, 1332.0, 1355.356205802236, 1426.664733787559, 1445.04626946215, 1473.7052589481932, 26371.0, 31272.530912036793, 32439.351212975136, 32616.34767304688, 32909.61436925322, 53736.462635373144, 54238.91522169614, 54281.0, 54355.91288174294, 54461.91076178534, 529843.0, 533220.0, 534215.0, 535165.0, 535576.0, 30590.0, 36480.81759591185, 38386.42420363753, 42690.359644605975, 43070.56929430791, 45645.77177114226, 49157.75421122871, 49324.0, 49902.0, 50834.0, 33266.334673305915, 33315.0, 33607.495887561214, 33640.49539256962, 34866.65133348634, 29461.26346841346, 31606.367872641957, 32064.679353207102, 33560.83219583886, 34730.305393891475, 36320.0, 37659.0, 39519.81440556788, 40102.59897400989, 40635.98410039773, 33255.833720831244, 33707.49438758371, 33841.153971149935, 34722.0, 34777.13057173591, 25918.870405647853, 25928.8703556481, 26078.86960565261, 26082.60876086822, 27049.0], "value": 20848.144732569395, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.2591117565739, 404.68636806474996, 404.82794812204816, 411.53291014698306, 427.5766990679227, 20545.486362840937, 21608.56782864342, 22024.449388765268, 22303.0, 22554.54890902181, 18774.62450750984, 22288.888555557198, 22521.09915603378, 23094.72978986155, 23189.420264493398, 5811.6803575803315, 5993.670348130851, 6125.540584456161, 6127.540434467411, 6150.66171360575, 5450.972745136269, 5709.172170035343, 5915.201447804556, 5970.910436343458, 5977.760889564434, 5253.79162792558, 5484.725763711818, 5906.084556893688, 5915.142304365864, 5916.408359164071, 5686.402927692595, 5884.882302353951, 5948.553858460633, 5950.285965684124, 5954.702264886781, 5108.6168537359845, 5163.225516172567, 5239.633225674204, 5249.685018898878, 5264.31563896691, 26802.927882884855, 27318.0, 27332.59001114985, 27433.765480553422, 27739.167824965283, 2518.382996165951, 2722.1425251045857, 2741.7943654226015, 2753.6695596528543, 2818.0982085732576, 9058.954705226432, 10373.688789336333, 10723.302985306009, 10904.945475272572, 11015.173861960386, 1850.8519318454491, 1922.3848368522079, 1925.2876435718733, 1926.6435709393807, 1960.9117589708496, 101561.0, 116021.0, 118531.0, 120579.19131212951, 138005.85982420543, 9858.901410985942, 11628.592999244986, 11875.88124118765, 11886.940565297118, 11901.285922844658, 15204.847951520564, 16411.261493232832, 16641.91679041597, 16758.0, 16773.32906683719, 7685.692572297157, 8492.447990880573, 9334.673286434941, 9339.766505837408, 9476.573554190078, 8555.957220213859, 8797.516136612549, 8816.250618697482, 8826.161514656098, 9144.679936202201, 4123.8969025774595, 4998.550130488274, 5003.949960500421, 5015.82444614444, 5098.872528186825, 1896.2225487550038, 2061.7835127311714, 2086.6661334186456, 2098.5173410115453, 2104.7789982051972, 984.837501812193, 999.6701088640731, 1039.111559616532, 1040.4641609571077, 1080.1250986700798, 21645.35063948084, 22724.545509089727, 22769.772302277095, 22781.860906954586, 22885.771142288697, 1014.3558840136567, 1017.4861694844204, 1042.723678225271, 1042.801867645145, 1042.9165666746642, 9150.588223529958, 10889.074428673493, 11917.523299068114, 11938.22401543897, 11955.701107472383, 761815.0, 763564.0, 772605.0, 778586.0, 795680.0, 139697.30151349178, 143871.0, 156416.0, 165642.0, 167491.1625441865, 1032.3238278927315, 1033.5245786937942, 1059.6344261229863, 1060.3107979813183, 1067.631667074858, 15891.761623575425, 18661.720074198627, 20015.899920500306, 20062.29781957683, 20062.79937200609, 45697.0, 53744.0, 60499.0, 61435.69282153561, 61979.690101549204, 64755.0, 87328.56335718535, 88129.55935220284, 88828.34877106555, 89581.0, 6843.0, 8425.241728244488, 8662.0, 8749.125087491455, 8774.254188393803, 11678.824817627912, 13027.348632568523, 13048.347582621022, 13300.334983250605, 13305.068645194744, 9272.6290948364, 10889.074428673652, 11388.94305528467, 11675.416229188677, 11679.824802627798, 10570.630027949292, 10634.255602107778, 10648.680539583826, 11019.504122314675, 11052.171087168334, 9723.46520941355, 11467.0, 11859.229150105215, 11934.820977685167, 11948.462319195483, 8428.747137585882, 8610.311175105851, 8733.475991440533, 8786.736397908073, 8920.687775927812, 8571.614277357408, 10772.946135269274, 11408.201425900439, 11601.767964640829, 11871.287722736663], "value": 10066.060113416685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.7836535337015, 1482.125545927903, 1507.0204367161346, 1513.6594266290085, 1516.196415899573, 7745.380369570435, 8141.267285944264, 8425.873611895826, 8573.485590864553, 8674.828898098755, 8554.016288126868, 8575.185357391054, 8626.525541095238, 8646.005709343428, 8647.351448641346, 2375.3705268103968, 2410.144398738449, 2418.1657328221736, 2419.0565679385054, 2424.260600516842, 2149.258505815491, 2238.6194346961056, 2373.6083546214854, 2439.256026911791, 2449.632555116729, 2384.3800611840875, 2393.700787401575, 2394.8084153267696, 2395.281415575329, 2396.6405039244078, 2313.4332088638225, 2334.8248881333798, 2334.9299521014395, 2340.3914982104607, 2343.7304709958403, 2281.0533628544135, 2309.515001849614, 2333.4749681321737, 2334.2763743239652, 2381.2856143156982, 8554.35842311829, 8628.568571571459, 8645.049044605088, 8656.09111043344, 8657.826843463095, 5261.1319132343115, 5413.242146099549, 5424.0, 5426.728663566806, 5439.48324909133, 2814.7044560321283, 2903.129061281607, 3390.0, 3563.4120370138894, 3601.2797440512004, 1209.9455524501418, 1253.8871501564904, 1282.1025282302332, 1292.7802273613509, 1300.4473098932915, 10695.251332406735, 10992.065674417685, 11050.060744836699, 11096.833547496793, 11117.277376970553, 4560.042391097841, 4636.907261854744, 4685.531446855355, 4690.15577196108, 4695.201815691341, 8943.5975381108, 8954.2836573074, 8961.731148065568, 8966.282697384193, 8986.55067246635, 4921.630877684188, 5298.443663415286, 5301.840944771663, 5302.628815982921, 5308.575313974873, 4953.25701144824, 4958.380202474691, 4962.5533701967, 4967.726775027409, 4968.6025117990475, 3531.717462603037, 3661.3043521730788, 3755.1550901047044, 3844.7116466265143, 3870.4968354113785, 1171.6367925942984, 1171.812509998396, 1176.1649229047473, 1185.2829038431626, 1187.7861984842812, 956.5599824080862, 960.9567569459391, 965.7971825916495, 982.4301904895144, 999.3803841618243, 5744.454276843693, 5751.482366587027, 5786.768529258867, 5883.0, 5932.7033648318275, 806.8184658451919, 1007.49882674814, 1043.6242952537082, 1059.592057058038, 1107.5182295701395, 3949.8420063197723, 3965.167314863911, 3965.8413663453716, 4031.294523458383, 4097.242010228118, 10127.341722787995, 10393.16854651626, 10512.947435262775, 10519.684409467729, 10520.579176832995, 10081.546330415149, 10184.541695623566, 10447.216458765623, 10450.68647940563, 10462.006109419744, 7807.921920780719, 8053.15441878606, 8229.300509456643, 8239.917600824036, 8256.958715206385, 5910.202122713378, 5956.642601443928, 6039.396060393926, 6134.355892631388, 6239.1577137087725, 7726.845463090819, 9494.192993595345, 9508.524573771421, 9620.95189524076, 9703.514824258618, 9202.769930751785, 9492.05079492073, 9606.0, 9809.215262779104, 9835.60657573689, 6546.8363290918105, 7343.8531229376185, 7403.888941665771, 7436.96281518589, 7569.1673915870315, 7349.0, 7592.658330375257, 7593.772186834404, 7874.251946065115, 8019.478733882279, 6118.724657390339, 7046.506744527834, 7073.752418665322, 7081.398081163159, 7140.500164988401, 6832.897506537306, 6966.407855332353, 7025.437964962893, 7052.9647351762915, 7130.322619351154, 6489.675516224264, 6540.607563546202, 6594.90107648376, 6607.603543787388, 6612.933870661232, 4915.852524424273, 5083.745812709423, 5154.14956532183, 5177.637565370388, 5321.5476684482255, 5120.590352771844, 5161.66449180802, 5174.068667639711, 5216.878371150221, 5263.315768950165], "value": 4521.862960050014, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.2194171560288, 367.1885133854182, 370.97959612221337, 382.6364953294371, 383.4918732679199, 4149.626533611974, 4495.86512404628, 5316.813911513098, 5386.434424385437, 5408.486193811586, 4440.555944405558, 5069.898602027966, 5188.351456067991, 5195.908859139576, 5342.412334643186, 4150.501939767217, 4182.330827067677, 4206.221848957937, 4217.493900731901, 4224.493060832704, 3515.859365625372, 3871.4192871069286, 4187.7176938568555, 4214.262504061792, 4215.515215750182, 3141.879231518727, 3987.342088555399, 4000.379941109118, 4035.59644035597, 4174.603412675791, 3320.966790332114, 4000.8399664013696, 4011.3180759270995, 4020.517537895457, 4038.547042278868, 3486.860525578974, 3497.2306092659574, 3498.8425520851624, 3517.595476520182, 3518.894433167009, 5000.549950504435, 5123.487651234884, 5188.169892817131, 5193.117170081057, 5197.570668066274, 4565.383673204141, 4624.745638989854, 4634.513376095495, 4634.728982798438, 4676.672632915697, 4652.55800698933, 5495.313085864267, 5565.666060036411, 5579.302587176603, 5595.580331475156, 3305.7190138838228, 3431.107911942913, 3886.3393223152134, 3888.844446222148, 3940.310445671996, 5761.9135712964335, 5891.882162356772, 5968.940310596882, 5987.580869339148, 6038.637681739066, 3940.7438516496336, 3971.781552014667, 3979.900502487403, 3982.542007669097, 3982.880513584597, 3693.171879919457, 3735.7198210134347, 4042.9892526868284, 4058.7564746115327, 4065.207284579538, 4260.701750877409, 4585.721209335341, 4592.425946756655, 4635.3278774578175, 4643.628509719214, 5395.3525576931015, 5659.773609055674, 5677.318721753416, 5682.460166284196, 5693.373728889819, 1179.339569840892, 1247.8502579690496, 1263.6335462715892, 1270.434656577814, 1292.5992942187952, 761.3186198352554, 835.7805504623543, 837.2715737308581, 839.995800020996, 857.7905153733207, 4278.07486631011, 4790.664653474293, 4910.950890491121, 4913.616895805531, 4942.184539551005, 4692.976535117303, 5440.347158341025, 5443.652153925307, 5471.917921231185, 5488.862778430571, 4108.979455102705, 4682.0881059457715, 4883.804647814048, 4930.5069493050405, 4954.844642580489, 2406.4344878953434, 2823.7035111313426, 2828.660560732725, 2841.957370639442, 2844.5306524423654, 4996.752760153913, 5001.974595207974, 5140.408852981955, 5273.235380869753, 5364.758585863646, 4583.702059366131, 5141.76862041209, 5452.0, 5485.61600687948, 5559.471850174227, 4989.5758860496535, 5372.892542149213, 5561.416051314634, 5602.543338731877, 5614.129809879475, 4768.976155119341, 4842.7820748065715, 5312.335958005249, 5371.060064488621, 5429.511343979061, 4631.791569379318, 4913.680610760289, 5341.839744807662, 5372.5701943843615, 5409.323834520685, 5566.805161819317, 5573.526250268773, 5579.8884022320135, 5597.944020559742, 5606.775728970795, 3541.2386336937684, 3584.084535503182, 3656.542932133483, 3682.834272457799, 3686.631336866292, 4862.489438608895, 4908.601048701103, 5171.45699701541, 5206.927912531624, 5345.022341733584, 4549.294859296814, 5217.991073436679, 5243.5542978847225, 5250.0, 5284.128118860345, 4209.34755112958, 4640.445450774028, 4845.442774080885, 4913.560507644592, 5195.3246078009615, 4855.393075865517, 5255.290535777621, 5441.809806449091, 5542.251796007487, 5560.638558493847, 5277.102892508359, 5537.179346251074, 5539.612227144061, 5565.443455654402, 5576.972115139399, 4910.263460480956, 5213.530782229466, 5515.200295957144, 5545.833624991256, 5625.296837895263], "value": 4001.123207611254, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.2072472981569, 739.3863093632285, 767.1024900865987, 847.2205570874795, 870.212457725758, 13687.384067716965, 15465.0, 15839.287232074556, 16136.757948630751, 16178.433754818554, 14210.573682789533, 14670.779938300933, 14692.853071469282, 14763.483278085268, 14851.331690073946, 702.7891632510252, 724.1889084225675, 877.2105105405138, 890.1276748786194, 894.4454438248296, 641.9582727122745, 853.8164294676643, 882.7307671160294, 887.7558671365362, 889.4352086425134, 903.8373092843285, 929.4980710416366, 936.4615346175942, 945.42801605029, 949.2168960607491, 901.9594118264661, 925.3938670171015, 941.1717688434134, 942.6323733743845, 942.6606421688186, 697.9302069793031, 697.9879175195986, 698.0018573439979, 698.5983059740619, 699.3286445012794, 15254.161021143833, 15430.0, 15654.373825046985, 15970.600734981603, 16217.594560135973, 14617.269136543131, 14879.404823807035, 14945.103293802407, 14969.326380312803, 15215.61960950974, 11546.134039947037, 11567.884321156766, 11761.588344407905, 11806.704832379259, 12168.0, 4585.36681944624, 4601.378813860119, 4639.350490931272, 4650.372199753024, 4714.151452738506, 97116.51441742817, 100671.48992765041, 102067.48966255196, 103059.0, 103319.0, 10984.615538456115, 11067.944660276647, 11164.665060048212, 11180.38507882058, 11692.356920369291, 21533.24633637815, 21555.56888862214, 21567.13731450756, 22136.66794998076, 22182.55634887293, 7774.455788094892, 7883.369330453665, 7898.01274840645, 7937.007874015748, 8019.35845132388, 4403.097365040159, 4415.116976604692, 4516.525764794715, 4568.543145685471, 4637.1653102441205, 3565.2691198304287, 3666.6150054244454, 3667.064898450878, 3922.86269980555, 4152.37714342851, 740.3965767899145, 743.4015617427914, 755.2145768400911, 755.7090520149782, 770.5453782268488, 553.4299671338528, 575.9971200143973, 578.7019684862299, 587.2981786764775, 597.3518732175552, 9471.857922131174, 10340.172786177087, 10531.420771857622, 10634.574617015232, 10931.726706832234, 687.9002544631, 710.1159056974101, 718.4324383736789, 723.3345322303494, 725.4849057169469, 4756.265147540178, 4954.6437358649855, 5422.40353561108, 5549.500544950974, 5799.9130013049835, 88423.55788221018, 106383.46808266063, 107802.9219707793, 108059.45970270099, 115024.84975150309, 86349.13650863411, 92290.53854730817, 97893.0, 99613.50193248987, 100910.0, 82171.17828821755, 83454.23730508209, 84613.57693211494, 85726.0, 87190.99999999873, 10904.34573925567, 11046.558137674403, 11179.508038154521, 11275.379854108103, 11295.830562541732, 53096.73451632717, 53818.19272710834, 54057.91884162216, 54970.62573435536, 56414.0, 48247.75876120597, 73466.63266683846, 75505.24494754981, 76352.23647763673, 77696.0, 11110.666679999613, 13536.255505947267, 13703.383347749575, 13824.930875345559, 13849.238291894042, 14667.071211495773, 14858.331375087932, 15150.3182356792, 15293.847061529243, 15624.140672263135, 13922.791158132839, 14064.578062658136, 14409.495667651581, 14416.351264192926, 14441.927790360982, 13785.241811700453, 13964.623619906206, 14027.438902443788, 14052.578422647337, 14204.431822726976, 13628.795568066686, 13978.44086236539, 14098.577042688736, 14190.92904535512, 14695.92652036733, 9575.425474471554, 10094.19246460296, 10174.03346682064, 10378.273520853469, 10534.893836147094, 10944.398058106563, 11175.72060698489, 11343.0, 11364.829527557258, 11420.257683250562], "value": 7792.740075433215, "unit": "score"}], "name": "dromaeo_css", "value": 7457.7796740609665, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 114.0, 113.0, 112.0, 114.0, 113.0, 112.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 107.0, 109.0, 143.0, 107.0, 106.0, 102.0, 108.0, 151.0, 136.0], "value": 120.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 187.0, 185.0, 183.0, 180.0, 185.0, 184.0, 182.0, 183.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 58.0, 91.0, 61.0, 59.0, 59.0, 58.0, 72.0, 58.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 109.0, 99.0, 96.0, 69.0, 81.0, 68.0, 68.0, 82.0], "value": 82.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 88.0, 89.0, 87.0, 91.0, 87.0, 90.0, 86.0], "value": 88.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 98.0, 123.0, 98.0, 98.0, 97.0, 98.0, 98.0, 96.0], "value": 100.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 88.0, 85.0, 100.0, 138.0, 134.0, 85.0, 84.0, 88.0], "value": 97.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 53.0, 56.0, 56.0, 56.0, 56.0, 56.0, 57.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 66.0, 73.0, 69.0, 67.0, 68.0, 68.0, 69.0, 69.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 83.0, 84.0, 69.0, 80.0, 79.0, 98.0, 97.0, 78.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 127.0, 138.0, 119.0, 142.0, 143.0, 133.0, 136.0, 171.0, 167.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 164.0, 165.0, 162.0, 160.0, 162.0, 163.0, 166.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 62.0, 63.0, 70.0, 69.0, 83.0, 81.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1430.5, "alertThreshold": 2.0}]} 07:19:54 INFO - Return code: 0 07:19:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:19:54 INFO - # TBPL SUCCESS # 07:19:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:19:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:19:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:19:54 INFO - 2017-04-10 07:19:54.907 screenresolution[1655:9605] starting screenresolution argv=screenresolution get 07:19:54 INFO - 2017-04-10 07:19:54.910 screenresolution[1655:9605] Display 0: 1600x1200x32@60 07:19:54 INFO - 2017-04-10 07:19:54.917 screenresolution[1656:9608] starting screenresolution argv=screenresolution list 07:19:54 INFO - Available Modes on Display 0 07:19:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:19:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:19:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:19:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:19:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:19:55 INFO - Intel Iris: 07:19:55 INFO - Chipset Model: Intel Iris 07:19:55 INFO - Type: GPU 07:19:55 INFO - Bus: Built-In 07:19:55 INFO - VRAM (Dynamic, Max): 1536 MB 07:19:55 INFO - Vendor: Intel (0x8086) 07:19:55 INFO - Device ID: 0x0a2e 07:19:55 INFO - Revision ID: 0x0009 07:19:55 INFO - Displays: 07:19:55 INFO - Display: 07:19:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:19:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:19:55 INFO - Display Serial Number: 1600x1200 60 07:19:55 INFO - Main Display: Yes 07:19:55 INFO - Mirror: Off 07:19:55 INFO - Online: Yes 07:19:55 INFO - Rotation: Supported 07:19:55 INFO - Return code: 0 07:19:55 INFO - Running post-action listener: _resource_record_post_action 07:19:55 INFO - [mozharness: 2017-04-10 14:19:55.154624Z] Finished run-tests step (success) 07:19:55 INFO - Running post-run listener: _resource_record_post_run 07:19:55 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 38872064; Write bytes: 422681088; Read time: 384; Write time: 1465 07:19:55 INFO - TinderboxPrint: CPU usage
53.7% 07:19:55 INFO - TinderboxPrint: I/O read bytes / time
38,872,064 / 384 07:19:55 INFO - TinderboxPrint: I/O write bytes / time
422,681,088 / 1,465 07:19:55 INFO - TinderboxPrint: CPU idle
2,209.9 (46.3%) 07:19:55 INFO - TinderboxPrint: CPU system
952.8 (20.0%) 07:19:55 INFO - TinderboxPrint: CPU user
1,607.0 (33.7%) 07:19:55 INFO - TinderboxPrint: Swap in / out
160,686,080 / 0 07:19:55 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122786304; Write bytes: 124159488; Read time: 11089; Write time: 284 07:19:55 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 34399232; Write bytes: 297001984; Read time: 345; Write time: 1168 07:19:55 INFO - Running post-run listener: _upload_blobber_files 07:19:55 INFO - Blob upload gear active. 07:19:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:19:55 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 07:19:55 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'] 07:19:55 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 07:19:56 INFO - (blobuploader) - INFO - Open directory for files ... 07:19:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:19:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:19:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:57 INFO - (blobuploader) - INFO - Done attempting. 07:19:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:19:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:19:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:58 INFO - (blobuploader) - INFO - Done attempting. 07:19:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:19:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:59 INFO - (blobuploader) - INFO - Done attempting. 07:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:01 INFO - (blobuploader) - INFO - Done attempting. 07:20:01 INFO - (blobuploader) - INFO - Iteration through files over. 07:20:01 INFO - Return code: 0 07:20:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:20:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:20:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9531fb19f403925bb5ba82912e03c70af17f0331f4b18099cdf1fa76976eaa26d1e3eb6834c160d14b1a54eee6dea473a9bf881a717ad70b21104e84d307821", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f727be0b0e45b6d9ff58a3e0234b6c88fb7c5bbd74db2e4b5af07962aa8e3dac2bcc814293e06d0a873f6f3931daa34ed4afdec18bc60c766dd17c0ef43ef66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0248638f1f3598cca09ba845b74d5fa26f391909ef1d57f09c1b4c26110f6f497bfe4abb48439c107f3a908af7841273b3ed60c0b30fa85bc9b10ecea2931312", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e2bd8aa9aa0ff8fdb85c66a5cc3e6c40ca299cca0695655d5b5a7194b7fc233859d703573827730c67be8da537b3978940c84566ff27104bd70e5fb6aeff61b"} 07:20:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:20:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:20:01 INFO - Contents: 07:20:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9531fb19f403925bb5ba82912e03c70af17f0331f4b18099cdf1fa76976eaa26d1e3eb6834c160d14b1a54eee6dea473a9bf881a717ad70b21104e84d307821", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f727be0b0e45b6d9ff58a3e0234b6c88fb7c5bbd74db2e4b5af07962aa8e3dac2bcc814293e06d0a873f6f3931daa34ed4afdec18bc60c766dd17c0ef43ef66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0248638f1f3598cca09ba845b74d5fa26f391909ef1d57f09c1b4c26110f6f497bfe4abb48439c107f3a908af7841273b3ed60c0b30fa85bc9b10ecea2931312", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e2bd8aa9aa0ff8fdb85c66a5cc3e6c40ca299cca0695655d5b5a7194b7fc233859d703573827730c67be8da537b3978940c84566ff27104bd70e5fb6aeff61b"} 07:20:01 INFO - Running post-run listener: copy_logs_to_upload_dir 07:20:01 INFO - Copying logs to upload dir... 07:20:01 INFO - mkdir: /builds/slave/test/build/upload/logs 07:20:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.803752 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-04-10 07:20:01.355669) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 07:20:01.360632) ========= 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.WOav0JLAQy/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.weAFMh06wH/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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/a9531fb19f403925bb5ba82912e03c70af17f0331f4b18099cdf1fa76976eaa26d1e3eb6834c160d14b1a54eee6dea473a9bf881a717ad70b21104e84d307821", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f727be0b0e45b6d9ff58a3e0234b6c88fb7c5bbd74db2e4b5af07962aa8e3dac2bcc814293e06d0a873f6f3931daa34ed4afdec18bc60c766dd17c0ef43ef66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0248638f1f3598cca09ba845b74d5fa26f391909ef1d57f09c1b4c26110f6f497bfe4abb48439c107f3a908af7841273b3ed60c0b30fa85bc9b10ecea2931312", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e2bd8aa9aa0ff8fdb85c66a5cc3e6c40ca299cca0695655d5b5a7194b7fc233859d703573827730c67be8da537b3978940c84566ff27104bd70e5fb6aeff61b"} build_url:https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010787 build_url: 'https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/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/a9531fb19f403925bb5ba82912e03c70af17f0331f4b18099cdf1fa76976eaa26d1e3eb6834c160d14b1a54eee6dea473a9bf881a717ad70b21104e84d307821", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f727be0b0e45b6d9ff58a3e0234b6c88fb7c5bbd74db2e4b5af07962aa8e3dac2bcc814293e06d0a873f6f3931daa34ed4afdec18bc60c766dd17c0ef43ef66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0248638f1f3598cca09ba845b74d5fa26f391909ef1d57f09c1b4c26110f6f497bfe4abb48439c107f3a908af7841273b3ed60c0b30fa85bc9b10ecea2931312", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e2bd8aa9aa0ff8fdb85c66a5cc3e6c40ca299cca0695655d5b5a7194b7fc233859d703573827730c67be8da537b3978940c84566ff27104bd70e5fb6aeff61b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 07:20:01.398893) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 07:20:01.399236) ========= 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.WOav0JLAQy/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.weAFMh06wH/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.004417 ========= master_lag: 0.41 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 07:20:01.817979) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 07:20:01.818365) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 07:20:01.820803) ========= ========= Total master_lag: 0.57 =========