builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0143 starttime: 1491218751.51 results: success (0) buildid: 20170403033124 builduid: d6631593546b41078b895ecb994a557e revision: 39c86569861c15fa391561284f8f31a3d87cff3d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 04:25:51.508332) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 04:25:51.508738) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 04:25:51.509023) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 04:25:51.535180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:25:51.535458) ========= 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.t7esywH02D/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.Y7vl5BuCwG/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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-03 04:25:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 143M=0s 2017-04-03 04:25:52 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.517222 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:25:52.076755) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:25:52.077081) ========= 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.t7esywH02D/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.Y7vl5BuCwG/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.028981 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:25:52.128421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 25 secs) (at 2017-04-03 04:25:52.128733) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 39c86569861c15fa391561284f8f31a3d87cff3d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 39c86569861c15fa391561284f8f31a3d87cff3d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t7esywH02D/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.Y7vl5BuCwG/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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-03 04:25:52,414 truncating revision to first 12 chars 2017-04-03 04:25:52,414 Setting DEBUG logging. 2017-04-03 04:25:52,414 attempt 1/10 2017-04-03 04:25:52,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/39c86569861c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 04:26:03,357 unpacking tar archive at: mozilla-beta-39c86569861c/testing/mozharness/ program finished with exit code 0 elapsedTime=25.671913 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 25 secs) (at 2017-04-03 04:26:17.823334) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 04:26:17.823725) ========= script_repo_revision: 39c86569861c15fa391561284f8f31a3d87cff3d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 04:26:17.824193) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 04:26:17.824469) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 04:26:17.844244) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 25 mins, 31 secs) (at 2017-04-03 04:26:17.844539) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t7esywH02D/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.Y7vl5BuCwG/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:26:18 INFO - MultiFileLogger online at 20170403 04:26:18 in /builds/slave/test 04:26:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:26:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:18 INFO - {'append_to_log': False, 04:26:18 INFO - 'base_work_dir': '/builds/slave/test', 04:26:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:26:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:18 INFO - 'branch': 'Mozilla-Beta', 04:26:18 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:18 INFO - 'config_files': ('talos/mac_config.py',), 04:26:18 INFO - 'default_actions': ('clobber', 04:26:18 INFO - 'read-buildbot-config', 04:26:18 INFO - 'download-and-extract', 04:26:18 INFO - 'populate-webroot', 04:26:18 INFO - 'create-virtualenv', 04:26:18 INFO - 'install', 04:26:18 INFO - 'run-tests'), 04:26:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:18 INFO - 'download_minidump_stackwalk': True, 04:26:18 INFO - 'download_symbols': 'ondemand', 04:26:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:18 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:18 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:18 INFO - 'installer_path': 'installer.exe', 04:26:18 INFO - 'log_level': 'info', 04:26:18 INFO - 'log_name': 'talos', 04:26:18 INFO - 'log_to_console': True, 04:26:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:26:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:26:18 INFO - 'opt_config_files': (), 04:26:18 INFO - 'pip_index': False, 04:26:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:26:18 INFO - 'cmd': ('bash', 04:26:18 INFO - '-c', 04:26:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:26:18 INFO - 'enabled': True, 04:26:18 INFO - 'halt_on_failure': False, 04:26:18 INFO - 'name': 'check_screen_resolution'},), 04:26:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:26:18 INFO - 'cmd': ('bash', 04:26:18 INFO - '-c', 04:26:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:26:18 INFO - 'enabled': True, 04:26:18 INFO - 'halt_on_failure': False, 04:26:18 INFO - 'name': 'check_screen_resolution'},), 04:26:18 INFO - 'run_cmd_checks_enabled': True, 04:26:18 INFO - 'sps_profile': False, 04:26:18 INFO - 'sps_profile_interval': 0, 04:26:18 INFO - 'suite': 'dromaeojs-e10s', 04:26:18 INFO - 'system_bits': '32', 04:26:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:18 INFO - 'title': 't-yosemite-r7-0143', 04:26:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:18 INFO - 'use_talos_json': True, 04:26:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:18 INFO - 'work_dir': 'build'} 04:26:18 INFO - [mozharness: 2017-04-03 11:26:18.240794Z] Running clobber step. 04:26:18 INFO - Running pre-action listener: _resource_record_pre_action 04:26:18 INFO - Running main action method: clobber 04:26:18 INFO - rmtree: /builds/slave/test/build 04:26:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:20 INFO - Running post-action listener: _resource_record_post_action 04:26:20 INFO - [mozharness: 2017-04-03 11:26:20.644790Z] Finished clobber step (success) 04:26:20 INFO - [mozharness: 2017-04-03 11:26:20.644913Z] Running read-buildbot-config step. 04:26:20 INFO - Running pre-action listener: _resource_record_pre_action 04:26:20 INFO - Running main action method: read_buildbot_config 04:26:20 INFO - Using buildbot properties: 04:26:20 INFO - { 04:26:20 INFO - "project": "", 04:26:20 INFO - "product": "firefox", 04:26:20 INFO - "script_repo_revision": "production", 04:26:20 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:26:20 INFO - "repository": "", 04:26:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:26:20 INFO - "buildid": "20170403033124", 04:26:20 INFO - "pgo_build": "False", 04:26:20 INFO - "basedir": "/builds/slave/test", 04:26:20 INFO - "buildnumber": 27, 04:26:20 INFO - "slavename": "t-yosemite-r7-0143", 04:26:20 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:26:20 INFO - "platform": "yosemite_r7", 04:26:20 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:26:20 INFO - "branch": "mozilla-beta", 04:26:20 INFO - "repo_path": "releases/mozilla-beta", 04:26:20 INFO - "revision": "39c86569861c15fa391561284f8f31a3d87cff3d", 04:26:20 INFO - "stage_platform": "macosx64", 04:26:20 INFO - "builduid": "d6631593546b41078b895ecb994a557e", 04:26:20 INFO - "slavebuilddir": "test" 04:26:20 INFO - } 04:26:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 04:26:20 INFO - Running post-action listener: _resource_record_post_action 04:26:20 INFO - [mozharness: 2017-04-03 11:26:20.648512Z] Finished read-buildbot-config step (success) 04:26:20 INFO - [mozharness: 2017-04-03 11:26:20.648612Z] Running download-and-extract step. 04:26:20 INFO - Running pre-action listener: _resource_record_pre_action 04:26:20 INFO - Running main action method: download_and_extract 04:26:20 INFO - mkdir: /builds/slave/test/build/tests 04:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:20 INFO - trying https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 04:26:20 INFO - Downloading https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 04:26:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 04:26:27 INFO - Downloaded 1165 bytes. 04:26:27 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 04:26:27 INFO - Using the following test package requirements: 04:26:27 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 04:26:27 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:26:27 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 04:26:27 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:26:27 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 04:26:27 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:26:27 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:26:27 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 04:26:27 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 04:26:27 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:26:27 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 04:26:27 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:26:27 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 04:26:27 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:26:27 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 04:26:27 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:26:27 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 04:26:27 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 04:26:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 04:26:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 04:26:27 INFO - Fetch https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 04:26:29 INFO - Expected file size: 16109773 04:26:29 INFO - Obtained file size: 16109773 04:26:36 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:26:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 04:26:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 04:26:36 INFO - Fetch https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 04:27:13 INFO - retry: attempt #1 caught exception: '' 04:27:13 INFO - retry: Failed, sleeping 60 seconds before retrying 04:28:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #2 04:28:13 INFO - Fetch https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 04:28:45 INFO - retry: attempt #2 caught exception: '' 04:28:45 INFO - retry: Failed, sleeping 120 seconds before retrying 04:30:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #3 04:30:45 INFO - Fetch https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 04:30:51 INFO - Expected file size: 16109773 04:30:51 INFO - Obtained file size: 16109773 04:30:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 04:30:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 04:30:58 INFO - Fetch https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 04:31:01 INFO - Expected file size: 14403663 04:31:01 INFO - Obtained file size: 14403663 04:31: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')]} 04:31:01 INFO - trying https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:31:01 INFO - Downloading https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 04:31:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 04:31:03 INFO - Downloaded 58726312 bytes. 04:31:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:31:03 INFO - mkdir: /builds/slave/test/properties 04:31:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:03 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:03 INFO - Contents: 04:31:03 INFO - build_url:https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:31:04 INFO - Running post-action listener: _resource_record_post_action 04:31:04 INFO - Running post-action listener: set_extra_try_arguments 04:31:04 INFO - [mozharness: 2017-04-03 11:31:04.974114Z] Finished download-and-extract step (success) 04:31:04 INFO - [mozharness: 2017-04-03 11:31:04.974239Z] Running populate-webroot step. 04:31:04 INFO - Running pre-action listener: _resource_record_pre_action 04:31:04 INFO - Running main action method: populate_webroot 04:31:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:04 INFO - '--tppagecycles', 04:31:04 INFO - '7'], 04:31:04 INFO - 'tests': ['tsvgm']}}, 04:31:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:31:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:31:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:31:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:31:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:31:04 INFO - 'talos_options': ['--disable-e10s'], 04:31:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:31:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:31:04 INFO - 'talos_options': ['--disable-e10s'], 04:31:04 INFO - 'tests': ['damp', 'tps']}, 04:31:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:31:04 INFO - 'tests': ['damp', 'tps']}, 04:31:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:31:04 INFO - 'tests': ['dromaeo_dom']}, 04:31:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:31:04 INFO - 'tests': ['basic_compositor_video']}, 04:31:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:31:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:31:04 INFO - 'tests': ['a11yr', 04:31:04 INFO - 'ts_paint', 04:31:04 INFO - 'tpaint', 04:31:04 INFO - 'sessionrestore', 04:31:04 INFO - 'sessionrestore_no_auto_restore', 04:31:04 INFO - 'tabpaint']}, 04:31:04 INFO - 'other-e10s': {'tests': ['a11yr', 04:31:04 INFO - 'ts_paint', 04:31:04 INFO - 'tpaint', 04:31:04 INFO - 'sessionrestore', 04:31:04 INFO - 'sessionrestore_no_auto_restore', 04:31:04 INFO - 'tabpaint']}, 04:31:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:31:04 INFO - 'ts_paint', 04:31:04 INFO - 'tpaint', 04:31:04 INFO - 'sessionrestore', 04:31:04 INFO - 'sessionrestore_no_auto_restore', 04:31:04 INFO - 'tabpaint']}, 04:31:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:31:04 INFO - 'ts_paint', 04:31:04 INFO - 'tpaint', 04:31:04 INFO - 'sessionrestore', 04:31:04 INFO - 'sessionrestore_no_auto_restore', 04:31:04 INFO - 'tabpaint']}, 04:31:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:31:04 INFO - 'tests': ['a11yr', 04:31:04 INFO - 'ts_paint', 04:31:04 INFO - 'tpaint', 04:31:04 INFO - 'sessionrestore', 04:31:04 INFO - 'sessionrestore_no_auto_restore', 04:31:04 INFO - 'tabpaint']}, 04:31:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:31:04 INFO - 'tests': ['a11yr', 04:31:04 INFO - 'ts_paint', 04:31:04 INFO - 'tpaint', 04:31:04 INFO - 'sessionrestore', 04:31:04 INFO - 'sessionrestore_no_auto_restore', 04:31:04 INFO - 'tabpaint']}, 04:31:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:31:04 INFO - 'tests': ['tsvgx', 04:31:04 INFO - 'tsvgr_opacity', 04:31:04 INFO - 'tart', 04:31:04 INFO - 'tscrollx', 04:31:04 INFO - 'cart', 04:31:04 INFO - 'tsvg_static']}, 04:31:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:31:04 INFO - 'tsvgr_opacity', 04:31:04 INFO - 'tart', 04:31:04 INFO - 'tscrollx', 04:31:04 INFO - 'cart', 04:31:04 INFO - 'tsvg_static']}, 04:31:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:31:04 INFO - 'talos_options': ['--disable-e10s'], 04:31:04 INFO - 'tests': ['tp5o']}, 04:31:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:31:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:31:04 INFO - 'talos_options': ['--disable-e10s', 04:31:04 INFO - '--xperf_path', 04:31:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:04 INFO - 'tests': ['tp5n']}, 04:31:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:31:04 INFO - 'talos_options': ['--xperf_path', 04:31:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:04 INFO - 'tests': ['tp5n']}}, 04:31:04 INFO - 'talos.zip': {'path': '', 04:31:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:04 INFO - Running post-action listener: _resource_record_post_action 04:31:04 INFO - [mozharness: 2017-04-03 11:31:04.992828Z] Finished populate-webroot step (success) 04:31:04 INFO - [mozharness: 2017-04-03 11:31:04.992939Z] Running create-virtualenv step. 04:31:04 INFO - Running pre-action listener: _resource_record_pre_action 04:31:04 INFO - Running main action method: create_virtualenv 04:31:04 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:31:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:05 INFO - Using real prefix '/tools/python27' 04:31:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:05 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:08 INFO - Installing pip.................done. 04:31:08 INFO - Return code: 0 04:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:31:08 INFO - Reading from file tmpfile_stdout 04:31:08 INFO - Output received: 04:31:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:31:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:10 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 0x103181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf925b1d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f5fd30>, '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 0x102e86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f54be8>, '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.t7esywH02D/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.Y7vl5BuCwG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:31:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t7esywH02D/Render', 04:31:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:10 INFO - 'HOME': '/Users/cltbld', 04:31:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:10 INFO - 'LOGNAME': 'cltbld', 04:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:10 INFO - 'MOZ_NO_REMOTE': '1', 04:31:10 INFO - 'NO_EM_RESTART': '1', 04:31:10 INFO - 'PAGER': '/bin/cat', 04:31:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:10 INFO - 'PWD': '/builds/slave/test', 04:31:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:10 INFO - 'SHELL': '/bin/bash', 04:31:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y7vl5BuCwG/Listeners', 04:31:10 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:31:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:10 INFO - 'USER': 'cltbld', 04:31:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:10 INFO - 'XPC_FLAGS': '0x0', 04:31:10 INFO - 'XPC_SERVICE_NAME': '0', 04:31:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:31:10 INFO - Cleaning up... 04:31:10 INFO - Return code: 0 04:31:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:10 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 0x103181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf925b1d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f5fd30>, '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 0x102e86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f54be8>, '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.t7esywH02D/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.Y7vl5BuCwG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:31:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t7esywH02D/Render', 04:31:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:10 INFO - 'HOME': '/Users/cltbld', 04:31:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:10 INFO - 'LOGNAME': 'cltbld', 04:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:10 INFO - 'MOZ_NO_REMOTE': '1', 04:31:10 INFO - 'NO_EM_RESTART': '1', 04:31:10 INFO - 'PAGER': '/bin/cat', 04:31:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:10 INFO - 'PWD': '/builds/slave/test', 04:31:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:10 INFO - 'SHELL': '/bin/bash', 04:31:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y7vl5BuCwG/Listeners', 04:31:10 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:31:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:10 INFO - 'USER': 'cltbld', 04:31:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:10 INFO - 'XPC_FLAGS': '0x0', 04:31:10 INFO - 'XPC_SERVICE_NAME': '0', 04:31:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:10 INFO - Downloading/unpacking psutil>=3.1.1 04:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:16 INFO - Installing collected packages: psutil 04:31:16 INFO - Running setup.py install for psutil 04:31:16 INFO - building 'psutil._psutil_osx' extension 04:31:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:31:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:31:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:31:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:31:17 INFO - building 'psutil._psutil_posix' extension 04:31:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:31:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:31:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:31:17 INFO - ^ 04:31:17 INFO - 1 warning generated. 04:31:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:31:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:17 INFO - Successfully installed psutil 04:31:17 INFO - Cleaning up... 04:31:17 INFO - Return code: 0 04:31:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:17 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 0x103181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf925b1d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f5fd30>, '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 0x102e86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f54be8>, '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.t7esywH02D/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.Y7vl5BuCwG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:31:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t7esywH02D/Render', 04:31:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:17 INFO - 'HOME': '/Users/cltbld', 04:31:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:17 INFO - 'LOGNAME': 'cltbld', 04:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:17 INFO - 'MOZ_NO_REMOTE': '1', 04:31:17 INFO - 'NO_EM_RESTART': '1', 04:31:17 INFO - 'PAGER': '/bin/cat', 04:31:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:17 INFO - 'PWD': '/builds/slave/test', 04:31:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:17 INFO - 'SHELL': '/bin/bash', 04:31:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y7vl5BuCwG/Listeners', 04:31:17 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:31:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:17 INFO - 'USER': 'cltbld', 04:31:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:17 INFO - 'XPC_FLAGS': '0x0', 04:31:17 INFO - 'XPC_SERVICE_NAME': '0', 04:31:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:31:24 INFO - Installing collected packages: mozsystemmonitor 04:31:24 INFO - Running setup.py install for mozsystemmonitor 04:31:24 INFO - Successfully installed mozsystemmonitor 04:31:24 INFO - Cleaning up... 04:31:24 INFO - Return code: 0 04:31:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:24 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 0x103181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf925b1d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f5fd30>, '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 0x102e86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f54be8>, '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.t7esywH02D/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.Y7vl5BuCwG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:31:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t7esywH02D/Render', 04:31:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:24 INFO - 'HOME': '/Users/cltbld', 04:31:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:24 INFO - 'LOGNAME': 'cltbld', 04:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:24 INFO - 'MOZ_NO_REMOTE': '1', 04:31:24 INFO - 'NO_EM_RESTART': '1', 04:31:24 INFO - 'PAGER': '/bin/cat', 04:31:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:24 INFO - 'PWD': '/builds/slave/test', 04:31:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:24 INFO - 'SHELL': '/bin/bash', 04:31:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y7vl5BuCwG/Listeners', 04:31:24 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:31:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:24 INFO - 'USER': 'cltbld', 04:31:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:24 INFO - 'XPC_FLAGS': '0x0', 04:31:24 INFO - 'XPC_SERVICE_NAME': '0', 04:31:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:25 INFO - Downloading/unpacking jsonschema==2.5.1 04:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:31 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:31 INFO - warning: no files found matching '*.txt' 04:31:31 INFO - no previously-included directories found matching 'build' 04:31:31 INFO - no previously-included directories found matching 'dist' 04:31:31 INFO - no previously-included directories found matching '.git*' 04:31:31 INFO - Installing collected packages: jsonschema, functools32 04:31:31 INFO - Running setup.py install for functools32 04:31:31 INFO - warning: no files found matching '*.txt' 04:31:31 INFO - no previously-included directories found matching 'build' 04:31:31 INFO - no previously-included directories found matching 'dist' 04:31:31 INFO - no previously-included directories found matching '.git*' 04:31:32 INFO - Successfully installed jsonschema functools32 04:31:32 INFO - Cleaning up... 04:31:32 INFO - Return code: 0 04:31:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf925b1d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f5fd30>, '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 0x102e86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f54be8>, '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.t7esywH02D/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.Y7vl5BuCwG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:31:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t7esywH02D/Render', 04:31:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:32 INFO - 'HOME': '/Users/cltbld', 04:31:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:32 INFO - 'LOGNAME': 'cltbld', 04:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:32 INFO - 'MOZ_NO_REMOTE': '1', 04:31:32 INFO - 'NO_EM_RESTART': '1', 04:31:32 INFO - 'PAGER': '/bin/cat', 04:31:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:32 INFO - 'PWD': '/builds/slave/test', 04:31:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:32 INFO - 'SHELL': '/bin/bash', 04:31:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y7vl5BuCwG/Listeners', 04:31:32 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:31:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:32 INFO - 'USER': 'cltbld', 04:31:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:32 INFO - 'XPC_FLAGS': '0x0', 04:31:32 INFO - 'XPC_SERVICE_NAME': '0', 04:31:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:31:32 INFO - Cleaning up... 04:31:32 INFO - Return code: 0 04:31:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf925b1d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f5fd30>, '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 0x102e86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f54be8>, '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.t7esywH02D/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.Y7vl5BuCwG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:31:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t7esywH02D/Render', 04:31:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:32 INFO - 'HOME': '/Users/cltbld', 04:31:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:32 INFO - 'LOGNAME': 'cltbld', 04:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:32 INFO - 'MOZ_NO_REMOTE': '1', 04:31:32 INFO - 'NO_EM_RESTART': '1', 04:31:32 INFO - 'PAGER': '/bin/cat', 04:31:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:32 INFO - 'PWD': '/builds/slave/test', 04:31:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:32 INFO - 'SHELL': '/bin/bash', 04:31:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y7vl5BuCwG/Listeners', 04:31:32 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:31:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:32 INFO - 'USER': 'cltbld', 04:31:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:32 INFO - 'XPC_FLAGS': '0x0', 04:31:32 INFO - 'XPC_SERVICE_NAME': '0', 04:31:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:32 INFO - Downloading/unpacking blobuploader==1.2.4 04:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:36 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:38 INFO - Downloading docopt-0.6.1.tar.gz 04:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:38 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:38 INFO - Running setup.py install for blobuploader 04:31:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:38 INFO - Running setup.py install for requests 04:31:38 INFO - Running setup.py install for docopt 04:31:38 INFO - Successfully installed blobuploader requests docopt 04:31:38 INFO - Cleaning up... 04:31:39 INFO - Return code: 0 04:31:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:39 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 0x103181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf925b1d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f5fd30>, '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 0x102e86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f54be8>, '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.t7esywH02D/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.Y7vl5BuCwG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t7esywH02D/Render', 04:31:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:39 INFO - 'HOME': '/Users/cltbld', 04:31:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:39 INFO - 'LOGNAME': 'cltbld', 04:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:39 INFO - 'MOZ_NO_REMOTE': '1', 04:31:39 INFO - 'NO_EM_RESTART': '1', 04:31:39 INFO - 'PAGER': '/bin/cat', 04:31:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:39 INFO - 'PWD': '/builds/slave/test', 04:31:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:39 INFO - 'SHELL': '/bin/bash', 04:31:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y7vl5BuCwG/Listeners', 04:31:39 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:31:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:39 INFO - 'USER': 'cltbld', 04:31:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:39 INFO - 'XPC_FLAGS': '0x0', 04:31:39 INFO - 'XPC_SERVICE_NAME': '0', 04:31:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:39 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-avuKIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:39 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-WFIuyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:39 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-G1uFB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:39 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-1eUafw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:39 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-nyJVpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:39 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-XFdw_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:39 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-W283Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-_Cc20A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-KegKM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-FMChvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-HyQ9tD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-F7Ugj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-xrHAwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-LHwxvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-cBJ4ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-NpkzSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:40 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-cNCNZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:41 INFO - Running setup.py install for manifestparser 04:31:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:41 INFO - Running setup.py install for mozcrash 04:31:41 INFO - Running setup.py install for mozdebug 04:31:41 INFO - Running setup.py install for mozdevice 04:31:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:41 INFO - Running setup.py install for mozfile 04:31:41 INFO - Running setup.py install for mozhttpd 04:31:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:41 INFO - Running setup.py install for mozinfo 04:31:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:42 INFO - Running setup.py install for mozInstall 04:31:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:42 INFO - Running setup.py install for mozleak 04:31:42 INFO - Running setup.py install for mozlog 04:31:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:42 INFO - Running setup.py install for moznetwork 04:31:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:42 INFO - Running setup.py install for mozprocess 04:31:42 INFO - Running setup.py install for mozprofile 04:31:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:43 INFO - Running setup.py install for mozrunner 04:31:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:43 INFO - Running setup.py install for mozscreenshot 04:31:43 INFO - Running setup.py install for moztest 04:31:43 INFO - Running setup.py install for mozversion 04:31:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:43 INFO - Cleaning up... 04:31:43 INFO - Return code: 0 04:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 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 0x103181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf925b1d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f5fd30>, '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 0x102e86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f54be8>, '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.t7esywH02D/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.Y7vl5BuCwG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t7esywH02D/Render', 04:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:43 INFO - 'HOME': '/Users/cltbld', 04:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:43 INFO - 'LOGNAME': 'cltbld', 04:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:43 INFO - 'MOZ_NO_REMOTE': '1', 04:31:43 INFO - 'NO_EM_RESTART': '1', 04:31:43 INFO - 'PAGER': '/bin/cat', 04:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:43 INFO - 'PWD': '/builds/slave/test', 04:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:43 INFO - 'SHELL': '/bin/bash', 04:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y7vl5BuCwG/Listeners', 04:31:43 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:43 INFO - 'USER': 'cltbld', 04:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:43 INFO - 'XPC_FLAGS': '0x0', 04:31:43 INFO - 'XPC_SERVICE_NAME': '0', 04:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:43 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-JqIO9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:44 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-rzSYda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:44 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-wFqyOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:44 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-1t687A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:44 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-gzOKb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:44 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Am6Nrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:44 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-x6ihZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:44 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-RSCNmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:44 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-bLyPMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:44 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-uUz7GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:44 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-JYWupC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-6bhpHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-2SKGem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-toex48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-usfhO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-7ejw1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:45 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-mrda_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:50 INFO - Downloading blessings-1.6.tar.gz 04:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:50 INFO - Installing collected packages: blessings 04:31:50 INFO - Running setup.py install for blessings 04:31:50 INFO - Successfully installed blessings 04:31:50 INFO - Cleaning up... 04:31:50 INFO - Return code: 0 04:31:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:50 INFO - Reading from file tmpfile_stdout 04:31:50 INFO - Current package versions: 04:31:50 INFO - blessings == 1.6 04:31:50 INFO - blobuploader == 1.2.4 04:31:50 INFO - docopt == 0.6.1 04:31:50 INFO - functools32 == 3.2.3-2 04:31:50 INFO - jsonschema == 2.5.1 04:31:50 INFO - manifestparser == 1.1 04:31:50 INFO - mozInstall == 1.12 04:31:50 INFO - mozcrash == 1.0 04:31:50 INFO - mozdebug == 0.1 04:31:50 INFO - mozdevice == 0.49 04:31:50 INFO - mozfile == 1.2 04:31:50 INFO - mozhttpd == 0.7 04:31:50 INFO - mozinfo == 0.9 04:31:50 INFO - mozleak == 0.1 04:31:50 INFO - mozlog == 3.4 04:31:50 INFO - moznetwork == 0.27 04:31:50 INFO - mozprocess == 0.24 04:31:50 INFO - mozprofile == 0.28 04:31:50 INFO - mozrunner == 6.13 04:31:50 INFO - mozscreenshot == 0.1 04:31:50 INFO - mozsystemmonitor == 0.3 04:31:50 INFO - moztest == 0.8 04:31:50 INFO - mozversion == 1.4 04:31:50 INFO - psutil == 3.1.1 04:31:50 INFO - requests == 1.2.3 04:31:50 INFO - wsgiref == 0.1.2 04:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:50 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 0x103181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf925b1d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f5fd30>, '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 0x102e86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f54be8>, '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.t7esywH02D/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.Y7vl5BuCwG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t7esywH02D/Render', 04:31:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:50 INFO - 'HOME': '/Users/cltbld', 04:31:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:50 INFO - 'LOGNAME': 'cltbld', 04:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:50 INFO - 'MOZ_NO_REMOTE': '1', 04:31:50 INFO - 'NO_EM_RESTART': '1', 04:31:50 INFO - 'PAGER': '/bin/cat', 04:31:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:50 INFO - 'PWD': '/builds/slave/test', 04:31:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:50 INFO - 'SHELL': '/bin/bash', 04:31:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y7vl5BuCwG/Listeners', 04:31:50 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:31:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:50 INFO - 'USER': 'cltbld', 04:31:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:50 INFO - 'XPC_FLAGS': '0x0', 04:31:50 INFO - 'XPC_SERVICE_NAME': '0', 04:31:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:51 INFO - Cleaning up... 04:31:51 INFO - Return code: 0 04:31:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf925b1d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f5fd30>, '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 0x102e86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f54be8>, '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.t7esywH02D/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.Y7vl5BuCwG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31: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', 'jsonschema'] in /builds/slave/test/build 04:31: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 jsonschema 04:31:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t7esywH02D/Render', 04:31:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:51 INFO - 'HOME': '/Users/cltbld', 04:31:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:51 INFO - 'LOGNAME': 'cltbld', 04:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:51 INFO - 'MOZ_NO_REMOTE': '1', 04:31:51 INFO - 'NO_EM_RESTART': '1', 04:31:51 INFO - 'PAGER': '/bin/cat', 04:31:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:51 INFO - 'PWD': '/builds/slave/test', 04:31:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:51 INFO - 'SHELL': '/bin/bash', 04:31:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y7vl5BuCwG/Listeners', 04:31:51 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:31:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:51 INFO - 'USER': 'cltbld', 04:31:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:51 INFO - 'XPC_FLAGS': '0x0', 04:31:51 INFO - 'XPC_SERVICE_NAME': '0', 04:31:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:31:51 INFO - Cleaning up... 04:31:51 INFO - Return code: 0 04:31:51 INFO - Running post-action listener: _resource_record_post_action 04:31:51 INFO - Running post-action listener: _start_resource_monitoring 04:31:51 INFO - Starting resource monitoring. 04:31:51 INFO - [mozharness: 2017-04-03 11:31:51.539740Z] Finished create-virtualenv step (success) 04:31:51 INFO - [mozharness: 2017-04-03 11:31:51.540720Z] Running install step. 04:31:51 INFO - Running pre-action listener: _resource_record_pre_action 04:31:51 INFO - Running main action method: install 04:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:51 INFO - Reading from file tmpfile_stdout 04:31:51 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:51 INFO - Reading from file tmpfile_stdout 04:31:51 INFO - Output received: 04:31:51 INFO - Usage: mozinstall [options] installer 04:31:51 INFO - Options: 04:31:51 INFO - -h, --help show this help message and exit 04:31:51 INFO - -d DEST, --destination=DEST 04:31:51 INFO - Directory to install application into. [default: 04:31:51 INFO - "/builds/slave/test"] 04:31:51 INFO - --app=APP Application being installed. [default: firefox] 04:31:51 INFO - mkdir: /builds/slave/test/build/application 04:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:32:06 INFO - Reading from file tmpfile_stdout 04:32:06 INFO - Output received: 04:32:06 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:32:06 INFO - Running post-action listener: _resource_record_post_action 04:32:06 INFO - [mozharness: 2017-04-03 11:32:06.519788Z] Finished install step (success) 04:32:06 INFO - [mozharness: 2017-04-03 11:32:06.519941Z] Running run-tests step. 04:32:06 INFO - Running pre-action listener: _resource_record_pre_action 04:32:06 INFO - Running main action method: run_tests 04:32:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:32:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:32:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:32:06 INFO - 2017-04-03 04:32:06.534 screenresolution[1629:7984] starting screenresolution argv=screenresolution get 04:32:06 INFO - 2017-04-03 04:32:06.537 screenresolution[1629:7984] Display 0: 1600x1200x32@60 04:32:06 INFO - 2017-04-03 04:32:06.543 screenresolution[1630:7986] starting screenresolution argv=screenresolution list 04:32:06 INFO - Available Modes on Display 0 04:32:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:32:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:32:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:32:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:32:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:32:06 INFO - Intel Iris: 04:32:06 INFO - Chipset Model: Intel Iris 04:32:06 INFO - Type: GPU 04:32:06 INFO - Bus: Built-In 04:32:06 INFO - VRAM (Dynamic, Max): 1536 MB 04:32:06 INFO - Vendor: Intel (0x8086) 04:32:06 INFO - Device ID: 0x0a2e 04:32:06 INFO - Revision ID: 0x0009 04:32:06 INFO - Displays: 04:32:06 INFO - Display: 04:32:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:32:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:32:06 INFO - Display Serial Number: 1600x1200 60 04:32:06 INFO - Main Display: Yes 04:32:06 INFO - Mirror: Off 04:32:06 INFO - Online: Yes 04:32:06 INFO - Rotation: Supported 04:32:06 INFO - Return code: 0 04:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:06 INFO - Python 2.7.3 04:32:06 INFO - Return code: 0 04:32:06 INFO - grabbing minidump binary from tooltool 04:32: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')]} 04:32:06 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 0x102f5fd30>, '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 0x102e86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f54be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:32:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:32:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:32:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:06 INFO - Return code: 0 04:32:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:32:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:32:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--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 04:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0143 --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 04:32:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t7esywH02D/Render', 04:32:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:06 INFO - 'HOME': '/Users/cltbld', 04:32:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:06 INFO - 'LOGNAME': 'cltbld', 04:32:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:06 INFO - 'MOZ_NO_REMOTE': '1', 04:32:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:06 INFO - 'NO_EM_RESTART': '1', 04:32:06 INFO - 'PAGER': '/bin/cat', 04:32:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:06 INFO - 'PWD': '/builds/slave/test', 04:32:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:06 INFO - 'SHELL': '/bin/bash', 04:32:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y7vl5BuCwG/Listeners', 04:32:06 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:32:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:06 INFO - 'USER': 'cltbld', 04:32:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:06 INFO - 'XPC_FLAGS': '0x0', 04:32:06 INFO - 'XPC_SERVICE_NAME': '0', 04:32:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--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 04:32:07 INFO - mozversion application_buildid: 20170403033124 04:32:07 INFO - mozversion application_changeset: 39c86569861c15fa391561284f8f31a3d87cff3d 04:32:07 INFO - mozversion application_display_name: Firefox 04:32:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:07 INFO - mozversion application_name: Firefox 04:32:07 INFO - mozversion application_remotingname: firefox 04:32:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:32:07 INFO - mozversion application_vendor: Mozilla 04:32:07 INFO - mozversion application_version: 53.0 04:32:07 INFO - mozversion platform_buildid: 20170403033124 04:32:07 INFO - mozversion platform_changeset: 39c86569861c15fa391561284f8f31a3d87cff3d 04:32:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:32:07 INFO - mozversion platform_version: 53.0 04:32:07 INFO - using testdate: 1491219127 04:32:07 INFO - actual date: 1491219127 04:32:07 INFO - starting webserver on 'localhost:49247' 04:32:07 INFO - SUITE-START | Running 2 tests 04:32:07 INFO - TEST-START | dromaeo_css 04:32:07 INFO - operating with platform_type : mac_ 04:32:07 INFO - Initialising browser for dromaeo_css test... 04:32:07 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpBYVBWQ/profile http://localhost:49247/getInfo.html) 04:32:09 INFO - PROCESS | 1640 | 2017-04-03 04:32:09.843 plugin-container[1643:8162] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d47, name = 'com.apple.tsm.portname' 04:32:09 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:09 INFO - PROCESS | 1640 | 2017-04-03 04:32:09.843 plugin-container[1643:8162] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 04:32:09 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:09 INFO - PROCESS | 1640 | 2017-04-03 04:32:09.843 plugin-container[1643:8162] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:32:09 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 04:32:09 INFO - PROCESS | 1640 | colorDepth:24 04:32:09 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 04:32:09 INFO - PROCESS | 1640 | __metrics 04:32:09 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 04:32:10 INFO - TEST-INFO | 1640: exit 0 04:32:10 INFO - Browser initialized. 04:32:10 INFO - Running cycle 1/1 for dromaeo_css test... 04:32:10 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpBYVBWQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:12 INFO - PROCESS | 1645 | 2017-04-03 04:32:12.899 plugin-container[1646:8301] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 04:32:12 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:12 INFO - PROCESS | 1645 | 2017-04-03 04:32:12.900 plugin-container[1646:8301] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 04:32:12 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:12 INFO - PROCESS | 1645 | 2017-04-03 04:32:12.900 plugin-container[1646:8301] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:32:22 INFO - PROCESS | 1645 | RSS: Main: 173268992 04:32:22 INFO - PROCESS | 1645 | 04:35:24 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 04:35:26 INFO - PROCESS | 1645 | RSS: Main: 192258048 04:35:26 INFO - PROCESS | 1645 | 04:38:28 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 04:38:29 INFO - PROCESS | 1645 | RSS: Main: 204337152 04:38:29 INFO - PROCESS | 1645 | 04:41:31 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 04:41:31 INFO - PROCESS | 1645 | RSS: Main: 206643200 04:41:31 INFO - PROCESS | 1645 | 04:44:33 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 04:44:34 INFO - PROCESS | 1645 | RSS: Main: 210362368 04:44:34 INFO - PROCESS | 1645 | 04:47:36 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 04:47:37 INFO - PROCESS | 1645 | RSS: Main: 211910656 04:47:37 INFO - PROCESS | 1645 | 04:50:40 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 04:50:40 INFO - PROCESS | 1645 | RSS: Main: 212090880 04:50:40 INFO - PROCESS | 1645 | 04:50:40 INFO - PROCESS | 1645 | __start_tp_report 04:50:40 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 04:50:40 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 04:50:40 INFO - PROCESS | 1645 | |i|pagename|runs| 04:50:40 INFO - PROCESS | 1645 | |0;dojo.html;3521.5245941797857;3529.8941031769054;3554.697850682691;3569.1255642367623;3571.2143328467746;5908.586398952069;6067.423594758502;6076.726547305371;6079.969600151999;6085.148079268901;5990.371011043843;6062.393760623935;6063.757449702007;6073.817785466443;6089.847753806157;5328.360596728398;5398.2982212312545;5411.107167317407;5411.702356370398;5481.342238931334;5460.945390546103;5464.289642346489;5492.395836458007;5494.395616482184;5537.280153580029;4395.516493185747;5355.384130824947;5457.590680698943;5464.836054918339;5489.039418101836;5419.458054194569;5447.972760136174;5457.481539253804;5469.890602187974;5473.042217611922;5259.737013149365;5378.811741589065;5401.891962160735;5410.594205434608;5429.809956651498;5997.7001149942325;6016.789412370546;6082.118092876508;6128.988716861712;6148.893199224138;6086.786962456293;6258.937410625881;6275.874482510324;6290.716917738667;6296.622202667854;6380.138681278015;6396.968015159941;6406.775762848324;6417.518686098561;6442.742290308382;6033.125196846433;6121.239585875146;6124.5100391968535;6133.815985520441;6135.846603834851;6564.113844631009;6567.211934567882;6569.638669873203;6571.868562628721;6593.3736295051895;6252.718627661766;6279.4662453691035;6285.622862628165;6295.18162638854;6309.716062777186;6226.62640241587;6249.843753906098;6250.218722659668;6261.186045814015;6412.903806442907;5486.259354987105;6226.128342032119;6262.436380725757;6316.336784637639;6334.429901308904;5426.321709786277;6268.310485846553;6296.212973378328;6304.338044505353;6322.557420980579;5098.439171691111;5111.131107711698;5130;5173.896522069537;5191.6884986900905;3996.260691771973;4614.976925115353;4617.7691115444095;4635.907281854344;4680.859574212779;5074.746262686851;6131.172291740558;6170.907436388457;6171.56799024073;6181.536384771161;6242.937570624326;6436.967815160894;6438.774642887476;6448.613083215022;6455.935440645628;6016.8796624068145;6077.361877002851;6077.908831367533;6101.298350689727;6170.82754276695;5650.406707295757;5659;5663.235463212496;5668.829935101953;5715.228444160069;5621.4659607337235;6323.715432805535;6414.935850641434;6525.477961763143;6534.117894084237;6433.774817881352;6458.644774537445;6464.612123272619;6487.578307410004;6518.934810651833;5851.1223316502865;6391.872162556816;6610.3720146586;6649.534532582867;6727.192736871607;6167.969160154171;6213.068039794067;6251.343608920998;6347.96826015867;6361.745530178926;6315.747370105144;6397.232332120176;6437.195350581177;6438.967805161132;6442.291347951628;6250.781222657185;6265.185525881606;6268.623882567061;6270.153529273673;6276.340984196594;6009.128676341993;6164.691765411621;6211.068339749074;6248.094026366242;6280.434760871361;5235.816746413857;6102.755889764359;6164.260288765377;6209.130721698875;6234.2830574482705;6252.155958945484;6255.96872015637;6258.843528911813;6278.246610406781;6290.622562646073;6120.690942950841;6150.630962142286;6178.644722947267;6217.285012223652;6230.626162430269 04:50:40 INFO - PROCESS | 1645 | |1;ext.html;483.5551292810614;504.2310476523304;515.078010361453;520.0612893726824;559.0496156533893;42066;44247.557524424745;44380.89047773803;44487.66537003895;47097.764511177484;46997.29504057442;47408.76295618517;47562.52437475624;47615;47626.76186619062;9758.414495130315;10007.699769006942;10016.699499015042;10053.69838904834;11707.473163707653;10030.39817610942;11943.58197463089;12035.638930832089;12043.879561204407;12087.456064477075;10303.381797092161;11684.298942063504;12058;12060.155789094766;12073.03415726744;11944.581939632071;11977.341246231454;11997.880021199764;12020.939895300555;12040.578579749666;11899.405029748565;11960.940195299056;11972.221805582609;11986;12015.158938874194;35980;37131.62868371336;39970;40334.19331613351;40369.59630403688;4069.491313585802;4085.9182816343505;4104.445899803518;4154.480689913761;4158.584141585848;28854.197231851176;29496.967606133683;29548.409031819243;29717.55423668647;31166;3274.754393420503;3366.932661346784;3513.1919658478437;3560.3413368526644;3560.608333083359;376020;442593;447509;448923.75538122427;449078.75460622815;61402.38597613967;61709;61771.691141544004;61859;61934;65362;65689;65771;65793;65854;17099.316027359015;17100.230489627997;17349.82650173482;17373;17377.04426256568;12238.81641775374;12558;13925.442982280596;14060.929695351459;14153.08004979673;19741.40775776729;21419.678704819442;22715.886420567793;22792.43018924507;22806;8142.90070840429;9104.81790364189;9153.908460915305;9342.48616326095;9396.530173491297;842.4776638484057;874.8294082653821;894.6019021535484;915.158054589779;932.4684929590204;32485.51271730926;32702.345953080807;32708.672913270562;32783.83608081944;33487.497687534706;1051.5163025008428;1086.9728256793485;1091.3560999010622;1097.8737445193744;1140.0993215359772;15792;16218.594535136715;16767.413140540022;16990.235439405256;17093.743593846102;581821;590348;591102;594634;603260;55939.16091258635;57066;57631.423685763446;57686;57780.844383112104;1430.8139941807706;1452.2048780972618;1470.4485817818318;1481.6962522682825;1490.3219035338896;29924.401511970074;31332;31505;31718.365632687677;32003.039908802773;51941;56603.71698141647;58111.418885812294;58132.83734325374;61215.38784612275;611560.9421952862;620066;620596;620950;622479;36724.44913326356;37337.81331093436;41860.79069604632;42744.57255427406;43930;45979.78141530194;47006.76496617632;47489.28766068443;47516;48588.2711759331;29852.552211717277;31729;32054;32657.020289391356;33272.83363583167;32331.428969206307;32894.67105329012;32948.341033179684;33203.00390988274;33853.83073084619;31598.36803263968;36846.26307473782;37727.245455091295;38575.842724718306;38595.614043860325;26702.722659894804;27030.459390812466;31711.682883170874;31925.6807431932;32802;24053.51892962166;25539.872300638377;25609;25664;26083.869580651975 04:50:40 INFO - PROCESS | 1645 | |2;jquery.html;402.96776257899353;408.5893676854761;409.2633260131763;413.6380666916449;432.37090034000533;20652.967351632415;20890.373288801322;21844.45388865279;22064.669029964523;22071.77928220717;18855;22040.559188816213;22326.33021009368;22549.985250663718;22814.429639259026;5847.093700476422;6147.047207682816;6195.442410183083;6207.193064901557;6208.037754148092;5921.88156236875;6011.819645410623;6022.095314097595;6074.696265186745;6075.696215189245;6027.246594175728;6030.366811484797;6031.366706495799;6033.7888173913925;6046.3349031606485;5857;6009.549283803733;6039.849003774919;6083.117947897575;6099.84750381244;4521.457425109008;5144.897102057976;5319.042572336978;5369.40936496985;5378.300820893298;26128.085517006813;26692;26693.733062669515;27007.729922700913;27076.729232707814;2611.099170786095;3146.7482601391835;3186.8884589039503;3226.822524761137;3230.16015835882;15575.299111540007;16138.75791863123;16227.269772860132;16388.83611163885;16988.660226795517;1596.3853916242215;1950.7268982342484;1964.1554131723353;2087.311187308185;2108.652072408051;141442;144417;146619.26690366588;147541.99999999892;148883;12262.693432664077;12362.505499780087;12464.43910024033;12563.309018003914;12655.493780248871;16280.348786048426;16435.506934791974;16443.83556164447;16471.01173929568;16486.258118384703;8826.646934122691;8999.235065019415;9052.185303322733;9224.953875230714;9229.123233292827;8811.162939520735;8812.911870881337;8867.512286824287;8960.327975401871;9008.864867027;4908.9263661045115;4982.90034199314;4996.6502344836235;5005.474425185376;5022.196448568212;1830.6155707301616;2098.0768461877033;2111.429913923263;2123.8831864247613;2133.200049981257;987.8073775613686;987.9012098790207;993.3989936088707;1000.674780696262;1001.3341128149845;20741.377758667266;21380.465488362915;21439.356819295444;23688.81555922197;23916.162934297216;1068.8984546468073;1072.1101485766794;1091.2415870969758;1099.6700989703056;1112.4548971004149;9037.909620903707;11220.382878941737;11472;11562.595309164139;11570.19008669385;732644;738047;738561;746894;768781;122423.77576224302;146285.26857365645;153322.46677533304;158370.2081489608;161388;1116.151724689242;1137.3517095255625;1141.8001849676273;1145.9025982791388;1146.1690274550883;15889.443869464514;18186.9997150158;19611.70582441236;19653.901730491256;19700.01499924969;63737.681311595;63740;64192.67903660452;65445.345546543926;65495.67252163708;84268;86519.26961460609;87340.56329718311;94573.52713236665;94627.52686236525;7502.812429689301;8345;8580.613872375883;9010.729678109667;9034.503102329434;11629.47667354988;12424.813627795409;12735.745285094432;13433.798493022809;13881;11436.313821170756;11733.413329333329;11734.765304694029;11856.051515878537;11981.520739170684;10662.786744264917;10914.23600347968;10988.780224395627;11106;11241.60654377093;11676.708082297671;11700.180987331145;11851.703707407383;12017.699557511132;12043.638690839289;7859.449838511478;7860.174681658572;7917.7624671259955;7955.880661789962;8049.919500804917;8604.440711353742;11000.944995274973;11470.311781293149;11788.056955443373;11948.044156467287 04:50:40 INFO - PROCESS | 1645 | |3;mootools.html;1373.99313003435;1448.869601735845;1507.5402002389274;1511.9092854428732;1517.8330383657803;7331.523450975683;7797.6880924762945;8072.757817265477;8493.193146651074;8792.51641159736;7233.312835280653;8270.297024752888;8546.658133674646;8670.176333248348;8672.696455624055;2026.5237669147812;2363.869987150706;2390.1992832401165;2391.5097405031925;2398.07674045492;2098.213170061227;2273.499830037389;2395.461021270209;2419.370963549481;2424.442378253003;2171.2834764527747;2346.5189636124637;2388.2118900762707;2397.19693902542;2432.62294344376;2039;2269.4439862233776;2324.5583339165505;2328.1153161798493;2342.1334106380577;2366.2073205476186;2370.4192472844093;2386.6181410974336;2388.8566685998894;2397.0172229385867;8692.391532592721;8778.517181555011;8779.64881404743;8781.38530302879;8786.736397908073;5246.449122842085;5388.030154572176;5415.323084614423;5422.186671999192;5452.563794896439;3430.2281986553076;3504.7196224301993;3616.764910280823;3693.556773187208;3695.0762309422644;1181.6395999220235;1185.7628474305172;1199.7840388730026;1299.2009913902975;1303.3092460995688;11226.326420414802;11270.380129092897;11306;11306.152038597056;11316.830247546293;3959.891230455477;4571.862844114682;4757.500462451393;4774.7135171889795;4868.2210846264425;8032.4778889372;9831.1643510301;9836.409815410954;9864.358816676893;9876.60493580263;5342.54588359986;5373.892522149613;5385.7576409061685;5388.811391601275;5454.509094181542;4433.002574420794;4449.532799056117;4898.706077635282;4961.776720047606;4975.203967365276;4002.4996875390575;4023.879283621496;4125.66994640428;4129;4129.070959034253;1290.6321698315935;1296.9805452918213;1301.4273719563362;1307.8888294494884;1308.117021010814;785.9017622797151;912.4388501071793;926.5552534783342;933.5145724223365;934.1032608695729;5693.231413759089;5765.654060756368;5924.881502369928;5954.225950626477;6052.727627256784;580.7125472890946;590.6839840685212;597.7549204826;604.5828378418877;605.4913872347162;3818.579956204871;3881.902952426212;3925.646691797752;4003.6396724294955;4012.137390461065;9612.855807162898;10286.588536458608;10321.690349289533;10356.585736570603;10389.272750907365;9969.700908972742;10203.132733717717;10284.640037598649;10293.588256469657;10318.071373576415;8082.474639148437;8128.837423251502;8131.268185863182;8150.38872084596;8156.755297341089;5611.943880561143;5690.971545142248;5783.306003279633;5803.622764520293;5853.502452291603;7949.244821741925;9233.938097118917;9409.811803764023;9465.432074075577;9525.999770024326;9191.448513089235;9562.56968436436;9572.617095316387;9625.229981601315;9772.02279772017;6869.347411995853;7058.752943646948;7250.818729531804;7447.404207663266;7597.430192735456;8051.35589152878;8208.58957052157;8352.749417517483;8355.289800367036;8361.498310101413;7132.572045677276;7165.785026449006;7194.604296763729;7319.487635865651;7340;7070.929290707233;7109.680064397218;7125.572465652078;7228.132624085143;7265.346118849117;6643.933560664332;6665.700043497957;6668.466522678077;6733.091032710521;6739.427148692416;5086.3896332440345;5122.180451127951;5160;5275.657082289639;5314.468553144809;5027.170516864677;5160.767765450489;5209.952177975926;5249.842504724865;5335.932813437251 04:50:40 INFO - PROCESS | 1645 | |4;prototype.html;367.68746565419394;372.57526419881333;376.62902041489144;379.5691889705184;380.4806439210478;4429.468463784347;5100.081985242659;5253.343332083489;5307.566956921629;5308.336457942757;5072.3405957225605;5222.556082732972;5231.2153177023465;5239.345081864767;5281.445448227938;4074.6349972759162;4145.378193271018;4160.0015996160855;4181.728187667807;4190.988325603712;3635.94546081809;3641.3445579795757;3867.8066096695193;3974.264761019206;4165.479315085614;3620.529331186942;4123.958760412403;4141.047559061418;4164.916701665965;4174.77038762868;3085.3520760640295;3631.7276204284653;3996.260691772017;4080.18396320737;4122.381642753581;3222.0333899829957;3336.4995250712345;3544.6455354464606;3569.39320315547;3572.178398968226;4588.944542755185;4856.465788763233;5264.420673797846;5274.734063824692;5290.603204759658;3985.0834308109297;4536.818527258905;4709.882252943669;4774.307725379836;4835.274708793674;4588.793504292282;5738.6556806591325;5775.768969241225;5783.5951483396175;5804.604306480714;3981.024648960994;3982.6216509431847;3982.960170398288;3990.4213888985932;4006.6193711597352;5035.615205818429;5748.511376533;6072.512234502531;6079.756809727605;6096.542759293026;3606.9819650901577;4258.253426539864;4350.499692535335;4375.431193944767;4380.6057454829215;3733.8506459741848;4437.112577484516;4456.9108617828115;4459.264221403432;4487.125010622897;4663.766811659471;4971.477994810565;4972.8508144755715;5024.346834911438;5039.974800125976;5492.121260598365;5733.158783614988;5822.496326579611;5828.591998560145;5853.239078919713;1411.9011669183058;1430.5350761002508;1431.0555033677722;1432.2265976372641;1441.7188648213707;809.2312303311877;822.6174828704561;918.5958178401615;986.31451141456;1017.811704834608;4319.855238361836;4968.279599458058;5098.2352647103235;5169.06956747789;5227.424983251839;4738.64460165489;4847.830325938575;5342.091844386464;5352.8661783454945;5361.35663720356;4325.589069038437;5042.520960508746;5155.427594583688;5168.586513078944;5272.841814745564;2458.9508209835703;2783.7216278372002;2882.4290761535012;3020.788544801887;3028.8485575721124;5500.4048825840055;5871.677057761779;5888.234529511136;5922.808560832434;5937.554683398763;5001.149804533238;5485.369182543979;5502.697351645618;5783.298688839062;5827.679477628772;4624.352590637313;5020.422651395063;5265.578753699771;5418.647787893774;5606.971965140148;5324.440933701905;5689.231953686365;5969.641821490724;5972.611780234271;5991.730372133177;5502.752376143003;5660.264225611077;5691.914621280601;5883.499902508163;5914.763409463573;6150.446459818638;6157.582541689227;6198;6209.782657606962;6242.687865606792;3755.75587586806;3991.8203680833853;4038.2529232092156;4054.351303791379;4061.7969101545395;5350.9732451337495;5358.276632654698;5529.723513824212;5721.5136713379825;5937.495312898452;5086.542211200862;5721.685307307972;5832.212651292021;5832.24180856486;5841.415858414124;4948.455669876383;5023.648344615988;5071.239314102914;5430.239766432782;5816.47651711348;5239.633225674319;5291.677080729817;5635.971820140873;5680.403557626555;5690.37405885344;5221.582273418041;5366.973165134305;5658.982122692934;5825.737841797045;5862.208601838697;3974.682025438016;5184.585233181261;5556.833295001156;5623.803166889139;5703.572232082527 04:50:40 INFO - PROCESS | 1645 | |5;yui.html;737.9077615298088;763.4732034895918;785.242241237206;832.9042160151582;872.6334939325485;15280.465183718572;15782;16240.75638865415;16457.506274811745;16539.586510337234;14784.704305913876;15067.321970511326;15074.773878391832;15159.772603410958;15169.089854608732;892.0455113029061;906.8186362727448;907.8774365460645;908.4095338030268;911.7674992876807;657.1555551116816;722.8626560953428;830.5141492227054;889.0798024045115;899.2446345070173;938.5870217104487;944.6552008516876;944.6882528765525;948.2556193388192;949.6011675096441;939.1641439119189;942.627662073484;943.5235206220815;944.9149576538076;945.9830682016825;703.3494018033299;703.7572037647054;704.0108647350481;704.9471289653245;706.233736396011;13761.449542018307;14885.106893586311;15470.149141797197;15685.529434116996;15913.761293580606;14463.13221206731;14683.48607798722;14702.55892323232;14708;14719.55841324762;10919.181061420346;11663.533458661728;11892.940535297355;11907.821382679267;11931.642050738492;3452.2577645806023;3787.791671458069;3816.370298900678;3825.5600605930395;3853.7687738735767;105319.47340263326;107377.46311268394;107423;108141.45929270382;109596.4520177402;11017.614383496539;11059.391733454577;11178.832317515244;11682.76634467323;11807.055435565135;22951;23245.88377058104;23505.764942350357;23522.411939701644;23640.88179559091;8008.719694810654;8010.519368837889;8097.959510202529;8179.591020448954;8196.467229630054;4443.511213766483;4541.455025396974;4550.658700597469;4612.0545288215835;4757.238841785298;3404.0638824323014;3440.0539851541025;3447.3967055765143;3484.651534846546;3562.786232826039;696.5611664651237;698.4447364345358;703.9718411263594;704.475166001322;705.7917914215319;579.0185635348129;674.3223060823939;692.3595674001629;720.718919621348;735.8712225360648;8800.383973121949;9551.283653726;10021.498925053718;10193.246339276731;10733.570657173626;682.9112215412064;701.6211245927244;725.4160400877239;729.4529103172621;734.3831181807308;5133.639585509843;5196.58427325813;5204.843854684365;5224.608154388436;5236.476352364733;96976;97530;97578;97632;99786;72073;77395;77851.61074194706;89726.55136724406;91701;66371;67608.6619566899;73957;74717.62641186759;75852;8810.647574096964;11035.172362072715;11104.222704410613;11331.773364532499;11445.25605835618;45096.77451612852;50293.74265643388;53003;53544.92910141697;53723.73138134284;70823;71059;71708;71928.921066183;74311.2568874326;13333.20000799955;13381.264030478416;13617.931910340782;13624.65938351549;13838.861611383758;14854.257287135817;14992.175430350999;15119.773203401737;15365.385384584491;15372.615684607974;13712.725745485233;14131.858681413054;14162.575122746333;14417;14849.40602375936;13466.730665386442;14216.004879658325;14400.927995359956;14731.852681473049;14773.778393323893;13109.475620975054;13315.600531984055;14154.716905662035;14452.855471445571;14601.780973285197;9795.116335614332;10085.848712269468;10279.074883260542;10420.426876521864;10680.092192163753;8615.353848461516;8860.000693580867;11227.214095013598;11301.604443844426;11433.428328583705 04:50:40 INFO - PROCESS | 1645 | __end_tp_report 04:50:40 INFO - PROCESS | 1645 | __start_cc_report 04:50:40 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,373 04:50:40 INFO - PROCESS | 1645 | __end_cc_report 04:50:40 INFO - PROCESS | 1645 | __startTimestamp1491220240515__endTimestamp 04:50:40 INFO - PROCESS | 1645 | 04:50:40 INFO - PROCESS | 1645 | ------- Summary: start ------- 04:50:40 INFO - PROCESS | 1645 | Number of tests: 6 04:50:40 INFO - PROCESS | 1645 | 04:50:40 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5919.76 Median:6164.69 stddev:646.80 (10.5%) stddev-sans-first:620.82 04:50:40 INFO - PROCESS | 1645 | Values: 3521.5 3529.9 3554.7 3569.1 3571.2 5908.6 6067.4 6076.7 6080.0 6085.1 5990.4 6062.4 6063.8 6073.8 6089.8 5328.4 5398.3 5411.1 5411.7 5481.3 5460.9 5464.3 5492.4 5494.4 5537.3 4395.5 5355.4 5457.6 5464.8 5489.0 5419.5 5448.0 5457.5 5469.9 5473.0 5259.7 5378.8 5401.9 5410.6 5429.8 5997.7 6016.8 6082.1 6129.0 6148.9 6086.8 6258.9 6275.9 6290.7 6296.6 6380.1 6397.0 6406.8 6417.5 6442.7 6033.1 6121.2 6124.5 6133.8 6135.8 6564.1 6567.2 6569.6 6571.9 6593.4 6252.7 6279.5 6285.6 6295.2 6309.7 6226.6 6249.8 6250.2 6261.2 6412.9 5486.3 6226.1 6262.4 6316.3 6334.4 5426.3 6268.3 6296.2 6304.3 6322.6 5098.4 5111.1 5130.0 5173.9 5191.7 3996.3 4615.0 4617.8 4635.9 4680.9 5074.7 6131.2 6170.9 6171.6 6181.5 6242.9 6437.0 6438.8 6448.6 6455.9 6016.9 6077.4 6077.9 6101.3 6170.8 5650.4 5659.0 5663.2 5668.8 5715.2 5621.5 6323.7 6414.9 6525.5 6534.1 6433.8 6458.6 6464.6 6487.6 6518.9 5851.1 6391.9 6610.4 6649.5 6727.2 6168.0 6213.1 6251.3 6348.0 6361.7 6315.7 6397.2 6437.2 6439.0 6442.3 6250.8 6265.2 6268.6 6270.2 6276.3 6009.1 6164.7 6211.1 6248.1 6280.4 5235.8 6102.8 6164.3 6209.1 6234.3 6252.2 6256.0 6258.8 6278.2 6290.6 6120.7 6150.6 6178.6 6217.3 6230.6 04:50:40 INFO - PROCESS | 1645 | 04:50:40 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:69519.00 Median:18610.38 stddev:147850.02 (794.4%) stddev-sans-first:148173.93 04:50:40 INFO - PROCESS | 1645 | Values: 483.6 504.2 515.1 520.1 559.0 42066.0 44247.6 44380.9 44487.7 47097.8 46997.3 47408.8 47562.5 47615.0 47626.8 9758.4 10007.7 10016.7 10053.7 11707.5 10030.4 11943.6 12035.6 12043.9 12087.5 10303.4 11684.3 12058.0 12060.2 12073.0 11944.6 11977.3 11997.9 12020.9 12040.6 11899.4 11960.9 11972.2 11986.0 12015.2 35980.0 37131.6 39970.0 40334.2 40369.6 4069.5 4085.9 4104.4 4154.5 4158.6 28854.2 29497.0 29548.4 29717.6 31166.0 3274.8 3366.9 3513.2 3560.3 3560.6 376020.0 442593.0 447509.0 448923.8 449078.8 61402.4 61709.0 61771.7 61859.0 61934.0 65362.0 65689.0 65771.0 65793.0 65854.0 17099.3 17100.2 17349.8 17373.0 17377.0 12238.8 12558.0 13925.4 14060.9 14153.1 19741.4 21419.7 22715.9 22792.4 22806.0 8142.9 9104.8 9153.9 9342.5 9396.5 842.5 874.8 894.6 915.2 932.5 32485.5 32702.3 32708.7 32783.8 33487.5 1051.5 1087.0 1091.4 1097.9 1140.1 15792.0 16218.6 16767.4 16990.2 17093.7 581821.0 590348.0 591102.0 594634.0 603260.0 55939.2 57066.0 57631.4 57686.0 57780.8 1430.8 1452.2 1470.4 1481.7 1490.3 29924.4 31332.0 31505.0 31718.4 32003.0 51941.0 56603.7 58111.4 58132.8 61215.4 611560.9 620066.0 620596.0 620950.0 622479.0 36724.4 37337.8 41860.8 42744.6 43930.0 45979.8 47006.8 47489.3 47516.0 48588.3 29852.6 31729.0 32054.0 32657.0 33272.8 32331.4 32894.7 32948.3 33203.0 33853.8 31598.4 36846.3 37727.2 38575.8 38595.6 26702.7 27030.5 31711.7 31925.7 32802.0 24053.5 25539.9 25609.0 25664.0 26083.9 04:50:40 INFO - PROCESS | 1645 | 04:50:40 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:41605.84 Median:22438.16 stddev:124286.29 (553.9%) stddev-sans-first:124596.44 04:50:40 INFO - PROCESS | 1645 | Values: 403.0 408.6 409.3 413.6 432.4 20653.0 20890.4 21844.5 22064.7 22071.8 18855.0 22040.6 22326.3 22550.0 22814.4 5847.1 6147.0 6195.4 6207.2 6208.0 5921.9 6011.8 6022.1 6074.7 6075.7 6027.2 6030.4 6031.4 6033.8 6046.3 5857.0 6009.5 6039.8 6083.1 6099.8 4521.5 5144.9 5319.0 5369.4 5378.3 26128.1 26692.0 26693.7 27007.7 27076.7 2611.1 3146.7 3186.9 3226.8 3230.2 15575.3 16138.8 16227.3 16388.8 16988.7 1596.4 1950.7 1964.2 2087.3 2108.7 141442.0 144417.0 146619.3 147542.0 148883.0 12262.7 12362.5 12464.4 12563.3 12655.5 16280.3 16435.5 16443.8 16471.0 16486.3 8826.6 8999.2 9052.2 9225.0 9229.1 8811.2 8812.9 8867.5 8960.3 9008.9 4908.9 4982.9 4996.7 5005.5 5022.2 1830.6 2098.1 2111.4 2123.9 2133.2 987.8 987.9 993.4 1000.7 1001.3 20741.4 21380.5 21439.4 23688.8 23916.2 1068.9 1072.1 1091.2 1099.7 1112.5 9037.9 11220.4 11472.0 11562.6 11570.2 732644.0 738047.0 738561.0 746894.0 768781.0 122423.8 146285.3 153322.5 158370.2 161388.0 1116.2 1137.4 1141.8 1145.9 1146.2 15889.4 18187.0 19611.7 19653.9 19700.0 63737.7 63740.0 64192.7 65445.3 65495.7 84268.0 86519.3 87340.6 94573.5 94627.5 7502.8 8345.0 8580.6 9010.7 9034.5 11629.5 12424.8 12735.7 13433.8 13881.0 11436.3 11733.4 11734.8 11856.1 11981.5 10662.8 10914.2 10988.8 11106.0 11241.6 11676.7 11700.2 11851.7 12017.7 12043.6 7859.4 7860.2 7917.8 7955.9 8049.9 8604.4 11000.9 11470.3 11788.1 11948.0 04:50:40 INFO - PROCESS | 1645 | 04:50:40 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5570.79 Median:5379.83 stddev:3047.16 (56.6%) stddev-sans-first:3039.38 04:50:40 INFO - PROCESS | 1645 | Values: 1374.0 1448.9 1507.5 1511.9 1517.8 7331.5 7797.7 8072.8 8493.2 8792.5 7233.3 8270.3 8546.7 8670.2 8672.7 2026.5 2363.9 2390.2 2391.5 2398.1 2098.2 2273.5 2395.5 2419.4 2424.4 2171.3 2346.5 2388.2 2397.2 2432.6 2039.0 2269.4 2324.6 2328.1 2342.1 2366.2 2370.4 2386.6 2388.9 2397.0 8692.4 8778.5 8779.6 8781.4 8786.7 5246.4 5388.0 5415.3 5422.2 5452.6 3430.2 3504.7 3616.8 3693.6 3695.1 1181.6 1185.8 1199.8 1299.2 1303.3 11226.3 11270.4 11306.0 11306.2 11316.8 3959.9 4571.9 4757.5 4774.7 4868.2 8032.5 9831.2 9836.4 9864.4 9876.6 5342.5 5373.9 5385.8 5388.8 5454.5 4433.0 4449.5 4898.7 4961.8 4975.2 4002.5 4023.9 4125.7 4129.0 4129.1 1290.6 1297.0 1301.4 1307.9 1308.1 785.9 912.4 926.6 933.5 934.1 5693.2 5765.7 5924.9 5954.2 6052.7 580.7 590.7 597.8 604.6 605.5 3818.6 3881.9 3925.6 4003.6 4012.1 9612.9 10286.6 10321.7 10356.6 10389.3 9969.7 10203.1 10284.6 10293.6 10318.1 8082.5 8128.8 8131.3 8150.4 8156.8 5611.9 5691.0 5783.3 5803.6 5853.5 7949.2 9233.9 9409.8 9465.4 9526.0 9191.4 9562.6 9572.6 9625.2 9772.0 6869.3 7058.8 7250.8 7447.4 7597.4 8051.4 8208.6 8352.7 8355.3 8361.5 7132.6 7165.8 7194.6 7319.5 7340.0 7070.9 7109.7 7125.6 7228.1 7265.3 6643.9 6665.7 6668.5 6733.1 6739.4 5086.4 5122.2 5160.0 5275.7 5314.5 5027.2 5160.8 5210.0 5249.8 5335.9 04:50:40 INFO - PROCESS | 1645 | 04:50:40 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4593.80 Median:5092.39 stddev:1388.47 (27.3%) stddev-sans-first:1355.64 04:50:40 INFO - PROCESS | 1645 | Values: 367.7 372.6 376.6 379.6 380.5 4429.5 5100.1 5253.3 5307.6 5308.3 5072.3 5222.6 5231.2 5239.3 5281.4 4074.6 4145.4 4160.0 4181.7 4191.0 3635.9 3641.3 3867.8 3974.3 4165.5 3620.5 4124.0 4141.0 4164.9 4174.8 3085.4 3631.7 3996.3 4080.2 4122.4 3222.0 3336.5 3544.6 3569.4 3572.2 4588.9 4856.5 5264.4 5274.7 5290.6 3985.1 4536.8 4709.9 4774.3 4835.3 4588.8 5738.7 5775.8 5783.6 5804.6 3981.0 3982.6 3983.0 3990.4 4006.6 5035.6 5748.5 6072.5 6079.8 6096.5 3607.0 4258.3 4350.5 4375.4 4380.6 3733.9 4437.1 4456.9 4459.3 4487.1 4663.8 4971.5 4972.9 5024.3 5040.0 5492.1 5733.2 5822.5 5828.6 5853.2 1411.9 1430.5 1431.1 1432.2 1441.7 809.2 822.6 918.6 986.3 1017.8 4319.9 4968.3 5098.2 5169.1 5227.4 4738.6 4847.8 5342.1 5352.9 5361.4 4325.6 5042.5 5155.4 5168.6 5272.8 2459.0 2783.7 2882.4 3020.8 3028.8 5500.4 5871.7 5888.2 5922.8 5937.6 5001.1 5485.4 5502.7 5783.3 5827.7 4624.4 5020.4 5265.6 5418.6 5607.0 5324.4 5689.2 5969.6 5972.6 5991.7 5502.8 5660.3 5691.9 5883.5 5914.8 6150.4 6157.6 6198.0 6209.8 6242.7 3755.8 3991.8 4038.3 4054.4 4061.8 5351.0 5358.3 5529.7 5721.5 5937.5 5086.5 5721.7 5832.2 5832.2 5841.4 4948.5 5023.6 5071.2 5430.2 5816.5 5239.6 5291.7 5636.0 5680.4 5690.4 5221.6 5367.0 5659.0 5825.7 5862.2 3974.7 5184.6 5556.8 5623.8 5703.6 04:50:40 INFO - PROCESS | 1645 | 04:50:40 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:20387.45 Median:24819.11 stddev:28573.20 (115.1%) stddev-sans-first:28615.26 04:50:40 INFO - PROCESS | 1645 | Values: 737.9 763.5 785.2 832.9 872.6 15280.5 15782.0 16240.8 16457.5 16539.6 14784.7 15067.3 15074.8 15159.8 15169.1 892.0 906.8 907.9 908.4 911.8 657.2 722.9 830.5 889.1 899.2 938.6 944.7 944.7 948.3 949.6 939.2 942.6 943.5 944.9 946.0 703.3 703.8 704.0 704.9 706.2 13761.4 14885.1 15470.1 15685.5 15913.8 14463.1 14683.5 14702.6 14708.0 14719.6 10919.2 11663.5 11892.9 11907.8 11931.6 3452.3 3787.8 3816.4 3825.6 3853.8 105319.5 107377.5 107423.0 108141.5 109596.5 11017.6 11059.4 11178.8 11682.8 11807.1 22951.0 23245.9 23505.8 23522.4 23640.9 8008.7 8010.5 8098.0 8179.6 8196.5 4443.5 4541.5 4550.7 4612.1 4757.2 3404.1 3440.1 3447.4 3484.7 3562.8 696.6 698.4 704.0 704.5 705.8 579.0 674.3 692.4 720.7 735.9 8800.4 9551.3 10021.5 10193.2 10733.6 682.9 701.6 725.4 729.5 734.4 5133.6 5196.6 5204.8 5224.6 5236.5 96976.0 97530.0 97578.0 97632.0 99786.0 72073.0 77395.0 77851.6 89726.6 91701.0 66371.0 67608.7 73957.0 74717.6 75852.0 8810.6 11035.2 11104.2 11331.8 11445.3 45096.8 50293.7 53003.0 53544.9 53723.7 70823.0 71059.0 71708.0 71928.9 74311.3 13333.2 13381.3 13617.9 13624.7 13838.9 14854.3 14992.2 15119.8 15365.4 15372.6 13712.7 14131.9 14162.6 14417.0 14849.4 13466.7 14216.0 14400.9 14731.9 14773.8 13109.5 13315.6 14154.7 14452.9 14601.8 9795.1 10085.8 10279.1 10420.4 10680.1 8615.4 8860.0 11227.2 11301.6 11433.4 04:50:40 INFO - PROCESS | 1645 | -------- Summary: end -------- 04:50:40 INFO - PROCESS | 1645 | 04:50:41 INFO - TEST-INFO | 1645: exit 0 04:50:41 INFO - TEST-OK | dromaeo_css | took 1113983ms 04:50:41 INFO - TEST-START | kraken 04:50:41 INFO - operating with platform_type : mac_ 04:50:41 INFO - Initialising browser for kraken test... 04:50:41 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpz0kCja/profile http://localhost:49247/getInfo.html) 04:50:43 INFO - PROCESS | 1652 | 2017-04-03 04:50:43.695 plugin-container[1654:10537] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 04:50:43 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:43 INFO - PROCESS | 1652 | 2017-04-03 04:50:43.696 plugin-container[1654:10537] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 04:50:43 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:43 INFO - PROCESS | 1652 | 2017-04-03 04:50:43.696 plugin-container[1654:10537] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:50:43 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 04:50:43 INFO - PROCESS | 1652 | colorDepth:24 04:50:43 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 04:50:43 INFO - PROCESS | 1652 | __metrics 04:50:43 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 04:50:44 INFO - TEST-INFO | 1652: exit 0 04:50:44 INFO - Browser initialized. 04:50:44 INFO - Running cycle 1/1 for kraken test... 04:50:44 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpz0kCja/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:46 INFO - PROCESS | 1655 | 2017-04-03 04:50:46.793 plugin-container[1656:10662] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8443, name = 'com.apple.tsm.portname' 04:50:46 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:46 INFO - PROCESS | 1655 | 2017-04-03 04:50:46.793 plugin-container[1656:10662] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4427, name = 'com.apple.CFPasteboardClient' 04:50:46 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:46 INFO - PROCESS | 1655 | 2017-04-03 04:50:46.793 plugin-container[1656:10662] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:50:56 INFO - PROCESS | 1655 | RSS: Main: 173408256 04:50:56 INFO - PROCESS | 1655 | 04:50:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:00 INFO - PROCESS | 1655 | RSS: Main: 187170816 04:51:00 INFO - PROCESS | 1655 | 04:51:03 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 04:51:04 INFO - PROCESS | 1655 | RSS: Main: 195821568 04:51:04 INFO - PROCESS | 1655 | 04:51:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 04:51:08 INFO - PROCESS | 1655 | RSS: Main: 198103040 04:51:08 INFO - PROCESS | 1655 | 04:51:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 04:51:10 INFO - PROCESS | 1655 | RSS: Main: 199933952 04:51:10 INFO - PROCESS | 1655 | 04:51:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:13 INFO - PROCESS | 1655 | RSS: Main: 199393280 04:51:13 INFO - PROCESS | 1655 | 04:51:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 04:51:17 INFO - PROCESS | 1655 | RSS: Main: 203710464 04:51:17 INFO - PROCESS | 1655 | 04:51:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:20 INFO - PROCESS | 1655 | RSS: Main: 203198464 04:51:20 INFO - PROCESS | 1655 | 04:51:23 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 04:51:24 INFO - PROCESS | 1655 | RSS: Main: 203165696 04:51:24 INFO - PROCESS | 1655 | 04:51:26 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:26 INFO - PROCESS | 1655 | RSS: Main: 202031104 04:51:26 INFO - PROCESS | 1655 | 04:51:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:29 INFO - PROCESS | 1655 | RSS: Main: 202022912 04:51:29 INFO - PROCESS | 1655 | 04:51:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:31 INFO - PROCESS | 1655 | RSS: Main: 202571776 04:51:31 INFO - PROCESS | 1655 | 04:51:34 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:35 INFO - PROCESS | 1655 | RSS: Main: 202895360 04:51:35 INFO - PROCESS | 1655 | 04:51:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:38 INFO - PROCESS | 1655 | RSS: Main: 201814016 04:51:38 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 04:51:40 INFO - PROCESS | 1655 | RSS: Main: 203718656 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | __start_tp_report 04:51:40 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 04:51:40 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 04:51:40 INFO - PROCESS | 1655 | |i|pagename|runs| 04:51:40 INFO - PROCESS | 1655 | |0;ai-astar;154;176;98;171;124;178;94;96;152;173 04:51:40 INFO - PROCESS | 1655 | |1;audio-beat-detection;140;124;94;165;139;145;111;109;164;143 04:51:40 INFO - PROCESS | 1655 | |2;audio-dft;197;193;197;197;199;197;194;236;275;247 04:51:40 INFO - PROCESS | 1655 | |3;audio-fft;81;70;76;102;85;82;83;61;71;60 04:51:40 INFO - PROCESS | 1655 | |4;audio-oscillator;100;94;71;99;54;68;103;101;102;113 04:51:40 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;89;87;89;99;136;132;91;87;88;101 04:51:40 INFO - PROCESS | 1655 | |6;imaging-darkroom;99;95;94;104;145;94;108;152;112;144 04:51:40 INFO - PROCESS | 1655 | |7;imaging-desaturate;93;91;91;94;147;90;146;145;96;91 04:51:40 INFO - PROCESS | 1655 | |8;json-parse-financial;59;57;57;59;62;61;61;60;62;63 04:51:40 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;74;67;67;74;73;68;67;69;68;70 04:51:40 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;85;95;109;85;80;81;85;84;88;108 04:51:40 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;139;147;138;161;154;136;138;139;183;143 04:51:40 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;165;164;163;161;164;163;161;166;165;164 04:51:40 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;66;63;65;67;65;65;65;67;64;64 04:51:40 INFO - PROCESS | 1655 | __end_tp_report 04:51:40 INFO - PROCESS | 1655 | __start_cc_report 04:51:40 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,939 04:51:40 INFO - PROCESS | 1655 | __end_cc_report 04:51:40 INFO - PROCESS | 1655 | __startTimestamp1491220300898__endTimestamp 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | ------- Summary: start ------- 04:51:40 INFO - PROCESS | 1655 | Number of tests: 14 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:141.60 Median:177.00 stddev:35.24 (19.9%) stddev-sans-first:37.09 04:51:40 INFO - PROCESS | 1655 | Values: 154.0 176.0 98.0 171.0 124.0 178.0 94.0 96.0 152.0 173.0 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:144.00 stddev:23.51 (16.3%) stddev-sans-first:24.81 04:51:40 INFO - PROCESS | 1655 | Values: 140.0 124.0 94.0 165.0 139.0 145.0 111.0 109.0 164.0 143.0 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:213.20 Median:198.00 stddev:28.89 (14.6%) stddev-sans-first:30.04 04:51:40 INFO - PROCESS | 1655 | Values: 197.0 193.0 197.0 197.0 199.0 197.0 194.0 236.0 275.0 247.0 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:77.10 Median:78.50 stddev:12.46 (15.9%) stddev-sans-first:13.13 04:51:40 INFO - PROCESS | 1655 | Values: 81.0 70.0 76.0 102.0 85.0 82.0 83.0 61.0 71.0 60.0 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:61.00 stddev:19.14 (31.4%) stddev-sans-first:19.99 04:51:40 INFO - PROCESS | 1655 | Values: 100.0 94.0 71.0 99.0 54.0 68.0 103.0 101.0 102.0 113.0 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:99.90 Median:88.50 stddev:18.64 (21.1%) stddev-sans-first:19.35 04:51:40 INFO - PROCESS | 1655 | Values: 89.0 87.0 89.0 99.0 136.0 132.0 91.0 87.0 88.0 101.0 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:114.70 Median:123.00 stddev:23.16 (18.8%) stddev-sans-first:23.85 04:51:40 INFO - PROCESS | 1655 | Values: 99.0 95.0 94.0 104.0 145.0 94.0 108.0 152.0 112.0 144.0 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:108.40 Median:91.00 stddev:26.01 (28.6%) stddev-sans-first:26.98 04:51:40 INFO - PROCESS | 1655 | Values: 93.0 91.0 91.0 94.0 147.0 90.0 146.0 145.0 96.0 91.0 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:61.00 stddev:2.08 (3.4%) stddev-sans-first:2.17 04:51:40 INFO - PROCESS | 1655 | Values: 59.0 57.0 57.0 59.0 62.0 61.0 61.0 60.0 62.0 63.0 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.50 stddev:2.91 (4.2%) stddev-sans-first:2.64 04:51:40 INFO - PROCESS | 1655 | Values: 74.0 67.0 67.0 74.0 73.0 68.0 67.0 69.0 68.0 70.0 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:85.00 stddev:10.57 (12.4%) stddev-sans-first:11.06 04:51:40 INFO - PROCESS | 1655 | Values: 85.0 95.0 109.0 85.0 80.0 81.0 85.0 84.0 88.0 108.0 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:145.00 stddev:14.76 (10.2%) stddev-sans-first:15.31 04:51:40 INFO - PROCESS | 1655 | Values: 139.0 147.0 138.0 161.0 154.0 136.0 138.0 139.0 183.0 143.0 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:164.00 stddev:1.65 (1.0%) stddev-sans-first:1.67 04:51:40 INFO - PROCESS | 1655 | Values: 165.0 164.0 163.0 161.0 164.0 163.0 161.0 166.0 165.0 164.0 04:51:40 INFO - PROCESS | 1655 | 04:51:40 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.29 (2.0%) stddev-sans-first:1.32 04:51:40 INFO - PROCESS | 1655 | Values: 66.0 63.0 65.0 67.0 65.0 65.0 65.0 67.0 64.0 64.0 04:51:40 INFO - PROCESS | 1655 | -------- Summary: end -------- 04:51:40 INFO - PROCESS | 1655 | 04:51:41 INFO - TEST-INFO | 1655: exit 0 04:51:41 INFO - TEST-OK | kraken | took 60799ms 04:51:41 INFO - SUITE-END | took 1174s 04:51:42 INFO - Completed test suite (00:19:34) 04:51:42 INFO - javascript benchmark 04:51:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7554.188247992851, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3521.5245941797857, 3529.8941031769054, 3554.697850682691, 3569.1255642367623, 3571.2143328467746, 5908.586398952069, 6067.423594758502, 6076.726547305371, 6079.969600151999, 6085.148079268901, 5990.371011043843, 6062.393760623935, 6063.757449702007, 6073.817785466443, 6089.847753806157, 5328.360596728398, 5398.2982212312545, 5411.107167317407, 5411.702356370398, 5481.342238931334, 5460.945390546103, 5464.289642346489, 5492.395836458007, 5494.395616482184, 5537.280153580029, 4395.516493185747, 5355.384130824947, 5457.590680698943, 5464.836054918339, 5489.039418101836, 5419.458054194569, 5447.972760136174, 5457.481539253804, 5469.890602187974, 5473.042217611922, 5259.737013149365, 5378.811741589065, 5401.891962160735, 5410.594205434608, 5429.809956651498, 5997.7001149942325, 6016.789412370546, 6082.118092876508, 6128.988716861712, 6148.893199224138, 6086.786962456293, 6258.937410625881, 6275.874482510324, 6290.716917738667, 6296.622202667854, 6380.138681278015, 6396.968015159941, 6406.775762848324, 6417.518686098561, 6442.742290308382, 6033.125196846433, 6121.239585875146, 6124.5100391968535, 6133.815985520441, 6135.846603834851, 6564.113844631009, 6567.211934567882, 6569.638669873203, 6571.868562628721, 6593.3736295051895, 6252.718627661766, 6279.4662453691035, 6285.622862628165, 6295.18162638854, 6309.716062777186, 6226.62640241587, 6249.843753906098, 6250.218722659668, 6261.186045814015, 6412.903806442907, 5486.259354987105, 6226.128342032119, 6262.436380725757, 6316.336784637639, 6334.429901308904, 5426.321709786277, 6268.310485846553, 6296.212973378328, 6304.338044505353, 6322.557420980579, 5098.439171691111, 5111.131107711698, 5130.0, 5173.896522069537, 5191.6884986900905, 3996.260691771973, 4614.976925115353, 4617.7691115444095, 4635.907281854344, 4680.859574212779, 5074.746262686851, 6131.172291740558, 6170.907436388457, 6171.56799024073, 6181.536384771161, 6242.937570624326, 6436.967815160894, 6438.774642887476, 6448.613083215022, 6455.935440645628, 6016.8796624068145, 6077.361877002851, 6077.908831367533, 6101.298350689727, 6170.82754276695, 5650.406707295757, 5659.0, 5663.235463212496, 5668.829935101953, 5715.228444160069, 5621.4659607337235, 6323.715432805535, 6414.935850641434, 6525.477961763143, 6534.117894084237, 6433.774817881352, 6458.644774537445, 6464.612123272619, 6487.578307410004, 6518.934810651833, 5851.1223316502865, 6391.872162556816, 6610.3720146586, 6649.534532582867, 6727.192736871607, 6167.969160154171, 6213.068039794067, 6251.343608920998, 6347.96826015867, 6361.745530178926, 6315.747370105144, 6397.232332120176, 6437.195350581177, 6438.967805161132, 6442.291347951628, 6250.781222657185, 6265.185525881606, 6268.623882567061, 6270.153529273673, 6276.340984196594, 6009.128676341993, 6164.691765411621, 6211.068339749074, 6248.094026366242, 6280.434760871361, 5235.816746413857, 6102.755889764359, 6164.260288765377, 6209.130721698875, 6234.2830574482705, 6252.155958945484, 6255.96872015637, 6258.843528911813, 6278.246610406781, 6290.622562646073, 6120.690942950841, 6150.630962142286, 6178.644722947267, 6217.285012223652, 6230.626162430269], "value": 5880.958462695845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.5551292810614, 504.2310476523304, 515.078010361453, 520.0612893726824, 559.0496156533893, 42066.0, 44247.557524424745, 44380.89047773803, 44487.66537003895, 47097.764511177484, 46997.29504057442, 47408.76295618517, 47562.52437475624, 47615.0, 47626.76186619062, 9758.414495130315, 10007.699769006942, 10016.699499015042, 10053.69838904834, 11707.473163707653, 10030.39817610942, 11943.58197463089, 12035.638930832089, 12043.879561204407, 12087.456064477075, 10303.381797092161, 11684.298942063504, 12058.0, 12060.155789094766, 12073.03415726744, 11944.581939632071, 11977.341246231454, 11997.880021199764, 12020.939895300555, 12040.578579749666, 11899.405029748565, 11960.940195299056, 11972.221805582609, 11986.0, 12015.158938874194, 35980.0, 37131.62868371336, 39970.0, 40334.19331613351, 40369.59630403688, 4069.491313585802, 4085.9182816343505, 4104.445899803518, 4154.480689913761, 4158.584141585848, 28854.197231851176, 29496.967606133683, 29548.409031819243, 29717.55423668647, 31166.0, 3274.754393420503, 3366.932661346784, 3513.1919658478437, 3560.3413368526644, 3560.608333083359, 376020.0, 442593.0, 447509.0, 448923.75538122427, 449078.75460622815, 61402.38597613967, 61709.0, 61771.691141544004, 61859.0, 61934.0, 65362.0, 65689.0, 65771.0, 65793.0, 65854.0, 17099.316027359015, 17100.230489627997, 17349.82650173482, 17373.0, 17377.04426256568, 12238.81641775374, 12558.0, 13925.442982280596, 14060.929695351459, 14153.08004979673, 19741.40775776729, 21419.678704819442, 22715.886420567793, 22792.43018924507, 22806.0, 8142.90070840429, 9104.81790364189, 9153.908460915305, 9342.48616326095, 9396.530173491297, 842.4776638484057, 874.8294082653821, 894.6019021535484, 915.158054589779, 932.4684929590204, 32485.51271730926, 32702.345953080807, 32708.672913270562, 32783.83608081944, 33487.497687534706, 1051.5163025008428, 1086.9728256793485, 1091.3560999010622, 1097.8737445193744, 1140.0993215359772, 15792.0, 16218.594535136715, 16767.413140540022, 16990.235439405256, 17093.743593846102, 581821.0, 590348.0, 591102.0, 594634.0, 603260.0, 55939.16091258635, 57066.0, 57631.423685763446, 57686.0, 57780.844383112104, 1430.8139941807706, 1452.2048780972618, 1470.4485817818318, 1481.6962522682825, 1490.3219035338896, 29924.401511970074, 31332.0, 31505.0, 31718.365632687677, 32003.039908802773, 51941.0, 56603.71698141647, 58111.418885812294, 58132.83734325374, 61215.38784612275, 611560.9421952862, 620066.0, 620596.0, 620950.0, 622479.0, 36724.44913326356, 37337.81331093436, 41860.79069604632, 42744.57255427406, 43930.0, 45979.78141530194, 47006.76496617632, 47489.28766068443, 47516.0, 48588.2711759331, 29852.552211717277, 31729.0, 32054.0, 32657.020289391356, 33272.83363583167, 32331.428969206307, 32894.67105329012, 32948.341033179684, 33203.00390988274, 33853.83073084619, 31598.36803263968, 36846.26307473782, 37727.245455091295, 38575.842724718306, 38595.614043860325, 26702.722659894804, 27030.459390812466, 31711.682883170874, 31925.6807431932, 32802.0, 24053.51892962166, 25539.872300638377, 25609.0, 25664.0, 26083.869580651975], "value": 21104.138072483027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.96776257899353, 408.5893676854761, 409.2633260131763, 413.6380666916449, 432.37090034000533, 20652.967351632415, 20890.373288801322, 21844.45388865279, 22064.669029964523, 22071.77928220717, 18855.0, 22040.559188816213, 22326.33021009368, 22549.985250663718, 22814.429639259026, 5847.093700476422, 6147.047207682816, 6195.442410183083, 6207.193064901557, 6208.037754148092, 5921.88156236875, 6011.819645410623, 6022.095314097595, 6074.696265186745, 6075.696215189245, 6027.246594175728, 6030.366811484797, 6031.366706495799, 6033.7888173913925, 6046.3349031606485, 5857.0, 6009.549283803733, 6039.849003774919, 6083.117947897575, 6099.84750381244, 4521.457425109008, 5144.897102057976, 5319.042572336978, 5369.40936496985, 5378.300820893298, 26128.085517006813, 26692.0, 26693.733062669515, 27007.729922700913, 27076.729232707814, 2611.099170786095, 3146.7482601391835, 3186.8884589039503, 3226.822524761137, 3230.16015835882, 15575.299111540007, 16138.75791863123, 16227.269772860132, 16388.83611163885, 16988.660226795517, 1596.3853916242215, 1950.7268982342484, 1964.1554131723353, 2087.311187308185, 2108.652072408051, 141442.0, 144417.0, 146619.26690366588, 147541.99999999892, 148883.0, 12262.693432664077, 12362.505499780087, 12464.43910024033, 12563.309018003914, 12655.493780248871, 16280.348786048426, 16435.506934791974, 16443.83556164447, 16471.01173929568, 16486.258118384703, 8826.646934122691, 8999.235065019415, 9052.185303322733, 9224.953875230714, 9229.123233292827, 8811.162939520735, 8812.911870881337, 8867.512286824287, 8960.327975401871, 9008.864867027, 4908.9263661045115, 4982.90034199314, 4996.6502344836235, 5005.474425185376, 5022.196448568212, 1830.6155707301616, 2098.0768461877033, 2111.429913923263, 2123.8831864247613, 2133.200049981257, 987.8073775613686, 987.9012098790207, 993.3989936088707, 1000.674780696262, 1001.3341128149845, 20741.377758667266, 21380.465488362915, 21439.356819295444, 23688.81555922197, 23916.162934297216, 1068.8984546468073, 1072.1101485766794, 1091.2415870969758, 1099.6700989703056, 1112.4548971004149, 9037.909620903707, 11220.382878941737, 11472.0, 11562.595309164139, 11570.19008669385, 732644.0, 738047.0, 738561.0, 746894.0, 768781.0, 122423.77576224302, 146285.26857365645, 153322.46677533304, 158370.2081489608, 161388.0, 1116.151724689242, 1137.3517095255625, 1141.8001849676273, 1145.9025982791388, 1146.1690274550883, 15889.443869464514, 18186.9997150158, 19611.70582441236, 19653.901730491256, 19700.01499924969, 63737.681311595, 63740.0, 64192.67903660452, 65445.345546543926, 65495.67252163708, 84268.0, 86519.26961460609, 87340.56329718311, 94573.52713236665, 94627.52686236525, 7502.812429689301, 8345.0, 8580.613872375883, 9010.729678109667, 9034.503102329434, 11629.47667354988, 12424.813627795409, 12735.745285094432, 13433.798493022809, 13881.0, 11436.313821170756, 11733.413329333329, 11734.765304694029, 11856.051515878537, 11981.520739170684, 10662.786744264917, 10914.23600347968, 10988.780224395627, 11106.0, 11241.60654377093, 11676.708082297671, 11700.180987331145, 11851.703707407383, 12017.699557511132, 12043.638690839289, 7859.449838511478, 7860.174681658572, 7917.7624671259955, 7955.880661789962, 8049.919500804917, 8604.440711353742, 11000.944995274973, 11470.311781293149, 11788.056955443373, 11948.044156467287], "value": 10422.18521476097, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.99313003435, 1448.869601735845, 1507.5402002389274, 1511.9092854428732, 1517.8330383657803, 7331.523450975683, 7797.6880924762945, 8072.757817265477, 8493.193146651074, 8792.51641159736, 7233.312835280653, 8270.297024752888, 8546.658133674646, 8670.176333248348, 8672.696455624055, 2026.5237669147812, 2363.869987150706, 2390.1992832401165, 2391.5097405031925, 2398.07674045492, 2098.213170061227, 2273.499830037389, 2395.461021270209, 2419.370963549481, 2424.442378253003, 2171.2834764527747, 2346.5189636124637, 2388.2118900762707, 2397.19693902542, 2432.62294344376, 2039.0, 2269.4439862233776, 2324.5583339165505, 2328.1153161798493, 2342.1334106380577, 2366.2073205476186, 2370.4192472844093, 2386.6181410974336, 2388.8566685998894, 2397.0172229385867, 8692.391532592721, 8778.517181555011, 8779.64881404743, 8781.38530302879, 8786.736397908073, 5246.449122842085, 5388.030154572176, 5415.323084614423, 5422.186671999192, 5452.563794896439, 3430.2281986553076, 3504.7196224301993, 3616.764910280823, 3693.556773187208, 3695.0762309422644, 1181.6395999220235, 1185.7628474305172, 1199.7840388730026, 1299.2009913902975, 1303.3092460995688, 11226.326420414802, 11270.380129092897, 11306.0, 11306.152038597056, 11316.830247546293, 3959.891230455477, 4571.862844114682, 4757.500462451393, 4774.7135171889795, 4868.2210846264425, 8032.4778889372, 9831.1643510301, 9836.409815410954, 9864.358816676893, 9876.60493580263, 5342.54588359986, 5373.892522149613, 5385.7576409061685, 5388.811391601275, 5454.509094181542, 4433.002574420794, 4449.532799056117, 4898.706077635282, 4961.776720047606, 4975.203967365276, 4002.4996875390575, 4023.879283621496, 4125.66994640428, 4129.0, 4129.070959034253, 1290.6321698315935, 1296.9805452918213, 1301.4273719563362, 1307.8888294494884, 1308.117021010814, 785.9017622797151, 912.4388501071793, 926.5552534783342, 933.5145724223365, 934.1032608695729, 5693.231413759089, 5765.654060756368, 5924.881502369928, 5954.225950626477, 6052.727627256784, 580.7125472890946, 590.6839840685212, 597.7549204826, 604.5828378418877, 605.4913872347162, 3818.579956204871, 3881.902952426212, 3925.646691797752, 4003.6396724294955, 4012.137390461065, 9612.855807162898, 10286.588536458608, 10321.690349289533, 10356.585736570603, 10389.272750907365, 9969.700908972742, 10203.132733717717, 10284.640037598649, 10293.588256469657, 10318.071373576415, 8082.474639148437, 8128.837423251502, 8131.268185863182, 8150.38872084596, 8156.755297341089, 5611.943880561143, 5690.971545142248, 5783.306003279633, 5803.622764520293, 5853.502452291603, 7949.244821741925, 9233.938097118917, 9409.811803764023, 9465.432074075577, 9525.999770024326, 9191.448513089235, 9562.56968436436, 9572.617095316387, 9625.229981601315, 9772.02279772017, 6869.347411995853, 7058.752943646948, 7250.818729531804, 7447.404207663266, 7597.430192735456, 8051.35589152878, 8208.58957052157, 8352.749417517483, 8355.289800367036, 8361.498310101413, 7132.572045677276, 7165.785026449006, 7194.604296763729, 7319.487635865651, 7340.0, 7070.929290707233, 7109.680064397218, 7125.572465652078, 7228.132624085143, 7265.346118849117, 6643.933560664332, 6665.700043497957, 6668.466522678077, 6733.091032710521, 6739.427148692416, 5086.3896332440345, 5122.180451127951, 5160.0, 5275.657082289639, 5314.468553144809, 5027.170516864677, 5160.767765450489, 5209.952177975926, 5249.842504724865, 5335.932813437251], "value": 4477.795213074426, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.68746565419394, 372.57526419881333, 376.62902041489144, 379.5691889705184, 380.4806439210478, 4429.468463784347, 5100.081985242659, 5253.343332083489, 5307.566956921629, 5308.336457942757, 5072.3405957225605, 5222.556082732972, 5231.2153177023465, 5239.345081864767, 5281.445448227938, 4074.6349972759162, 4145.378193271018, 4160.0015996160855, 4181.728187667807, 4190.988325603712, 3635.94546081809, 3641.3445579795757, 3867.8066096695193, 3974.264761019206, 4165.479315085614, 3620.529331186942, 4123.958760412403, 4141.047559061418, 4164.916701665965, 4174.77038762868, 3085.3520760640295, 3631.7276204284653, 3996.260691772017, 4080.18396320737, 4122.381642753581, 3222.0333899829957, 3336.4995250712345, 3544.6455354464606, 3569.39320315547, 3572.178398968226, 4588.944542755185, 4856.465788763233, 5264.420673797846, 5274.734063824692, 5290.603204759658, 3985.0834308109297, 4536.818527258905, 4709.882252943669, 4774.307725379836, 4835.274708793674, 4588.793504292282, 5738.6556806591325, 5775.768969241225, 5783.5951483396175, 5804.604306480714, 3981.024648960994, 3982.6216509431847, 3982.960170398288, 3990.4213888985932, 4006.6193711597352, 5035.615205818429, 5748.511376533, 6072.512234502531, 6079.756809727605, 6096.542759293026, 3606.9819650901577, 4258.253426539864, 4350.499692535335, 4375.431193944767, 4380.6057454829215, 3733.8506459741848, 4437.112577484516, 4456.9108617828115, 4459.264221403432, 4487.125010622897, 4663.766811659471, 4971.477994810565, 4972.8508144755715, 5024.346834911438, 5039.974800125976, 5492.121260598365, 5733.158783614988, 5822.496326579611, 5828.591998560145, 5853.239078919713, 1411.9011669183058, 1430.5350761002508, 1431.0555033677722, 1432.2265976372641, 1441.7188648213707, 809.2312303311877, 822.6174828704561, 918.5958178401615, 986.31451141456, 1017.811704834608, 4319.855238361836, 4968.279599458058, 5098.2352647103235, 5169.06956747789, 5227.424983251839, 4738.64460165489, 4847.830325938575, 5342.091844386464, 5352.8661783454945, 5361.35663720356, 4325.589069038437, 5042.520960508746, 5155.427594583688, 5168.586513078944, 5272.841814745564, 2458.9508209835703, 2783.7216278372002, 2882.4290761535012, 3020.788544801887, 3028.8485575721124, 5500.4048825840055, 5871.677057761779, 5888.234529511136, 5922.808560832434, 5937.554683398763, 5001.149804533238, 5485.369182543979, 5502.697351645618, 5783.298688839062, 5827.679477628772, 4624.352590637313, 5020.422651395063, 5265.578753699771, 5418.647787893774, 5606.971965140148, 5324.440933701905, 5689.231953686365, 5969.641821490724, 5972.611780234271, 5991.730372133177, 5502.752376143003, 5660.264225611077, 5691.914621280601, 5883.499902508163, 5914.763409463573, 6150.446459818638, 6157.582541689227, 6198.0, 6209.782657606962, 6242.687865606792, 3755.75587586806, 3991.8203680833853, 4038.2529232092156, 4054.351303791379, 4061.7969101545395, 5350.9732451337495, 5358.276632654698, 5529.723513824212, 5721.5136713379825, 5937.495312898452, 5086.542211200862, 5721.685307307972, 5832.212651292021, 5832.24180856486, 5841.415858414124, 4948.455669876383, 5023.648344615988, 5071.239314102914, 5430.239766432782, 5816.47651711348, 5239.633225674319, 5291.677080729817, 5635.971820140873, 5680.403557626555, 5690.37405885344, 5221.582273418041, 5366.973165134305, 5658.982122692934, 5825.737841797045, 5862.208601838697, 3974.682025438016, 5184.585233181261, 5556.833295001156, 5623.803166889139, 5703.572232082527], "value": 4173.422316688119, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.9077615298088, 763.4732034895918, 785.242241237206, 832.9042160151582, 872.6334939325485, 15280.465183718572, 15782.0, 16240.75638865415, 16457.506274811745, 16539.586510337234, 14784.704305913876, 15067.321970511326, 15074.773878391832, 15159.772603410958, 15169.089854608732, 892.0455113029061, 906.8186362727448, 907.8774365460645, 908.4095338030268, 911.7674992876807, 657.1555551116816, 722.8626560953428, 830.5141492227054, 889.0798024045115, 899.2446345070173, 938.5870217104487, 944.6552008516876, 944.6882528765525, 948.2556193388192, 949.6011675096441, 939.1641439119189, 942.627662073484, 943.5235206220815, 944.9149576538076, 945.9830682016825, 703.3494018033299, 703.7572037647054, 704.0108647350481, 704.9471289653245, 706.233736396011, 13761.449542018307, 14885.106893586311, 15470.149141797197, 15685.529434116996, 15913.761293580606, 14463.13221206731, 14683.48607798722, 14702.55892323232, 14708.0, 14719.55841324762, 10919.181061420346, 11663.533458661728, 11892.940535297355, 11907.821382679267, 11931.642050738492, 3452.2577645806023, 3787.791671458069, 3816.370298900678, 3825.5600605930395, 3853.7687738735767, 105319.47340263326, 107377.46311268394, 107423.0, 108141.45929270382, 109596.4520177402, 11017.614383496539, 11059.391733454577, 11178.832317515244, 11682.76634467323, 11807.055435565135, 22951.0, 23245.88377058104, 23505.764942350357, 23522.411939701644, 23640.88179559091, 8008.719694810654, 8010.519368837889, 8097.959510202529, 8179.591020448954, 8196.467229630054, 4443.511213766483, 4541.455025396974, 4550.658700597469, 4612.0545288215835, 4757.238841785298, 3404.0638824323014, 3440.0539851541025, 3447.3967055765143, 3484.651534846546, 3562.786232826039, 696.5611664651237, 698.4447364345358, 703.9718411263594, 704.475166001322, 705.7917914215319, 579.0185635348129, 674.3223060823939, 692.3595674001629, 720.718919621348, 735.8712225360648, 8800.383973121949, 9551.283653726, 10021.498925053718, 10193.246339276731, 10733.570657173626, 682.9112215412064, 701.6211245927244, 725.4160400877239, 729.4529103172621, 734.3831181807308, 5133.639585509843, 5196.58427325813, 5204.843854684365, 5224.608154388436, 5236.476352364733, 96976.0, 97530.0, 97578.0, 97632.0, 99786.0, 72073.0, 77395.0, 77851.61074194706, 89726.55136724406, 91701.0, 66371.0, 67608.6619566899, 73957.0, 74717.62641186759, 75852.0, 8810.647574096964, 11035.172362072715, 11104.222704410613, 11331.773364532499, 11445.25605835618, 45096.77451612852, 50293.74265643388, 53003.0, 53544.92910141697, 53723.73138134284, 70823.0, 71059.0, 71708.0, 71928.921066183, 74311.2568874326, 13333.20000799955, 13381.264030478416, 13617.931910340782, 13624.65938351549, 13838.861611383758, 14854.257287135817, 14992.175430350999, 15119.773203401737, 15365.385384584491, 15372.615684607974, 13712.725745485233, 14131.858681413054, 14162.575122746333, 14417.0, 14849.40602375936, 13466.730665386442, 14216.004879658325, 14400.927995359956, 14731.852681473049, 14773.778393323893, 13109.475620975054, 13315.600531984055, 14154.716905662035, 14452.855471445571, 14601.780973285197, 9795.116335614332, 10085.848712269468, 10279.074883260542, 10420.426876521864, 10680.092192163753, 8615.353848461516, 8860.000693580867, 11227.214095013598, 11301.604443844426, 11433.428328583705], "value": 7686.825981412328, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 176.0, 98.0, 171.0, 124.0, 178.0, 94.0, 96.0, 152.0, 173.0], "value": 141.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 124.0, 94.0, 165.0, 139.0, 145.0, 111.0, 109.0, 164.0, 143.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 193.0, 197.0, 197.0, 199.0, 197.0, 194.0, 236.0, 275.0, 247.0], "value": 213.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 70.0, 76.0, 102.0, 85.0, 82.0, 83.0, 61.0, 71.0, 60.0], "value": 77.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 71.0, 99.0, 54.0, 68.0, 103.0, 101.0, 102.0, 113.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 99.0, 136.0, 132.0, 91.0, 87.0, 88.0, 101.0], "value": 99.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 94.0, 104.0, 145.0, 94.0, 108.0, 152.0, 112.0, 144.0], "value": 114.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 91.0, 94.0, 147.0, 90.0, 146.0, 145.0, 96.0, 91.0], "value": 108.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 57.0, 59.0, 62.0, 61.0, 61.0, 60.0, 62.0, 63.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 67.0, 67.0, 74.0, 73.0, 68.0, 67.0, 69.0, 68.0, 70.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 95.0, 109.0, 85.0, 80.0, 81.0, 85.0, 84.0, 88.0, 108.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 147.0, 138.0, 161.0, 154.0, 136.0, 138.0, 139.0, 183.0, 143.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 161.0, 164.0, 163.0, 161.0, 166.0, 165.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 65.0, 67.0, 65.0, 65.0, 65.0, 67.0, 64.0, 64.0], "value": 65.1, "unit": "score"}]}]} 04:51:42 INFO - Return code: 0 04:51:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:51:42 ERROR - # TBPL SUCCESS # 04:51:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:51:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:51:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:51:42 INFO - 2017-04-03 04:51:42.209 screenresolution[1660:11044] starting screenresolution argv=screenresolution get 04:51:42 INFO - 2017-04-03 04:51:42.212 screenresolution[1660:11044] Display 0: 1600x1200x32@60 04:51:42 INFO - 2017-04-03 04:51:42.218 screenresolution[1661:11047] starting screenresolution argv=screenresolution list 04:51:42 INFO - Available Modes on Display 0 04:51:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:51:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:51:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:51:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:51:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:51:42 INFO - Intel Iris: 04:51:42 INFO - Chipset Model: Intel Iris 04:51:42 INFO - Type: GPU 04:51:42 INFO - Bus: Built-In 04:51:42 INFO - VRAM (Dynamic, Max): 1536 MB 04:51:42 INFO - Vendor: Intel (0x8086) 04:51:42 INFO - Device ID: 0x0a2e 04:51:42 INFO - Revision ID: 0x0009 04:51:42 INFO - Displays: 04:51:42 INFO - Display: 04:51:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:51:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:51:42 INFO - Display Serial Number: 1600x1200 60 04:51:42 INFO - Main Display: Yes 04:51:42 INFO - Mirror: Off 04:51:42 INFO - Online: Yes 04:51:42 INFO - Rotation: Supported 04:51:42 INFO - Return code: 0 04:51:42 INFO - Running post-action listener: _resource_record_post_action 04:51:42 INFO - [mozharness: 2017-04-03 11:51:42.460280Z] Finished run-tests step (success) 04:51:42 INFO - Running post-run listener: _resource_record_post_run 04:51:42 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 35102720; Write bytes: 426749952; Read time: 323; Write time: 1556 04:51:42 INFO - TinderboxPrint: CPU usage
54.2% 04:51:42 INFO - TinderboxPrint: I/O read bytes / time
35,102,720 / 323 04:51:42 INFO - TinderboxPrint: I/O write bytes / time
426,749,952 / 1,556 04:51:42 INFO - TinderboxPrint: CPU idle
2,178.8 (45.8%) 04:51:42 INFO - TinderboxPrint: CPU system
961.3 (20.2%) 04:51:42 INFO - TinderboxPrint: CPU user
1,621.8 (34.1%) 04:51:42 INFO - TinderboxPrint: Swap in / out
153,051,136 / 0 04:51:42 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 109791744; Write bytes: 104175616; Read time: 9897; Write time: 233 04:51:42 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 34168832; Write bytes: 302045184; Read time: 309; Write time: 1267 04:51:42 INFO - Running post-run listener: _upload_blobber_files 04:51:42 INFO - Blob upload gear active. 04:51:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:42 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 04:51:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:51:43 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:51:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:51:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:44 INFO - (blobuploader) - INFO - Done attempting. 04:51:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:51:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:46 INFO - (blobuploader) - INFO - Done attempting. 04:51:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:51:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:51:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:47 INFO - (blobuploader) - INFO - Done attempting. 04:51:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:51:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:51:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:49 INFO - (blobuploader) - INFO - Done attempting. 04:51:49 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:49 INFO - Return code: 0 04:51:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14c9327c2cdd277645004ad86458a86730445451630e38ea4a77a2a0a9e73b007fa307d5f23c1d2830ea2b6004f9de19191f4640ab353e37eb16205bf63e3485", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40df5a448c3fc794af9f09c962f26412fa8bc2ded928227f19dd85b1918ab29f3c4637857e29b145a4d0eee39fef330e12f4e7fe7388666c7bb566f4630c776a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2de8e1b902ed6a44f90b2c67f5dc5d7e5ef1948550d6551c4157e14760e99ed40d8303a9c007334367f8b83c95fcaafc758bb4da386aa68651deb0d1ed00946f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/855dcf43606f3f13cbcfe7c53848042a4aafdaa67728a0ab0ecc0c671feac100161535b2286b806c9a5904af0f3918b9c800d2b40c6ec5e8e2cd531da3b452d1"} 04:51:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:49 INFO - Contents: 04:51:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14c9327c2cdd277645004ad86458a86730445451630e38ea4a77a2a0a9e73b007fa307d5f23c1d2830ea2b6004f9de19191f4640ab353e37eb16205bf63e3485", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40df5a448c3fc794af9f09c962f26412fa8bc2ded928227f19dd85b1918ab29f3c4637857e29b145a4d0eee39fef330e12f4e7fe7388666c7bb566f4630c776a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2de8e1b902ed6a44f90b2c67f5dc5d7e5ef1948550d6551c4157e14760e99ed40d8303a9c007334367f8b83c95fcaafc758bb4da386aa68651deb0d1ed00946f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/855dcf43606f3f13cbcfe7c53848042a4aafdaa67728a0ab0ecc0c671feac100161535b2286b806c9a5904af0f3918b9c800d2b40c6ec5e8e2cd531da3b452d1"} 04:51:49 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:49 INFO - Copying logs to upload dir... 04:51:49 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1531.164627 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 25 mins, 31 secs) (at 2017-04-03 04:51:49.278668) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 04:51:49.282197) ========= 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.t7esywH02D/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.Y7vl5BuCwG/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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/Mozilla-Beta/sha512/14c9327c2cdd277645004ad86458a86730445451630e38ea4a77a2a0a9e73b007fa307d5f23c1d2830ea2b6004f9de19191f4640ab353e37eb16205bf63e3485", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40df5a448c3fc794af9f09c962f26412fa8bc2ded928227f19dd85b1918ab29f3c4637857e29b145a4d0eee39fef330e12f4e7fe7388666c7bb566f4630c776a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2de8e1b902ed6a44f90b2c67f5dc5d7e5ef1948550d6551c4157e14760e99ed40d8303a9c007334367f8b83c95fcaafc758bb4da386aa68651deb0d1ed00946f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/855dcf43606f3f13cbcfe7c53848042a4aafdaa67728a0ab0ecc0c671feac100161535b2286b806c9a5904af0f3918b9c800d2b40c6ec5e8e2cd531da3b452d1"} build_url:https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011030 build_url: 'https://queue.taskcluster.net/v1/task/U7fRZclaQlSrXZl7tyjlnQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14c9327c2cdd277645004ad86458a86730445451630e38ea4a77a2a0a9e73b007fa307d5f23c1d2830ea2b6004f9de19191f4640ab353e37eb16205bf63e3485", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40df5a448c3fc794af9f09c962f26412fa8bc2ded928227f19dd85b1918ab29f3c4637857e29b145a4d0eee39fef330e12f4e7fe7388666c7bb566f4630c776a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2de8e1b902ed6a44f90b2c67f5dc5d7e5ef1948550d6551c4157e14760e99ed40d8303a9c007334367f8b83c95fcaafc758bb4da386aa68651deb0d1ed00946f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/855dcf43606f3f13cbcfe7c53848042a4aafdaa67728a0ab0ecc0c671feac100161535b2286b806c9a5904af0f3918b9c800d2b40c6ec5e8e2cd531da3b452d1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 04:51:49.316078) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:51:49.316362) ========= 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.t7esywH02D/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.Y7vl5BuCwG/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005173 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:51:49.364323) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 04:51:49.364605) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 04:51:49.364905) ========= ========= Total master_lag: 0.40 =========