builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0132 starttime: 1493569910.66 results: success (0) buildid: 20170430075046 builduid: 4dbbad5eaf8244a89bf25e7fbf14e6f7 revision: e2f942326f941f481b004ecbb7b9d18e55bd4322 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:50.659528) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:50.660043) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:50.660372) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:50.885517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:50.885779) ========= 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.l4wy5feQoZ/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.5YTlsrdd08/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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-30 09:31:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 142M=0s 2017-04-30 09:31:51 (142 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.173615 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:51.084323) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:51.084629) ========= 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.l4wy5feQoZ/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.5YTlsrdd08/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.021454 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:51.144599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:51.144939) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e2f942326f941f481b004ecbb7b9d18e55bd4322 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e2f942326f941f481b004ecbb7b9d18e55bd4322 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.l4wy5feQoZ/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.5YTlsrdd08/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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-30 09:31:51,246 truncating revision to first 12 chars 2017-04-30 09:31:51,246 Setting DEBUG logging. 2017-04-30 09:31:51,246 attempt 1/10 2017-04-30 09:31:51,246 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e2f942326f94?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-30 09:31:51,892 unpacking tar archive at: mozilla-central-e2f942326f94/testing/mozharness/ program finished with exit code 0 elapsedTime=0.904147 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:52.073550) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:52.073857) ========= script_repo_revision: e2f942326f941f481b004ecbb7b9d18e55bd4322 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:52.074252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:52.074536) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:52.095413) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-30 09:31:52.095845) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.l4wy5feQoZ/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.5YTlsrdd08/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 09:31:52 INFO - MultiFileLogger online at 20170430 09:31:52 in /builds/slave/test 09:31:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:31:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:31:52 INFO - {'append_to_log': False, 09:31:52 INFO - 'base_work_dir': '/builds/slave/test', 09:31:52 INFO - 'blob_upload_branch': 'Firefox', 09:31:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:31:52 INFO - 'branch': 'Firefox', 09:31:52 INFO - 'buildbot_json_path': 'buildprops.json', 09:31:52 INFO - 'config_files': ('talos/mac_config.py',), 09:31:52 INFO - 'default_actions': ('clobber', 09:31:52 INFO - 'read-buildbot-config', 09:31:52 INFO - 'download-and-extract', 09:31:52 INFO - 'populate-webroot', 09:31:52 INFO - 'create-virtualenv', 09:31:52 INFO - 'install', 09:31:52 INFO - 'run-tests'), 09:31:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:31:52 INFO - 'download_minidump_stackwalk': True, 09:31:52 INFO - 'download_symbols': 'ondemand', 09:31:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:31:52 INFO - 'tooltool.py': '/tools/tooltool.py', 09:31:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:31:52 INFO - '/tools/misc-python/virtualenv.py')}, 09:31:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:31:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:31:52 INFO - 'gecko_profile': False, 09:31:52 INFO - 'gecko_profile_interval': 0, 09:31:52 INFO - 'installer_path': 'installer.exe', 09:31:52 INFO - 'log_level': 'info', 09:31:52 INFO - 'log_name': 'talos', 09:31:52 INFO - 'log_to_console': True, 09:31:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:31:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:31:52 INFO - 'opt_config_files': (), 09:31:52 INFO - 'pip_index': False, 09:31:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:31:52 INFO - 'cmd': ('bash', 09:31:52 INFO - '-c', 09:31:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:31:52 INFO - 'enabled': True, 09:31:52 INFO - 'halt_on_failure': False, 09:31:52 INFO - 'name': 'check_screen_resolution'},), 09:31:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:31:52 INFO - 'cmd': ('bash', 09:31:52 INFO - '-c', 09:31:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:31:52 INFO - 'enabled': True, 09:31:52 INFO - 'halt_on_failure': False, 09:31:52 INFO - 'name': 'check_screen_resolution'},), 09:31:52 INFO - 'run_cmd_checks_enabled': True, 09:31:52 INFO - 'suite': 'dromaeojs-e10s', 09:31:52 INFO - 'system_bits': '32', 09:31:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:31:52 INFO - 'title': 't-yosemite-r7-0132', 09:31:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:31:52 INFO - 'use_talos_json': True, 09:31:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:31:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:31:52 INFO - 'work_dir': 'build'} 09:31:52 INFO - [mozharness: 2017-04-30 16:31:52.323842Z] Running clobber step. 09:31:52 INFO - Running pre-action listener: _resource_record_pre_action 09:31:52 INFO - Running main action method: clobber 09:31:52 INFO - rmtree: /builds/slave/test/build 09:31:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:31:53 INFO - Running post-action listener: _resource_record_post_action 09:31:53 INFO - [mozharness: 2017-04-30 16:31:53.607851Z] Finished clobber step (success) 09:31:53 INFO - [mozharness: 2017-04-30 16:31:53.608076Z] Running read-buildbot-config step. 09:31:53 INFO - Running pre-action listener: _resource_record_pre_action 09:31:53 INFO - Running main action method: read_buildbot_config 09:31:53 INFO - Using buildbot properties: 09:31:53 INFO - { 09:31:53 INFO - "project": "", 09:31:53 INFO - "product": "firefox", 09:31:53 INFO - "script_repo_revision": "production", 09:31:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:31:53 INFO - "repository": "", 09:31:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:31:53 INFO - "buildid": "20170430075046", 09:31:53 INFO - "pgo_build": "False", 09:31:53 INFO - "basedir": "/builds/slave/test", 09:31:53 INFO - "buildnumber": 134, 09:31:53 INFO - "slavename": "t-yosemite-r7-0132", 09:31:53 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:31:53 INFO - "platform": "yosemite_r7", 09:31:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:31:53 INFO - "branch": "mozilla-central", 09:31:53 INFO - "repo_path": "mozilla-central", 09:31:53 INFO - "revision": "e2f942326f941f481b004ecbb7b9d18e55bd4322", 09:31:53 INFO - "stage_platform": "macosx64", 09:31:53 INFO - "builduid": "4dbbad5eaf8244a89bf25e7fbf14e6f7", 09:31:53 INFO - "slavebuilddir": "test" 09:31:53 INFO - } 09:31:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:31:53 INFO - Running post-action listener: _resource_record_post_action 09:31:53 INFO - [mozharness: 2017-04-30 16:31:53.613841Z] Finished read-buildbot-config step (success) 09:31:53 INFO - [mozharness: 2017-04-30 16:31:53.613989Z] Running download-and-extract step. 09:31:53 INFO - Running pre-action listener: _resource_record_pre_action 09:31:53 INFO - Running main action method: download_and_extract 09:31:53 INFO - mkdir: /builds/slave/test/build/tests 09:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:53 INFO - trying https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:31:53 INFO - Downloading https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:31:54 INFO - Downloaded 1325 bytes. 09:31:54 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:31:54 INFO - Using the following test package requirements: 09:31:54 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:54 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:31:54 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:31:54 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:54 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:31:54 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:54 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:31:54 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:54 INFO - u'jsshell-mac.zip'], 09:31:54 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:54 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:31:54 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:31:54 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:54 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:31:54 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:54 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:31:54 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:54 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:31:54 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:54 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:31:54 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:31:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:31:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:31:54 INFO - Fetch https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:31:56 INFO - Content-Length response header: 52700817 09:31:56 INFO - Bytes received: 52700817 09:32:12 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:32:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:32:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:32:12 INFO - Fetch https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:32:14 INFO - Content-Length response header: 52700817 09:32:14 INFO - Bytes received: 52700817 09:32:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:32:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:32:30 INFO - Fetch https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:32:31 INFO - Content-Length response header: 14408811 09:32:31 INFO - Bytes received: 14408811 09:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:31 INFO - trying https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:32:31 INFO - Downloading https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:32:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:32:33 INFO - Downloaded 71197596 bytes. 09:32:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:32:33 INFO - mkdir: /builds/slave/test/properties 09:32:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:32:33 INFO - Writing to file /builds/slave/test/properties/build_url 09:32:33 INFO - Contents: 09:32:33 INFO - build_url:https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:32:34 INFO - Running post-action listener: _resource_record_post_action 09:32:34 INFO - Running post-action listener: set_extra_try_arguments 09:32:34 INFO - [mozharness: 2017-04-30 16:32:34.578281Z] Finished download-and-extract step (success) 09:32:34 INFO - [mozharness: 2017-04-30 16:32:34.578408Z] Running populate-webroot step. 09:32:34 INFO - Running pre-action listener: _resource_record_pre_action 09:32:34 INFO - Running main action method: populate_webroot 09:32:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:32:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:32:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:32:34 INFO - '--tppagecycles', 09:32:34 INFO - '7'], 09:32:34 INFO - 'tests': ['tsvgm']}}, 09:32:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:32:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:32:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:32:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:32:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:32:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:32:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:32:34 INFO - 'talos_options': ['--disable-e10s'], 09:32:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:32:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:32:34 INFO - 'talos_options': ['--disable-e10s'], 09:32:34 INFO - 'tests': ['damp', 'tps']}, 09:32:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:32:34 INFO - 'tests': ['damp', 'tps']}, 09:32:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:32:34 INFO - 'tests': ['dromaeo_dom']}, 09:32:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:32:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:32:34 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:32:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:32:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:32:34 INFO - 'tests': ['a11yr', 09:32:34 INFO - 'ts_paint', 09:32:34 INFO - 'tpaint', 09:32:34 INFO - 'sessionrestore', 09:32:34 INFO - 'sessionrestore_no_auto_restore', 09:32:34 INFO - 'tabpaint']}, 09:32:34 INFO - 'other-e10s': {'tests': ['a11yr', 09:32:34 INFO - 'ts_paint', 09:32:34 INFO - 'tpaint', 09:32:34 INFO - 'sessionrestore', 09:32:34 INFO - 'sessionrestore_no_auto_restore', 09:32:34 INFO - 'tabpaint']}, 09:32:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:32:34 INFO - 'ts_paint', 09:32:34 INFO - 'tpaint', 09:32:34 INFO - 'sessionrestore', 09:32:34 INFO - 'sessionrestore_no_auto_restore', 09:32:34 INFO - 'tabpaint']}, 09:32:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:32:34 INFO - 'ts_paint', 09:32:34 INFO - 'tpaint', 09:32:34 INFO - 'sessionrestore', 09:32:34 INFO - 'sessionrestore_no_auto_restore', 09:32:34 INFO - 'tabpaint']}, 09:32:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:32:34 INFO - 'tests': ['a11yr', 09:32:34 INFO - 'ts_paint', 09:32:34 INFO - 'tpaint', 09:32:34 INFO - 'sessionrestore', 09:32:34 INFO - 'sessionrestore_no_auto_restore', 09:32:34 INFO - 'tabpaint']}, 09:32:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:32:34 INFO - 'tests': ['a11yr', 09:32:34 INFO - 'ts_paint', 09:32:34 INFO - 'tpaint', 09:32:34 INFO - 'sessionrestore', 09:32:34 INFO - 'sessionrestore_no_auto_restore', 09:32:34 INFO - 'tabpaint']}, 09:32:34 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:32:34 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:32:34 INFO - 'bloom_basic_ref']}, 09:32:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:32:34 INFO - 'tests': ['tsvgx', 09:32:34 INFO - 'tsvgr_opacity', 09:32:34 INFO - 'tart', 09:32:34 INFO - 'tscrollx', 09:32:34 INFO - 'cart', 09:32:34 INFO - 'tsvg_static']}, 09:32:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:32:34 INFO - 'tsvgr_opacity', 09:32:34 INFO - 'tart', 09:32:34 INFO - 'tscrollx', 09:32:34 INFO - 'cart', 09:32:34 INFO - 'tsvg_static']}, 09:32:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:32:34 INFO - 'talos_options': ['--disable-e10s'], 09:32:34 INFO - 'tests': ['tp5o']}, 09:32:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:32:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:32:34 INFO - 'talos_options': ['--disable-e10s', 09:32:34 INFO - '--xperf_path', 09:32:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:34 INFO - 'tests': ['tp5n']}, 09:32:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:32:34 INFO - 'talos_options': ['--xperf_path', 09:32:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:34 INFO - 'tests': ['tp5n']}}, 09:32:34 INFO - 'talos.zip': {'path': '', 09:32:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:32:34 INFO - Running post-action listener: _resource_record_post_action 09:32:34 INFO - [mozharness: 2017-04-30 16:32:34.597781Z] Finished populate-webroot step (success) 09:32:34 INFO - [mozharness: 2017-04-30 16:32:34.597916Z] Running create-virtualenv step. 09:32:34 INFO - Running pre-action listener: _resource_record_pre_action 09:32:34 INFO - Running main action method: create_virtualenv 09:32:34 INFO - Creating virtualenv /builds/slave/test/build/venv 09:32:34 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 09:32:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:32:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:32:34 INFO - Using real prefix '/tools/python27' 09:32:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:32:35 INFO - Installing distribute.............................................................................................................................................................................................done. 09:32:38 INFO - Installing pip.................done. 09:32:38 INFO - Return code: 0 09:32:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:32:38 INFO - Reading from file tmpfile_stdout 09:32:38 INFO - Output received: 09:32:38 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) 09:32:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:32:38 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')]} 09:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:38 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')]} 09:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:38 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 0x106544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d8599700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106322d30>, '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 0x106248db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106317be8>, '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.l4wy5feQoZ/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.5YTlsrdd08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 09:32:38 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 09:32:38 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 09:32:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l4wy5feQoZ/Render', 09:32:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:38 INFO - 'HOME': '/Users/cltbld', 09:32:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:38 INFO - 'LOGNAME': 'cltbld', 09:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:38 INFO - 'MOZ_NO_REMOTE': '1', 09:32:38 INFO - 'NO_EM_RESTART': '1', 09:32:38 INFO - 'PAGER': '/bin/cat', 09:32:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:38 INFO - 'PWD': '/builds/slave/test', 09:32:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:38 INFO - 'SHELL': '/bin/bash', 09:32:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5YTlsrdd08/Listeners', 09:32:38 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 09:32:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:38 INFO - 'USER': 'cltbld', 09:32:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:38 INFO - 'XPC_FLAGS': '0x0', 09:32:38 INFO - 'XPC_SERVICE_NAME': '0', 09:32:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:38 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 09:32:38 INFO - Cleaning up... 09:32:38 INFO - Return code: 0 09:32:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:32:38 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')]} 09:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:38 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')]} 09:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:38 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 0x106544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d8599700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106322d30>, '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 0x106248db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106317be8>, '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.l4wy5feQoZ/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.5YTlsrdd08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 09:32:38 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 09:32:38 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 09:32:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l4wy5feQoZ/Render', 09:32:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:38 INFO - 'HOME': '/Users/cltbld', 09:32:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:38 INFO - 'LOGNAME': 'cltbld', 09:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:38 INFO - 'MOZ_NO_REMOTE': '1', 09:32:38 INFO - 'NO_EM_RESTART': '1', 09:32:38 INFO - 'PAGER': '/bin/cat', 09:32:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:38 INFO - 'PWD': '/builds/slave/test', 09:32:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:38 INFO - 'SHELL': '/bin/bash', 09:32:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5YTlsrdd08/Listeners', 09:32:38 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 09:32:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:38 INFO - 'USER': 'cltbld', 09:32:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:38 INFO - 'XPC_FLAGS': '0x0', 09:32:38 INFO - 'XPC_SERVICE_NAME': '0', 09:32:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:39 INFO - Downloading/unpacking psutil>=3.1.1 09:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:32:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:43 INFO - Installing collected packages: psutil 09:32:43 INFO - Running setup.py install for psutil 09:32:43 INFO - building 'psutil._psutil_osx' extension 09:32:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:32:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:32:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:32:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:32:43 INFO - building 'psutil._psutil_posix' extension 09:32:43 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 09:32:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:32:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:32:43 INFO - ^ 09:32:43 INFO - 1 warning generated. 09:32:43 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 09:32:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:44 INFO - Successfully installed psutil 09:32:44 INFO - Cleaning up... 09:32:44 INFO - Return code: 0 09:32:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d8599700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106322d30>, '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 0x106248db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106317be8>, '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.l4wy5feQoZ/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.5YTlsrdd08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 09:32:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l4wy5feQoZ/Render', 09:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:44 INFO - 'HOME': '/Users/cltbld', 09:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:44 INFO - 'LOGNAME': 'cltbld', 09:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:44 INFO - 'MOZ_NO_REMOTE': '1', 09:32:44 INFO - 'NO_EM_RESTART': '1', 09:32:44 INFO - 'PAGER': '/bin/cat', 09:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:44 INFO - 'PWD': '/builds/slave/test', 09:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:44 INFO - 'SHELL': '/bin/bash', 09:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5YTlsrdd08/Listeners', 09:32:44 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 09:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:44 INFO - 'USER': 'cltbld', 09:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:44 INFO - 'XPC_FLAGS': '0x0', 09:32:44 INFO - 'XPC_SERVICE_NAME': '0', 09:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:32:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:32:47 INFO - Installing collected packages: mozsystemmonitor 09:32:47 INFO - Running setup.py install for mozsystemmonitor 09:32:47 INFO - Successfully installed mozsystemmonitor 09:32:47 INFO - Cleaning up... 09:32:47 INFO - Return code: 0 09:32:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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')]} 09:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d8599700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106322d30>, '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 0x106248db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106317be8>, '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.l4wy5feQoZ/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.5YTlsrdd08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 09:32:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l4wy5feQoZ/Render', 09:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:47 INFO - 'HOME': '/Users/cltbld', 09:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:47 INFO - 'LOGNAME': 'cltbld', 09:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:47 INFO - 'MOZ_NO_REMOTE': '1', 09:32:47 INFO - 'NO_EM_RESTART': '1', 09:32:47 INFO - 'PAGER': '/bin/cat', 09:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:47 INFO - 'PWD': '/builds/slave/test', 09:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:47 INFO - 'SHELL': '/bin/bash', 09:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5YTlsrdd08/Listeners', 09:32:47 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 09:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:47 INFO - 'USER': 'cltbld', 09:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:47 INFO - 'XPC_FLAGS': '0x0', 09:32:47 INFO - 'XPC_SERVICE_NAME': '0', 09:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:47 INFO - Downloading/unpacking jsonschema==2.5.1 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:32:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32:50 INFO - Downloading functools32-3.2.3-2.tar.gz 09:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:32:50 INFO - warning: no files found matching '*.txt' 09:32:50 INFO - no previously-included directories found matching 'build' 09:32:50 INFO - no previously-included directories found matching 'dist' 09:32:50 INFO - no previously-included directories found matching '.git*' 09:32:50 INFO - Installing collected packages: jsonschema, functools32 09:32:50 INFO - Running setup.py install for functools32 09:32:50 INFO - warning: no files found matching '*.txt' 09:32:50 INFO - no previously-included directories found matching 'build' 09:32:50 INFO - no previously-included directories found matching 'dist' 09:32:50 INFO - no previously-included directories found matching '.git*' 09:32:50 INFO - Successfully installed jsonschema functools32 09:32:50 INFO - Cleaning up... 09:32:51 INFO - Return code: 0 09:32:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d8599700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106322d30>, '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 0x106248db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106317be8>, '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.l4wy5feQoZ/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.5YTlsrdd08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 09:32:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:32:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l4wy5feQoZ/Render', 09:32:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:51 INFO - 'HOME': '/Users/cltbld', 09:32:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:51 INFO - 'LOGNAME': 'cltbld', 09:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:51 INFO - 'MOZ_NO_REMOTE': '1', 09:32:51 INFO - 'NO_EM_RESTART': '1', 09:32:51 INFO - 'PAGER': '/bin/cat', 09:32:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:51 INFO - 'PWD': '/builds/slave/test', 09:32:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:51 INFO - 'SHELL': '/bin/bash', 09:32:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5YTlsrdd08/Listeners', 09:32:51 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 09:32:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:51 INFO - 'USER': 'cltbld', 09:32:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:51 INFO - 'XPC_FLAGS': '0x0', 09:32:51 INFO - 'XPC_SERVICE_NAME': '0', 09:32:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:32:51 INFO - Cleaning up... 09:32:51 INFO - Return code: 0 09:32:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d8599700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106322d30>, '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 0x106248db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106317be8>, '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.l4wy5feQoZ/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.5YTlsrdd08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 09:32:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:32:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l4wy5feQoZ/Render', 09:32:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:51 INFO - 'HOME': '/Users/cltbld', 09:32:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:51 INFO - 'LOGNAME': 'cltbld', 09:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:51 INFO - 'MOZ_NO_REMOTE': '1', 09:32:51 INFO - 'NO_EM_RESTART': '1', 09:32:51 INFO - 'PAGER': '/bin/cat', 09:32:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:51 INFO - 'PWD': '/builds/slave/test', 09:32:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:51 INFO - 'SHELL': '/bin/bash', 09:32:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5YTlsrdd08/Listeners', 09:32:51 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 09:32:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:51 INFO - 'USER': 'cltbld', 09:32:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:51 INFO - 'XPC_FLAGS': '0x0', 09:32:51 INFO - 'XPC_SERVICE_NAME': '0', 09:32:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:51 INFO - Downloading/unpacking blobuploader==1.2.4 09:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:54 INFO - Downloading blobuploader-1.2.4.tar.gz 09:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:32:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:32:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32:55 INFO - Downloading docopt-0.6.1.tar.gz 09:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:32:55 INFO - Installing collected packages: blobuploader, requests, docopt 09:32:55 INFO - Running setup.py install for blobuploader 09:32:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:32:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:32:55 INFO - Running setup.py install for requests 09:32:56 INFO - Running setup.py install for docopt 09:32:56 INFO - Successfully installed blobuploader requests docopt 09:32:56 INFO - Cleaning up... 09:32:56 INFO - Return code: 0 09:32:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d8599700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106322d30>, '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 0x106248db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106317be8>, '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.l4wy5feQoZ/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.5YTlsrdd08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 09:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l4wy5feQoZ/Render', 09:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:56 INFO - 'HOME': '/Users/cltbld', 09:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:56 INFO - 'LOGNAME': 'cltbld', 09:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:56 INFO - 'MOZ_NO_REMOTE': '1', 09:32:56 INFO - 'NO_EM_RESTART': '1', 09:32:56 INFO - 'PAGER': '/bin/cat', 09:32:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:56 INFO - 'PWD': '/builds/slave/test', 09:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:56 INFO - 'SHELL': '/bin/bash', 09:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5YTlsrdd08/Listeners', 09:32:56 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 09:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:56 INFO - 'USER': 'cltbld', 09:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:56 INFO - 'XPC_FLAGS': '0x0', 09:32:56 INFO - 'XPC_SERVICE_NAME': '0', 09:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:56 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-3i_yu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:56 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-TQlnaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:56 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-1Iemvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:56 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-YtCTv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:57 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-SHq3Yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:57 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-MgUY5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:57 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-jb90Z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:57 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-RmbK51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:57 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-C7OeGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:57 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Zphc_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:57 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-EdRClR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:57 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-va3qz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:57 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-C_7kPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:58 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-e4JwZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:58 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-60HC8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:58 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-hXK36j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:58 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-xgyjbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:32:58 INFO - Running setup.py install for manifestparser 09:32:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:32:58 INFO - Running setup.py install for mozcrash 09:32:58 INFO - Running setup.py install for mozdebug 09:32:58 INFO - Running setup.py install for mozdevice 09:32:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:32:59 INFO - Running setup.py install for mozfile 09:32:59 INFO - Running setup.py install for mozhttpd 09:32:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:32:59 INFO - Running setup.py install for mozinfo 09:32:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:32:59 INFO - Running setup.py install for mozInstall 09:32:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:32:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:32:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:32:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:32:59 INFO - Running setup.py install for mozleak 09:32:59 INFO - Running setup.py install for mozlog 09:32:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:32:59 INFO - Running setup.py install for moznetwork 09:33:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:00 INFO - Running setup.py install for mozprocess 09:33:00 INFO - Running setup.py install for mozprofile 09:33:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:00 INFO - Running setup.py install for mozrunner 09:33:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:00 INFO - Running setup.py install for mozscreenshot 09:33:00 INFO - Running setup.py install for moztest 09:33:00 INFO - Running setup.py install for mozversion 09:33:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:00 INFO - Cleaning up... 09:33:01 INFO - Return code: 0 09:33:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d8599700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106322d30>, '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 0x106248db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106317be8>, '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.l4wy5feQoZ/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.5YTlsrdd08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 09:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:33:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l4wy5feQoZ/Render', 09:33:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:01 INFO - 'HOME': '/Users/cltbld', 09:33:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:01 INFO - 'LOGNAME': 'cltbld', 09:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:01 INFO - 'MOZ_NO_REMOTE': '1', 09:33:01 INFO - 'NO_EM_RESTART': '1', 09:33:01 INFO - 'PAGER': '/bin/cat', 09:33:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:01 INFO - 'PWD': '/builds/slave/test', 09:33:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:01 INFO - 'SHELL': '/bin/bash', 09:33:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5YTlsrdd08/Listeners', 09:33:01 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 09:33:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:01 INFO - 'USER': 'cltbld', 09:33:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:01 INFO - 'XPC_FLAGS': '0x0', 09:33:01 INFO - 'XPC_SERVICE_NAME': '0', 09:33:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:01 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-wil2Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:01 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-MHUVxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:01 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-TRppay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:01 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-KiX9Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:01 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-5fj0Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:01 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-2JnS1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:01 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)) 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:01 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-hJoh4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-xI6r2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-m5HuMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-dWDw_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-k9kPPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-kJXjFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:02 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)) 09:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-p27R3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-OrFu42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-CwXiT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:02 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)) 09:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:02 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-ci913w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:03 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-5zQiOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:05 INFO - Downloading blessings-1.6.tar.gz 09:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:05 INFO - Installing collected packages: blessings 09:33:05 INFO - Running setup.py install for blessings 09:33:05 INFO - Successfully installed blessings 09:33:05 INFO - Cleaning up... 09:33:06 INFO - Return code: 0 09:33:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:06 INFO - Reading from file tmpfile_stdout 09:33:06 INFO - Current package versions: 09:33:06 INFO - blessings == 1.6 09:33:06 INFO - blobuploader == 1.2.4 09:33:06 INFO - docopt == 0.6.1 09:33:06 INFO - functools32 == 3.2.3-2 09:33:06 INFO - jsonschema == 2.5.1 09:33:06 INFO - manifestparser == 1.1 09:33:06 INFO - mozInstall == 1.12 09:33:06 INFO - mozcrash == 1.0 09:33:06 INFO - mozdebug == 0.1 09:33:06 INFO - mozdevice == 0.50 09:33:06 INFO - mozfile == 1.2 09:33:06 INFO - mozhttpd == 0.7 09:33:06 INFO - mozinfo == 0.9 09:33:06 INFO - mozleak == 0.1 09:33:06 INFO - mozlog == 3.4 09:33:06 INFO - moznetwork == 0.27 09:33:06 INFO - mozprocess == 0.25 09:33:06 INFO - mozprofile == 0.28 09:33:06 INFO - mozrunner == 6.13 09:33:06 INFO - mozscreenshot == 0.1 09:33:06 INFO - mozsystemmonitor == 0.3 09:33:06 INFO - moztest == 0.8 09:33:06 INFO - mozversion == 1.4 09:33:06 INFO - psutil == 3.1.1 09:33:06 INFO - requests == 1.2.3 09:33:06 INFO - wsgiref == 0.1.2 09:33:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:06 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 0x106544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d8599700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106322d30>, '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 0x106248db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106317be8>, '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.l4wy5feQoZ/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.5YTlsrdd08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 09:33:06 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 09:33:06 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 09:33:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l4wy5feQoZ/Render', 09:33:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:06 INFO - 'HOME': '/Users/cltbld', 09:33:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:06 INFO - 'LOGNAME': 'cltbld', 09:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:06 INFO - 'MOZ_NO_REMOTE': '1', 09:33:06 INFO - 'NO_EM_RESTART': '1', 09:33:06 INFO - 'PAGER': '/bin/cat', 09:33:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:06 INFO - 'PWD': '/builds/slave/test', 09:33:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:06 INFO - 'SHELL': '/bin/bash', 09:33:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5YTlsrdd08/Listeners', 09:33:06 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 09:33:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:06 INFO - 'USER': 'cltbld', 09:33:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:06 INFO - 'XPC_FLAGS': '0x0', 09:33:06 INFO - 'XPC_SERVICE_NAME': '0', 09:33:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:06 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)) 09:33:06 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)) 09:33:06 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)) 09:33:06 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)) 09:33:06 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)) 09:33:06 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)) 09:33:06 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)) 09:33:06 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)) 09:33:06 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)) 09:33:06 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)) 09:33:06 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)) 09:33:06 INFO - Cleaning up... 09:33:06 INFO - Return code: 0 09:33:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:06 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 0x106544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d8599700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106322d30>, '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 0x106248db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106317be8>, '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.l4wy5feQoZ/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.5YTlsrdd08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 09:33:06 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 09:33:06 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 09:33:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l4wy5feQoZ/Render', 09:33:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:06 INFO - 'HOME': '/Users/cltbld', 09:33:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:06 INFO - 'LOGNAME': 'cltbld', 09:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:06 INFO - 'MOZ_NO_REMOTE': '1', 09:33:06 INFO - 'NO_EM_RESTART': '1', 09:33:06 INFO - 'PAGER': '/bin/cat', 09:33:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:06 INFO - 'PWD': '/builds/slave/test', 09:33:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:06 INFO - 'SHELL': '/bin/bash', 09:33:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5YTlsrdd08/Listeners', 09:33:06 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 09:33:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:06 INFO - 'USER': 'cltbld', 09:33:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:06 INFO - 'XPC_FLAGS': '0x0', 09:33:06 INFO - 'XPC_SERVICE_NAME': '0', 09:33:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:33:06 INFO - Cleaning up... 09:33:06 INFO - Return code: 0 09:33:06 INFO - Running post-action listener: _resource_record_post_action 09:33:06 INFO - Running post-action listener: _start_resource_monitoring 09:33:06 INFO - Starting resource monitoring. 09:33:06 INFO - [mozharness: 2017-04-30 16:33:06.917198Z] Finished create-virtualenv step (success) 09:33:06 INFO - [mozharness: 2017-04-30 16:33:06.918128Z] Running install step. 09:33:06 INFO - Running pre-action listener: _resource_record_pre_action 09:33:06 INFO - Running main action method: install 09:33:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:07 INFO - Reading from file tmpfile_stdout 09:33:07 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:07 INFO - Reading from file tmpfile_stdout 09:33:07 INFO - Output received: 09:33:07 INFO - Usage: mozinstall [options] installer 09:33:07 INFO - Options: 09:33:07 INFO - -h, --help show this help message and exit 09:33:07 INFO - -d DEST, --destination=DEST 09:33:07 INFO - Directory to install application into. [default: 09:33:07 INFO - "/builds/slave/test"] 09:33:07 INFO - --app=APP Application being installed. [default: firefox] 09:33:07 INFO - mkdir: /builds/slave/test/build/application 09:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:33:27 INFO - Reading from file tmpfile_stdout 09:33:27 INFO - Output received: 09:33:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:33:27 INFO - Running post-action listener: _resource_record_post_action 09:33:27 INFO - [mozharness: 2017-04-30 16:33:27.548560Z] Finished install step (success) 09:33:27 INFO - [mozharness: 2017-04-30 16:33:27.548705Z] Running run-tests step. 09:33:27 INFO - Running pre-action listener: _resource_record_pre_action 09:33:27 INFO - Running main action method: run_tests 09:33:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:33:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:33:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:33:27 INFO - 2017-04-30 09:33:27.562 screenresolution[2300:46522] starting screenresolution argv=screenresolution get 09:33:27 INFO - 2017-04-30 09:33:27.565 screenresolution[2300:46522] Display 0: 1600x1200x32@60 09:33:27 INFO - 2017-04-30 09:33:27.570 screenresolution[2301:46525] starting screenresolution argv=screenresolution list 09:33:27 INFO - Available Modes on Display 0 09:33:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:33:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:33:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:33:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:33:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:33:27 INFO - Intel Iris: 09:33:27 INFO - Chipset Model: Intel Iris 09:33:27 INFO - Type: GPU 09:33:27 INFO - Bus: Built-In 09:33:27 INFO - VRAM (Dynamic, Max): 1536 MB 09:33:27 INFO - Vendor: Intel (0x8086) 09:33:27 INFO - Device ID: 0x0a2e 09:33:27 INFO - Revision ID: 0x0009 09:33:27 INFO - Displays: 09:33:27 INFO - Display: 09:33:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:33:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:33:27 INFO - Display Serial Number: 1600x1200 60 09:33:27 INFO - Main Display: Yes 09:33:27 INFO - Mirror: Off 09:33:27 INFO - Online: Yes 09:33:27 INFO - Rotation: Supported 09:33:27 INFO - Return code: 0 09:33:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:33:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:33:27 INFO - Python 2.7.3 09:33:27 INFO - Return code: 0 09:33:27 INFO - grabbing minidump binary from tooltool 09:33:27 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')]} 09:33:27 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 0x106322d30>, '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 0x106248db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106317be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:33:27 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 09:33:27 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 09:33:27 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 09:33:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:33:27 INFO - Return code: 0 09:33:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:33:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:33:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:33:27 INFO - ENV: RUST_BACKTRACE is now 1 09:33:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:33:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:33:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:33:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0132 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:33:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l4wy5feQoZ/Render', 09:33:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:27 INFO - 'HOME': '/Users/cltbld', 09:33:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:27 INFO - 'LOGNAME': 'cltbld', 09:33:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:33:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:33:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:27 INFO - 'MOZ_NO_REMOTE': '1', 09:33:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:33:27 INFO - 'NO_EM_RESTART': '1', 09:33:27 INFO - 'PAGER': '/bin/cat', 09:33:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:27 INFO - 'PWD': '/builds/slave/test', 09:33:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:33:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:27 INFO - 'RUST_BACKTRACE': '1', 09:33:27 INFO - 'SHELL': '/bin/bash', 09:33:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5YTlsrdd08/Listeners', 09:33:27 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 09:33:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:27 INFO - 'USER': 'cltbld', 09:33:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:27 INFO - 'XPC_FLAGS': '0x0', 09:33:27 INFO - 'XPC_SERVICE_NAME': '0', 09:33:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:33:28 INFO - mozversion application_buildid: 20170430075046 09:33:28 INFO - mozversion application_changeset: e2f942326f941f481b004ecbb7b9d18e55bd4322 09:33:28 INFO - mozversion application_display_name: Nightly 09:33:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:33:28 INFO - mozversion application_name: Firefox 09:33:28 INFO - mozversion application_remotingname: firefox 09:33:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:33:28 INFO - mozversion application_vendor: Mozilla 09:33:28 INFO - mozversion application_version: 55.0a1 09:33:28 INFO - mozversion platform_buildid: 20170430075046 09:33:28 INFO - mozversion platform_changeset: e2f942326f941f481b004ecbb7b9d18e55bd4322 09:33:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:33:28 INFO - mozversion platform_version: 55.0a1 09:33:28 INFO - using testdate: 1493570008 09:33:28 INFO - actual date: 1493570008 09:33:28 INFO - starting webserver on 'localhost:50301' 09:33:28 INFO - SUITE-START | Running 2 tests 09:33:28 INFO - TEST-START | dromaeo_css 09:33:28 INFO - operating with platform_type : mac_ 09:33:28 INFO - Initialising browser for dromaeo_css test... 09:33:28 INFO - TEST-INFO | started process 2311 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpt9ZbBZ/profile http://localhost:50301/getInfo.html) 09:33:31 INFO - PID 2311 | 2017-04-30 09:33:31.126 plugin-container[2313:46695] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e47, name = 'com.apple.tsm.portname' 09:33:31 INFO - PID 2311 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:33:31 INFO - PID 2311 | 2017-04-30 09:33:31.129 plugin-container[2313:46695] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0xa20b, name = 'com.apple.CFPasteboardClient' 09:33:31 INFO - PID 2311 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:33:31 INFO - PID 2311 | 2017-04-30 09:33:31.129 plugin-container[2313:46695] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:33:31 INFO - PID 2311 | __metrics Screen width/height:1600/1200 09:33:31 INFO - PID 2311 | colorDepth:24 09:33:31 INFO - PID 2311 | Browser inner width/height: 1024/689 09:33:31 INFO - PID 2311 | __metrics 09:33:32 INFO - TEST-INFO | 2311: exit 0 09:33:32 INFO - Browser initialized. 09:33:32 INFO - Running cycle 1/1 for dromaeo_css test... 09:33:32 INFO - TEST-INFO | started process 2314 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpt9ZbBZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:34 INFO - PID 2314 | 2017-04-30 09:33:34.696 plugin-container[2315:46826] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x933b, name = 'com.apple.tsm.portname' 09:33:34 INFO - PID 2314 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:33:34 INFO - PID 2314 | 2017-04-30 09:33:34.696 plugin-container[2315:46826] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4417, name = 'com.apple.CFPasteboardClient' 09:33:34 INFO - PID 2314 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:33:34 INFO - PID 2314 | 2017-04-30 09:33:34.696 plugin-container[2315:46826] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:33:44 INFO - PID 2314 | RSS: Main: 234930176 09:33:44 INFO - PID 2314 | 09:36:48 INFO - PID 2314 | Cycle 1(1): loaded http://localhost:50301/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50301/tests/dromaeo/cssquery-ext.html) 09:36:49 INFO - PID 2314 | RSS: Main: 252026880 09:36:49 INFO - PID 2314 | 09:38:32 INFO - PID 2314 | ************************* 09:38:32 INFO - PID 2314 | A coding exception was thrown and uncaught in a Task. 09:38:32 INFO - PID 2314 | 09:38:32 ERROR - PID 2314 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:38:32 INFO - PID 2314 | Full stack: 09:38:32 INFO - PID 2314 | ************************* 09:38:32 INFO - PID 2314 | ************************* 09:38:32 INFO - PID 2314 | A coding exception was thrown and uncaught in a Task. 09:38:32 INFO - PID 2314 | 09:38:32 ERROR - PID 2314 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:38:32 INFO - PID 2314 | Full stack: 09:38:32 INFO - PID 2314 | ************************* 09:38:32 INFO - PID 2314 | ************************* 09:38:32 INFO - PID 2314 | A coding exception was thrown and uncaught in a Task. 09:38:32 INFO - PID 2314 | 09:38:32 ERROR - PID 2314 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:38:32 INFO - PID 2314 | Full stack: 09:38:32 INFO - PID 2314 | ************************* 09:38:32 INFO - PID 2314 | ************************* 09:38:32 INFO - PID 2314 | A coding exception was thrown and uncaught in a Task. 09:38:32 INFO - PID 2314 | 09:38:32 ERROR - PID 2314 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:38:32 INFO - PID 2314 | Full stack: 09:38:32 INFO - PID 2314 | ************************* 09:39:51 INFO - PID 2314 | Cycle 1(1): loaded http://localhost:50301/tests/dromaeo/cssquery-ext.html (next: http://localhost:50301/tests/dromaeo/cssquery-jquery.html) 09:39:52 INFO - PID 2314 | RSS: Main: 256479232 09:39:52 INFO - PID 2314 | 09:42:54 INFO - PID 2314 | Cycle 1(1): loaded http://localhost:50301/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50301/tests/dromaeo/cssquery-mootools.html) 09:42:54 INFO - PID 2314 | RSS: Main: 265940992 09:42:54 INFO - PID 2314 | 09:45:56 INFO - PID 2314 | Cycle 1(1): loaded http://localhost:50301/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50301/tests/dromaeo/cssquery-prototype.html) 09:45:57 INFO - PID 2314 | RSS: Main: 259354624 09:45:57 INFO - PID 2314 | 09:49:00 INFO - PID 2314 | Cycle 1(1): loaded http://localhost:50301/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50301/tests/dromaeo/cssquery-yui.html) 09:49:00 INFO - PID 2314 | RSS: Main: 269471744 09:49:00 INFO - PID 2314 | 09:52:02 INFO - PID 2314 | Cycle 1(1): loaded http://localhost:50301/tests/dromaeo/cssquery-yui.html (next: http://localhost:50301/tests/dromaeo/cssquery-dojo.html) 09:52:02 INFO - PID 2314 | RSS: Main: 264372224 09:52:02 INFO - PID 2314 | 09:52:02 INFO - PID 2314 | __start_tp_report 09:52:02 INFO - PID 2314 | _x_x_mozilla_page_load 09:52:02 INFO - PID 2314 | _x_x_mozilla_page_load_details 09:52:02 INFO - PID 2314 | |i|pagename|runs| 09:52:02 INFO - PID 2314 | |0;dojo.html;3063.4792085345503;3569.6251893551175;3575.1419659281773;3606.981965090174;3621.3662609043417;6118.265808103023;6214.471769899558;6225.937740622587;6239.344868788774;6253.062040693898;6133.64071396136;6140.258857967792;6168.074788781685;6199.194104766385;6260.655663938482;4315.82736690532;4472.195004899117;5362.839114826542;5395.541378982782;5412.296401467804;4943.380211046157;5350.3312085989255;5500.28496295481;5529.640573362739;5545.500904918556;5413.02565538203;5438.374586922515;5445.074337362658;5449;5507.807226747044;5440.809571664972;5441.075017247038;5443.755031023614;5472.069748142825;5480.095784195603;5392.083345831218;5394.622376433651;5396.892062158735;5405.918911216335;5485.286912701363;6024.216851809237;6035.577509574332;6135.355787642323;6143.4470897618985;6295.937040629581;6458.128152699373;6553.14809074822;6625.4699624030445;6635.701393437259;6645.435138013275;6737.292584278629;6739.932600673979;6746.865062698767;6751.42612877906;6764.188297404294;6297.370262973666;6325.841853953642;6359.109724638462;6361.3638636136475;6390.5526613136635;5611.579131565149;6608.372204640552;6707.262201157869;6711.228208755958;6818.727250909908;5482.369527504308;5574.358948720868;6212.943799554087;6295.213098362705;6363.9045414318825;6594.505412094112;6608.43828274602;6640.269570347258;6686.364795344434;6691.7323307068145;6612.008198770223;6641.468682505388;6657.267700552935;6658.83352916181;6669.133012708414;5556.361018482846;6034.48706859913;6375.394337537927;6442.806715798533;6656.101426307483;5263.763130659129;5267.920981185285;5311.575073994071;5339.839804805862;5343.732813359316;3983.5219773626773;4696.272077827942;4713.9629281558;4720.598749106296;4722.693024953367;5608.831735047955;6212.254529456494;6323.083152942798;6345;6367.866764633807;5013.222950442687;5584.97207513968;6493.31820158886;6636.767713130113;6660.234073081658;4967.05625931072;6261.218140481055;6274.247090349096;6352.872942541216;6363.522735794834;5830.737616807254;5834.445727655866;5835;5847.3275573308765;5849.327327357323;6515.902261466082;6713.12729345182;6795.694193761194;6854.794356169323;6884.070650462324;6706.39642432164;6723.596584204964;6730.596164229966;6756.729730810713;6762.729490820312;6827.89758153638;6849.452043836581;6873.347032031949;6890.20762612306;6915.619640919797;5434;6481.675916204076;6546.24718157418;6579.2104947406615;6618.404343609098;5740.569457290637;6197.667501487202;6672.699728512326;6701.430378417889;6760.628165450948;6274.905876411949;6326.367363263636;6515.250746164063;6519.674016299071;6524.902126468011;6453.354664533509;6547.148870646785;6549.443297319781;6557.770478033246;6560.147180866456;6278.497720182283;6291.779787707408;6355.936440635534;6362;6438.90341644885;6450.903236451551;6523.64119973387;6533.705983230861;6536.477081833346;6571.277159512354;6366.9681651591445;6370.55406121567;6370.936290637034;6379.808605741649;6387.808365749035 09:52:02 INFO - PID 2314 | |1;ext.html;802.5024484819413;823.6952327638772;1195.9043276537873;1242.912996090274;1247.4885297028216;35781.46327805082;36368.45447318292;36374.63625363746;36449.271014579725;36568.817155914214;36719.63280367196;37016.07459813506;37020;37050.44424333637;37066.62933370665;6545.345465453453;7912.446128770988;7918.089419716749;8159.102498725136;8299.66801327946;8071.5964201789675;8328.750137495854;8357.707480238192;8364.749057528285;8368.372372072088;8302.501849888995;8305.252527272543;8389.244967952884;8389.580520973957;8390.958045209796;8301.875471867927;8315.625796839127;8325.66697332106;8333.458325208903;8383.287420569259;8106.067802202704;8173;8231.506109633381;8247.010358756928;8249.958750206271;35607.82196089029;35729;35810.104747381265;35861.10347241314;35882.282354353025;3613.765105268149;3656.213914008501;3658.1037645776955;3670.926581468382;3678.9632103679155;29667;29828.850855745583;29963.40073198524;29968.550471742943;29977;3075.0467355119986;3142.355817057498;3160.367926414703;3161.0832858471017;3178.761592880543;277639;280526;280953;282485;282993;37078.8146059268;37690.43464348037;44752.55247447549;46238.612841614806;46429.7678511612;39790.005249868984;47635.761821190674;47662.76168619204;47864;47935.5206447938;13941.30293485342;14028.789568156486;14035.438582456587;14177.92911035459;14183.71632567343;11230.989210971053;11268;11360.715982100513;11376.976072153546;11404.771904562029;11513.597024104116;13131.934340328236;13164.210147391188;13176.945844332431;13191.868081319257;5276.15581506957;5987.341392446828;6011.849703757353;6095.6952152392205;6103.725332360054;912.625823412411;944.1927152284835;948.4546385828038;1043.5564884923876;1087.1737479515466;24112.75887241105;24234.51530969406;24316;24343.90452429645;24547.63178552323;1141.3551343490901;1160.5995931403652;1176.923499972499;1182.467889449751;1183.1363104933275;11912.166148369532;12349.567765128177;12378.81431778524;12404.503819847285;12443.93778031104;328212;329729;330409.3479532587;330682;331600.8139308186;52192.73903630458;52194.47805521972;52301;52529.474705253226;52548.73725631347;1515.5226103777275;1548.7676848472595;1558.3844381469255;1564.4915402494007;1571.230097252338;23680.881595591913;23783.405414864766;23863.64204536968;23944.922478488163;24070;35921.46117808287;35971.640283596826;36109;36148.4577731329;36193;283322.58338708174;283461;283496;284302;284386;31381.8430907844;32769;32825.70220084571;32884.38271790053;32934.83532582418;41409.37885931774;42452.301907923335;43144.78427607842;43164;43270.567294326655;28568.714312857435;29183.562246565893;29532.852335739044;30271.848640756656;30556.08331750051;29463.116106516838;30007.54988675128;30241.395172096876;30454.086377408712;30541.54187687142;35123.47314790229;35670;36134.27731445304;36217.45673814948;36245.27509449743;29746.553801693426;29789.404211915207;30358.544621831134;30701.232469187555;30741.385172296876;21754.89122554377;22798.20206292838;23821;24034.555865977025;24272.1504747333 09:52:02 INFO - PID 2314 | |2;jquery.html;408.87120557024554;436.3520172543773;439.3848611943279;454.52275111133304;454.8067071494616;16951.406700765474;19284.614307713855;21701.45746356342;21922.671159932615;21935.122595096196;21645.783542164572;22414.103435862547;22545.774542254574;22572.097116115336;23238.3028509145;6766.255711871702;6891.1730592328995;6980.162380514345;6995.33544313292;7000.5449645773115;5865.76536938522;6655.334466553354;6923.273056329089;6940.861182776342;6944.375006249436;6690.531662783607;6755.5271131020845;6881.13985751781;6901.896471552931;6918.827029324257;6705.753572553201;6798.9660051699675;6902.5858448492745;6914.478814660766;6931.202911665147;6566.5075119365765;6667.066610674509;6693;6706.2287836898895;6709.362610552039;27148.658412018078;29085.85457072701;29798.40403191924;29984.100476985725;30072.398552029055;2282.5663124006387;2318.8956496957508;2320.5358928214423;2328.080408238753;2328.604137296664;16741.330346786115;18589.349372772023;19232.80767192324;19478.318258861014;19533.80466195334;2290.89690963907;2306.8385213035094;2358.1982126077046;2364.491634298634;2370.4073981504625;142139.28930355283;149672;149693;151360;158726;23492.882535587214;24724.752752472246;25514.74485255161;25535.87232063828;25756.742432575807;41093.79453102775;41178.911581631495;41240;41394.586054139676;41432;7345.853082938312;9051.321150913707;9186.713860059597;9232.261419086457;9282.814343713088;8672.132786721404;8706.216440520384;8722;8865.423747456394;8891.422057566237;7936.960315198503;8092.109867914524;8093.109757926623;8121.959390203129;8132.5933703314595;2231.877246751412;2237.988810055939;2239.73123225214;2241.753407125215;2410.903563857461;941.1623654947102;949.3544389814854;976.99023009769;996.8504724291414;1031.5770534080991;19968.30110946139;21235.256766013423;21321.893390532947;21335;21588.46028849291;945.4894357047117;981.8218138234005;1015.1117771949545;1034.6068493972243;1039.298473530364;10593.788124237471;10929.672109836718;10940.398278094623;10969.23215374916;10977.780444391226;555570;563192;563782;566148;572397;101569;123826;129681;130123;134155;1050.9579616815395;1098.6319582939805;1161.8315344275034;1233.5250928392634;1259.1689484939895;21910.90445477688;22679.20622778195;23233.070677172724;23346.416339590967;23472.882635587397;58975;59220;59826;59932;60131.699341503016;71733.20666983367;73072.63463682648;81568.7764683542;82287.5885620568;82549;8547.273481753871;8809.779755506164;8857.689980850639;8963.372563920462;9098.135677110664;11257;13389.799153012907;14109.365078571283;14217.649323314268;14548.927255364079;11979.28124312544;12090.75818483643;12095.81856272139;12191.573294934635;12343.938280308541;11209.253732835508;11252.493637786483;11391.316521008766;11629.24409913353;11654.88345116538;11901.523939042341;11924;12098.697532561757;12109.515619375126;12144;6710.731570737116;8851.822963540822;9018.684346047858;9047.683331083645;9093.545322733704;11990.160688751703;11997.700057498283;12120.939395302967;12211.87788122143;12232 09:52:02 INFO - PID 2314 | |3;mootools.html;1259.836221291232;1427.7358688642596;1445.638590352412;1450.8549145085485;1454.9854501454986;11190.44047797609;11241.662750117499;11677.532898684052;11700.590479333236;11774.470148843302;11722.120840936921;11804.7639047219;11939.880601193985;11943.701407464796;11946.761064778699;2516.5470215361274;2557.3223095879607;2574.7167811540808;2577.445849142434;2586.107792811477;2500.987495062522;2539.200151952138;2550.349660836484;2551.170869467421;2554.6806649168852;2493.775560199582;2507.661465702134;2513.74862513749;2534.911278105267;2537.949241015179;2474.40614252579;2497.413107919628;2503.949921001579;2520.621906713989;2520.7479252074645;2431.7081950166094;2506.9247922562354;2533.6199570064455;2550.1711943618398;2552.3619095226195;11669.941650291694;11711.945924866803;11751.823722644167;11758.647240582795;11763.470643821049;6196.318404975449;6449.677516124175;6608.768693095719;6849.897251541231;6897.172339319263;4070.14526949341;4341.153475072362;4410.713303635285;4411.536788637179;4458.866234012952;1248.825164476974;1258.6161220827644;1326.8208791813079;1329.388481298604;1334.5395838435725;13983.860161398357;14552.763015143619;16141.192940353052;16321.265543050473;16442.095684737335;5624.943750562524;5647.943520564824;5788.652680839163;5809.477147056785;5869.6771677558145;11770.234934729386;11818.468168932419;11860.22908510944;11866;11961.70095747596;6636.303188165173;6706.899396509057;6709.7316107355155;6719.260881303053;6725.596464212065;6002.309734380515;6245.094461303176;6267.0286105653695;6311.96844015777;6317.305096439388;4293.5706429356815;4405.207062728676;4415.911681766347;4445.955200527874;4478.529754375809;1064.7489200189746;1112.6995711157942;1167.6746892277326;1281.7372438650054;1310.9541166059332;762.3634265388463;785.9410544209208;786.9016372953381;791.5290402210676;793.8928244686894;6056.454919057306;6717;6898.099879777162;7076.646167691595;7098.396636285974;908.3505293715026;933.3000249812641;934.4486752815872;941.5857022909897;944.8677185194078;3495.1262184453885;3850.5764365920286;3919.2749341371937;4125.814338354781;4425.822967081281;14305.713885722227;15019.24903754808;15084.321205545777;15319.080855148726;15319.770203446957;12092.972097371821;14463.915206359354;15170.772438413433;15211.239438028275;15283.847161528241;8400.243978042006;8481.321494280442;8663;8718.564071796385;8724.607392667345;6849.075374824534;7031.332023457763;7122.821929451805;7146.928530714834;7160.856782864209;12662.620121396372;13250.403731831899;13277.336133193108;13679.042467027213;13698.931505342409;13511.594652160451;13886.583402497941;13964;13987.090839095426;14024.719505610035;9248.121428464285;9501.192398646193;9538.618455261989;9543.713688589354;9581.616735330788;10510.1066409353;10627.89372106269;10680.732981675521;10739.14086873064;10772.24594278393;8407.495550267004;8567.228949394585;9185;9197.034311397207;9260.39807412516;8837.337199710177;8902.42134261271;8934.195922367018;8994.640214391613;9014.819703606023;6422.807315780534;6736.259011508632;8067.354611631173;8106.513609183467;8110.107888132418;5792.913106303493;5835.328937172279;5878.676672783038;5958.136070269873;6024.698765061817;5469.863253418696;5952.255968003999;6101.932161871743;6125.571210015256;6230.7819226326865 09:52:02 INFO - PID 2314 | |4;prototype.html;374.77700768043024;385.6702519345959;386.54773914520007;407.4865669256736;413.958604139586;5365.409804921455;6015.0676645120075;6081.665508397036;6231.3145553989025;6232.376762323765;5100.979804039198;5937.495312898409;5980.551458640609;6056.818295451132;6063.211782468273;3854.9421758673643;4413.713108647936;4432.936095337112;4439.955600444003;4458.777061146946;3651.3427583035045;4449.443819522559;4543.954560454403;4696.624270058404;4772.355731976191;4648.814047438115;4682;4696.64775141864;4708;4719.90560188796;4710.7880145393365;4714.151452738506;4720.253506202693;4724.126036683225;4741.700275366445;3772.264408440355;4137.275976704064;4156.501219853607;4183.267928112598;4234.110836724291;5153.974230128825;5992.610480318809;6008.128821320884;6045.516358691294;6070.2412198475195;5596.720163991784;5620.5503559715125;5624.803131890364;5627.831165065055;5628;5390.649607775482;6156;6397.52018598607;6587.505937054692;6601.405873471363;4779.450363208206;4792.9281060784115;4795.904081918342;4796.37647105874;4802.783874725646;5402.459754024605;5610.803621873256;6063.363346848561;6482.092507049017;6936.167659880796;3821.5987321331418;4053.4527838741983;4250.51119121305;4467.530909254481;4837.564619184291;4415.448068991376;4733.473562196117;4930.383702037246;4969.925451118236;4972.185152419341;5353.197020446886;5539.861503462365;5549.001179787677;5577.414371491016;5635.098384258499;5939.46544810969;6311.211098612674;6351.079093531412;6553.049807777846;6589.76935807254;1412.6468382904275;1691.8984860908386;1693.9745903811452;1697.796264448274;1698.3206717312926;1137.2153214282118;1182.869884312725;1187.804012337972;1189.3161432176532;1199.4182821331647;6120.479759220427;6161.168242287234;6177.752889884444;6178.115674719254;6246.593971391845;6083.5741498095595;6460.773872914426;6658.1344425224415;6675.499337549606;6752.729890804411;5558.470895742427;5755.366909639936;5949.10763385487;6186.81439556814;6269.310375858652;3494.5282386877952;3531.7527773056154;3554.489342029627;3558.893233203008;3559.760617837755;6122.418370254819;6125.632462052291;6425.646589437626;7005.684744186524;7014.789556313319;5824.504917082011;6381.712822922979;6477.866373384639;6976.302369762983;7001.229864714877;6709.36261055199;6949.930500694928;6960.807345686093;6970.919507476349;6972.825679358057;6049.637021778707;6302.684865756785;6726.091977583159;6726.831829204309;6735.225449073419;6589.220910354082;6629.602223866584;6634.734610615521;6652.704816838183;6672.199336079701;5830.4461076197695;5830.591858569859;6112.724927378367;6990.6504674767075;7022.157341118894;4123.237201117803;4225.345071513921;4265.573442655709;4297.935530967101;4299.98950246698;5335.653182543122;5908.261467316585;6246;6391.137196478602;6742.966285168739;5199.610029247746;5661.669507665778;5867.471927526543;5875.853103672443;6506.739730410731;5827.475527202402;6442.679250753678;6503.219613646393;6505.837354065997;6522.934770652422;5332.093544097435;5756.453136951983;5892.850894075614;6198.768443360296;6415.8716825662295;5624.35319938196;5950.672713000653;6399.8080057598345;6426.967865160645;6507.28419873823;4720.055988802184;4924.113659541317;5553.250311207935;6302.936970630235;6420.582662126947 09:52:02 INFO - PID 2314 | |5;yui.html;766.6358479722131;815.62888885557;824.8740469259461;825.178946947787;854.8033952190996;16269.43056993004;16276.267567959441;16655.833441665578;18286.725699114522;19291.0354482276;15438.150901700403;17874;18148.092595370246;18267.543311417223;18346.724799128024;971.0338213477582;982.7395740128871;989.2382865193797;990.1732053735104;994.0357852882693;974.410481658597;1007.425767312632;1010.7675234696025;1012.8126296635146;1014.3102690170681;1053.5364439646569;1060.1677683018831;1061.4639606998455;1061.8725752909622;1063.7766069125494;1040.287403128859;1043.9373637581768;1056.6935588679273;1056.7146870345002;1058.6612284069101;775.6509570693154;778.3850757901251;778.6729573579111;779.8245394786185;782.5969625642798;16495.34018639253;16926.069066201355;17022.659546808994;17084.914575427043;17364.91317543417;17310.56723581908;17316.13419329041;17664.735028974577;17670.469885903443;17804.55488612795;11398.487068081957;13858.792118118236;14146.504872329522;14324.498642547565;14336.64158396038;3500.929981400383;3521.6126226115107;3531.2584357285;3534.964650353489;3538.610752817188;134996;135289;136323.31838340746;136668;138141;13185.73628527424;13339;13493.662658433617;13501.324933753272;13537.323133843269;20910.686339704916;24962.251132466055;25424.618630720553;25645.61531577028;25873.965041398133;6883.518153729291;7542.396608271325;7827.099883513469;7829.138794732575;7837.255460731221;3932.744371615836;3955.7824319662695;3983.46223259862;4012.799360032045;4020.4974378202724;4317.805698743564;4408.889777755518;4415.359772832921;4415.977920110379;4421.403110580095;864.4510735682886;893.9016708162097;903.5572569441058;904.2088172848757;904.2946501728662;646.9288378278386;662.7547807311229;664.6909187227963;666.3469799596422;694.2016680817;9509.667161649448;11241.887581124247;11846.348450835287;11973.580924667769;12034.338111403782;637.2162240444279;658.8451713847242;669.3106100716172;680.2041611314773;682.7780971184286;4428.734275943454;4936.284238785356;5438.83683489496;5483.506484416422;5594;104772.47613762035;105513.47243263734;108061.45969270103;108246;110998;92716.53641731883;94829;95216;95954.52022739842;96621;82267.7659835103;83629;84179.5791021041;84374;84583;9974.32784732024;10001.899981000388;10458.581656733646;11341.659750207507;11490;31662;33862.64549417996;39641;40387.596124038384;40474;45085.64743057713;48920;49366.50633493763;49406.25890611715;50182;11654.592089276835;13902.30488475552;13985.881129509818;14361;14390.928045359706;15328.233588320316;15383.077015378665;15535.223238838238;15556.222188890737;15676.608084797972;14216.360263787947;14544.41822327095;14672.3397447113;14722.263886805402;14812.111273323635;13900.374483148486;14093.365798539295;14422.495212667925;14515.274236287933;14599.270036498345;14095.506657266946;14222;14375;14466.710665786835;14494.855051449773;9285.885693716797;10408.271421000458;10456;10493.632722854663;10924.508397122308;11669.35818529989;11719.765604687687;11841.28952262867;11859.70350741204;11887.989520890822 09:52:02 INFO - PID 2314 | __end_tp_report 09:52:02 INFO - PID 2314 | __start_cc_report 09:52:02 INFO - PID 2314 | _x_x_mozilla_cycle_collect,420 09:52:02 INFO - PID 2314 | __end_cc_report 09:52:02 INFO - PID 2314 | __startTimestamp1493571122761__endTimestamp 09:52:02 INFO - PID 2314 | 09:52:02 INFO - PID 2314 | ------- Summary: start ------- 09:52:02 INFO - PID 2314 | Number of tests: 6 09:52:02 INFO - PID 2314 | 09:52:02 INFO - PID 2314 | [#0] dojo.html Cycles:165 Average:6050.71 Median:6325.84 stddev:755.28 (11.9%) stddev-sans-first:720.32 09:52:02 INFO - PID 2314 | Values: 3063.5 3569.6 3575.1 3607.0 3621.4 6118.3 6214.5 6225.9 6239.3 6253.1 6133.6 6140.3 6168.1 6199.2 6260.7 4315.8 4472.2 5362.8 5395.5 5412.3 4943.4 5350.3 5500.3 5529.6 5545.5 5413.0 5438.4 5445.1 5449.0 5507.8 5440.8 5441.1 5443.8 5472.1 5480.1 5392.1 5394.6 5396.9 5405.9 5485.3 6024.2 6035.6 6135.4 6143.4 6295.9 6458.1 6553.1 6625.5 6635.7 6645.4 6737.3 6739.9 6746.9 6751.4 6764.2 6297.4 6325.8 6359.1 6361.4 6390.6 5611.6 6608.4 6707.3 6711.2 6818.7 5482.4 5574.4 6212.9 6295.2 6363.9 6594.5 6608.4 6640.3 6686.4 6691.7 6612.0 6641.5 6657.3 6658.8 6669.1 5556.4 6034.5 6375.4 6442.8 6656.1 5263.8 5267.9 5311.6 5339.8 5343.7 3983.5 4696.3 4714.0 4720.6 4722.7 5608.8 6212.3 6323.1 6345.0 6367.9 5013.2 5585.0 6493.3 6636.8 6660.2 4967.1 6261.2 6274.2 6352.9 6363.5 5830.7 5834.4 5835.0 5847.3 5849.3 6515.9 6713.1 6795.7 6854.8 6884.1 6706.4 6723.6 6730.6 6756.7 6762.7 6827.9 6849.5 6873.3 6890.2 6915.6 5434.0 6481.7 6546.2 6579.2 6618.4 5740.6 6197.7 6672.7 6701.4 6760.6 6274.9 6326.4 6515.3 6519.7 6524.9 6453.4 6547.1 6549.4 6557.8 6560.1 6278.5 6291.8 6355.9 6362.0 6438.9 6450.9 6523.6 6533.7 6536.5 6571.3 6367.0 6370.6 6370.9 6379.8 6387.8 09:52:02 INFO - PID 2314 | 09:52:02 INFO - PID 2314 | [#1] ext.html Cycles:180 Average:44234.60 Median:181331.92 stddev:78478.18 (43.3%) stddev-sans-first:78630.58 09:52:02 INFO - PID 2314 | Values: 802.5 823.7 1195.9 1242.9 1247.5 35781.5 36368.5 36374.6 36449.3 36568.8 36719.6 37016.1 37020.0 37050.4 37066.6 6545.3 7912.4 7918.1 8159.1 8299.7 8071.6 8328.8 8357.7 8364.7 8368.4 8302.5 8305.3 8389.2 8389.6 8391.0 8301.9 8315.6 8325.7 8333.5 8383.3 8106.1 8173.0 8231.5 8247.0 8250.0 35607.8 35729.0 35810.1 35861.1 35882.3 3613.8 3656.2 3658.1 3670.9 3679.0 29667.0 29828.9 29963.4 29968.6 29977.0 3075.0 3142.4 3160.4 3161.1 3178.8 277639.0 280526.0 280953.0 282485.0 282993.0 37078.8 37690.4 44752.6 46238.6 46429.8 39790.0 47635.8 47662.8 47864.0 47935.5 13941.3 14028.8 14035.4 14177.9 14183.7 11231.0 11268.0 11360.7 11377.0 11404.8 11513.6 13131.9 13164.2 13176.9 13191.9 5276.2 5987.3 6011.8 6095.7 6103.7 912.6 944.2 948.5 1043.6 1087.2 24112.8 24234.5 24316.0 24343.9 24547.6 1141.4 1160.6 1176.9 1182.5 1183.1 11912.2 12349.6 12378.8 12404.5 12443.9 328212.0 329729.0 330409.3 330682.0 331600.8 52192.7 52194.5 52301.0 52529.5 52548.7 1515.5 1548.8 1558.4 1564.5 1571.2 23680.9 23783.4 23863.6 23944.9 24070.0 35921.5 35971.6 36109.0 36148.5 36193.0 283322.6 283461.0 283496.0 284302.0 284386.0 31381.8 32769.0 32825.7 32884.4 32934.8 41409.4 42452.3 43144.8 43164.0 43270.6 28568.7 29183.6 29532.9 30271.8 30556.1 29463.1 30007.5 30241.4 30454.1 30541.5 35123.5 35670.0 36134.3 36217.5 36245.3 29746.6 29789.4 30358.5 30701.2 30741.4 21754.9 22798.2 23821.0 24034.6 24272.2 09:52:02 INFO - PID 2314 | 09:52:02 INFO - PID 2314 | [#2] jquery.html Cycles:180 Average:37137.46 Median:25119.75 stddev:95051.77 (378.4%) stddev-sans-first:95278.41 09:52:02 INFO - PID 2314 | Values: 408.9 436.4 439.4 454.5 454.8 16951.4 19284.6 21701.5 21922.7 21935.1 21645.8 22414.1 22545.8 22572.1 23238.3 6766.3 6891.2 6980.2 6995.3 7000.5 5865.8 6655.3 6923.3 6940.9 6944.4 6690.5 6755.5 6881.1 6901.9 6918.8 6705.8 6799.0 6902.6 6914.5 6931.2 6566.5 6667.1 6693.0 6706.2 6709.4 27148.7 29085.9 29798.4 29984.1 30072.4 2282.6 2318.9 2320.5 2328.1 2328.6 16741.3 18589.3 19232.8 19478.3 19533.8 2290.9 2306.8 2358.2 2364.5 2370.4 142139.3 149672.0 149693.0 151360.0 158726.0 23492.9 24724.8 25514.7 25535.9 25756.7 41093.8 41178.9 41240.0 41394.6 41432.0 7345.9 9051.3 9186.7 9232.3 9282.8 8672.1 8706.2 8722.0 8865.4 8891.4 7937.0 8092.1 8093.1 8122.0 8132.6 2231.9 2238.0 2239.7 2241.8 2410.9 941.2 949.4 977.0 996.9 1031.6 19968.3 21235.3 21321.9 21335.0 21588.5 945.5 981.8 1015.1 1034.6 1039.3 10593.8 10929.7 10940.4 10969.2 10977.8 555570.0 563192.0 563782.0 566148.0 572397.0 101569.0 123826.0 129681.0 130123.0 134155.0 1051.0 1098.6 1161.8 1233.5 1259.2 21910.9 22679.2 23233.1 23346.4 23472.9 58975.0 59220.0 59826.0 59932.0 60131.7 71733.2 73072.6 81568.8 82287.6 82549.0 8547.3 8809.8 8857.7 8963.4 9098.1 11257.0 13389.8 14109.4 14217.6 14548.9 11979.3 12090.8 12095.8 12191.6 12343.9 11209.3 11252.5 11391.3 11629.2 11654.9 11901.5 11924.0 12098.7 12109.5 12144.0 6710.7 8851.8 9018.7 9047.7 9093.5 11990.2 11997.7 12120.9 12211.9 12232.0 09:52:02 INFO - PID 2314 | 09:52:02 INFO - PID 2314 | [#3] mootools.html Cycles:180 Average:7087.28 Median:3672.85 stddev:4432.25 (120.7%) stddev-sans-first:4423.05 09:52:02 INFO - PID 2314 | Values: 1259.8 1427.7 1445.6 1450.9 1455.0 11190.4 11241.7 11677.5 11700.6 11774.5 11722.1 11804.8 11939.9 11943.7 11946.8 2516.5 2557.3 2574.7 2577.4 2586.1 2501.0 2539.2 2550.3 2551.2 2554.7 2493.8 2507.7 2513.7 2534.9 2537.9 2474.4 2497.4 2503.9 2520.6 2520.7 2431.7 2506.9 2533.6 2550.2 2552.4 11669.9 11711.9 11751.8 11758.6 11763.5 6196.3 6449.7 6608.8 6849.9 6897.2 4070.1 4341.2 4410.7 4411.5 4458.9 1248.8 1258.6 1326.8 1329.4 1334.5 13983.9 14552.8 16141.2 16321.3 16442.1 5624.9 5647.9 5788.7 5809.5 5869.7 11770.2 11818.5 11860.2 11866.0 11961.7 6636.3 6706.9 6709.7 6719.3 6725.6 6002.3 6245.1 6267.0 6312.0 6317.3 4293.6 4405.2 4415.9 4446.0 4478.5 1064.7 1112.7 1167.7 1281.7 1311.0 762.4 785.9 786.9 791.5 793.9 6056.5 6717.0 6898.1 7076.6 7098.4 908.4 933.3 934.4 941.6 944.9 3495.1 3850.6 3919.3 4125.8 4425.8 14305.7 15019.2 15084.3 15319.1 15319.8 12093.0 14463.9 15170.8 15211.2 15283.8 8400.2 8481.3 8663.0 8718.6 8724.6 6849.1 7031.3 7122.8 7146.9 7160.9 12662.6 13250.4 13277.3 13679.0 13698.9 13511.6 13886.6 13964.0 13987.1 14024.7 9248.1 9501.2 9538.6 9543.7 9581.6 10510.1 10627.9 10680.7 10739.1 10772.2 8407.5 8567.2 9185.0 9197.0 9260.4 8837.3 8902.4 8934.2 8994.6 9014.8 6422.8 6736.3 8067.4 8106.5 8110.1 5792.9 5835.3 5878.7 5958.1 6024.7 5469.9 5952.3 6101.9 6125.6 6230.8 09:52:02 INFO - PID 2314 | 09:52:02 INFO - PID 2314 | [#4] prototype.html Cycles:180 Average:5242.99 Median:5755.91 stddev:1561.03 (27.1%) stddev-sans-first:1522.05 09:52:02 INFO - PID 2314 | Values: 374.8 385.7 386.5 407.5 414.0 5365.4 6015.1 6081.7 6231.3 6232.4 5101.0 5937.5 5980.6 6056.8 6063.2 3854.9 4413.7 4432.9 4440.0 4458.8 3651.3 4449.4 4544.0 4696.6 4772.4 4648.8 4682.0 4696.6 4708.0 4719.9 4710.8 4714.2 4720.3 4724.1 4741.7 3772.3 4137.3 4156.5 4183.3 4234.1 5154.0 5992.6 6008.1 6045.5 6070.2 5596.7 5620.6 5624.8 5627.8 5628.0 5390.6 6156.0 6397.5 6587.5 6601.4 4779.5 4792.9 4795.9 4796.4 4802.8 5402.5 5610.8 6063.4 6482.1 6936.2 3821.6 4053.5 4250.5 4467.5 4837.6 4415.4 4733.5 4930.4 4969.9 4972.2 5353.2 5539.9 5549.0 5577.4 5635.1 5939.5 6311.2 6351.1 6553.0 6589.8 1412.6 1691.9 1694.0 1697.8 1698.3 1137.2 1182.9 1187.8 1189.3 1199.4 6120.5 6161.2 6177.8 6178.1 6246.6 6083.6 6460.8 6658.1 6675.5 6752.7 5558.5 5755.4 5949.1 6186.8 6269.3 3494.5 3531.8 3554.5 3558.9 3559.8 6122.4 6125.6 6425.6 7005.7 7014.8 5824.5 6381.7 6477.9 6976.3 7001.2 6709.4 6949.9 6960.8 6970.9 6972.8 6049.6 6302.7 6726.1 6726.8 6735.2 6589.2 6629.6 6634.7 6652.7 6672.2 5830.4 5830.6 6112.7 6990.7 7022.2 4123.2 4225.3 4265.6 4297.9 4300.0 5335.7 5908.3 6246.0 6391.1 6743.0 5199.6 5661.7 5867.5 5875.9 6506.7 5827.5 6442.7 6503.2 6505.8 6522.9 5332.1 5756.5 5892.9 6198.8 6415.9 5624.4 5950.7 6399.8 6427.0 6507.3 4720.1 4924.1 5553.3 6302.9 6420.6 09:52:02 INFO - PID 2314 | 09:52:02 INFO - PID 2314 | [#5] yui.html Cycles:180 Average:21628.32 Median:18011.05 stddev:32143.43 (178.5%) stddev-sans-first:32195.44 09:52:02 INFO - PID 2314 | Values: 766.6 815.6 824.9 825.2 854.8 16269.4 16276.3 16655.8 18286.7 19291.0 15438.2 17874.0 18148.1 18267.5 18346.7 971.0 982.7 989.2 990.2 994.0 974.4 1007.4 1010.8 1012.8 1014.3 1053.5 1060.2 1061.5 1061.9 1063.8 1040.3 1043.9 1056.7 1056.7 1058.7 775.7 778.4 778.7 779.8 782.6 16495.3 16926.1 17022.7 17084.9 17364.9 17310.6 17316.1 17664.7 17670.5 17804.6 11398.5 13858.8 14146.5 14324.5 14336.6 3500.9 3521.6 3531.3 3535.0 3538.6 134996.0 135289.0 136323.3 136668.0 138141.0 13185.7 13339.0 13493.7 13501.3 13537.3 20910.7 24962.3 25424.6 25645.6 25874.0 6883.5 7542.4 7827.1 7829.1 7837.3 3932.7 3955.8 3983.5 4012.8 4020.5 4317.8 4408.9 4415.4 4416.0 4421.4 864.5 893.9 903.6 904.2 904.3 646.9 662.8 664.7 666.3 694.2 9509.7 11241.9 11846.3 11973.6 12034.3 637.2 658.8 669.3 680.2 682.8 4428.7 4936.3 5438.8 5483.5 5594.0 104772.5 105513.5 108061.5 108246.0 110998.0 92716.5 94829.0 95216.0 95954.5 96621.0 82267.8 83629.0 84179.6 84374.0 84583.0 9974.3 10001.9 10458.6 11341.7 11490.0 31662.0 33862.6 39641.0 40387.6 40474.0 45085.6 48920.0 49366.5 49406.3 50182.0 11654.6 13902.3 13985.9 14361.0 14390.9 15328.2 15383.1 15535.2 15556.2 15676.6 14216.4 14544.4 14672.3 14722.3 14812.1 13900.4 14093.4 14422.5 14515.3 14599.3 14095.5 14222.0 14375.0 14466.7 14494.9 9285.9 10408.3 10456.0 10493.6 10924.5 11669.4 11719.8 11841.3 11859.7 11888.0 09:52:02 INFO - PID 2314 | -------- Summary: end -------- 09:52:02 INFO - PID 2314 | 09:52:03 INFO - TEST-INFO | 2314: exit 0 09:52:03 INFO - TEST-OK | dromaeo_css | took 1115270ms 09:52:03 INFO - TEST-START | kraken 09:52:03 INFO - operating with platform_type : mac_ 09:52:03 INFO - Initialising browser for kraken test... 09:52:03 INFO - TEST-INFO | started process 2320 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpUnJ2tP/profile http://localhost:50301/getInfo.html) 09:52:06 INFO - PID 2320 | 2017-04-30 09:52:06.420 plugin-container[2321:48999] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433b, name = 'com.apple.tsm.portname' 09:52:06 INFO - PID 2320 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:52:06 INFO - PID 2320 | 2017-04-30 09:52:06.424 plugin-container[2321:48999] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 09:52:06 INFO - PID 2320 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:52:06 INFO - PID 2320 | 2017-04-30 09:52:06.424 plugin-container[2321:48999] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:52:06 INFO - PID 2320 | __metrics Screen width/height:1600/1200 09:52:06 INFO - PID 2320 | colorDepth:24 09:52:06 INFO - PID 2320 | Browser inner width/height: 1024/689 09:52:06 INFO - PID 2320 | __metrics 09:52:07 INFO - TEST-INFO | 2320: exit 0 09:52:07 INFO - Browser initialized. 09:52:07 INFO - Running cycle 1/1 for kraken test... 09:52:07 INFO - TEST-INFO | started process 2322 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpUnJ2tP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:09 INFO - PID 2322 | 2017-04-30 09:52:09.628 plugin-container[2323:49123] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x933f, name = 'com.apple.tsm.portname' 09:52:09 INFO - PID 2322 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:52:09 INFO - PID 2322 | 2017-04-30 09:52:09.629 plugin-container[2323:49123] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 09:52:09 INFO - PID 2322 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:52:09 INFO - PID 2322 | 2017-04-30 09:52:09.629 plugin-container[2323:49123] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:52:19 INFO - PID 2322 | RSS: Main: 234971136 09:52:19 INFO - PID 2322 | 09:52:22 INFO - PID 2322 | Cycle 1(1): loaded http://localhost:50301/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50301/tests/kraken/driver.html?testName=audio-beat-detection) 09:52:23 INFO - PID 2322 | RSS: Main: 247939072 09:52:23 INFO - PID 2322 | 09:52:26 INFO - PID 2322 | Cycle 1(1): loaded http://localhost:50301/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50301/tests/kraken/driver.html?testName=audio-dft) 09:52:26 INFO - PID 2322 | RSS: Main: 256532480 09:52:26 INFO - PID 2322 | 09:52:30 INFO - PID 2322 | Cycle 1(1): loaded http://localhost:50301/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50301/tests/kraken/driver.html?testName=audio-fft) 09:52:30 INFO - PID 2322 | RSS: Main: 259121152 09:52:30 INFO - PID 2322 | 09:52:32 INFO - PID 2322 | Cycle 1(1): loaded http://localhost:50301/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50301/tests/kraken/driver.html?testName=audio-oscillator) 09:52:33 INFO - PID 2322 | RSS: Main: 261029888 09:52:33 INFO - PID 2322 | 09:52:35 INFO - PID 2322 | Cycle 1(1): loaded http://localhost:50301/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50301/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:52:35 INFO - PID 2322 | RSS: Main: 261480448 09:52:35 INFO - PID 2322 | 09:52:38 INFO - PID 2322 | Cycle 1(1): loaded http://localhost:50301/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50301/tests/kraken/driver.html?testName=imaging-darkroom) 09:52:39 INFO - PID 2322 | RSS: Main: 267091968 09:52:39 INFO - PID 2322 | 09:52:42 INFO - PID 2322 | Cycle 1(1): loaded http://localhost:50301/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50301/tests/kraken/driver.html?testName=imaging-desaturate) 09:52:43 INFO - PID 2322 | RSS: Main: 268869632 09:52:43 INFO - PID 2322 | 09:52:45 INFO - PID 2322 | Cycle 1(1): loaded http://localhost:50301/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50301/tests/kraken/driver.html?testName=json-parse-financial) 09:52:46 INFO - PID 2322 | RSS: Main: 268091392 09:52:46 INFO - PID 2322 | 09:52:48 INFO - PID 2322 | Cycle 1(1): loaded http://localhost:50301/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50301/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:52:48 INFO - PID 2322 | RSS: Main: 267493376 09:52:48 INFO - PID 2322 | 09:52:50 INFO - PID 2322 | Cycle 1(1): loaded http://localhost:50301/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50301/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:52:51 INFO - PID 2322 | RSS: Main: 268296192 09:52:51 INFO - PID 2322 | 09:52:53 INFO - PID 2322 | Cycle 1(1): loaded http://localhost:50301/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50301/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:52:54 INFO - PID 2322 | RSS: Main: 267497472 09:52:54 INFO - PID 2322 | 09:52:56 INFO - PID 2322 | Cycle 1(1): loaded http://localhost:50301/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:52:57 INFO - PID 2322 | RSS: Main: 267804672 09:52:57 INFO - PID 2322 | 09:53:00 INFO - PID 2322 | Cycle 1(1): loaded http://localhost:50301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:01 INFO - PID 2322 | RSS: Main: 267845632 09:53:01 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | Cycle 1(1): loaded http://localhost:50301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50301/tests/kraken/driver.html?testName=ai-astar) 09:53:03 INFO - PID 2322 | RSS: Main: 269529088 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | __start_tp_report 09:53:03 INFO - PID 2322 | _x_x_mozilla_page_load 09:53:03 INFO - PID 2322 | _x_x_mozilla_page_load_details 09:53:03 INFO - PID 2322 | |i|pagename|runs| 09:53:03 INFO - PID 2322 | |0;ai-astar;108;171;174;128;116;115;115;115;115;114 09:53:03 INFO - PID 2322 | |1;audio-beat-detection;145;110;109;160;149;145;145;111;140;112 09:53:03 INFO - PID 2322 | |2;audio-dft;199;200;205;226;215;203;203;178;271;252 09:53:03 INFO - PID 2322 | |3;audio-fft;82;75;85;112;69;58;59;61;80;57 09:53:03 INFO - PID 2322 | |4;audio-oscillator;90;70;81;84;103;81;88;70;70;91 09:53:03 INFO - PID 2322 | |5;imaging-gaussian-blur;92;89;91;91;92;90;90;90;90;91 09:53:03 INFO - PID 2322 | |6;imaging-darkroom;122;154;98;100;99;98;99;99;98;99 09:53:03 INFO - PID 2322 | |7;imaging-desaturate;92;96;89;94;94;90;91;94;91;93 09:53:03 INFO - PID 2322 | |8;json-parse-financial;50;48;48;53;59;67;75;75;75;78 09:53:03 INFO - PID 2322 | |9;json-stringify-tinderbox;62;57;55;72;64;62;55;57;56;54 09:53:03 INFO - PID 2322 | |10;stanford-crypto-aes;85;82;85;81;82;81;119;108;89;74 09:53:03 INFO - PID 2322 | |11;stanford-crypto-ccm;132;154;128;152;129;130;153;152;204;136 09:53:03 INFO - PID 2322 | |12;stanford-crypto-pbkdf2;229;184;189;188;220;185;182;180;183;191 09:53:03 INFO - PID 2322 | |13;stanford-crypto-sha256-iterative;86;89;98;98;66;68;70;70;70;70 09:53:03 INFO - PID 2322 | __end_tp_report 09:53:03 INFO - PID 2322 | __start_cc_report 09:53:03 INFO - PID 2322 | _x_x_mozilla_cycle_collect,991 09:53:03 INFO - PID 2322 | __end_cc_report 09:53:03 INFO - PID 2322 | __startTimestamp1493571183612__endTimestamp 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | ------- Summary: start ------- 09:53:03 INFO - PID 2322 | Number of tests: 14 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | [#0] ai-astar Cycles:10 Average:127.10 Median:115.50 stddev:24.43 (21.2%) stddev-sans-first:24.92 09:53:03 INFO - PID 2322 | Values: 108.0 171.0 174.0 128.0 116.0 115.0 115.0 115.0 115.0 114.0 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:145.00 stddev:19.70 (13.6%) stddev-sans-first:20.38 09:53:03 INFO - PID 2322 | Values: 145.0 110.0 109.0 160.0 149.0 145.0 145.0 111.0 140.0 112.0 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | [#2] audio-dft Cycles:10 Average:215.20 Median:210.00 stddev:27.62 (13.2%) stddev-sans-first:28.66 09:53:03 INFO - PID 2322 | Values: 199.0 200.0 205.0 226.0 215.0 203.0 203.0 178.0 271.0 252.0 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | [#3] audio-fft Cycles:10 Average:73.80 Median:72.00 stddev:17.09 (23.7%) stddev-sans-first:17.87 09:53:03 INFO - PID 2322 | Values: 82.0 75.0 85.0 112.0 69.0 58.0 59.0 61.0 80.0 57.0 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | [#4] audio-oscillator Cycles:10 Average:82.80 Median:82.50 stddev:10.82 (13.1%) stddev-sans-first:11.16 09:53:03 INFO - PID 2322 | Values: 90.0 70.0 81.0 84.0 103.0 81.0 88.0 70.0 70.0 91.0 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:91.00 stddev:0.97 (1.1%) stddev-sans-first:0.88 09:53:03 INFO - PID 2322 | Values: 92.0 89.0 91.0 91.0 92.0 90.0 90.0 90.0 90.0 91.0 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | [#6] imaging-darkroom Cycles:10 Average:106.60 Median:98.50 stddev:18.20 (18.5%) stddev-sans-first:18.43 09:53:03 INFO - PID 2322 | Values: 122.0 154.0 98.0 100.0 99.0 98.0 99.0 99.0 98.0 99.0 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:93.50 stddev:2.17 (2.3%) stddev-sans-first:2.30 09:53:03 INFO - PID 2322 | Values: 92.0 96.0 89.0 94.0 94.0 90.0 91.0 94.0 91.0 93.0 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:71.00 stddev:12.51 (17.6%) stddev-sans-first:12.38 09:53:03 INFO - PID 2322 | Values: 50.0 48.0 48.0 53.0 59.0 67.0 75.0 75.0 75.0 78.0 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:5.62 (9.4%) stddev-sans-first:5.88 09:53:03 INFO - PID 2322 | Values: 62.0 57.0 55.0 72.0 64.0 62.0 55.0 57.0 56.0 54.0 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:82.00 stddev:13.91 (17.0%) stddev-sans-first:14.70 09:53:03 INFO - PID 2322 | Values: 85.0 82.0 85.0 81.0 82.0 81.0 119.0 108.0 89.0 74.0 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:152.00 stddev:22.86 (15.0%) stddev-sans-first:23.60 09:53:03 INFO - PID 2322 | Values: 132.0 154.0 128.0 152.0 129.0 130.0 153.0 152.0 204.0 136.0 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.10 Median:188.50 stddev:17.01 (9.0%) stddev-sans-first:12.11 09:53:03 INFO - PID 2322 | Values: 229.0 184.0 189.0 188.0 220.0 185.0 182.0 180.0 183.0 191.0 09:53:03 INFO - PID 2322 | 09:53:03 INFO - PID 2322 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.50 Median:78.00 stddev:12.83 (16.5%) stddev-sans-first:13.32 09:53:03 INFO - PID 2322 | Values: 86.0 89.0 98.0 98.0 66.0 68.0 70.0 70.0 70.0 70.0 09:53:03 INFO - PID 2322 | -------- Summary: end -------- 09:53:03 INFO - PID 2322 | 09:53:04 INFO - TEST-INFO | 2322: exit 0 09:53:04 INFO - TEST-OK | kraken | took 61232ms 09:53:04 INFO - SUITE-END | took 1176s 09:53:04 INFO - Completed test suite (00:19:36) 09:53:04 INFO - javascript benchmark 09:53:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7898.08834126745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3063.4792085345503, 3569.6251893551175, 3575.1419659281773, 3606.981965090174, 3621.3662609043417, 6118.265808103023, 6214.471769899558, 6225.937740622587, 6239.344868788774, 6253.062040693898, 6133.64071396136, 6140.258857967792, 6168.074788781685, 6199.194104766385, 6260.655663938482, 4315.82736690532, 4472.195004899117, 5362.839114826542, 5395.541378982782, 5412.296401467804, 4943.380211046157, 5350.3312085989255, 5500.28496295481, 5529.640573362739, 5545.500904918556, 5413.02565538203, 5438.374586922515, 5445.074337362658, 5449.0, 5507.807226747044, 5440.809571664972, 5441.075017247038, 5443.755031023614, 5472.069748142825, 5480.095784195603, 5392.083345831218, 5394.622376433651, 5396.892062158735, 5405.918911216335, 5485.286912701363, 6024.216851809237, 6035.577509574332, 6135.355787642323, 6143.4470897618985, 6295.937040629581, 6458.128152699373, 6553.14809074822, 6625.4699624030445, 6635.701393437259, 6645.435138013275, 6737.292584278629, 6739.932600673979, 6746.865062698767, 6751.42612877906, 6764.188297404294, 6297.370262973666, 6325.841853953642, 6359.109724638462, 6361.3638636136475, 6390.5526613136635, 5611.579131565149, 6608.372204640552, 6707.262201157869, 6711.228208755958, 6818.727250909908, 5482.369527504308, 5574.358948720868, 6212.943799554087, 6295.213098362705, 6363.9045414318825, 6594.505412094112, 6608.43828274602, 6640.269570347258, 6686.364795344434, 6691.7323307068145, 6612.008198770223, 6641.468682505388, 6657.267700552935, 6658.83352916181, 6669.133012708414, 5556.361018482846, 6034.48706859913, 6375.394337537927, 6442.806715798533, 6656.101426307483, 5263.763130659129, 5267.920981185285, 5311.575073994071, 5339.839804805862, 5343.732813359316, 3983.5219773626773, 4696.272077827942, 4713.9629281558, 4720.598749106296, 4722.693024953367, 5608.831735047955, 6212.254529456494, 6323.083152942798, 6345.0, 6367.866764633807, 5013.222950442687, 5584.97207513968, 6493.31820158886, 6636.767713130113, 6660.234073081658, 4967.05625931072, 6261.218140481055, 6274.247090349096, 6352.872942541216, 6363.522735794834, 5830.737616807254, 5834.445727655866, 5835.0, 5847.3275573308765, 5849.327327357323, 6515.902261466082, 6713.12729345182, 6795.694193761194, 6854.794356169323, 6884.070650462324, 6706.39642432164, 6723.596584204964, 6730.596164229966, 6756.729730810713, 6762.729490820312, 6827.89758153638, 6849.452043836581, 6873.347032031949, 6890.20762612306, 6915.619640919797, 5434.0, 6481.675916204076, 6546.24718157418, 6579.2104947406615, 6618.404343609098, 5740.569457290637, 6197.667501487202, 6672.699728512326, 6701.430378417889, 6760.628165450948, 6274.905876411949, 6326.367363263636, 6515.250746164063, 6519.674016299071, 6524.902126468011, 6453.354664533509, 6547.148870646785, 6549.443297319781, 6557.770478033246, 6560.147180866456, 6278.497720182283, 6291.779787707408, 6355.936440635534, 6362.0, 6438.90341644885, 6450.903236451551, 6523.64119973387, 6533.705983230861, 6536.477081833346, 6571.277159512354, 6366.9681651591445, 6370.55406121567, 6370.936290637034, 6379.808605741649, 6387.808365749035], "value": 6001.305233104827, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.5024484819413, 823.6952327638772, 1195.9043276537873, 1242.912996090274, 1247.4885297028216, 35781.46327805082, 36368.45447318292, 36374.63625363746, 36449.271014579725, 36568.817155914214, 36719.63280367196, 37016.07459813506, 37020.0, 37050.44424333637, 37066.62933370665, 6545.345465453453, 7912.446128770988, 7918.089419716749, 8159.102498725136, 8299.66801327946, 8071.5964201789675, 8328.750137495854, 8357.707480238192, 8364.749057528285, 8368.372372072088, 8302.501849888995, 8305.252527272543, 8389.244967952884, 8389.580520973957, 8390.958045209796, 8301.875471867927, 8315.625796839127, 8325.66697332106, 8333.458325208903, 8383.287420569259, 8106.067802202704, 8173.0, 8231.506109633381, 8247.010358756928, 8249.958750206271, 35607.82196089029, 35729.0, 35810.104747381265, 35861.10347241314, 35882.282354353025, 3613.765105268149, 3656.213914008501, 3658.1037645776955, 3670.926581468382, 3678.9632103679155, 29667.0, 29828.850855745583, 29963.40073198524, 29968.550471742943, 29977.0, 3075.0467355119986, 3142.355817057498, 3160.367926414703, 3161.0832858471017, 3178.761592880543, 277639.0, 280526.0, 280953.0, 282485.0, 282993.0, 37078.8146059268, 37690.43464348037, 44752.55247447549, 46238.612841614806, 46429.7678511612, 39790.005249868984, 47635.761821190674, 47662.76168619204, 47864.0, 47935.5206447938, 13941.30293485342, 14028.789568156486, 14035.438582456587, 14177.92911035459, 14183.71632567343, 11230.989210971053, 11268.0, 11360.715982100513, 11376.976072153546, 11404.771904562029, 11513.597024104116, 13131.934340328236, 13164.210147391188, 13176.945844332431, 13191.868081319257, 5276.15581506957, 5987.341392446828, 6011.849703757353, 6095.6952152392205, 6103.725332360054, 912.625823412411, 944.1927152284835, 948.4546385828038, 1043.5564884923876, 1087.1737479515466, 24112.75887241105, 24234.51530969406, 24316.0, 24343.90452429645, 24547.63178552323, 1141.3551343490901, 1160.5995931403652, 1176.923499972499, 1182.467889449751, 1183.1363104933275, 11912.166148369532, 12349.567765128177, 12378.81431778524, 12404.503819847285, 12443.93778031104, 328212.0, 329729.0, 330409.3479532587, 330682.0, 331600.8139308186, 52192.73903630458, 52194.47805521972, 52301.0, 52529.474705253226, 52548.73725631347, 1515.5226103777275, 1548.7676848472595, 1558.3844381469255, 1564.4915402494007, 1571.230097252338, 23680.881595591913, 23783.405414864766, 23863.64204536968, 23944.922478488163, 24070.0, 35921.46117808287, 35971.640283596826, 36109.0, 36148.4577731329, 36193.0, 283322.58338708174, 283461.0, 283496.0, 284302.0, 284386.0, 31381.8430907844, 32769.0, 32825.70220084571, 32884.38271790053, 32934.83532582418, 41409.37885931774, 42452.301907923335, 43144.78427607842, 43164.0, 43270.567294326655, 28568.714312857435, 29183.562246565893, 29532.852335739044, 30271.848640756656, 30556.08331750051, 29463.116106516838, 30007.54988675128, 30241.395172096876, 30454.086377408712, 30541.54187687142, 35123.47314790229, 35670.0, 36134.27731445304, 36217.45673814948, 36245.27509449743, 29746.553801693426, 29789.404211915207, 30358.544621831134, 30701.232469187555, 30741.385172296876, 21754.89122554377, 22798.20206292838, 23821.0, 24034.555865977025, 24272.1504747333], "value": 17206.64639961046, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.87120557024554, 436.3520172543773, 439.3848611943279, 454.52275111133304, 454.8067071494616, 16951.406700765474, 19284.614307713855, 21701.45746356342, 21922.671159932615, 21935.122595096196, 21645.783542164572, 22414.103435862547, 22545.774542254574, 22572.097116115336, 23238.3028509145, 6766.255711871702, 6891.1730592328995, 6980.162380514345, 6995.33544313292, 7000.5449645773115, 5865.76536938522, 6655.334466553354, 6923.273056329089, 6940.861182776342, 6944.375006249436, 6690.531662783607, 6755.5271131020845, 6881.13985751781, 6901.896471552931, 6918.827029324257, 6705.753572553201, 6798.9660051699675, 6902.5858448492745, 6914.478814660766, 6931.202911665147, 6566.5075119365765, 6667.066610674509, 6693.0, 6706.2287836898895, 6709.362610552039, 27148.658412018078, 29085.85457072701, 29798.40403191924, 29984.100476985725, 30072.398552029055, 2282.5663124006387, 2318.8956496957508, 2320.5358928214423, 2328.080408238753, 2328.604137296664, 16741.330346786115, 18589.349372772023, 19232.80767192324, 19478.318258861014, 19533.80466195334, 2290.89690963907, 2306.8385213035094, 2358.1982126077046, 2364.491634298634, 2370.4073981504625, 142139.28930355283, 149672.0, 149693.0, 151360.0, 158726.0, 23492.882535587214, 24724.752752472246, 25514.74485255161, 25535.87232063828, 25756.742432575807, 41093.79453102775, 41178.911581631495, 41240.0, 41394.586054139676, 41432.0, 7345.853082938312, 9051.321150913707, 9186.713860059597, 9232.261419086457, 9282.814343713088, 8672.132786721404, 8706.216440520384, 8722.0, 8865.423747456394, 8891.422057566237, 7936.960315198503, 8092.109867914524, 8093.109757926623, 8121.959390203129, 8132.5933703314595, 2231.877246751412, 2237.988810055939, 2239.73123225214, 2241.753407125215, 2410.903563857461, 941.1623654947102, 949.3544389814854, 976.99023009769, 996.8504724291414, 1031.5770534080991, 19968.30110946139, 21235.256766013423, 21321.893390532947, 21335.0, 21588.46028849291, 945.4894357047117, 981.8218138234005, 1015.1117771949545, 1034.6068493972243, 1039.298473530364, 10593.788124237471, 10929.672109836718, 10940.398278094623, 10969.23215374916, 10977.780444391226, 555570.0, 563192.0, 563782.0, 566148.0, 572397.0, 101569.0, 123826.0, 129681.0, 130123.0, 134155.0, 1050.9579616815395, 1098.6319582939805, 1161.8315344275034, 1233.5250928392634, 1259.1689484939895, 21910.90445477688, 22679.20622778195, 23233.070677172724, 23346.416339590967, 23472.882635587397, 58975.0, 59220.0, 59826.0, 59932.0, 60131.699341503016, 71733.20666983367, 73072.63463682648, 81568.7764683542, 82287.5885620568, 82549.0, 8547.273481753871, 8809.779755506164, 8857.689980850639, 8963.372563920462, 9098.135677110664, 11257.0, 13389.799153012907, 14109.365078571283, 14217.649323314268, 14548.927255364079, 11979.28124312544, 12090.75818483643, 12095.81856272139, 12191.573294934635, 12343.938280308541, 11209.253732835508, 11252.493637786483, 11391.316521008766, 11629.24409913353, 11654.88345116538, 11901.523939042341, 11924.0, 12098.697532561757, 12109.515619375126, 12144.0, 6710.731570737116, 8851.822963540822, 9018.684346047858, 9047.683331083645, 9093.545322733704, 11990.160688751703, 11997.700057498283, 12120.939395302967, 12211.87788122143, 12232.0], "value": 11281.082888307987, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.836221291232, 1427.7358688642596, 1445.638590352412, 1450.8549145085485, 1454.9854501454986, 11190.44047797609, 11241.662750117499, 11677.532898684052, 11700.590479333236, 11774.470148843302, 11722.120840936921, 11804.7639047219, 11939.880601193985, 11943.701407464796, 11946.761064778699, 2516.5470215361274, 2557.3223095879607, 2574.7167811540808, 2577.445849142434, 2586.107792811477, 2500.987495062522, 2539.200151952138, 2550.349660836484, 2551.170869467421, 2554.6806649168852, 2493.775560199582, 2507.661465702134, 2513.74862513749, 2534.911278105267, 2537.949241015179, 2474.40614252579, 2497.413107919628, 2503.949921001579, 2520.621906713989, 2520.7479252074645, 2431.7081950166094, 2506.9247922562354, 2533.6199570064455, 2550.1711943618398, 2552.3619095226195, 11669.941650291694, 11711.945924866803, 11751.823722644167, 11758.647240582795, 11763.470643821049, 6196.318404975449, 6449.677516124175, 6608.768693095719, 6849.897251541231, 6897.172339319263, 4070.14526949341, 4341.153475072362, 4410.713303635285, 4411.536788637179, 4458.866234012952, 1248.825164476974, 1258.6161220827644, 1326.8208791813079, 1329.388481298604, 1334.5395838435725, 13983.860161398357, 14552.763015143619, 16141.192940353052, 16321.265543050473, 16442.095684737335, 5624.943750562524, 5647.943520564824, 5788.652680839163, 5809.477147056785, 5869.6771677558145, 11770.234934729386, 11818.468168932419, 11860.22908510944, 11866.0, 11961.70095747596, 6636.303188165173, 6706.899396509057, 6709.7316107355155, 6719.260881303053, 6725.596464212065, 6002.309734380515, 6245.094461303176, 6267.0286105653695, 6311.96844015777, 6317.305096439388, 4293.5706429356815, 4405.207062728676, 4415.911681766347, 4445.955200527874, 4478.529754375809, 1064.7489200189746, 1112.6995711157942, 1167.6746892277326, 1281.7372438650054, 1310.9541166059332, 762.3634265388463, 785.9410544209208, 786.9016372953381, 791.5290402210676, 793.8928244686894, 6056.454919057306, 6717.0, 6898.099879777162, 7076.646167691595, 7098.396636285974, 908.3505293715026, 933.3000249812641, 934.4486752815872, 941.5857022909897, 944.8677185194078, 3495.1262184453885, 3850.5764365920286, 3919.2749341371937, 4125.814338354781, 4425.822967081281, 14305.713885722227, 15019.24903754808, 15084.321205545777, 15319.080855148726, 15319.770203446957, 12092.972097371821, 14463.915206359354, 15170.772438413433, 15211.239438028275, 15283.847161528241, 8400.243978042006, 8481.321494280442, 8663.0, 8718.564071796385, 8724.607392667345, 6849.075374824534, 7031.332023457763, 7122.821929451805, 7146.928530714834, 7160.856782864209, 12662.620121396372, 13250.403731831899, 13277.336133193108, 13679.042467027213, 13698.931505342409, 13511.594652160451, 13886.583402497941, 13964.0, 13987.090839095426, 14024.719505610035, 9248.121428464285, 9501.192398646193, 9538.618455261989, 9543.713688589354, 9581.616735330788, 10510.1066409353, 10627.89372106269, 10680.732981675521, 10739.14086873064, 10772.24594278393, 8407.495550267004, 8567.228949394585, 9185.0, 9197.034311397207, 9260.39807412516, 8837.337199710177, 8902.42134261271, 8934.195922367018, 8994.640214391613, 9014.819703606023, 6422.807315780534, 6736.259011508632, 8067.354611631173, 8106.513609183467, 8110.107888132418, 5792.913106303493, 5835.328937172279, 5878.676672783038, 5958.136070269873, 6024.698765061817, 5469.863253418696, 5952.255968003999, 6101.932161871743, 6125.571210015256, 6230.7819226326865], "value": 5380.214417630818, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.77700768043024, 385.6702519345959, 386.54773914520007, 407.4865669256736, 413.958604139586, 5365.409804921455, 6015.0676645120075, 6081.665508397036, 6231.3145553989025, 6232.376762323765, 5100.979804039198, 5937.495312898409, 5980.551458640609, 6056.818295451132, 6063.211782468273, 3854.9421758673643, 4413.713108647936, 4432.936095337112, 4439.955600444003, 4458.777061146946, 3651.3427583035045, 4449.443819522559, 4543.954560454403, 4696.624270058404, 4772.355731976191, 4648.814047438115, 4682.0, 4696.64775141864, 4708.0, 4719.90560188796, 4710.7880145393365, 4714.151452738506, 4720.253506202693, 4724.126036683225, 4741.700275366445, 3772.264408440355, 4137.275976704064, 4156.501219853607, 4183.267928112598, 4234.110836724291, 5153.974230128825, 5992.610480318809, 6008.128821320884, 6045.516358691294, 6070.2412198475195, 5596.720163991784, 5620.5503559715125, 5624.803131890364, 5627.831165065055, 5628.0, 5390.649607775482, 6156.0, 6397.52018598607, 6587.505937054692, 6601.405873471363, 4779.450363208206, 4792.9281060784115, 4795.904081918342, 4796.37647105874, 4802.783874725646, 5402.459754024605, 5610.803621873256, 6063.363346848561, 6482.092507049017, 6936.167659880796, 3821.5987321331418, 4053.4527838741983, 4250.51119121305, 4467.530909254481, 4837.564619184291, 4415.448068991376, 4733.473562196117, 4930.383702037246, 4969.925451118236, 4972.185152419341, 5353.197020446886, 5539.861503462365, 5549.001179787677, 5577.414371491016, 5635.098384258499, 5939.46544810969, 6311.211098612674, 6351.079093531412, 6553.049807777846, 6589.76935807254, 1412.6468382904275, 1691.8984860908386, 1693.9745903811452, 1697.796264448274, 1698.3206717312926, 1137.2153214282118, 1182.869884312725, 1187.804012337972, 1189.3161432176532, 1199.4182821331647, 6120.479759220427, 6161.168242287234, 6177.752889884444, 6178.115674719254, 6246.593971391845, 6083.5741498095595, 6460.773872914426, 6658.1344425224415, 6675.499337549606, 6752.729890804411, 5558.470895742427, 5755.366909639936, 5949.10763385487, 6186.81439556814, 6269.310375858652, 3494.5282386877952, 3531.7527773056154, 3554.489342029627, 3558.893233203008, 3559.760617837755, 6122.418370254819, 6125.632462052291, 6425.646589437626, 7005.684744186524, 7014.789556313319, 5824.504917082011, 6381.712822922979, 6477.866373384639, 6976.302369762983, 7001.229864714877, 6709.36261055199, 6949.930500694928, 6960.807345686093, 6970.919507476349, 6972.825679358057, 6049.637021778707, 6302.684865756785, 6726.091977583159, 6726.831829204309, 6735.225449073419, 6589.220910354082, 6629.602223866584, 6634.734610615521, 6652.704816838183, 6672.199336079701, 5830.4461076197695, 5830.591858569859, 6112.724927378367, 6990.6504674767075, 7022.157341118894, 4123.237201117803, 4225.345071513921, 4265.573442655709, 4297.935530967101, 4299.98950246698, 5335.653182543122, 5908.261467316585, 6246.0, 6391.137196478602, 6742.966285168739, 5199.610029247746, 5661.669507665778, 5867.471927526543, 5875.853103672443, 6506.739730410731, 5827.475527202402, 6442.679250753678, 6503.219613646393, 6505.837354065997, 6522.934770652422, 5332.093544097435, 5756.453136951983, 5892.850894075614, 6198.768443360296, 6415.8716825662295, 5624.35319938196, 5950.672713000653, 6399.8080057598345, 6426.967865160645, 6507.28419873823, 4720.055988802184, 4924.113659541317, 5553.250311207935, 6302.936970630235, 6420.582662126947], "value": 4771.473282832751, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.6358479722131, 815.62888885557, 824.8740469259461, 825.178946947787, 854.8033952190996, 16269.43056993004, 16276.267567959441, 16655.833441665578, 18286.725699114522, 19291.0354482276, 15438.150901700403, 17874.0, 18148.092595370246, 18267.543311417223, 18346.724799128024, 971.0338213477582, 982.7395740128871, 989.2382865193797, 990.1732053735104, 994.0357852882693, 974.410481658597, 1007.425767312632, 1010.7675234696025, 1012.8126296635146, 1014.3102690170681, 1053.5364439646569, 1060.1677683018831, 1061.4639606998455, 1061.8725752909622, 1063.7766069125494, 1040.287403128859, 1043.9373637581768, 1056.6935588679273, 1056.7146870345002, 1058.6612284069101, 775.6509570693154, 778.3850757901251, 778.6729573579111, 779.8245394786185, 782.5969625642798, 16495.34018639253, 16926.069066201355, 17022.659546808994, 17084.914575427043, 17364.91317543417, 17310.56723581908, 17316.13419329041, 17664.735028974577, 17670.469885903443, 17804.55488612795, 11398.487068081957, 13858.792118118236, 14146.504872329522, 14324.498642547565, 14336.64158396038, 3500.929981400383, 3521.6126226115107, 3531.2584357285, 3534.964650353489, 3538.610752817188, 134996.0, 135289.0, 136323.31838340746, 136668.0, 138141.0, 13185.73628527424, 13339.0, 13493.662658433617, 13501.324933753272, 13537.323133843269, 20910.686339704916, 24962.251132466055, 25424.618630720553, 25645.61531577028, 25873.965041398133, 6883.518153729291, 7542.396608271325, 7827.099883513469, 7829.138794732575, 7837.255460731221, 3932.744371615836, 3955.7824319662695, 3983.46223259862, 4012.799360032045, 4020.4974378202724, 4317.805698743564, 4408.889777755518, 4415.359772832921, 4415.977920110379, 4421.403110580095, 864.4510735682886, 893.9016708162097, 903.5572569441058, 904.2088172848757, 904.2946501728662, 646.9288378278386, 662.7547807311229, 664.6909187227963, 666.3469799596422, 694.2016680817, 9509.667161649448, 11241.887581124247, 11846.348450835287, 11973.580924667769, 12034.338111403782, 637.2162240444279, 658.8451713847242, 669.3106100716172, 680.2041611314773, 682.7780971184286, 4428.734275943454, 4936.284238785356, 5438.83683489496, 5483.506484416422, 5594.0, 104772.47613762035, 105513.47243263734, 108061.45969270103, 108246.0, 110998.0, 92716.53641731883, 94829.0, 95216.0, 95954.52022739842, 96621.0, 82267.7659835103, 83629.0, 84179.5791021041, 84374.0, 84583.0, 9974.32784732024, 10001.899981000388, 10458.581656733646, 11341.659750207507, 11490.0, 31662.0, 33862.64549417996, 39641.0, 40387.596124038384, 40474.0, 45085.64743057713, 48920.0, 49366.50633493763, 49406.25890611715, 50182.0, 11654.592089276835, 13902.30488475552, 13985.881129509818, 14361.0, 14390.928045359706, 15328.233588320316, 15383.077015378665, 15535.223238838238, 15556.222188890737, 15676.608084797972, 14216.360263787947, 14544.41822327095, 14672.3397447113, 14722.263886805402, 14812.111273323635, 13900.374483148486, 14093.365798539295, 14422.495212667925, 14515.274236287933, 14599.270036498345, 14095.506657266946, 14222.0, 14375.0, 14466.710665786835, 14494.855051449773, 9285.885693716797, 10408.271421000458, 10456.0, 10493.632722854663, 10924.508397122308, 11669.35818529989, 11719.765604687687, 11841.28952262867, 11859.70350741204, 11887.989520890822], "value": 8116.254945820563, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 171.0, 174.0, 128.0, 116.0, 115.0, 115.0, 115.0, 115.0, 114.0], "value": 127.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 109.0, 160.0, 149.0, 145.0, 145.0, 111.0, 140.0, 112.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 200.0, 205.0, 226.0, 215.0, 203.0, 203.0, 178.0, 271.0, 252.0], "value": 215.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 85.0, 112.0, 69.0, 58.0, 59.0, 61.0, 80.0, 57.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 81.0, 84.0, 103.0, 81.0, 88.0, 70.0, 70.0, 91.0], "value": 82.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 91.0, 91.0, 92.0, 90.0, 90.0, 90.0, 90.0, 91.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 154.0, 98.0, 100.0, 99.0, 98.0, 99.0, 99.0, 98.0, 99.0], "value": 106.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 89.0, 94.0, 94.0, 90.0, 91.0, 94.0, 91.0, 93.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 48.0, 53.0, 59.0, 67.0, 75.0, 75.0, 75.0, 78.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 57.0, 55.0, 72.0, 64.0, 62.0, 55.0, 57.0, 56.0, 54.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 85.0, 81.0, 82.0, 81.0, 119.0, 108.0, 89.0, 74.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 154.0, 128.0, 152.0, 129.0, 130.0, 153.0, 152.0, 204.0, 136.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [229.0, 184.0, 189.0, 188.0, 220.0, 185.0, 182.0, 180.0, 183.0, 191.0], "value": 193.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 98.0, 98.0, 66.0, 68.0, 70.0, 70.0, 70.0, 70.0], "value": 78.5, "unit": "score"}]}]} 09:53:04 INFO - Return code: 0 09:53:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:53:04 ERROR - # TBPL SUCCESS # 09:53:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:53:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:53:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:53:04 INFO - 2017-04-30 09:53:04.952 screenresolution[2328:49527] starting screenresolution argv=screenresolution get 09:53:04 INFO - 2017-04-30 09:53:04.955 screenresolution[2328:49527] Display 0: 1600x1200x32@60 09:53:04 INFO - 2017-04-30 09:53:04.961 screenresolution[2329:49530] starting screenresolution argv=screenresolution list 09:53:04 INFO - Available Modes on Display 0 09:53:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:53:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:53:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:53:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:53:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:53:05 INFO - Intel Iris: 09:53:05 INFO - Chipset Model: Intel Iris 09:53:05 INFO - Type: GPU 09:53:05 INFO - Bus: Built-In 09:53:05 INFO - VRAM (Dynamic, Max): 1536 MB 09:53:05 INFO - Vendor: Intel (0x8086) 09:53:05 INFO - Device ID: 0x0a2e 09:53:05 INFO - Revision ID: 0x0009 09:53:05 INFO - Displays: 09:53:05 INFO - Display: 09:53:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:53:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:53:05 INFO - Display Serial Number: 1600x1200 60 09:53:05 INFO - Main Display: Yes 09:53:05 INFO - Mirror: Off 09:53:05 INFO - Online: Yes 09:53:05 INFO - Rotation: Supported 09:53:05 INFO - Return code: 0 09:53:05 INFO - Running post-action listener: _resource_record_post_action 09:53:05 INFO - [mozharness: 2017-04-30 16:53:05.202378Z] Finished run-tests step (success) 09:53:05 INFO - Running post-run listener: _resource_record_post_run 09:53:05 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 1415168; Write bytes: 511811584; Read time: 16; Write time: 1641 09:53:05 INFO - TinderboxPrint: CPU usage
54.2% 09:53:05 INFO - TinderboxPrint: I/O read bytes / time
1,415,168 / 16 09:53:05 INFO - TinderboxPrint: I/O write bytes / time
511,811,584 / 1,641 09:53:05 INFO - TinderboxPrint: CPU idle
2,192.8 (45.8%) 09:53:05 INFO - TinderboxPrint: CPU system
967.2 (20.2%) 09:53:05 INFO - TinderboxPrint: CPU user
1,629.7 (34.0%) 09:53:05 INFO - TinderboxPrint: Swap in / out
209,911,808 / 0 09:53:05 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203262464; Write bytes: 199755776; Read time: 16200; Write time: 451 09:53:05 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 1415168; Write bytes: 297494528; Read time: 16; Write time: 1144 09:53:05 INFO - Running post-run listener: _upload_blobber_files 09:53:05 INFO - Blob upload gear active. 09:53:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:53:05 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 09:53:05 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:53:05 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:53:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:53:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:53:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:53:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:06 INFO - (blobuploader) - INFO - Done attempting. 09:53:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:53:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:53:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:07 INFO - (blobuploader) - INFO - Done attempting. 09:53:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:53:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:53:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:08 INFO - (blobuploader) - INFO - Done attempting. 09:53:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:53:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:53:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:10 INFO - (blobuploader) - INFO - Done attempting. 09:53:10 INFO - (blobuploader) - INFO - Iteration through files over. 09:53:10 INFO - Return code: 0 09:53:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:53:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:53:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5181def51ad4621bb97b8c389135b0e7fa30dc177c1a400b7a76046419eda95b9dd112d7bf7003ab004ec45ddc3f072e88fc81d82dbe9dee48f09826cd5329e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62ed615196e594b5b4eaaa25e4f9e70a14bd9cffd32890bcdfaf50dcc73069d2f5061b705e704c0f600c7910bd7f943738e0c1b1f3507e60728f1041c59e07b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba74ac3f6e8662cda8edae126e0c611d4e9ffcf7a93e91a86fa26baeb0e3e45614ebae2fe275bc9692ed29937ee031697a774600db02fb22e0ef0dec53cf02a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71a3cc55085228930046d63a82d3755637dbcd60c73e0d5c3673252c9b69292b5cdbe07dfd07dd64e616ff221ab846d5b73eee0759f013aede582c58dba73308"} 09:53:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:53:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:53:10 INFO - Contents: 09:53:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5181def51ad4621bb97b8c389135b0e7fa30dc177c1a400b7a76046419eda95b9dd112d7bf7003ab004ec45ddc3f072e88fc81d82dbe9dee48f09826cd5329e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62ed615196e594b5b4eaaa25e4f9e70a14bd9cffd32890bcdfaf50dcc73069d2f5061b705e704c0f600c7910bd7f943738e0c1b1f3507e60728f1041c59e07b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba74ac3f6e8662cda8edae126e0c611d4e9ffcf7a93e91a86fa26baeb0e3e45614ebae2fe275bc9692ed29937ee031697a774600db02fb22e0ef0dec53cf02a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71a3cc55085228930046d63a82d3755637dbcd60c73e0d5c3673252c9b69292b5cdbe07dfd07dd64e616ff221ab846d5b73eee0759f013aede582c58dba73308"} 09:53:10 INFO - Running post-run listener: copy_logs_to_upload_dir 09:53:10 INFO - Copying logs to upload dir... 09:53:10 INFO - mkdir: /builds/slave/test/build/upload/logs 09:53:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.710579 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-30 09:53:10.863944) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-30 09:53:10.867558) ========= 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.l4wy5feQoZ/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.5YTlsrdd08/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5181def51ad4621bb97b8c389135b0e7fa30dc177c1a400b7a76046419eda95b9dd112d7bf7003ab004ec45ddc3f072e88fc81d82dbe9dee48f09826cd5329e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62ed615196e594b5b4eaaa25e4f9e70a14bd9cffd32890bcdfaf50dcc73069d2f5061b705e704c0f600c7910bd7f943738e0c1b1f3507e60728f1041c59e07b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba74ac3f6e8662cda8edae126e0c611d4e9ffcf7a93e91a86fa26baeb0e3e45614ebae2fe275bc9692ed29937ee031697a774600db02fb22e0ef0dec53cf02a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71a3cc55085228930046d63a82d3755637dbcd60c73e0d5c3673252c9b69292b5cdbe07dfd07dd64e616ff221ab846d5b73eee0759f013aede582c58dba73308"} build_url:https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011075 build_url: 'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5181def51ad4621bb97b8c389135b0e7fa30dc177c1a400b7a76046419eda95b9dd112d7bf7003ab004ec45ddc3f072e88fc81d82dbe9dee48f09826cd5329e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62ed615196e594b5b4eaaa25e4f9e70a14bd9cffd32890bcdfaf50dcc73069d2f5061b705e704c0f600c7910bd7f943738e0c1b1f3507e60728f1041c59e07b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba74ac3f6e8662cda8edae126e0c611d4e9ffcf7a93e91a86fa26baeb0e3e45614ebae2fe275bc9692ed29937ee031697a774600db02fb22e0ef0dec53cf02a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71a3cc55085228930046d63a82d3755637dbcd60c73e0d5c3673252c9b69292b5cdbe07dfd07dd64e616ff221ab846d5b73eee0759f013aede582c58dba73308"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-30 09:53:10.908029) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 09:53:10.908792) ========= 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.l4wy5feQoZ/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.5YTlsrdd08/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.005096 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 09:53:10.958198) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-30 09:53:10.958535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-30 09:53:10.958882) ========= ========= Total master_lag: 0.22 =========