builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0305 starttime: 1492689290.98 results: success (0) buildid: 20170420031727 builduid: 3e63fc48d4d441d1b236390e7a61392b revision: e0ef5e00268e86fe010d9104473e05e7d5307058 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 04:54:50.982755) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 04:54:50.983195) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 04:54:50.983477) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 04:54:51.013223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 04:54:51.013600) ========= 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.7MaxsZXNHU/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.jxeSrgmstE/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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-20 04:54:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 23.5M=0s 2017-04-20 04:54:51 (23.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129092 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 04:54:51.166073) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 04:54:51.166408) ========= 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.7MaxsZXNHU/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.jxeSrgmstE/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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.027881 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 04:54:51.216626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-20 04:54:51.216996) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e0ef5e00268e86fe010d9104473e05e7d5307058 --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 e0ef5e00268e86fe010d9104473e05e7d5307058 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7MaxsZXNHU/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.jxeSrgmstE/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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-20 04:54:51,328 truncating revision to first 12 chars 2017-04-20 04:54:51,328 Setting DEBUG logging. 2017-04-20 04:54:51,328 attempt 1/10 2017-04-20 04:54:51,328 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e0ef5e00268e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-20 04:54:52,065 unpacking tar archive at: mozilla-beta-e0ef5e00268e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.230657 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-20 04:54:52.468114) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 04:54:52.468441) ========= script_repo_revision: e0ef5e00268e86fe010d9104473e05e7d5307058 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 04:54:52.468849) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 04:54:52.469141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 04:54:52.487388) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-20 04:54:52.487823) ========= /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.7MaxsZXNHU/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.jxeSrgmstE/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:54:52 INFO - MultiFileLogger online at 20170420 04:54:52 in /builds/slave/test 04:54:52 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 04:54:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:54:52 INFO - {'append_to_log': False, 04:54:52 INFO - 'base_work_dir': '/builds/slave/test', 04:54:52 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:54:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:54:52 INFO - 'branch': 'Mozilla-Beta', 04:54:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:54:52 INFO - 'config_files': ('talos/mac_config.py',), 04:54:52 INFO - 'default_actions': ('clobber', 04:54:52 INFO - 'read-buildbot-config', 04:54:52 INFO - 'download-and-extract', 04:54:52 INFO - 'populate-webroot', 04:54:52 INFO - 'create-virtualenv', 04:54:52 INFO - 'install', 04:54:52 INFO - 'run-tests'), 04:54:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:54:52 INFO - 'download_minidump_stackwalk': True, 04:54:52 INFO - 'download_symbols': 'ondemand', 04:54:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:54:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:54:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:54:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:54:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:54:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:54:52 INFO - 'gecko_profile': False, 04:54:52 INFO - 'gecko_profile_interval': 0, 04:54:52 INFO - 'installer_path': 'installer.exe', 04:54:52 INFO - 'log_level': 'info', 04:54:52 INFO - 'log_name': 'talos', 04:54:52 INFO - 'log_to_console': True, 04:54:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:54:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:54:52 INFO - 'opt_config_files': (), 04:54:52 INFO - 'pip_index': False, 04:54:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:54:52 INFO - 'cmd': ('bash', 04:54:52 INFO - '-c', 04:54:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:54:52 INFO - 'enabled': True, 04:54:52 INFO - 'halt_on_failure': False, 04:54:52 INFO - 'name': 'check_screen_resolution'},), 04:54:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:54:52 INFO - 'cmd': ('bash', 04:54:52 INFO - '-c', 04:54:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:54:52 INFO - 'enabled': True, 04:54:52 INFO - 'halt_on_failure': False, 04:54:52 INFO - 'name': 'check_screen_resolution'},), 04:54:52 INFO - 'run_cmd_checks_enabled': True, 04:54:52 INFO - 'suite': 'dromaeojs', 04:54:52 INFO - 'system_bits': '32', 04:54:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:54:52 INFO - 'title': 't-yosemite-r7-0305', 04:54:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:54:52 INFO - 'use_talos_json': True, 04:54:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:54:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:54:52 INFO - 'work_dir': 'build'} 04:54:52 INFO - [mozharness: 2017-04-20 11:54:52.690033Z] Running clobber step. 04:54:52 INFO - Running pre-action listener: _resource_record_pre_action 04:54:52 INFO - Running main action method: clobber 04:54:52 INFO - rmtree: /builds/slave/test/build 04:54:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:54:57 INFO - Running post-action listener: _resource_record_post_action 04:54:57 INFO - [mozharness: 2017-04-20 11:54:57.061565Z] Finished clobber step (success) 04:54:57 INFO - [mozharness: 2017-04-20 11:54:57.061689Z] Running read-buildbot-config step. 04:54:57 INFO - Running pre-action listener: _resource_record_pre_action 04:54:57 INFO - Running main action method: read_buildbot_config 04:54:57 INFO - Using buildbot properties: 04:54:57 INFO - { 04:54:57 INFO - "project": "", 04:54:57 INFO - "product": "firefox", 04:54:57 INFO - "script_repo_revision": "production", 04:54:57 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 04:54:57 INFO - "repository": "", 04:54:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 04:54:57 INFO - "buildid": "20170420031727", 04:54:57 INFO - "pgo_build": "False", 04:54:57 INFO - "basedir": "/builds/slave/test", 04:54:57 INFO - "buildnumber": 6, 04:54:57 INFO - "slavename": "t-yosemite-r7-0305", 04:54:57 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:54:57 INFO - "platform": "yosemite_r7", 04:54:57 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:54:57 INFO - "branch": "mozilla-beta", 04:54:57 INFO - "repo_path": "releases/mozilla-beta", 04:54:57 INFO - "revision": "e0ef5e00268e86fe010d9104473e05e7d5307058", 04:54:57 INFO - "stage_platform": "macosx64", 04:54:57 INFO - "builduid": "3e63fc48d4d441d1b236390e7a61392b", 04:54:57 INFO - "slavebuilddir": "test" 04:54:57 INFO - } 04:54:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 04:54:57 INFO - Running post-action listener: _resource_record_post_action 04:54:57 INFO - [mozharness: 2017-04-20 11:54:57.064790Z] Finished read-buildbot-config step (success) 04:54:57 INFO - [mozharness: 2017-04-20 11:54:57.064896Z] Running download-and-extract step. 04:54:57 INFO - Running pre-action listener: _resource_record_pre_action 04:54:57 INFO - Running main action method: download_and_extract 04:54:57 INFO - mkdir: /builds/slave/test/build/tests 04:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:57 INFO - trying https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 04:54:57 INFO - Downloading https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 04:54:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 04:54:58 INFO - Downloaded 1165 bytes. 04:54:58 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 04:54:58 INFO - Using the following test package requirements: 04:54:58 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 04:54:58 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:54:58 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 04:54:58 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:54:58 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 04:54:58 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:54:58 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:54:58 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 04:54:58 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 04:54:58 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:54:58 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 04:54:58 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:54:58 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 04:54:58 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:54:58 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 04:54:58 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:54:58 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 04:54:58 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 04:54:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 04:54:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 04:54:58 INFO - Fetch https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 04:54:59 INFO - Expected file size: 51223860 04:54:59 INFO - Obtained file size: 51223860 04:55:15 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:55:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 04:55:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 04:55:15 INFO - Fetch https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 04:55:17 INFO - Expected file size: 51223860 04:55:17 INFO - Obtained file size: 51223860 04:55:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 04:55:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 04:55:32 INFO - Fetch https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 04:55:33 INFO - Expected file size: 14404424 04:55:33 INFO - Obtained file size: 14404424 04:55:33 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')]} 04:55:33 INFO - trying https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.dmg 04:55:33 INFO - Downloading https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 04:55:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 04:55:35 INFO - Downloaded 59226429 bytes. 04:55:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.dmg 04:55:35 INFO - mkdir: /builds/slave/test/properties 04:55:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:55:35 INFO - Writing to file /builds/slave/test/properties/build_url 04:55:35 INFO - Contents: 04:55:35 INFO - build_url:https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.dmg 04:55:36 INFO - Running post-action listener: _resource_record_post_action 04:55:36 INFO - Running post-action listener: set_extra_try_arguments 04:55:36 INFO - [mozharness: 2017-04-20 11:55:36.515201Z] Finished download-and-extract step (success) 04:55:36 INFO - [mozharness: 2017-04-20 11:55:36.515324Z] Running populate-webroot step. 04:55:36 INFO - Running pre-action listener: _resource_record_pre_action 04:55:36 INFO - Running main action method: populate_webroot 04:55:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:55:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:55:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:55:36 INFO - '--tppagecycles', 04:55:36 INFO - '7'], 04:55:36 INFO - 'tests': ['tsvgm']}}, 04:55:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:55:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:55:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:55:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:55:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:55:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:55:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:55:36 INFO - 'talos_options': ['--disable-e10s'], 04:55:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:55:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:55:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:55:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:55:36 INFO - 'talos_options': ['--disable-e10s'], 04:55:36 INFO - 'tests': ['damp', 'tps']}, 04:55:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:55:36 INFO - 'tests': ['damp', 'tps']}, 04:55:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:55:36 INFO - 'tests': ['dromaeo_dom']}, 04:55:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:55:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:55:36 INFO - 'tests': ['basic_compositor_video']}, 04:55:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:55:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:55:36 INFO - 'tests': ['a11yr', 04:55:36 INFO - 'ts_paint', 04:55:36 INFO - 'tpaint', 04:55:36 INFO - 'sessionrestore', 04:55:36 INFO - 'sessionrestore_no_auto_restore', 04:55:36 INFO - 'tabpaint']}, 04:55:36 INFO - 'other-e10s': {'tests': ['a11yr', 04:55:36 INFO - 'ts_paint', 04:55:36 INFO - 'tpaint', 04:55:36 INFO - 'sessionrestore', 04:55:36 INFO - 'sessionrestore_no_auto_restore', 04:55:36 INFO - 'tabpaint']}, 04:55:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:55:36 INFO - 'ts_paint', 04:55:36 INFO - 'tpaint', 04:55:36 INFO - 'sessionrestore', 04:55:36 INFO - 'sessionrestore_no_auto_restore', 04:55:36 INFO - 'tabpaint']}, 04:55:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:55:36 INFO - 'ts_paint', 04:55:36 INFO - 'tpaint', 04:55:36 INFO - 'sessionrestore', 04:55:36 INFO - 'sessionrestore_no_auto_restore', 04:55:36 INFO - 'tabpaint']}, 04:55:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:55:36 INFO - 'tests': ['a11yr', 04:55:36 INFO - 'ts_paint', 04:55:36 INFO - 'tpaint', 04:55:36 INFO - 'sessionrestore', 04:55:36 INFO - 'sessionrestore_no_auto_restore', 04:55:36 INFO - 'tabpaint']}, 04:55:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:55:36 INFO - 'tests': ['a11yr', 04:55:36 INFO - 'ts_paint', 04:55:36 INFO - 'tpaint', 04:55:36 INFO - 'sessionrestore', 04:55:36 INFO - 'sessionrestore_no_auto_restore', 04:55:36 INFO - 'tabpaint']}, 04:55:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:55:36 INFO - 'tests': ['tsvgx', 04:55:36 INFO - 'tsvgr_opacity', 04:55:36 INFO - 'tart', 04:55:36 INFO - 'tscrollx', 04:55:36 INFO - 'cart', 04:55:36 INFO - 'tsvg_static']}, 04:55:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:55:36 INFO - 'tsvgr_opacity', 04:55:36 INFO - 'tart', 04:55:36 INFO - 'tscrollx', 04:55:36 INFO - 'cart', 04:55:36 INFO - 'tsvg_static']}, 04:55:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:55:36 INFO - 'talos_options': ['--disable-e10s'], 04:55:36 INFO - 'tests': ['tp5o']}, 04:55:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:55:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:55:36 INFO - 'talos_options': ['--disable-e10s', 04:55:36 INFO - '--xperf_path', 04:55:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:55:36 INFO - 'tests': ['tp5n']}, 04:55:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:55:36 INFO - 'talos_options': ['--xperf_path', 04:55:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:55:36 INFO - 'tests': ['tp5n']}}, 04:55:36 INFO - 'talos.zip': {'path': '', 04:55:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:55:36 INFO - Running post-action listener: _resource_record_post_action 04:55:36 INFO - [mozharness: 2017-04-20 11:55:36.533503Z] Finished populate-webroot step (success) 04:55:36 INFO - [mozharness: 2017-04-20 11:55:36.533608Z] Running create-virtualenv step. 04:55:36 INFO - Running pre-action listener: _resource_record_pre_action 04:55:36 INFO - Running main action method: create_virtualenv 04:55:36 INFO - Creating virtualenv /builds/slave/test/build/venv 04:55:36 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 04:55:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:55:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:55:36 INFO - Using real prefix '/tools/python27' 04:55:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:55:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:55:40 INFO - Installing pip.................done. 04:55:40 INFO - Return code: 0 04:55:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:55:40 INFO - Reading from file tmpfile_stdout 04:55:40 INFO - Output received: 04:55:40 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) 04:55:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:55:40 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')]} 04:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:40 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')]} 04:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10970bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10970e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf2557900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e9d30>, '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 0x109410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094debe8>, '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.7MaxsZXNHU/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.jxeSrgmstE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:55: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', 'pip>=1.5'] in /builds/slave/test/build 04:55: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 pip>=1.5 04:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MaxsZXNHU/Render', 04:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:41 INFO - 'HOME': '/Users/cltbld', 04:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:41 INFO - 'LOGNAME': 'cltbld', 04:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:41 INFO - 'MOZ_NO_REMOTE': '1', 04:55:41 INFO - 'NO_EM_RESTART': '1', 04:55:41 INFO - 'PAGER': '/bin/cat', 04:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:41 INFO - 'PWD': '/builds/slave/test', 04:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:41 INFO - 'SHELL': '/bin/bash', 04:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jxeSrgmstE/Listeners', 04:55:41 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:41 INFO - 'USER': 'cltbld', 04:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:41 INFO - 'XPC_FLAGS': '0x0', 04:55:41 INFO - 'XPC_SERVICE_NAME': '0', 04:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:41 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 04:55:41 INFO - Cleaning up... 04:55:41 INFO - Return code: 0 04:55:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:55: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')]} 04:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55: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')]} 04:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55: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', '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 0x10970bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10970e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf2557900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e9d30>, '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 0x109410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094debe8>, '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.7MaxsZXNHU/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.jxeSrgmstE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:55: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:55: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 psutil>=3.1.1 04:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MaxsZXNHU/Render', 04:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:41 INFO - 'HOME': '/Users/cltbld', 04:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:41 INFO - 'LOGNAME': 'cltbld', 04:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:41 INFO - 'MOZ_NO_REMOTE': '1', 04:55:41 INFO - 'NO_EM_RESTART': '1', 04:55:41 INFO - 'PAGER': '/bin/cat', 04:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:41 INFO - 'PWD': '/builds/slave/test', 04:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:41 INFO - 'SHELL': '/bin/bash', 04:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jxeSrgmstE/Listeners', 04:55:41 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:41 INFO - 'USER': 'cltbld', 04:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:41 INFO - 'XPC_FLAGS': '0x0', 04:55:41 INFO - 'XPC_SERVICE_NAME': '0', 04:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:42 INFO - Downloading/unpacking psutil>=3.1.1 04:55:42 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 04:55:42 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 04:55:42 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 04:55:42 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 04:55:42 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 04:55:42 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 04:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:55:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:55:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:55:46 INFO - Installing collected packages: psutil 04:55:46 INFO - Running setup.py install for psutil 04:55:46 INFO - building 'psutil._psutil_osx' extension 04:55:46 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 04:55:46 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 04:55:46 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 04:55:46 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 04:55:46 INFO - building 'psutil._psutil_posix' extension 04:55:46 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 04:55:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:55:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:55:46 INFO - ^ 04:55:47 INFO - 1 warning generated. 04:55:47 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 04:55:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:55:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:55:47 INFO - Successfully installed psutil 04:55:47 INFO - Cleaning up... 04:55:47 INFO - Return code: 0 04:55:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10970bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10970e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf2557900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e9d30>, '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 0x109410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094debe8>, '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.7MaxsZXNHU/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.jxeSrgmstE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:55:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:55:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:55:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MaxsZXNHU/Render', 04:55:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:47 INFO - 'HOME': '/Users/cltbld', 04:55:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:47 INFO - 'LOGNAME': 'cltbld', 04:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:47 INFO - 'MOZ_NO_REMOTE': '1', 04:55:47 INFO - 'NO_EM_RESTART': '1', 04:55:47 INFO - 'PAGER': '/bin/cat', 04:55:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:47 INFO - 'PWD': '/builds/slave/test', 04:55:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:47 INFO - 'SHELL': '/bin/bash', 04:55:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jxeSrgmstE/Listeners', 04:55:47 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:55:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:47 INFO - 'USER': 'cltbld', 04:55:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:47 INFO - 'XPC_FLAGS': '0x0', 04:55:47 INFO - 'XPC_SERVICE_NAME': '0', 04:55:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:55:50 INFO - Installing collected packages: mozsystemmonitor 04:55:50 INFO - Running setup.py install for mozsystemmonitor 04:55:50 INFO - Successfully installed mozsystemmonitor 04:55:50 INFO - Cleaning up... 04:55:50 INFO - Return code: 0 04:55:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:55: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')]} 04:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55: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')]} 04:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:50 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 0x10970bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10970e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf2557900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e9d30>, '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 0x109410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094debe8>, '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.7MaxsZXNHU/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.jxeSrgmstE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:55:50 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 04:55:50 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 04:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MaxsZXNHU/Render', 04:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:50 INFO - 'HOME': '/Users/cltbld', 04:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:50 INFO - 'LOGNAME': 'cltbld', 04:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:50 INFO - 'MOZ_NO_REMOTE': '1', 04:55:50 INFO - 'NO_EM_RESTART': '1', 04:55:50 INFO - 'PAGER': '/bin/cat', 04:55:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:50 INFO - 'PWD': '/builds/slave/test', 04:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:50 INFO - 'SHELL': '/bin/bash', 04:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jxeSrgmstE/Listeners', 04:55:50 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:50 INFO - 'USER': 'cltbld', 04:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:50 INFO - 'XPC_FLAGS': '0x0', 04:55:50 INFO - 'XPC_SERVICE_NAME': '0', 04:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:50 INFO - Downloading/unpacking jsonschema==2.5.1 04:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:55:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:53 INFO - Downloading functools32-3.2.3-2.tar.gz 04:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:55:53 INFO - warning: no files found matching '*.txt' 04:55:53 INFO - no previously-included directories found matching 'build' 04:55:53 INFO - no previously-included directories found matching 'dist' 04:55:53 INFO - no previously-included directories found matching '.git*' 04:55:54 INFO - Installing collected packages: jsonschema, functools32 04:55:54 INFO - Running setup.py install for functools32 04:55:54 INFO - warning: no files found matching '*.txt' 04:55:54 INFO - no previously-included directories found matching 'build' 04:55:54 INFO - no previously-included directories found matching 'dist' 04:55:54 INFO - no previously-included directories found matching '.git*' 04:55:54 INFO - Successfully installed jsonschema functools32 04:55:54 INFO - Cleaning up... 04:55:54 INFO - Return code: 0 04:55:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:55: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')]} 04:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55: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')]} 04:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:54 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 0x10970bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10970e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf2557900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e9d30>, '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 0x109410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094debe8>, '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.7MaxsZXNHU/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.jxeSrgmstE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:55:54 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 04:55:54 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 04:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MaxsZXNHU/Render', 04:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:54 INFO - 'HOME': '/Users/cltbld', 04:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:54 INFO - 'LOGNAME': 'cltbld', 04:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:54 INFO - 'MOZ_NO_REMOTE': '1', 04:55:54 INFO - 'NO_EM_RESTART': '1', 04:55:54 INFO - 'PAGER': '/bin/cat', 04:55:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:54 INFO - 'PWD': '/builds/slave/test', 04:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:54 INFO - 'SHELL': '/bin/bash', 04:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jxeSrgmstE/Listeners', 04:55:54 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:54 INFO - 'USER': 'cltbld', 04:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:54 INFO - 'XPC_FLAGS': '0x0', 04:55:54 INFO - 'XPC_SERVICE_NAME': '0', 04:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:55:54 INFO - Cleaning up... 04:55:54 INFO - Return code: 0 04:55:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:55: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')]} 04:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55: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')]} 04:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:54 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 0x10970bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10970e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf2557900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e9d30>, '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 0x109410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094debe8>, '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.7MaxsZXNHU/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.jxeSrgmstE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:55:54 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 04:55:54 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 04:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MaxsZXNHU/Render', 04:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:54 INFO - 'HOME': '/Users/cltbld', 04:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:54 INFO - 'LOGNAME': 'cltbld', 04:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:54 INFO - 'MOZ_NO_REMOTE': '1', 04:55:54 INFO - 'NO_EM_RESTART': '1', 04:55:54 INFO - 'PAGER': '/bin/cat', 04:55:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:54 INFO - 'PWD': '/builds/slave/test', 04:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:54 INFO - 'SHELL': '/bin/bash', 04:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jxeSrgmstE/Listeners', 04:55:54 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:54 INFO - 'USER': 'cltbld', 04:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:54 INFO - 'XPC_FLAGS': '0x0', 04:55:54 INFO - 'XPC_SERVICE_NAME': '0', 04:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:55:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:55:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:55:58 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 04:55:58 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 04:55:58 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 04:55:58 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 04:55:58 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 04:55:58 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 04:55:58 INFO - Downloading docopt-0.6.1.tar.gz 04:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:55:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:55:58 INFO - Running setup.py install for blobuploader 04:55:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:55:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:55:58 INFO - Running setup.py install for requests 04:55:59 INFO - Running setup.py install for docopt 04:55:59 INFO - Successfully installed blobuploader requests docopt 04:55:59 INFO - Cleaning up... 04:55:59 INFO - Return code: 0 04:55:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:59 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')]} 04:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:59 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')]} 04:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:59 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 0x10970bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10970e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf2557900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e9d30>, '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 0x109410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094debe8>, '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.7MaxsZXNHU/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.jxeSrgmstE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:55:59 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 04:55:59 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 04:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MaxsZXNHU/Render', 04:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:59 INFO - 'HOME': '/Users/cltbld', 04:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:59 INFO - 'LOGNAME': 'cltbld', 04:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:59 INFO - 'MOZ_NO_REMOTE': '1', 04:55:59 INFO - 'NO_EM_RESTART': '1', 04:55:59 INFO - 'PAGER': '/bin/cat', 04:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:59 INFO - 'PWD': '/builds/slave/test', 04:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:59 INFO - 'SHELL': '/bin/bash', 04:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jxeSrgmstE/Listeners', 04:55:59 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:59 INFO - 'USER': 'cltbld', 04:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:59 INFO - 'XPC_FLAGS': '0x0', 04:55:59 INFO - 'XPC_SERVICE_NAME': '0', 04:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:55:59 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-oUNXFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:55:59 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-gzlR8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Y6HJSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-TZYZpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-6bXIU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-3VbeQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-7TozGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-YwzkZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Y8xemv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-7l1oaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:00 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-_1afjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:01 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-_Xhscy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:01 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-wTxAgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:01 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-SH3q73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:01 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-gJ946e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:01 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-7_29ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:01 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-rithK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:56:01 INFO - Running setup.py install for manifestparser 04:56:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:56:01 INFO - Running setup.py install for mozcrash 04:56:01 INFO - Running setup.py install for mozdebug 04:56:02 INFO - Running setup.py install for mozdevice 04:56:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Running setup.py install for mozfile 04:56:02 INFO - Running setup.py install for mozhttpd 04:56:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Running setup.py install for mozinfo 04:56:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Running setup.py install for mozInstall 04:56:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Running setup.py install for mozleak 04:56:02 INFO - Running setup.py install for mozlog 04:56:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:56:03 INFO - Running setup.py install for moznetwork 04:56:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:56:03 INFO - Running setup.py install for mozprocess 04:56:03 INFO - Running setup.py install for mozprofile 04:56:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:56:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:56:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:56:03 INFO - Running setup.py install for mozrunner 04:56:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:56:03 INFO - Running setup.py install for mozscreenshot 04:56:03 INFO - Running setup.py install for moztest 04:56:04 INFO - Running setup.py install for mozversion 04:56:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:56:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:56:04 INFO - Cleaning up... 04:56:04 INFO - Return code: 0 04:56:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:04 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')]} 04:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:04 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')]} 04:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:04 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 0x10970bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10970e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf2557900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e9d30>, '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 0x109410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094debe8>, '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.7MaxsZXNHU/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.jxeSrgmstE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:56:04 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 04:56:04 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 04:56:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MaxsZXNHU/Render', 04:56:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:04 INFO - 'HOME': '/Users/cltbld', 04:56:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:04 INFO - 'LOGNAME': 'cltbld', 04:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:04 INFO - 'MOZ_NO_REMOTE': '1', 04:56:04 INFO - 'NO_EM_RESTART': '1', 04:56:04 INFO - 'PAGER': '/bin/cat', 04:56:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:04 INFO - 'PWD': '/builds/slave/test', 04:56:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:04 INFO - 'SHELL': '/bin/bash', 04:56:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jxeSrgmstE/Listeners', 04:56:04 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:56:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:04 INFO - 'USER': 'cltbld', 04:56:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:04 INFO - 'XPC_FLAGS': '0x0', 04:56:04 INFO - 'XPC_SERVICE_NAME': '0', 04:56:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:04 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Og8Cjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:04 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)) 04:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:04 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-gFdfPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:04 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)) 04:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:04 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-uaewI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:04 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)) 04:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:04 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Vn6D9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:04 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)) 04:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:04 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Ws5EBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:05 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-fxT1Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:05 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-oDwS8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:05 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-PsPvct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:05 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-nUW7Ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:05 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-lndMWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:05 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-0bP0R3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:05 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-7Zveh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:05 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-lE0y3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:05 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-YyCr3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:05 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-fQAQHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:06 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)) 04:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:06 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-kPEXuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:06 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)) 04:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:06 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-sF8WM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:06 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)) 04:56:06 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)) 04:56:06 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)) 04:56:06 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)) 04:56:06 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)) 04:56:06 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)) 04:56:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:08 INFO - Downloading blessings-1.6.tar.gz 04:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:56:09 INFO - Installing collected packages: blessings 04:56:09 INFO - Running setup.py install for blessings 04:56:09 INFO - Successfully installed blessings 04:56:09 INFO - Cleaning up... 04:56:09 INFO - Return code: 0 04:56:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:09 INFO - Reading from file tmpfile_stdout 04:56:09 INFO - Current package versions: 04:56:09 INFO - blessings == 1.6 04:56:09 INFO - blobuploader == 1.2.4 04:56:09 INFO - docopt == 0.6.1 04:56:09 INFO - functools32 == 3.2.3-2 04:56:09 INFO - jsonschema == 2.5.1 04:56:09 INFO - manifestparser == 1.1 04:56:09 INFO - mozInstall == 1.12 04:56:09 INFO - mozcrash == 1.0 04:56:09 INFO - mozdebug == 0.1 04:56:09 INFO - mozdevice == 0.49 04:56:09 INFO - mozfile == 1.2 04:56:09 INFO - mozhttpd == 0.7 04:56:09 INFO - mozinfo == 0.9 04:56:09 INFO - mozleak == 0.1 04:56:09 INFO - mozlog == 3.4 04:56:09 INFO - moznetwork == 0.27 04:56:09 INFO - mozprocess == 0.25 04:56:09 INFO - mozprofile == 0.28 04:56:09 INFO - mozrunner == 6.13 04:56:09 INFO - mozscreenshot == 0.1 04:56:09 INFO - mozsystemmonitor == 0.3 04:56:09 INFO - moztest == 0.8 04:56:09 INFO - mozversion == 1.4 04:56:09 INFO - psutil == 3.1.1 04:56:09 INFO - requests == 1.2.3 04:56:09 INFO - wsgiref == 0.1.2 04:56:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56: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')]} 04:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56: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')]} 04:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:09 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 0x10970bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10970e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf2557900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e9d30>, '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 0x109410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094debe8>, '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.7MaxsZXNHU/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.jxeSrgmstE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:56:09 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 04:56:09 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 04:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MaxsZXNHU/Render', 04:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:09 INFO - 'HOME': '/Users/cltbld', 04:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:09 INFO - 'LOGNAME': 'cltbld', 04:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:09 INFO - 'MOZ_NO_REMOTE': '1', 04:56:09 INFO - 'NO_EM_RESTART': '1', 04:56:09 INFO - 'PAGER': '/bin/cat', 04:56:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:09 INFO - 'PWD': '/builds/slave/test', 04:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:09 INFO - 'SHELL': '/bin/bash', 04:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jxeSrgmstE/Listeners', 04:56:09 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:09 INFO - 'USER': 'cltbld', 04:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:09 INFO - 'XPC_FLAGS': '0x0', 04:56:09 INFO - 'XPC_SERVICE_NAME': '0', 04:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 INFO - Cleaning up... 04:56:09 INFO - Return code: 0 04:56:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:56: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')]} 04:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56: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')]} 04:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:09 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 0x10970bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10970e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feaf2557900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094e9d30>, '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 0x109410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094debe8>, '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.7MaxsZXNHU/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.jxeSrgmstE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:56:09 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 04:56:09 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 04:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MaxsZXNHU/Render', 04:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:09 INFO - 'HOME': '/Users/cltbld', 04:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:09 INFO - 'LOGNAME': 'cltbld', 04:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:09 INFO - 'MOZ_NO_REMOTE': '1', 04:56:09 INFO - 'NO_EM_RESTART': '1', 04:56:09 INFO - 'PAGER': '/bin/cat', 04:56:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:09 INFO - 'PWD': '/builds/slave/test', 04:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:09 INFO - 'SHELL': '/bin/bash', 04:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jxeSrgmstE/Listeners', 04:56:09 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:09 INFO - 'USER': 'cltbld', 04:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:09 INFO - 'XPC_FLAGS': '0x0', 04:56:09 INFO - 'XPC_SERVICE_NAME': '0', 04:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:56:10 INFO - Cleaning up... 04:56:10 INFO - Return code: 0 04:56:10 INFO - Running post-action listener: _resource_record_post_action 04:56:10 INFO - Running post-action listener: _start_resource_monitoring 04:56:10 INFO - Starting resource monitoring. 04:56:10 INFO - [mozharness: 2017-04-20 11:56:10.152998Z] Finished create-virtualenv step (success) 04:56:10 INFO - [mozharness: 2017-04-20 11:56:10.153950Z] Running install step. 04:56:10 INFO - Running pre-action listener: _resource_record_pre_action 04:56:10 INFO - Running main action method: install 04:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:10 INFO - Reading from file tmpfile_stdout 04:56:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:56:10 INFO - Reading from file tmpfile_stdout 04:56:10 INFO - Output received: 04:56:10 INFO - Usage: mozinstall [options] installer 04:56:10 INFO - Options: 04:56:10 INFO - -h, --help show this help message and exit 04:56:10 INFO - -d DEST, --destination=DEST 04:56:10 INFO - Directory to install application into. [default: 04:56:10 INFO - "/builds/slave/test"] 04:56:10 INFO - --app=APP Application being installed. [default: firefox] 04:56:10 INFO - mkdir: /builds/slave/test/build/application 04:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:56:25 INFO - Reading from file tmpfile_stdout 04:56:25 INFO - Output received: 04:56:25 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:56:25 INFO - Running post-action listener: _resource_record_post_action 04:56:25 INFO - [mozharness: 2017-04-20 11:56:25.229429Z] Finished install step (success) 04:56:25 INFO - [mozharness: 2017-04-20 11:56:25.229557Z] Running run-tests step. 04:56:25 INFO - Running pre-action listener: _resource_record_pre_action 04:56:25 INFO - Running main action method: run_tests 04:56:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:56:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:56:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:56:25 INFO - 2017-04-20 04:56:25.241 screenresolution[1628:7577] starting screenresolution argv=screenresolution get 04:56:25 INFO - 2017-04-20 04:56:25.244 screenresolution[1628:7577] Display 0: 1600x1200x32@60 04:56:25 INFO - 2017-04-20 04:56:25.249 screenresolution[1629:7579] starting screenresolution argv=screenresolution list 04:56:25 INFO - Available Modes on Display 0 04:56:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:56:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:56:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:56:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:56:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:56:25 INFO - Intel Iris: 04:56:25 INFO - Chipset Model: Intel Iris 04:56:25 INFO - Type: GPU 04:56:25 INFO - Bus: Built-In 04:56:25 INFO - VRAM (Dynamic, Max): 1536 MB 04:56:25 INFO - Vendor: Intel (0x8086) 04:56:25 INFO - Device ID: 0x0a2e 04:56:25 INFO - Revision ID: 0x0009 04:56:25 INFO - Displays: 04:56:25 INFO - Display: 04:56:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:56:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:56:25 INFO - Display Serial Number: 1600x1200 60 04:56:25 INFO - Main Display: Yes 04:56:25 INFO - Mirror: Off 04:56:25 INFO - Online: Yes 04:56:25 INFO - Rotation: Supported 04:56:25 INFO - Return code: 0 04:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:56:25 INFO - Python 2.7.3 04:56:25 INFO - Return code: 0 04:56:25 INFO - grabbing minidump binary from tooltool 04:56:25 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')]} 04:56:25 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 0x1094e9d30>, '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 0x109410db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094debe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:56:25 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 04:56:25 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 04:56:25 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 04:56:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:56:25 INFO - Return code: 0 04:56:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:56:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:56:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:56:25 INFO - ENV: RUST_BACKTRACE is now 1 04:56:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:56:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:56:25 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/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0305', '--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 04:56:25 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/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0305 --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 04:56:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MaxsZXNHU/Render', 04:56:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:25 INFO - 'HOME': '/Users/cltbld', 04:56:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:25 INFO - 'LOGNAME': 'cltbld', 04:56:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:56:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:25 INFO - 'MOZ_NO_REMOTE': '1', 04:56:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:56:25 INFO - 'NO_EM_RESTART': '1', 04:56:25 INFO - 'PAGER': '/bin/cat', 04:56:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:25 INFO - 'PWD': '/builds/slave/test', 04:56:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:56:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:25 INFO - 'RUST_BACKTRACE': '1', 04:56:25 INFO - 'SHELL': '/bin/bash', 04:56:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jxeSrgmstE/Listeners', 04:56:25 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:56:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:25 INFO - 'USER': 'cltbld', 04:56:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:25 INFO - 'XPC_FLAGS': '0x0', 04:56:25 INFO - 'XPC_SERVICE_NAME': '0', 04:56:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:25 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/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0305', '--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 04:56:25 INFO - mozversion application_buildid: 20170420031727 04:56:25 INFO - mozversion application_changeset: e0ef5e00268e86fe010d9104473e05e7d5307058 04:56:25 INFO - mozversion application_display_name: Firefox 04:56:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:56:25 INFO - mozversion application_name: Firefox 04:56:25 INFO - mozversion application_remotingname: firefox 04:56:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:56:25 INFO - mozversion application_vendor: Mozilla 04:56:25 INFO - mozversion application_version: 54.0 04:56:25 INFO - mozversion platform_buildid: 20170420031727 04:56:25 INFO - mozversion platform_changeset: e0ef5e00268e86fe010d9104473e05e7d5307058 04:56:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:56:25 INFO - mozversion platform_version: 54.0 04:56:25 INFO - using testdate: 1492689385 04:56:25 INFO - actual date: 1492689385 04:56:25 INFO - starting webserver on 'localhost:49241' 04:56:25 INFO - SUITE-START | Running 2 tests 04:56:25 INFO - TEST-START | dromaeo_css 04:56:25 INFO - operating with platform_type : mac_ 04:56:25 INFO - Initialising browser for dromaeo_css test... 04:56:25 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpmko7UU/profile http://localhost:49241/getInfo.html) 04:56:28 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 04:56:28 INFO - PROCESS | 1639 | colorDepth:24 04:56:28 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 04:56:28 INFO - PROCESS | 1639 | __metrics 04:56:28 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:56:28 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:56:29 INFO - TEST-INFO | 1639: exit 0 04:56:29 INFO - Browser initialized. 04:56:29 INFO - Running cycle 1/1 for dromaeo_css test... 04:56:29 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpmko7UU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:41 INFO - PROCESS | 1642 | RSS: Main: 165457920 04:56:41 INFO - PROCESS | 1642 | 04:59:44 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:59:46 INFO - PROCESS | 1642 | RSS: Main: 320577536 04:59:46 INFO - PROCESS | 1642 | 05:02:48 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 05:02:49 INFO - PROCESS | 1642 | RSS: Main: 304259072 05:02:49 INFO - PROCESS | 1642 | 05:05:52 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 05:05:52 INFO - PROCESS | 1642 | RSS: Main: 297431040 05:05:52 INFO - PROCESS | 1642 | 05:08:55 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 05:08:55 INFO - PROCESS | 1642 | RSS: Main: 270966784 05:08:55 INFO - PROCESS | 1642 | 05:11:59 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:11:59 INFO - PROCESS | 1642 | RSS: Main: 262909952 05:11:59 INFO - PROCESS | 1642 | 05:15:02 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:15:03 INFO - PROCESS | 1642 | RSS: Main: 579280896 05:15:03 INFO - PROCESS | 1642 | 05:15:03 INFO - PROCESS | 1642 | __start_tp_report 05:15:03 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 05:15:03 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 05:15:03 INFO - PROCESS | 1642 | |i|pagename|runs| 05:15:03 INFO - PROCESS | 1642 | |0;dojo.html;3497.702695270902;3498.387782138126;3504.2816222674337;3517.120719820045;3525.03061658044;5841.766329346821;5909.940900590993;5920.437558431953;5921.289445266563;5988.461038506533;5872.295324561059;5906.704664766766;5906.88186236275;5936.643801371921;5947.494462970652;5347.1177255752755;5364.758585863646;5386.111291636876;5395.433479484656;5512.283403157584;4370;5287.603429742765;5302.992431438014;5461.262729531502;5466.371367292752;5398.91901621476;5410.026195284847;5413.810516631918;5418.864528386802;5433.212184233284;4350.8042138103865;5168.198929165986;5391.757370918318;5400.29796126505;5404.540614047811;5242.7378631068295;5347.786088556453;5358.624896257264;5369.40936496985;5396.055690254189;5933.851653708649;5951.22634057574;5958.433948774859;5961.612495187799;5963.98612235921;6332.746690132389;6335.5565110442285;6339.36606339367;6350.0792385103905;6354.523410744213;6279.089532017878;6299.842503937438;6304.684765761694;6324.08300796382;6336.20797400325;5983.670898100603;6003.969980150071;6026.309257880367;6047.5766696331275;6082.330943596201;6275.937240627627;6461.6446095464735;6510.479161667055;6513.73945042193;6515.185601799775;6254.3745625437095;6278.780242691484;6334.493240540745;6359.141515895388;6400.423961843363;6362;6408.61548307103;6412.3267056959285;6420.6147631142285;6425.132607097982;5269.367675878919;6137.048757442603;6341.8731625368155;6356.459700925473;6359.20509936258;6103.6032657877095;6242.563020588515;6290.21372328459;6342.238931328178;6352.428281454691;5114.693118412907;5132.923006154911;5175.792968281226;5185.455527169593;5203.271541984125;4548.5906268436;4584.770761461914;4586.954130458719;4587.082583483317;4621.052684199798;6052.334243233241;6092.664903430265;6197.597156184834;6249.468795152372;6255.906161407583;6320.62076275425;6322.36776322364;6331.240251169889;6333.778317758856;6339.397757213057;6191.504679625619;6193.38066193377;6236.968815155986;6254;6254.562180647311;5600.719964001783;5620.156976453564;5627.43725627434;5628.493435590816;5649.209110724501;5249.3438320210735;6282.2147231596055;6598.670066496752;6635.336466353326;6723.327667233433;6397.392247736458;6410.262819775786;6411.679416029273;6414.326495717883;6424.871502570016;6648.83377915556;6652.700628471827;6713.12729345182;6723.226828914738;6731.32686731323;5198.792048318025;6207.317195108444;6280.937190628035;6283.842903927439;6346.174997250328;6321.11504389395;6372.6495042773095;6380.425761681471;6384.968075159594;6412.23053233615;6291.559590828598;6294.213223347082;6308.179936608211;6309.085182648582;6310.368963103653;6120.785772497941;6159.23009623797;6200.596961197508;6264.185655864709;6291.653959032297;6058.909116363347;6145.740123274807;6158.261008678987;6207.286162091417;6221.626702397871;6385.169927909528;6402.775902843378;6410.839729006812;6421.743130274736;6434.64609446485;5989.880202396015;6027.849303767441;6041.2750469943885;6134.099846298167;6192.164057852132 05:15:03 INFO - PROCESS | 1642 | |1;ext.html;766.7048186448219;803.5058439059978;821.1993306526136;902.2466240689021;912.4388501071835;26195.2141435757;38964.41553376698;41030;41262.793686031604;41275.380869286986;42917.7854110729;43240;43311.35032974508;43332.56667433325;43421.78289108558;7950.363970882345;9695.369800962933;9855.817301923778;9865.309428340019;9876.753081172992;8021.9197808022045;11803.763924721501;11878.46546905387;11889.7622047559;11893.821592676117;12086.033117350635;12087;12098;12119.515219391214;12123.878761212407;12003.93998030013;12035.578754743541;12042.0366370691;12052.819207711891;12056.63830085099;11738.119641026957;11756.470958806874;11765.705857353549;11788.941055294668;11789.05687545003;40399.7980010098;40632;40684.389734153716;40726.592734072874;40822.38766418506;3969.146633473817;4012.578679238667;4012.7391719538136;4015.13674559971;4049.2306461772464;29100.8544957276;29401.70598294011;29735.40529189404;30291.242718931982;30987.070387888398;3233.466478031122;3284.2282063715006;3312.8840490582716;3433.9313213735836;3439.1230236289834;356868;358992;359721;360591;361136;54041.729791350794;54056.729716351954;54169.45830541723;54255.45744542583;54268.72865635646;56380;56410;56419;56453.15320270199;56679;15453.845461545241;15918.124503152438;15927.124008179662;15929.442469513511;15984.840151598335;12169;12231.755364892651;12389.876101239053;13541.526046588519;13544.322783860767;12743.93628031854;12947.287899165449;13046.347682615831;13058.412371443308;13154.539591114266;5556.361018482846;5604.187392828098;5608.383077861432;5640.71796410186;5658.801941932013;949.7578117580111;1008.6973907827622;1093.561966014688;1156.3177725142207;1189.6668932698858;27280;27385;27415.588766168523;27738.3065423362;27963.741631626217;1272.4210484229654;1274.751423472414;1278.7634287656813;1300.4993077665167;1324.344449497505;14183.219922904133;14298.142111473346;14433.566992990227;14482.275886205647;14591;458904;460057;460228.6988565036;460748;461561;57879.710601447565;57907.71046144827;58104.709476453194;58132.4186758127;58160.836783264094;1483.8293596236572;1497.0269324939095;1509.1850400783892;1513.160196091158;1519.369461673393;27364;28309.77740516005;28388.85805570959;28595;28733.706983185388;38913.805430972665;38950;38957;38959.6104038956;39118;441325;445205;445381;445630;446232.5376746191;20113.597728045064;26818.463630726885;27065.72934270632;30928.53607195849;31218.907338243054;32644.34711305808;32700.69197232179;32729.18177045593;32920.34159316848;38174.236515270095;24637.753622463544;27561;28836.567451487826;29135.125946221648;30081.54877676793;26873.596896046183;27569.586456203575;29371.11886643404;29588.704112958596;30125.246868828453;33297;34261;34348.82825585856;34393.656063440045;34475.965721028406;29247.702235515753;29329.706702932697;29533.966311179007;30016.84991575028;30092.54861177128;16559.586010349354;22954.770452295263;23454.179103731287;23762.64342541834;24110.758892410853 05:15:03 INFO - PROCESS | 1642 | |2;jquery.html;418.50616272798084;428.4223076428363;433.26561478294286;440.6849102891432;442.6016585073435;21160.89419552902;22099.337019889408;22245.887705614714;23142.032927201166;23435.062597496122;22176.77823221767;22686.092556297768;22753.431164220863;23665.645015324742;23938.04247830089;6876.96561517193;6932.653367331638;6975.895361569581;7281.599512026836;7606.277403646673;7285.380742636882;7591.620418979057;7633.3893288537065;7640.923590764077;7664.731734389297;7745.496542724733;7747.457677962545;7751.147373788879;7768.135647444629;7768.650410731502;7486.812829679247;7686.5772382518935;7799.649015794303;7801.921980780205;7828.256315650005;6188.84527886802;7217.3865221456235;7398.4081273497995;7591.506552074097;7603.9619801900635;22348;27279.45441091187;27406.862965685043;27459.725402746117;27737.306567335778;2572.9099481518056;3129.9687003129907;3310.966890331114;3561.786292822439;3598.1184609770776;15726.74186065112;15893.841061589468;16059.759103613454;16143.838561614351;16483.58791030222;1777.5200695812186;2147.795959383856;2190.1020581561643;2205.4927366705588;2212.2588932707563;110566.44716776445;131558.6844131556;132517;134994.3250283752;158292.4170758289;17569;20091.799082008994;20224.887631180427;20536.281230156874;20986.685199722015;32506.349873002408;33090;33160.834195829346;33203;33235.335293293996;10486.05625493694;10630.25588208818;10854.07740342064;10873.456327183609;11021.44892755359;9038.09619038104;9049.502277374675;9052.683156089637;9203.815923681623;9204.631814727336;7908.52548847071;8015.238552337519;9619.951900240454;9648.855267170999;9824.361416507903;3341.8496167672515;3767.1523907120677;3947.348687466536;3975.741576797499;3985.7608543487486;623.4949690750507;688.3185646210216;857.5197889182078;904.7964208053136;1005.939643621385;20214.494637634176;21585.67621485679;21620.243291484723;21695;21779.564408711736;1006.4313662780652;1017.4251547875426;1037.273908264218;1052.8736551613856;1059.332620449112;11178.776424471627;11518.88481115195;11559.248648837798;11572.537098516133;11575;525285;723766;735012;739456;755888;148340;148376;152646;153108;158066;1307.1111644082116;1321.5110409148485;1343.4559003603752;1346.9865301347056;1349.6693310138883;18665.44003679892;19601.31395401154;19621.70567441461;19658.21367145298;19660.918649474417;62317.688411559466;63998;64736;64859.67570162119;65477;90353.54823225841;91526.54236728774;91772.62341065022;91821.54089229512;93167.58464159288;11713.41432928333;11719.589814356457;11848.76302473963;11894.524219031142;12094.274343539415;12863.871361286267;13280.667983300495;13300.667483312607;13594.184348939096;14202.573922782332;11580;11792.646220613395;12136.75726485483;12168.965637920875;12179.269243845398;9287.746154269087;9632.95183524078;9666.130048295687;9712.02879712023;10080.395176289447;10789.082927951213;11817.231879927776;11883.405829708652;12171.026317894724;12250.571230006906;12015.279083255033;12070.27578345302;12092.818607721067;12115.212511186744;12437.315947622606;11749.118816088656;11834.289942603471;11952.462139203582;11973.221740586834;11999.08014717641 05:15:03 INFO - PROCESS | 1642 | |3;mootools.html;1579.1630435868985;1603.3987254779458;1623.2776414495547;1649.983500164998;1657.6353202295497;10733.40966246856;11374.317540947528;11388.259763115402;11398.25911315766;11415.143864210197;10773.299735517186;11055.170862185349;11064.502097405615;11243.550257989691;11276.4361781911;2450.2894160693377;2493.5386953413586;2496.1263557754733;2497.8376405533672;2507.2227609441043;2442.7435119312395;2463.6304554316907;2505.686789151356;2508.535920854639;2510.5230006298834;2443.875817124125;2452.534018536481;2465.4206261528525;2494.114589320792;2500.862452565117;2432.513497300547;2439.5852705040184;2453.0678342229926;2465.5438743832447;2489.5892177790643;2080.958380832375;2419.189571493534;2457;2458.987705061481;2464.938376540601;11250.887491125148;11316.717082072932;11347.886521134847;11352.659420217407;11369.658910232707;5929.0513517836935;6116.327204007555;6125.264968203799;6127.988881834492;6132.50939924805;3548.308079924416;3566.251087271676;3662.047867554455;3741.9625803741887;3783.3000894834267;1206.4691535724253;1210.860751013636;1247.1830950727287;1269.225772278909;1285.0233822295122;13729.244891530961;13967.720645587133;14339.856601434061;15425.922870385688;15597.766033509393;4912.238603016538;5125.384953805493;5171.069207542603;5176.430592634807;5191.377034755854;11943.820842687366;12154.939225303817;12428.440720167615;12566.931810796003;12935.28855912915;5990.281166260077;6119.020956647004;6162.014077747539;6169.136320915076;6209.441150296495;5282.788688452419;5310.4424035476495;5416.756245968941;5430.22519580619;5488.313960754906;4156.501219853637;4237.597428244312;4257.57424257578;4298.075913678512;4312.633426158812;1153.1985270237105;1167.0605162843992;1168.7779321928977;1184.7452797648375;1185.8102703567388;834.8246868157755;962.74550504601;965.6958058211641;968.3899143539525;1020.132887046005;6592.17597800275;6610.30591787865;6616.4376028037195;6863.862722745617;6881.65591720412;948.2698322291934;953.3183773601908;993.9950300248597;1032.5405194688442;1044.5926088825365;4011.1376054147913;4113.280175969194;4258.808353624095;4392.978035109804;4412.580804823537;13345.599632011055;13949.58151255464;13975.79036314456;13993.950453716012;14029.78955315671;12534.74930501385;12825.422855971503;13352.599422017354;13879.167249965034;13921.443142274196;10033.297669163234;10121.39271643689;10270.640527581649;10373.948130259301;10454.42500662471;6787.5588086774205;6865.656717164022;6907.447404207752;7023.438124950094;7111.53775004623;11140.944295278472;11324.886751132713;11394.917482839117;12418.254904705747;12620.936895315832;11247.100231981585;12559.183653062522;12801.423935923092;12905.548305809252;13103.67240818949;9389.24886009104;9508.952455237679;9584.424934503952;9586.28102892272;9588.232941364535;10398.532066056894;10412.167026638002;10417.114545263434;10527.999840015187;10530.31552949056;9025.458472491671;9040.141186587263;9089.227415669742;9145.954270228607;9177.265818734619;8802.295816334807;8837.911620883966;8913.420627659181;8937.508437036025;8949;7844.725434609762;8011.719589814328;8212.876806847782;8231.135730748185;8288.254057134887;5927.762889484372;5965.28416590012;5984.551158663205;6062.848428789139;6152.230971128609;6000.51995840323;6134.35589263121;6136.110264011604;6229.7714453847075;6267.341929097379 05:15:03 INFO - PROCESS | 1642 | |4;prototype.html;343.7044142037848;373.25721813590945;388.2429262937273;388.6657474571868;395.91092004299026;4818.734969576672;4963.801447942083;4969.826056088038;5062.696238225709;5217.5565076968505;4172.916541669165;4226.45056142701;4514.322851572266;4858.222684370501;4945.505449455061;4109.609587089237;4231.238377092122;4234.644913627641;4250.744955302692;4265.698961816653;3733.328000959826;3857.3635350167187;3905.7461265017823;4254.383773792268;4303.54812744662;3976.005998500375;3995.240904228202;4278.61492465678;4299.441072660566;4301.483821941371;3701.000729802965;3807.8857634271017;3991.9201615967663;4162.604552567516;4349.064951035542;3496.2657841853243;3927.5483319418345;3935.2719746846637;3940.645341919241;3970.3845903884944;4372.868813935587;4606.591122569308;4931.901361972777;4936.555709986119;4952.727599981999;4655.7439340836245;4888.560029597318;4901.460839307673;4922.655414121013;4930.8520744377365;4519.525449827754;5131.897362052738;5354.5180933715765;5425.430329815352;5459.727013649302;3723.7579557328686;3979.7413168144267;4314.017310006947;4394.2969124939855;4447.621952134073;5248.580113590903;5469.343678758534;5631.746571404296;5679;5830.970845145789;4128.793560321972;4373.431453910971;4422.447194100738;4430.800613972379;4442.400275962768;3995.420664003703;4160.750354978651;4518.289026584089;4531.342955271467;4538.364628951949;4341.5007274163245;4618.660588429385;4701.566022363212;4725.716457012591;4859.586935110555;4936.456989731127;4948.703077815343;5034.320366750515;5405.459434065982;5408.729563521808;1354.525915929417;1411.792917055923;1487.2935355705954;1503.8270598881268;1514.7273490771768;883.8276536075404;995.1988649137514;1155.439611788282;1159.9942000289946;1180.4687890449331;4604.651627669846;4690.507496712864;4860.205381905418;4916.606671466274;5268.894622107537;4754.619630429557;5335.546478549367;5336.493033161843;5626.578006649518;5646.830595082154;4681.789319480631;4911.926321105187;5099.5410413063;5113.463086375877;5184.7407629618365;2682.9597556036674;2781.91356482638;2791.860406979643;2920.8754629467385;2924.0789151417234;4667.6732628716345;5281.894362112736;5851.32709738377;5882.646891271934;5896.823095307148;4769.618430525549;5289.994900968881;5710.343310519261;5783.624064435882;5789.507891829242;4962.280469331927;4980;5770.682612456271;5867.442592953663;5867.618604790675;4389.53909839475;5611.354694210055;5617.522510586646;5628;5639.351474580476;5313.282706834528;5495.560355171657;5541.251930989265;5548.334199895877;5561.165825126263;4586.449626044896;5697.040556812975;5740;5884.382139875252;5915.970420148044;4066.7153299268766;4312.504062032906;4496.460424749051;4560.582891067739;4567.817287308603;4498.617617502418;4817.89188486643;5100.322330776224;5332.893342133058;5675.971620141873;4734.360861283821;4829.420469543677;4869.342638743724;5455.790404886027;5482.698451585201;4868.4177642265695;5241.68549887008;5404.945950540444;5433.809816656398;5473.945260547343;3931.6264954829244;5094.2103973884105;5283.498067683564;5379.789547351815;5446.373667028342;4689.577937985598;4793.6031984008;4892.804287828447;5465.562754979672;5469.316335458067;4086.1214838809797;4709.599684026759;4850.345203397637;5187.636865419536;5314.601404894725 05:15:03 INFO - PROCESS | 1642 | |5;yui.html;779.8167430653799;793.4326956226297;823.1562648285503;877.4296707140358;887.6271965774374;16452.588685282873;17312.22095005728;17364.131793410343;17404.65190696185;17425.825741742596;13305.467781288737;15756.212189390513;15877.285522151502;15953.521394358158;15993.440229591937;947.5830634520789;964.7346979580619;1000.8798944126715;1002.6340385759219;1023.6673081248587;1014.0923873133578;1015.664830605902;1015.9687916764453;1017.2218253036433;1019.7858449725529;1056.8309070548714;1057.5505410200672;1058.9629362972298;1060.42736922062;1061.0927656853396;944.2021491839454;973.9269554783419;1051.5215576912487;1052.021619893495;1052.8999745024248;785.6150486261748;787.000509353124;787.4881327137407;788.2078511096312;789.1122487201898;17039;17082.14589270544;17098.487045388658;17649.470515884543;17933.461996140137;14503;14787.334569944378;14847.777283340758;14868.553943381608;15130.394784208618;11742.354170520617;11943.522259109712;12016.835467511424;12284.447199875938;12361.196522226026;3457.94813077804;3563.768355056913;3585.2470981094;3691.741578089535;3768.5854555998817;85013.72479412814;103475.48262258715;119003.809961901;119744.40127799305;121914.17128743076;9313.813723725487;9820.4107753535;9872.308938374388;11609.678064387157;11728.824067638992;23991.28026159218;24221.394465138514;24278;24289.27132186037;24757.2572822812;7550.640884640818;7845.882311765328;7904.1700621435075;8107.067687215927;8340.62467188978;4438.578335058164;4445.711028783118;4538.591526762607;4553.567411095941;4627.074585082997;3242.7081562659473;3313.0226583157546;3332.283559034819;3348.3303339332233;3350.64818194091;584.7602482981957;586.7506309818395;594.7799314253667;600.8948434024028;601.3955974245943;552.6380220955281;667.2160211751172;669.1201070592156;683.2893790457967;686.7870960002415;9789.9021009789;10010.64962726301;10103;10193.847092293621;10373.118284945864;658.0715814624938;670.5406796344422;677.2820809941478;693.9722411103601;719.6653556096336;4197.3074442717225;4265.232258193493;4283.250431174532;4285.671501732011;4423.889402764892;81647.59176204081;81889.67717098488;82418.76371854427;98581;107257.39113913297;51004.74497627488;70059;75500.24499754932;80858.78711819327;98170.52744208842;62458.750824984156;65883;66154.66922665355;77101.99999999888;78223;10901.400422976496;11271.774564508827;11341.716457088638;11448.82826757616;11572.94213528927;45455.31817022681;46300.7684961573;46540;46745;46864;59826;59860.70069649624;60130;60145;60206.397936020076;12482.375881205722;12899.161554498927;12904.8064279034;13225.206487610389;13464.326783660974;14503.492377766728;14880.255987200813;15428.614284642525;15543.98964067332;15954.760678589599;13468.818687452742;14185;14361.353739081558;14534.563963081124;14677;13187;14012.719745605234;14076;14079.929600351932;14090.154590724589;13186.340682966005;13641.931790340985;13948.314819710286;13988.300584970508;13992.300384980506;9778.9022109778;10316.17470602335;10367.32612380193;10533.210009249184;10662.040416362564;9400.717978460658;9991.700248992542;10725.41010244444;11394.316341019565;11620.593279235187 05:15:03 INFO - PROCESS | 1642 | __end_tp_report 05:15:03 INFO - PROCESS | 1642 | __start_cc_report 05:15:03 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1462 05:15:03 INFO - PROCESS | 1642 | __end_cc_report 05:15:03 INFO - PROCESS | 1642 | __startTimestamp1492690503063__endTimestamp 05:15:03 INFO - PROCESS | 1642 | 05:15:03 INFO - PROCESS | 1642 | ------- Summary: start ------- 05:15:03 INFO - PROCESS | 1642 | Number of tests: 6 05:15:03 INFO - PROCESS | 1642 | 05:15:03 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5911.94 Median:6192.16 stddev:666.79 (10.8%) stddev-sans-first:641.37 05:15:03 INFO - PROCESS | 1642 | Values: 3497.7 3498.4 3504.3 3517.1 3525.0 5841.8 5909.9 5920.4 5921.3 5988.5 5872.3 5906.7 5906.9 5936.6 5947.5 5347.1 5364.8 5386.1 5395.4 5512.3 4370.0 5287.6 5303.0 5461.3 5466.4 5398.9 5410.0 5413.8 5418.9 5433.2 4350.8 5168.2 5391.8 5400.3 5404.5 5242.7 5347.8 5358.6 5369.4 5396.1 5933.9 5951.2 5958.4 5961.6 5964.0 6332.7 6335.6 6339.4 6350.1 6354.5 6279.1 6299.8 6304.7 6324.1 6336.2 5983.7 6004.0 6026.3 6047.6 6082.3 6275.9 6461.6 6510.5 6513.7 6515.2 6254.4 6278.8 6334.5 6359.1 6400.4 6362.0 6408.6 6412.3 6420.6 6425.1 5269.4 6137.0 6341.9 6356.5 6359.2 6103.6 6242.6 6290.2 6342.2 6352.4 5114.7 5132.9 5175.8 5185.5 5203.3 4548.6 4584.8 4587.0 4587.1 4621.1 6052.3 6092.7 6197.6 6249.5 6255.9 6320.6 6322.4 6331.2 6333.8 6339.4 6191.5 6193.4 6237.0 6254.0 6254.6 5600.7 5620.2 5627.4 5628.5 5649.2 5249.3 6282.2 6598.7 6635.3 6723.3 6397.4 6410.3 6411.7 6414.3 6424.9 6648.8 6652.7 6713.1 6723.2 6731.3 5198.8 6207.3 6280.9 6283.8 6346.2 6321.1 6372.6 6380.4 6385.0 6412.2 6291.6 6294.2 6308.2 6309.1 6310.4 6120.8 6159.2 6200.6 6264.2 6291.7 6058.9 6145.7 6158.3 6207.3 6221.6 6385.2 6402.8 6410.8 6421.7 6434.6 5989.9 6027.8 6041.3 6134.1 6192.2 05:15:03 INFO - PROCESS | 1642 | 05:15:03 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:55929.72 Median:30609.89 stddev:112401.69 (367.2%) stddev-sans-first:112640.70 05:15:03 INFO - PROCESS | 1642 | Values: 766.7 803.5 821.2 902.2 912.4 26195.2 38964.4 41030.0 41262.8 41275.4 42917.8 43240.0 43311.4 43332.6 43421.8 7950.4 9695.4 9855.8 9865.3 9876.8 8021.9 11803.8 11878.5 11889.8 11893.8 12086.0 12087.0 12098.0 12119.5 12123.9 12003.9 12035.6 12042.0 12052.8 12056.6 11738.1 11756.5 11765.7 11788.9 11789.1 40399.8 40632.0 40684.4 40726.6 40822.4 3969.1 4012.6 4012.7 4015.1 4049.2 29100.9 29401.7 29735.4 30291.2 30987.1 3233.5 3284.2 3312.9 3433.9 3439.1 356868.0 358992.0 359721.0 360591.0 361136.0 54041.7 54056.7 54169.5 54255.5 54268.7 56380.0 56410.0 56419.0 56453.2 56679.0 15453.8 15918.1 15927.1 15929.4 15984.8 12169.0 12231.8 12389.9 13541.5 13544.3 12743.9 12947.3 13046.3 13058.4 13154.5 5556.4 5604.2 5608.4 5640.7 5658.8 949.8 1008.7 1093.6 1156.3 1189.7 27280.0 27385.0 27415.6 27738.3 27963.7 1272.4 1274.8 1278.8 1300.5 1324.3 14183.2 14298.1 14433.6 14482.3 14591.0 458904.0 460057.0 460228.7 460748.0 461561.0 57879.7 57907.7 58104.7 58132.4 58160.8 1483.8 1497.0 1509.2 1513.2 1519.4 27364.0 28309.8 28388.9 28595.0 28733.7 38913.8 38950.0 38957.0 38959.6 39118.0 441325.0 445205.0 445381.0 445630.0 446232.5 20113.6 26818.5 27065.7 30928.5 31218.9 32644.3 32700.7 32729.2 32920.3 38174.2 24637.8 27561.0 28836.6 29135.1 30081.5 26873.6 27569.6 29371.1 29588.7 30125.2 33297.0 34261.0 34348.8 34393.7 34476.0 29247.7 29329.7 29534.0 30016.8 30092.5 16559.6 22954.8 23454.2 23762.6 24110.8 05:15:03 INFO - PROCESS | 1642 | 05:15:03 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:41460.39 Median:22296.94 stddev:116939.05 (524.5%) stddev-sans-first:117226.49 05:15:03 INFO - PROCESS | 1642 | Values: 418.5 428.4 433.3 440.7 442.6 21160.9 22099.3 22245.9 23142.0 23435.1 22176.8 22686.1 22753.4 23665.6 23938.0 6877.0 6932.7 6975.9 7281.6 7606.3 7285.4 7591.6 7633.4 7640.9 7664.7 7745.5 7747.5 7751.1 7768.1 7768.7 7486.8 7686.6 7799.6 7801.9 7828.3 6188.8 7217.4 7398.4 7591.5 7604.0 22348.0 27279.5 27406.9 27459.7 27737.3 2572.9 3130.0 3311.0 3561.8 3598.1 15726.7 15893.8 16059.8 16143.8 16483.6 1777.5 2147.8 2190.1 2205.5 2212.3 110566.4 131558.7 132517.0 134994.3 158292.4 17569.0 20091.8 20224.9 20536.3 20986.7 32506.3 33090.0 33160.8 33203.0 33235.3 10486.1 10630.3 10854.1 10873.5 11021.4 9038.1 9049.5 9052.7 9203.8 9204.6 7908.5 8015.2 9620.0 9648.9 9824.4 3341.8 3767.2 3947.3 3975.7 3985.8 623.5 688.3 857.5 904.8 1005.9 20214.5 21585.7 21620.2 21695.0 21779.6 1006.4 1017.4 1037.3 1052.9 1059.3 11178.8 11518.9 11559.2 11572.5 11575.0 525285.0 723766.0 735012.0 739456.0 755888.0 148340.0 148376.0 152646.0 153108.0 158066.0 1307.1 1321.5 1343.5 1347.0 1349.7 18665.4 19601.3 19621.7 19658.2 19660.9 62317.7 63998.0 64736.0 64859.7 65477.0 90353.5 91526.5 91772.6 91821.5 93167.6 11713.4 11719.6 11848.8 11894.5 12094.3 12863.9 13280.7 13300.7 13594.2 14202.6 11580.0 11792.6 12136.8 12169.0 12179.3 9287.7 9633.0 9666.1 9712.0 10080.4 10789.1 11817.2 11883.4 12171.0 12250.6 12015.3 12070.3 12092.8 12115.2 12437.3 11749.1 11834.3 11952.5 11973.2 11999.1 05:15:03 INFO - PROCESS | 1642 | 05:15:03 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:6873.61 Median:2495.12 stddev:4189.62 (167.9%) stddev-sans-first:4182.48 05:15:03 INFO - PROCESS | 1642 | Values: 1579.2 1603.4 1623.3 1650.0 1657.6 10733.4 11374.3 11388.3 11398.3 11415.1 10773.3 11055.2 11064.5 11243.6 11276.4 2450.3 2493.5 2496.1 2497.8 2507.2 2442.7 2463.6 2505.7 2508.5 2510.5 2443.9 2452.5 2465.4 2494.1 2500.9 2432.5 2439.6 2453.1 2465.5 2489.6 2081.0 2419.2 2457.0 2459.0 2464.9 11250.9 11316.7 11347.9 11352.7 11369.7 5929.1 6116.3 6125.3 6128.0 6132.5 3548.3 3566.3 3662.0 3742.0 3783.3 1206.5 1210.9 1247.2 1269.2 1285.0 13729.2 13967.7 14339.9 15425.9 15597.8 4912.2 5125.4 5171.1 5176.4 5191.4 11943.8 12154.9 12428.4 12566.9 12935.3 5990.3 6119.0 6162.0 6169.1 6209.4 5282.8 5310.4 5416.8 5430.2 5488.3 4156.5 4237.6 4257.6 4298.1 4312.6 1153.2 1167.1 1168.8 1184.7 1185.8 834.8 962.7 965.7 968.4 1020.1 6592.2 6610.3 6616.4 6863.9 6881.7 948.3 953.3 994.0 1032.5 1044.6 4011.1 4113.3 4258.8 4393.0 4412.6 13345.6 13949.6 13975.8 13994.0 14029.8 12534.7 12825.4 13352.6 13879.2 13921.4 10033.3 10121.4 10270.6 10373.9 10454.4 6787.6 6865.7 6907.4 7023.4 7111.5 11140.9 11324.9 11394.9 12418.3 12620.9 11247.1 12559.2 12801.4 12905.5 13103.7 9389.2 9509.0 9584.4 9586.3 9588.2 10398.5 10412.2 10417.1 10528.0 10530.3 9025.5 9040.1 9089.2 9146.0 9177.3 8802.3 8837.9 8913.4 8937.5 8949.0 7844.7 8011.7 8212.9 8231.1 8288.3 5927.8 5965.3 5984.6 6062.8 6152.2 6000.5 6134.4 6136.1 6229.8 6267.3 05:15:03 INFO - PROCESS | 1642 | 05:15:03 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4484.96 Median:4824.08 stddev:1255.89 (26.0%) stddev-sans-first:1220.34 05:15:03 INFO - PROCESS | 1642 | Values: 343.7 373.3 388.2 388.7 395.9 4818.7 4963.8 4969.8 5062.7 5217.6 4172.9 4226.5 4514.3 4858.2 4945.5 4109.6 4231.2 4234.6 4250.7 4265.7 3733.3 3857.4 3905.7 4254.4 4303.5 3976.0 3995.2 4278.6 4299.4 4301.5 3701.0 3807.9 3991.9 4162.6 4349.1 3496.3 3927.5 3935.3 3940.6 3970.4 4372.9 4606.6 4931.9 4936.6 4952.7 4655.7 4888.6 4901.5 4922.7 4930.9 4519.5 5131.9 5354.5 5425.4 5459.7 3723.8 3979.7 4314.0 4394.3 4447.6 5248.6 5469.3 5631.7 5679.0 5831.0 4128.8 4373.4 4422.4 4430.8 4442.4 3995.4 4160.8 4518.3 4531.3 4538.4 4341.5 4618.7 4701.6 4725.7 4859.6 4936.5 4948.7 5034.3 5405.5 5408.7 1354.5 1411.8 1487.3 1503.8 1514.7 883.8 995.2 1155.4 1160.0 1180.5 4604.7 4690.5 4860.2 4916.6 5268.9 4754.6 5335.5 5336.5 5626.6 5646.8 4681.8 4911.9 5099.5 5113.5 5184.7 2683.0 2781.9 2791.9 2920.9 2924.1 4667.7 5281.9 5851.3 5882.6 5896.8 4769.6 5290.0 5710.3 5783.6 5789.5 4962.3 4980.0 5770.7 5867.4 5867.6 4389.5 5611.4 5617.5 5628.0 5639.4 5313.3 5495.6 5541.3 5548.3 5561.2 4586.4 5697.0 5740.0 5884.4 5916.0 4066.7 4312.5 4496.5 4560.6 4567.8 4498.6 4817.9 5100.3 5332.9 5676.0 4734.4 4829.4 4869.3 5455.8 5482.7 4868.4 5241.7 5404.9 5433.8 5473.9 3931.6 5094.2 5283.5 5379.8 5446.4 4689.6 4793.6 4892.8 5465.6 5469.3 4086.1 4709.6 4850.3 5187.6 5314.6 05:15:03 INFO - PROCESS | 1642 | 05:15:03 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:19642.02 Median:24249.70 stddev:27304.21 (112.6%) stddev-sans-first:27344.07 05:15:03 INFO - PROCESS | 1642 | Values: 779.8 793.4 823.2 877.4 887.6 16452.6 17312.2 17364.1 17404.7 17425.8 13305.5 15756.2 15877.3 15953.5 15993.4 947.6 964.7 1000.9 1002.6 1023.7 1014.1 1015.7 1016.0 1017.2 1019.8 1056.8 1057.6 1059.0 1060.4 1061.1 944.2 973.9 1051.5 1052.0 1052.9 785.6 787.0 787.5 788.2 789.1 17039.0 17082.1 17098.5 17649.5 17933.5 14503.0 14787.3 14847.8 14868.6 15130.4 11742.4 11943.5 12016.8 12284.4 12361.2 3457.9 3563.8 3585.2 3691.7 3768.6 85013.7 103475.5 119003.8 119744.4 121914.2 9313.8 9820.4 9872.3 11609.7 11728.8 23991.3 24221.4 24278.0 24289.3 24757.3 7550.6 7845.9 7904.2 8107.1 8340.6 4438.6 4445.7 4538.6 4553.6 4627.1 3242.7 3313.0 3332.3 3348.3 3350.6 584.8 586.8 594.8 600.9 601.4 552.6 667.2 669.1 683.3 686.8 9789.9 10010.6 10103.0 10193.8 10373.1 658.1 670.5 677.3 694.0 719.7 4197.3 4265.2 4283.3 4285.7 4423.9 81647.6 81889.7 82418.8 98581.0 107257.4 51004.7 70059.0 75500.2 80858.8 98170.5 62458.8 65883.0 66154.7 77102.0 78223.0 10901.4 11271.8 11341.7 11448.8 11572.9 45455.3 46300.8 46540.0 46745.0 46864.0 59826.0 59860.7 60130.0 60145.0 60206.4 12482.4 12899.2 12904.8 13225.2 13464.3 14503.5 14880.3 15428.6 15544.0 15954.8 13468.8 14185.0 14361.4 14534.6 14677.0 13187.0 14012.7 14076.0 14079.9 14090.2 13186.3 13641.9 13948.3 13988.3 13992.3 9778.9 10316.2 10367.3 10533.2 10662.0 9400.7 9991.7 10725.4 11394.3 11620.6 05:15:03 INFO - PROCESS | 1642 | -------- Summary: end -------- 05:15:03 INFO - PROCESS | 1642 | 05:15:03 INFO - TEST-INFO | 1642: exit 0 05:15:03 INFO - TEST-OK | dromaeo_css | took 1117854ms 05:15:03 INFO - TEST-START | kraken 05:15:03 INFO - operating with platform_type : mac_ 05:15:03 INFO - Initialising browser for kraken test... 05:15:03 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpKL2mZp/profile http://localhost:49241/getInfo.html) 05:15:05 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 05:15:05 INFO - PROCESS | 1653 | colorDepth:24 05:15:05 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 05:15:05 INFO - PROCESS | 1653 | __metrics 05:15:06 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:15:06 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:15:06 INFO - TEST-INFO | 1653: exit 0 05:15:06 INFO - Browser initialized. 05:15:06 INFO - Running cycle 1/1 for kraken test... 05:15:06 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpKL2mZp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:18 INFO - PROCESS | 1655 | RSS: Main: 165138432 05:15:18 INFO - PROCESS | 1655 | 05:15:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:15:22 INFO - PROCESS | 1655 | RSS: Main: 216285184 05:15:22 INFO - PROCESS | 1655 | 05:15:24 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:15:25 INFO - PROCESS | 1655 | RSS: Main: 231792640 05:15:25 INFO - PROCESS | 1655 | 05:15:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:15:29 INFO - PROCESS | 1655 | RSS: Main: 328564736 05:15:29 INFO - PROCESS | 1655 | 05:15:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:15:31 INFO - PROCESS | 1655 | RSS: Main: 231079936 05:15:31 INFO - PROCESS | 1655 | 05:15:33 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:15:34 INFO - PROCESS | 1655 | RSS: Main: 232636416 05:15:34 INFO - PROCESS | 1655 | 05:15:37 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:15:38 INFO - PROCESS | 1655 | RSS: Main: 272916480 05:15:38 INFO - PROCESS | 1655 | 05:15:41 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:15:41 INFO - PROCESS | 1655 | RSS: Main: 272646144 05:15:41 INFO - PROCESS | 1655 | 05:15:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:15:45 INFO - PROCESS | 1655 | RSS: Main: 270073856 05:15:45 INFO - PROCESS | 1655 | 05:15:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:15:47 INFO - PROCESS | 1655 | RSS: Main: 248094720 05:15:47 INFO - PROCESS | 1655 | 05:15:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:15:50 INFO - PROCESS | 1655 | RSS: Main: 252547072 05:15:50 INFO - PROCESS | 1655 | 05:15:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:15:52 INFO - PROCESS | 1655 | RSS: Main: 261083136 05:15:52 INFO - PROCESS | 1655 | 05:15:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:15:56 INFO - PROCESS | 1655 | RSS: Main: 274452480 05:15:56 INFO - PROCESS | 1655 | 05:15:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:16:00 INFO - PROCESS | 1655 | RSS: Main: 267788288 05:16:00 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:16:01 INFO - PROCESS | 1655 | RSS: Main: 312360960 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | __start_tp_report 05:16:01 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 05:16:01 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 05:16:01 INFO - PROCESS | 1655 | |i|pagename|runs| 05:16:01 INFO - PROCESS | 1655 | |0;ai-astar;108;117;118;116;115;118;116;117;117;116 05:16:01 INFO - PROCESS | 1655 | |1;audio-beat-detection;148;108;110;143;110;109;109;105;128;109 05:16:01 INFO - PROCESS | 1655 | |2;audio-dft;186;183;183;185;182;186;183;184;184;184 05:16:01 INFO - PROCESS | 1655 | |3;audio-fft;82;59;65;125;86;69;57;58;75;58 05:16:01 INFO - PROCESS | 1655 | |4;audio-oscillator;85;69;87;70;68;68;81;69;68;83 05:16:01 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;88;88;89;88;89;88;88;89;89;89 05:16:01 INFO - PROCESS | 1655 | |6;imaging-darkroom;94;94;102;146;100;94;95;93;93;93 05:16:01 INFO - PROCESS | 1655 | |7;imaging-desaturate;105;130;131;82;86;86;99;138;108;83 05:16:01 INFO - PROCESS | 1655 | |8;json-parse-financial;62;59;59;59;62;63;63;62;63;64 05:16:01 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;61;58;55;66;58;58;57;62;57;58 05:16:01 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;80;80;84;84;81;84;81;82;87;87 05:16:01 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;137;136;144;132;133;133;132;152;188;158 05:16:01 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;161;159;163;159;158;158;154;161;212;197 05:16:01 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;63;64;64;64;64;65;64;63;62;62 05:16:01 INFO - PROCESS | 1655 | __end_tp_report 05:16:01 INFO - PROCESS | 1655 | __start_cc_report 05:16:01 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2040 05:16:01 INFO - PROCESS | 1655 | __end_cc_report 05:16:01 INFO - PROCESS | 1655 | __startTimestamp1492690561970__endTimestamp 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | ------- Summary: start ------- 05:16:01 INFO - PROCESS | 1655 | Number of tests: 14 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:115.80 Median:117.00 stddev:2.90 (2.5%) stddev-sans-first:1.00 05:16:01 INFO - PROCESS | 1655 | Values: 108.0 117.0 118.0 116.0 115.0 118.0 116.0 117.0 117.0 116.0 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:117.90 Median:110.00 stddev:15.86 (14.4%) stddev-sans-first:12.54 05:16:01 INFO - PROCESS | 1655 | Values: 148.0 108.0 110.0 143.0 110.0 109.0 109.0 105.0 128.0 109.0 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:1.33 (0.7%) stddev-sans-first:1.20 05:16:01 INFO - PROCESS | 1655 | Values: 186.0 183.0 183.0 185.0 182.0 186.0 183.0 184.0 184.0 184.0 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:73.40 Median:67.00 stddev:20.92 (31.2%) stddev-sans-first:21.96 05:16:01 INFO - PROCESS | 1655 | Values: 82.0 59.0 65.0 125.0 86.0 69.0 57.0 58.0 75.0 58.0 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:74.80 Median:75.50 stddev:8.08 (10.7%) stddev-sans-first:7.68 05:16:01 INFO - PROCESS | 1655 | Values: 85.0 69.0 87.0 70.0 68.0 68.0 81.0 69.0 68.0 83.0 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:89.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 05:16:01 INFO - PROCESS | 1655 | Values: 88.0 88.0 89.0 88.0 89.0 88.0 88.0 89.0 89.0 89.0 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:100.40 Median:93.50 stddev:16.32 (17.5%) stddev-sans-first:17.15 05:16:01 INFO - PROCESS | 1655 | Values: 94.0 94.0 102.0 146.0 100.0 94.0 95.0 93.0 93.0 93.0 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:104.80 Median:82.50 stddev:21.52 (26.1%) stddev-sans-first:22.83 05:16:01 INFO - PROCESS | 1655 | Values: 105.0 130.0 131.0 82.0 86.0 86.0 99.0 138.0 108.0 83.0 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:62.50 stddev:1.90 (3.0%) stddev-sans-first:2.01 05:16:01 INFO - PROCESS | 1655 | Values: 62.0 59.0 59.0 59.0 62.0 63.0 63.0 62.0 63.0 64.0 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:58.00 stddev:3.16 (5.5%) stddev-sans-first:3.27 05:16:01 INFO - PROCESS | 1655 | Values: 61.0 58.0 55.0 66.0 58.0 58.0 57.0 62.0 57.0 58.0 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:84.00 stddev:2.62 (3.1%) stddev-sans-first:2.55 05:16:01 INFO - PROCESS | 1655 | Values: 80.0 80.0 84.0 84.0 81.0 84.0 81.0 82.0 87.0 87.0 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:140.50 stddev:17.75 (12.6%) stddev-sans-first:18.62 05:16:01 INFO - PROCESS | 1655 | Values: 137.0 136.0 144.0 132.0 133.0 133.0 132.0 152.0 188.0 158.0 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:161.00 stddev:19.60 (12.2%) stddev-sans-first:20.62 05:16:01 INFO - PROCESS | 1655 | Values: 161.0 159.0 163.0 159.0 158.0 158.0 154.0 161.0 212.0 197.0 05:16:01 INFO - PROCESS | 1655 | 05:16:01 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 05:16:01 INFO - PROCESS | 1655 | Values: 63.0 64.0 64.0 64.0 64.0 65.0 64.0 63.0 62.0 62.0 05:16:01 INFO - PROCESS | 1655 | -------- Summary: end -------- 05:16:01 INFO - PROCESS | 1655 | 05:16:02 INFO - TEST-INFO | 1655: exit 0 05:16:02 INFO - TEST-OK | kraken | took 59170ms 05:16:02 INFO - SUITE-END | took 1177s 05:16:03 INFO - Completed test suite (00:19:37) 05:16:03 INFO - javascript benchmark 05:16:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7779.906491392468, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3497.702695270902, 3498.387782138126, 3504.2816222674337, 3517.120719820045, 3525.03061658044, 5841.766329346821, 5909.940900590993, 5920.437558431953, 5921.289445266563, 5988.461038506533, 5872.295324561059, 5906.704664766766, 5906.88186236275, 5936.643801371921, 5947.494462970652, 5347.1177255752755, 5364.758585863646, 5386.111291636876, 5395.433479484656, 5512.283403157584, 4370.0, 5287.603429742765, 5302.992431438014, 5461.262729531502, 5466.371367292752, 5398.91901621476, 5410.026195284847, 5413.810516631918, 5418.864528386802, 5433.212184233284, 4350.8042138103865, 5168.198929165986, 5391.757370918318, 5400.29796126505, 5404.540614047811, 5242.7378631068295, 5347.786088556453, 5358.624896257264, 5369.40936496985, 5396.055690254189, 5933.851653708649, 5951.22634057574, 5958.433948774859, 5961.612495187799, 5963.98612235921, 6332.746690132389, 6335.5565110442285, 6339.36606339367, 6350.0792385103905, 6354.523410744213, 6279.089532017878, 6299.842503937438, 6304.684765761694, 6324.08300796382, 6336.20797400325, 5983.670898100603, 6003.969980150071, 6026.309257880367, 6047.5766696331275, 6082.330943596201, 6275.937240627627, 6461.6446095464735, 6510.479161667055, 6513.73945042193, 6515.185601799775, 6254.3745625437095, 6278.780242691484, 6334.493240540745, 6359.141515895388, 6400.423961843363, 6362.0, 6408.61548307103, 6412.3267056959285, 6420.6147631142285, 6425.132607097982, 5269.367675878919, 6137.048757442603, 6341.8731625368155, 6356.459700925473, 6359.20509936258, 6103.6032657877095, 6242.563020588515, 6290.21372328459, 6342.238931328178, 6352.428281454691, 5114.693118412907, 5132.923006154911, 5175.792968281226, 5185.455527169593, 5203.271541984125, 4548.5906268436, 4584.770761461914, 4586.954130458719, 4587.082583483317, 4621.052684199798, 6052.334243233241, 6092.664903430265, 6197.597156184834, 6249.468795152372, 6255.906161407583, 6320.62076275425, 6322.36776322364, 6331.240251169889, 6333.778317758856, 6339.397757213057, 6191.504679625619, 6193.38066193377, 6236.968815155986, 6254.0, 6254.562180647311, 5600.719964001783, 5620.156976453564, 5627.43725627434, 5628.493435590816, 5649.209110724501, 5249.3438320210735, 6282.2147231596055, 6598.670066496752, 6635.336466353326, 6723.327667233433, 6397.392247736458, 6410.262819775786, 6411.679416029273, 6414.326495717883, 6424.871502570016, 6648.83377915556, 6652.700628471827, 6713.12729345182, 6723.226828914738, 6731.32686731323, 5198.792048318025, 6207.317195108444, 6280.937190628035, 6283.842903927439, 6346.174997250328, 6321.11504389395, 6372.6495042773095, 6380.425761681471, 6384.968075159594, 6412.23053233615, 6291.559590828598, 6294.213223347082, 6308.179936608211, 6309.085182648582, 6310.368963103653, 6120.785772497941, 6159.23009623797, 6200.596961197508, 6264.185655864709, 6291.653959032297, 6058.909116363347, 6145.740123274807, 6158.261008678987, 6207.286162091417, 6221.626702397871, 6385.169927909528, 6402.775902843378, 6410.839729006812, 6421.743130274736, 6434.64609446485, 5989.880202396015, 6027.849303767441, 6041.2750469943885, 6134.099846298167, 6192.164057852132], "value": 5870.6592214340235, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.7048186448219, 803.5058439059978, 821.1993306526136, 902.2466240689021, 912.4388501071835, 26195.2141435757, 38964.41553376698, 41030.0, 41262.793686031604, 41275.380869286986, 42917.7854110729, 43240.0, 43311.35032974508, 43332.56667433325, 43421.78289108558, 7950.363970882345, 9695.369800962933, 9855.817301923778, 9865.309428340019, 9876.753081172992, 8021.9197808022045, 11803.763924721501, 11878.46546905387, 11889.7622047559, 11893.821592676117, 12086.033117350635, 12087.0, 12098.0, 12119.515219391214, 12123.878761212407, 12003.93998030013, 12035.578754743541, 12042.0366370691, 12052.819207711891, 12056.63830085099, 11738.119641026957, 11756.470958806874, 11765.705857353549, 11788.941055294668, 11789.05687545003, 40399.7980010098, 40632.0, 40684.389734153716, 40726.592734072874, 40822.38766418506, 3969.146633473817, 4012.578679238667, 4012.7391719538136, 4015.13674559971, 4049.2306461772464, 29100.8544957276, 29401.70598294011, 29735.40529189404, 30291.242718931982, 30987.070387888398, 3233.466478031122, 3284.2282063715006, 3312.8840490582716, 3433.9313213735836, 3439.1230236289834, 356868.0, 358992.0, 359721.0, 360591.0, 361136.0, 54041.729791350794, 54056.729716351954, 54169.45830541723, 54255.45744542583, 54268.72865635646, 56380.0, 56410.0, 56419.0, 56453.15320270199, 56679.0, 15453.845461545241, 15918.124503152438, 15927.124008179662, 15929.442469513511, 15984.840151598335, 12169.0, 12231.755364892651, 12389.876101239053, 13541.526046588519, 13544.322783860767, 12743.93628031854, 12947.287899165449, 13046.347682615831, 13058.412371443308, 13154.539591114266, 5556.361018482846, 5604.187392828098, 5608.383077861432, 5640.71796410186, 5658.801941932013, 949.7578117580111, 1008.6973907827622, 1093.561966014688, 1156.3177725142207, 1189.6668932698858, 27280.0, 27385.0, 27415.588766168523, 27738.3065423362, 27963.741631626217, 1272.4210484229654, 1274.751423472414, 1278.7634287656813, 1300.4993077665167, 1324.344449497505, 14183.219922904133, 14298.142111473346, 14433.566992990227, 14482.275886205647, 14591.0, 458904.0, 460057.0, 460228.6988565036, 460748.0, 461561.0, 57879.710601447565, 57907.71046144827, 58104.709476453194, 58132.4186758127, 58160.836783264094, 1483.8293596236572, 1497.0269324939095, 1509.1850400783892, 1513.160196091158, 1519.369461673393, 27364.0, 28309.77740516005, 28388.85805570959, 28595.0, 28733.706983185388, 38913.805430972665, 38950.0, 38957.0, 38959.6104038956, 39118.0, 441325.0, 445205.0, 445381.0, 445630.0, 446232.5376746191, 20113.597728045064, 26818.463630726885, 27065.72934270632, 30928.53607195849, 31218.907338243054, 32644.34711305808, 32700.69197232179, 32729.18177045593, 32920.34159316848, 38174.236515270095, 24637.753622463544, 27561.0, 28836.567451487826, 29135.125946221648, 30081.54877676793, 26873.596896046183, 27569.586456203575, 29371.11886643404, 29588.704112958596, 30125.246868828453, 33297.0, 34261.0, 34348.82825585856, 34393.656063440045, 34475.965721028406, 29247.702235515753, 29329.706702932697, 29533.966311179007, 30016.84991575028, 30092.54861177128, 16559.586010349354, 22954.770452295263, 23454.179103731287, 23762.64342541834, 24110.758892410853], "value": 19048.01975860775, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.50616272798084, 428.4223076428363, 433.26561478294286, 440.6849102891432, 442.6016585073435, 21160.89419552902, 22099.337019889408, 22245.887705614714, 23142.032927201166, 23435.062597496122, 22176.77823221767, 22686.092556297768, 22753.431164220863, 23665.645015324742, 23938.04247830089, 6876.96561517193, 6932.653367331638, 6975.895361569581, 7281.599512026836, 7606.277403646673, 7285.380742636882, 7591.620418979057, 7633.3893288537065, 7640.923590764077, 7664.731734389297, 7745.496542724733, 7747.457677962545, 7751.147373788879, 7768.135647444629, 7768.650410731502, 7486.812829679247, 7686.5772382518935, 7799.649015794303, 7801.921980780205, 7828.256315650005, 6188.84527886802, 7217.3865221456235, 7398.4081273497995, 7591.506552074097, 7603.9619801900635, 22348.0, 27279.45441091187, 27406.862965685043, 27459.725402746117, 27737.306567335778, 2572.9099481518056, 3129.9687003129907, 3310.966890331114, 3561.786292822439, 3598.1184609770776, 15726.74186065112, 15893.841061589468, 16059.759103613454, 16143.838561614351, 16483.58791030222, 1777.5200695812186, 2147.795959383856, 2190.1020581561643, 2205.4927366705588, 2212.2588932707563, 110566.44716776445, 131558.6844131556, 132517.0, 134994.3250283752, 158292.4170758289, 17569.0, 20091.799082008994, 20224.887631180427, 20536.281230156874, 20986.685199722015, 32506.349873002408, 33090.0, 33160.834195829346, 33203.0, 33235.335293293996, 10486.05625493694, 10630.25588208818, 10854.07740342064, 10873.456327183609, 11021.44892755359, 9038.09619038104, 9049.502277374675, 9052.683156089637, 9203.815923681623, 9204.631814727336, 7908.52548847071, 8015.238552337519, 9619.951900240454, 9648.855267170999, 9824.361416507903, 3341.8496167672515, 3767.1523907120677, 3947.348687466536, 3975.741576797499, 3985.7608543487486, 623.4949690750507, 688.3185646210216, 857.5197889182078, 904.7964208053136, 1005.939643621385, 20214.494637634176, 21585.67621485679, 21620.243291484723, 21695.0, 21779.564408711736, 1006.4313662780652, 1017.4251547875426, 1037.273908264218, 1052.8736551613856, 1059.332620449112, 11178.776424471627, 11518.88481115195, 11559.248648837798, 11572.537098516133, 11575.0, 525285.0, 723766.0, 735012.0, 739456.0, 755888.0, 148340.0, 148376.0, 152646.0, 153108.0, 158066.0, 1307.1111644082116, 1321.5110409148485, 1343.4559003603752, 1346.9865301347056, 1349.6693310138883, 18665.44003679892, 19601.31395401154, 19621.70567441461, 19658.21367145298, 19660.918649474417, 62317.688411559466, 63998.0, 64736.0, 64859.67570162119, 65477.0, 90353.54823225841, 91526.54236728774, 91772.62341065022, 91821.54089229512, 93167.58464159288, 11713.41432928333, 11719.589814356457, 11848.76302473963, 11894.524219031142, 12094.274343539415, 12863.871361286267, 13280.667983300495, 13300.667483312607, 13594.184348939096, 14202.573922782332, 11580.0, 11792.646220613395, 12136.75726485483, 12168.965637920875, 12179.269243845398, 9287.746154269087, 9632.95183524078, 9666.130048295687, 9712.02879712023, 10080.395176289447, 10789.082927951213, 11817.231879927776, 11883.405829708652, 12171.026317894724, 12250.571230006906, 12015.279083255033, 12070.27578345302, 12092.818607721067, 12115.212511186744, 12437.315947622606, 11749.118816088656, 11834.289942603471, 11952.462139203582, 11973.221740586834, 11999.08014717641], "value": 11864.347337397296, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1579.1630435868985, 1603.3987254779458, 1623.2776414495547, 1649.983500164998, 1657.6353202295497, 10733.40966246856, 11374.317540947528, 11388.259763115402, 11398.25911315766, 11415.143864210197, 10773.299735517186, 11055.170862185349, 11064.502097405615, 11243.550257989691, 11276.4361781911, 2450.2894160693377, 2493.5386953413586, 2496.1263557754733, 2497.8376405533672, 2507.2227609441043, 2442.7435119312395, 2463.6304554316907, 2505.686789151356, 2508.535920854639, 2510.5230006298834, 2443.875817124125, 2452.534018536481, 2465.4206261528525, 2494.114589320792, 2500.862452565117, 2432.513497300547, 2439.5852705040184, 2453.0678342229926, 2465.5438743832447, 2489.5892177790643, 2080.958380832375, 2419.189571493534, 2457.0, 2458.987705061481, 2464.938376540601, 11250.887491125148, 11316.717082072932, 11347.886521134847, 11352.659420217407, 11369.658910232707, 5929.0513517836935, 6116.327204007555, 6125.264968203799, 6127.988881834492, 6132.50939924805, 3548.308079924416, 3566.251087271676, 3662.047867554455, 3741.9625803741887, 3783.3000894834267, 1206.4691535724253, 1210.860751013636, 1247.1830950727287, 1269.225772278909, 1285.0233822295122, 13729.244891530961, 13967.720645587133, 14339.856601434061, 15425.922870385688, 15597.766033509393, 4912.238603016538, 5125.384953805493, 5171.069207542603, 5176.430592634807, 5191.377034755854, 11943.820842687366, 12154.939225303817, 12428.440720167615, 12566.931810796003, 12935.28855912915, 5990.281166260077, 6119.020956647004, 6162.014077747539, 6169.136320915076, 6209.441150296495, 5282.788688452419, 5310.4424035476495, 5416.756245968941, 5430.22519580619, 5488.313960754906, 4156.501219853637, 4237.597428244312, 4257.57424257578, 4298.075913678512, 4312.633426158812, 1153.1985270237105, 1167.0605162843992, 1168.7779321928977, 1184.7452797648375, 1185.8102703567388, 834.8246868157755, 962.74550504601, 965.6958058211641, 968.3899143539525, 1020.132887046005, 6592.17597800275, 6610.30591787865, 6616.4376028037195, 6863.862722745617, 6881.65591720412, 948.2698322291934, 953.3183773601908, 993.9950300248597, 1032.5405194688442, 1044.5926088825365, 4011.1376054147913, 4113.280175969194, 4258.808353624095, 4392.978035109804, 4412.580804823537, 13345.599632011055, 13949.58151255464, 13975.79036314456, 13993.950453716012, 14029.78955315671, 12534.74930501385, 12825.422855971503, 13352.599422017354, 13879.167249965034, 13921.443142274196, 10033.297669163234, 10121.39271643689, 10270.640527581649, 10373.948130259301, 10454.42500662471, 6787.5588086774205, 6865.656717164022, 6907.447404207752, 7023.438124950094, 7111.53775004623, 11140.944295278472, 11324.886751132713, 11394.917482839117, 12418.254904705747, 12620.936895315832, 11247.100231981585, 12559.183653062522, 12801.423935923092, 12905.548305809252, 13103.67240818949, 9389.24886009104, 9508.952455237679, 9584.424934503952, 9586.28102892272, 9588.232941364535, 10398.532066056894, 10412.167026638002, 10417.114545263434, 10527.999840015187, 10530.31552949056, 9025.458472491671, 9040.141186587263, 9089.227415669742, 9145.954270228607, 9177.265818734619, 8802.295816334807, 8837.911620883966, 8913.420627659181, 8937.508437036025, 8949.0, 7844.725434609762, 8011.719589814328, 8212.876806847782, 8231.135730748185, 8288.254057134887, 5927.762889484372, 5965.28416590012, 5984.551158663205, 6062.848428789139, 6152.230971128609, 6000.51995840323, 6134.35589263121, 6136.110264011604, 6229.7714453847075, 6267.341929097379], "value": 5288.184265364553, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.7044142037848, 373.25721813590945, 388.2429262937273, 388.6657474571868, 395.91092004299026, 4818.734969576672, 4963.801447942083, 4969.826056088038, 5062.696238225709, 5217.5565076968505, 4172.916541669165, 4226.45056142701, 4514.322851572266, 4858.222684370501, 4945.505449455061, 4109.609587089237, 4231.238377092122, 4234.644913627641, 4250.744955302692, 4265.698961816653, 3733.328000959826, 3857.3635350167187, 3905.7461265017823, 4254.383773792268, 4303.54812744662, 3976.005998500375, 3995.240904228202, 4278.61492465678, 4299.441072660566, 4301.483821941371, 3701.000729802965, 3807.8857634271017, 3991.9201615967663, 4162.604552567516, 4349.064951035542, 3496.2657841853243, 3927.5483319418345, 3935.2719746846637, 3940.645341919241, 3970.3845903884944, 4372.868813935587, 4606.591122569308, 4931.901361972777, 4936.555709986119, 4952.727599981999, 4655.7439340836245, 4888.560029597318, 4901.460839307673, 4922.655414121013, 4930.8520744377365, 4519.525449827754, 5131.897362052738, 5354.5180933715765, 5425.430329815352, 5459.727013649302, 3723.7579557328686, 3979.7413168144267, 4314.017310006947, 4394.2969124939855, 4447.621952134073, 5248.580113590903, 5469.343678758534, 5631.746571404296, 5679.0, 5830.970845145789, 4128.793560321972, 4373.431453910971, 4422.447194100738, 4430.800613972379, 4442.400275962768, 3995.420664003703, 4160.750354978651, 4518.289026584089, 4531.342955271467, 4538.364628951949, 4341.5007274163245, 4618.660588429385, 4701.566022363212, 4725.716457012591, 4859.586935110555, 4936.456989731127, 4948.703077815343, 5034.320366750515, 5405.459434065982, 5408.729563521808, 1354.525915929417, 1411.792917055923, 1487.2935355705954, 1503.8270598881268, 1514.7273490771768, 883.8276536075404, 995.1988649137514, 1155.439611788282, 1159.9942000289946, 1180.4687890449331, 4604.651627669846, 4690.507496712864, 4860.205381905418, 4916.606671466274, 5268.894622107537, 4754.619630429557, 5335.546478549367, 5336.493033161843, 5626.578006649518, 5646.830595082154, 4681.789319480631, 4911.926321105187, 5099.5410413063, 5113.463086375877, 5184.7407629618365, 2682.9597556036674, 2781.91356482638, 2791.860406979643, 2920.8754629467385, 2924.0789151417234, 4667.6732628716345, 5281.894362112736, 5851.32709738377, 5882.646891271934, 5896.823095307148, 4769.618430525549, 5289.994900968881, 5710.343310519261, 5783.624064435882, 5789.507891829242, 4962.280469331927, 4980.0, 5770.682612456271, 5867.442592953663, 5867.618604790675, 4389.53909839475, 5611.354694210055, 5617.522510586646, 5628.0, 5639.351474580476, 5313.282706834528, 5495.560355171657, 5541.251930989265, 5548.334199895877, 5561.165825126263, 4586.449626044896, 5697.040556812975, 5740.0, 5884.382139875252, 5915.970420148044, 4066.7153299268766, 4312.504062032906, 4496.460424749051, 4560.582891067739, 4567.817287308603, 4498.617617502418, 4817.89188486643, 5100.322330776224, 5332.893342133058, 5675.971620141873, 4734.360861283821, 4829.420469543677, 4869.342638743724, 5455.790404886027, 5482.698451585201, 4868.4177642265695, 5241.68549887008, 5404.945950540444, 5433.809816656398, 5473.945260547343, 3931.6264954829244, 5094.2103973884105, 5283.498067683564, 5379.789547351815, 5446.373667028342, 4689.577937985598, 4793.6031984008, 4892.804287828447, 5465.562754979672, 5469.316335458067, 4086.1214838809797, 4709.599684026759, 4850.345203397637, 5187.636865419536, 5314.601404894725], "value": 4119.512173341266, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.8167430653799, 793.4326956226297, 823.1562648285503, 877.4296707140358, 887.6271965774374, 16452.588685282873, 17312.22095005728, 17364.131793410343, 17404.65190696185, 17425.825741742596, 13305.467781288737, 15756.212189390513, 15877.285522151502, 15953.521394358158, 15993.440229591937, 947.5830634520789, 964.7346979580619, 1000.8798944126715, 1002.6340385759219, 1023.6673081248587, 1014.0923873133578, 1015.664830605902, 1015.9687916764453, 1017.2218253036433, 1019.7858449725529, 1056.8309070548714, 1057.5505410200672, 1058.9629362972298, 1060.42736922062, 1061.0927656853396, 944.2021491839454, 973.9269554783419, 1051.5215576912487, 1052.021619893495, 1052.8999745024248, 785.6150486261748, 787.000509353124, 787.4881327137407, 788.2078511096312, 789.1122487201898, 17039.0, 17082.14589270544, 17098.487045388658, 17649.470515884543, 17933.461996140137, 14503.0, 14787.334569944378, 14847.777283340758, 14868.553943381608, 15130.394784208618, 11742.354170520617, 11943.522259109712, 12016.835467511424, 12284.447199875938, 12361.196522226026, 3457.94813077804, 3563.768355056913, 3585.2470981094, 3691.741578089535, 3768.5854555998817, 85013.72479412814, 103475.48262258715, 119003.809961901, 119744.40127799305, 121914.17128743076, 9313.813723725487, 9820.4107753535, 9872.308938374388, 11609.678064387157, 11728.824067638992, 23991.28026159218, 24221.394465138514, 24278.0, 24289.27132186037, 24757.2572822812, 7550.640884640818, 7845.882311765328, 7904.1700621435075, 8107.067687215927, 8340.62467188978, 4438.578335058164, 4445.711028783118, 4538.591526762607, 4553.567411095941, 4627.074585082997, 3242.7081562659473, 3313.0226583157546, 3332.283559034819, 3348.3303339332233, 3350.64818194091, 584.7602482981957, 586.7506309818395, 594.7799314253667, 600.8948434024028, 601.3955974245943, 552.6380220955281, 667.2160211751172, 669.1201070592156, 683.2893790457967, 686.7870960002415, 9789.9021009789, 10010.64962726301, 10103.0, 10193.847092293621, 10373.118284945864, 658.0715814624938, 670.5406796344422, 677.2820809941478, 693.9722411103601, 719.6653556096336, 4197.3074442717225, 4265.232258193493, 4283.250431174532, 4285.671501732011, 4423.889402764892, 81647.59176204081, 81889.67717098488, 82418.76371854427, 98581.0, 107257.39113913297, 51004.74497627488, 70059.0, 75500.24499754932, 80858.78711819327, 98170.52744208842, 62458.750824984156, 65883.0, 66154.66922665355, 77101.99999999888, 78223.0, 10901.400422976496, 11271.774564508827, 11341.716457088638, 11448.82826757616, 11572.94213528927, 45455.31817022681, 46300.7684961573, 46540.0, 46745.0, 46864.0, 59826.0, 59860.70069649624, 60130.0, 60145.0, 60206.397936020076, 12482.375881205722, 12899.161554498927, 12904.8064279034, 13225.206487610389, 13464.326783660974, 14503.492377766728, 14880.255987200813, 15428.614284642525, 15543.98964067332, 15954.760678589599, 13468.818687452742, 14185.0, 14361.353739081558, 14534.563963081124, 14677.0, 13187.0, 14012.719745605234, 14076.0, 14079.929600351932, 14090.154590724589, 13186.340682966005, 13641.931790340985, 13948.314819710286, 13988.300584970508, 13992.300384980506, 9778.9022109778, 10316.17470602335, 10367.32612380193, 10533.210009249184, 10662.040416362564, 9400.717978460658, 9991.700248992542, 10725.41010244444, 11394.316341019565, 11620.593279235187], "value": 7671.331294485756, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1439.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 118.0, 116.0, 115.0, 118.0, 116.0, 117.0, 117.0, 116.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 108.0, 110.0, 143.0, 110.0, 109.0, 109.0, 105.0, 128.0, 109.0], "value": 117.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 183.0, 185.0, 182.0, 186.0, 183.0, 184.0, 184.0, 184.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 65.0, 125.0, 86.0, 69.0, 57.0, 58.0, 75.0, 58.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 87.0, 70.0, 68.0, 68.0, 81.0, 69.0, 68.0, 83.0], "value": 74.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 89.0, 88.0, 89.0, 88.0, 88.0, 89.0, 89.0, 89.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 102.0, 146.0, 100.0, 94.0, 95.0, 93.0, 93.0, 93.0], "value": 100.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 130.0, 131.0, 82.0, 86.0, 86.0, 99.0, 138.0, 108.0, 83.0], "value": 104.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 59.0, 59.0, 62.0, 63.0, 63.0, 62.0, 63.0, 64.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 55.0, 66.0, 58.0, 58.0, 57.0, 62.0, 57.0, 58.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 84.0, 84.0, 81.0, 84.0, 81.0, 82.0, 87.0, 87.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 144.0, 132.0, 133.0, 133.0, 132.0, 152.0, 188.0, 158.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 163.0, 159.0, 158.0, 158.0, 154.0, 161.0, 212.0, 197.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 63.0, 62.0, 62.0], "value": 63.5, "unit": "score"}]}]} 05:16:03 INFO - Return code: 0 05:16:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:16:03 INFO - # TBPL SUCCESS # 05:16:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:16:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:16:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:16:03 INFO - 2017-04-20 05:16:03.280 screenresolution[1659:10191] starting screenresolution argv=screenresolution get 05:16:03 INFO - 2017-04-20 05:16:03.283 screenresolution[1659:10191] Display 0: 1600x1200x32@60 05:16:03 INFO - 2017-04-20 05:16:03.289 screenresolution[1660:10194] starting screenresolution argv=screenresolution list 05:16:03 INFO - Available Modes on Display 0 05:16:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:16:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:16:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:16:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:16:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:16:03 INFO - Intel Iris: 05:16:03 INFO - Chipset Model: Intel Iris 05:16:03 INFO - Type: GPU 05:16:03 INFO - Bus: Built-In 05:16:03 INFO - VRAM (Dynamic, Max): 1536 MB 05:16:03 INFO - Vendor: Intel (0x8086) 05:16:03 INFO - Device ID: 0x0a2e 05:16:03 INFO - Revision ID: 0x0009 05:16:03 INFO - Displays: 05:16:03 INFO - Display: 05:16:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:16:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:16:03 INFO - Display Serial Number: 1600x1200 60 05:16:03 INFO - Main Display: Yes 05:16:03 INFO - Mirror: Off 05:16:03 INFO - Online: Yes 05:16:03 INFO - Rotation: Supported 05:16:03 INFO - Return code: 0 05:16:03 INFO - Running post-action listener: _resource_record_post_action 05:16:03 INFO - [mozharness: 2017-04-20 12:16:03.524857Z] Finished run-tests step (success) 05:16:03 INFO - Running post-run listener: _resource_record_post_run 05:16:03 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 38564864; Write bytes: 421070848; Read time: 242; Write time: 1390 05:16:03 INFO - TinderboxPrint: CPU usage
53.7% 05:16:03 INFO - TinderboxPrint: I/O read bytes / time
38,564,864 / 242 05:16:03 INFO - TinderboxPrint: I/O write bytes / time
421,070,848 / 1,390 05:16:03 INFO - TinderboxPrint: CPU idle
2,206.0 (46.3%) 05:16:03 INFO - TinderboxPrint: CPU system
955.0 (20.0%) 05:16:03 INFO - TinderboxPrint: CPU user
1,608.6 (33.7%) 05:16:03 INFO - TinderboxPrint: Swap in / out
160,710,656 / 0 05:16:03 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122761728; Write bytes: 122576896; Read time: 11155; Write time: 282 05:16:03 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 34567168; Write bytes: 297117696; Read time: 217; Write time: 1103 05:16:04 INFO - Running post-run listener: _upload_blobber_files 05:16:04 INFO - Blob upload gear active. 05:16:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:16:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:16:04 INFO - (blobuploader) - INFO - Open directory for files ... 05:16:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:16:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:16:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:05 INFO - (blobuploader) - INFO - Done attempting. 05:16:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:16:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:16:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:06 INFO - (blobuploader) - INFO - Done attempting. 05:16:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:16:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:16:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:07 INFO - (blobuploader) - INFO - Done attempting. 05:16:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:16:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:16:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:09 INFO - (blobuploader) - INFO - Done attempting. 05:16:09 INFO - (blobuploader) - INFO - Iteration through files over. 05:16:09 INFO - Return code: 0 05:16:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:16:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:16:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3173f00481fe8ba0cea404af6edc64e39cdbca29b7a2b99bee724490617b8bda31af02224afa94ea6b1dab681d944eb67c050781e297e20d796ed0e123e6caaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e81293e5dd68a7f51891726c90ccb8ca398539adaa48c264f759d519d6b0ce9fbb0a5d271db32829c23d610428ed01b1c177865594534c908bb02c4ad1e8074", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6dadf3f3377e49c07cd5251f3f07dddcb7b4dde5a158a5dc99dbdc2dbbbd488ac206c6348b06c122f36330c5a404bd6909b4ae4e8e412d135cf64880fb3e2da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/38ef84012b4afd937c5c0839fdde7eaae8738aa0e5c4c95da222bb7d7b7a4f5bf1c48a18a033b56e77d59baa5fa5809b3e9aa9865d10d7370bfd300dba2f56bc"} 05:16:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:16:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:16:09 INFO - Contents: 05:16:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3173f00481fe8ba0cea404af6edc64e39cdbca29b7a2b99bee724490617b8bda31af02224afa94ea6b1dab681d944eb67c050781e297e20d796ed0e123e6caaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e81293e5dd68a7f51891726c90ccb8ca398539adaa48c264f759d519d6b0ce9fbb0a5d271db32829c23d610428ed01b1c177865594534c908bb02c4ad1e8074", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6dadf3f3377e49c07cd5251f3f07dddcb7b4dde5a158a5dc99dbdc2dbbbd488ac206c6348b06c122f36330c5a404bd6909b4ae4e8e412d135cf64880fb3e2da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/38ef84012b4afd937c5c0839fdde7eaae8738aa0e5c4c95da222bb7d7b7a4f5bf1c48a18a033b56e77d59baa5fa5809b3e9aa9865d10d7370bfd300dba2f56bc"} 05:16:09 INFO - Running post-run listener: copy_logs_to_upload_dir 05:16:09 INFO - Copying logs to upload dir... 05:16:09 INFO - mkdir: /builds/slave/test/build/upload/logs 05:16:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.769991 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-20 05:16:09.298886) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 05:16:09.303620) ========= 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.7MaxsZXNHU/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.jxeSrgmstE/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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/3173f00481fe8ba0cea404af6edc64e39cdbca29b7a2b99bee724490617b8bda31af02224afa94ea6b1dab681d944eb67c050781e297e20d796ed0e123e6caaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e81293e5dd68a7f51891726c90ccb8ca398539adaa48c264f759d519d6b0ce9fbb0a5d271db32829c23d610428ed01b1c177865594534c908bb02c4ad1e8074", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6dadf3f3377e49c07cd5251f3f07dddcb7b4dde5a158a5dc99dbdc2dbbbd488ac206c6348b06c122f36330c5a404bd6909b4ae4e8e412d135cf64880fb3e2da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/38ef84012b4afd937c5c0839fdde7eaae8738aa0e5c4c95da222bb7d7b7a4f5bf1c48a18a033b56e77d59baa5fa5809b3e9aa9865d10d7370bfd300dba2f56bc"} build_url:https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010689 build_url: 'https://queue.taskcluster.net/v1/task/T3DDPy2HR-e2pnOtmzle4w/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3173f00481fe8ba0cea404af6edc64e39cdbca29b7a2b99bee724490617b8bda31af02224afa94ea6b1dab681d944eb67c050781e297e20d796ed0e123e6caaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e81293e5dd68a7f51891726c90ccb8ca398539adaa48c264f759d519d6b0ce9fbb0a5d271db32829c23d610428ed01b1c177865594534c908bb02c4ad1e8074", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6dadf3f3377e49c07cd5251f3f07dddcb7b4dde5a158a5dc99dbdc2dbbbd488ac206c6348b06c122f36330c5a404bd6909b4ae4e8e412d135cf64880fb3e2da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/38ef84012b4afd937c5c0839fdde7eaae8738aa0e5c4c95da222bb7d7b7a4f5bf1c48a18a033b56e77d59baa5fa5809b3e9aa9865d10d7370bfd300dba2f56bc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 05:16:09.338635) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 05:16:09.338988) ========= 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.7MaxsZXNHU/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.jxeSrgmstE/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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.005122 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 05:16:09.388441) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 05:16:09.388797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 05:16:09.389216) ========= ========= Total master_lag: 0.18 =========