builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0273 starttime: 1492603050.99 results: success (0) buildid: 20170419030223 builduid: 15059296d08342d4b73e158562765efa revision: c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:30.990825) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:30.991378) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:30.991712) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:31.023540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:31.023948) ========= 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.elB6rdnwTZ/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.BN9o00orkH/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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-19 04:57:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 204M=0s 2017-04-19 04:57:31 (204 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082525 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:31.132446) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:31.132974) ========= 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.elB6rdnwTZ/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.BN9o00orkH/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.021683 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:31.181729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 04:57:31.182223) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.elB6rdnwTZ/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.BN9o00orkH/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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-19 04:57:31,284 truncating revision to first 12 chars 2017-04-19 04:57:31,284 Setting DEBUG logging. 2017-04-19 04:57:31,284 attempt 1/10 2017-04-19 04:57:31,284 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c0ea5ed7f91a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-19 04:57:32,962 unpacking tar archive at: mozilla-central-c0ea5ed7f91a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.959967 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 04:57:33.168277) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:33.168858) ========= script_repo_revision: c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:33.169522) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:33.170231) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 04:57:33.191767) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2017-04-19 04:57:33.192385) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.elB6rdnwTZ/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.BN9o00orkH/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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:57:33 INFO - MultiFileLogger online at 20170419 04:57:33 in /builds/slave/test 04:57:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:57:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:57:33 INFO - {'append_to_log': False, 04:57:33 INFO - 'base_work_dir': '/builds/slave/test', 04:57:33 INFO - 'blob_upload_branch': 'Firefox', 04:57:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:57:33 INFO - 'branch': 'Firefox', 04:57:33 INFO - 'buildbot_json_path': 'buildprops.json', 04:57:33 INFO - 'config_files': ('talos/mac_config.py',), 04:57:33 INFO - 'default_actions': ('clobber', 04:57:33 INFO - 'read-buildbot-config', 04:57:33 INFO - 'download-and-extract', 04:57:33 INFO - 'populate-webroot', 04:57:33 INFO - 'create-virtualenv', 04:57:33 INFO - 'install', 04:57:33 INFO - 'run-tests'), 04:57:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:57:33 INFO - 'download_minidump_stackwalk': True, 04:57:33 INFO - 'download_symbols': 'ondemand', 04:57:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:57:33 INFO - 'tooltool.py': '/tools/tooltool.py', 04:57:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:57:33 INFO - '/tools/misc-python/virtualenv.py')}, 04:57:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:57:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:57:33 INFO - 'gecko_profile': False, 04:57:33 INFO - 'gecko_profile_interval': 0, 04:57:33 INFO - 'installer_path': 'installer.exe', 04:57:33 INFO - 'log_level': 'info', 04:57:33 INFO - 'log_name': 'talos', 04:57:33 INFO - 'log_to_console': True, 04:57:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:57:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:57:33 INFO - 'opt_config_files': (), 04:57:33 INFO - 'pip_index': False, 04:57:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:57:33 INFO - 'cmd': ('bash', 04:57:33 INFO - '-c', 04:57:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:57:33 INFO - 'enabled': True, 04:57:33 INFO - 'halt_on_failure': False, 04:57:33 INFO - 'name': 'check_screen_resolution'},), 04:57:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:57:33 INFO - 'cmd': ('bash', 04:57:33 INFO - '-c', 04:57:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:57:33 INFO - 'enabled': True, 04:57:33 INFO - 'halt_on_failure': False, 04:57:33 INFO - 'name': 'check_screen_resolution'},), 04:57:33 INFO - 'run_cmd_checks_enabled': True, 04:57:33 INFO - 'suite': 'dromaeojs-e10s', 04:57:33 INFO - 'system_bits': '32', 04:57:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:57:33 INFO - 'title': 't-yosemite-r7-0273', 04:57:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:57:33 INFO - 'use_talos_json': True, 04:57:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:57:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:57:33 INFO - 'work_dir': 'build'} 04:57:33 INFO - [mozharness: 2017-04-19 11:57:33.410410Z] Running clobber step. 04:57:33 INFO - Running pre-action listener: _resource_record_pre_action 04:57:33 INFO - Running main action method: clobber 04:57:33 INFO - rmtree: /builds/slave/test/build 04:57:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:57:35 INFO - Running post-action listener: _resource_record_post_action 04:57:35 INFO - [mozharness: 2017-04-19 11:57:35.508019Z] Finished clobber step (success) 04:57:35 INFO - [mozharness: 2017-04-19 11:57:35.508182Z] Running read-buildbot-config step. 04:57:35 INFO - Running pre-action listener: _resource_record_pre_action 04:57:35 INFO - Running main action method: read_buildbot_config 04:57:35 INFO - Using buildbot properties: 04:57:35 INFO - { 04:57:35 INFO - "project": "", 04:57:35 INFO - "product": "firefox", 04:57:35 INFO - "script_repo_revision": "production", 04:57:35 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:57:35 INFO - "repository": "", 04:57:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:57:35 INFO - "buildid": "20170419030223", 04:57:35 INFO - "stage_platform": "macosx64", 04:57:35 INFO - "basedir": "/builds/slave/test", 04:57:35 INFO - "nightly_build": "True", 04:57:35 INFO - "buildnumber": 26, 04:57:35 INFO - "slavename": "t-yosemite-r7-0273", 04:57:35 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:57:35 INFO - "platform": "yosemite_r7", 04:57:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:57:35 INFO - "branch": "mozilla-central", 04:57:35 INFO - "repo_path": "mozilla-central", 04:57:35 INFO - "revision": "c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e", 04:57:35 INFO - "pgo_build": "False", 04:57:35 INFO - "builduid": "15059296d08342d4b73e158562765efa", 04:57:35 INFO - "slavebuilddir": "test" 04:57:35 INFO - } 04:57:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:57:35 INFO - Running post-action listener: _resource_record_post_action 04:57:35 INFO - [mozharness: 2017-04-19 11:57:35.511649Z] Finished read-buildbot-config step (success) 04:57:35 INFO - [mozharness: 2017-04-19 11:57:35.511789Z] Running download-and-extract step. 04:57:35 INFO - Running pre-action listener: _resource_record_pre_action 04:57:35 INFO - Running main action method: download_and_extract 04:57:35 INFO - mkdir: /builds/slave/test/build/tests 04:57:35 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:57:35 INFO - trying https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:57:35 INFO - Downloading https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:57:38 INFO - Downloaded 1325 bytes. 04:57:38 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:57:38 INFO - Using the following test package requirements: 04:57:38 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:38 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:57:38 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:57:38 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:38 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:57:38 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:38 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:57:38 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:38 INFO - u'jsshell-mac.zip'], 04:57:38 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:38 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:57:38 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:57:38 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:38 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:57:38 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:38 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:57:38 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:38 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:57:38 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:57:38 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:57:38 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:57:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:57:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:57:38 INFO - Fetch https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:57:39 INFO - Expected file size: 52609371 04:57:39 INFO - Obtained file size: 52609371 04:57:56 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:57:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:57:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:57:56 INFO - Fetch https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:57:57 INFO - Expected file size: 52609371 04:57:57 INFO - Obtained file size: 52609371 04:58:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:58:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:58:13 INFO - Fetch https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:58:23 INFO - Expected file size: 14408802 04:58:23 INFO - Obtained file size: 14408802 04:58: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:58:24 INFO - trying https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:58:24 INFO - Downloading https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:58:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:58:27 INFO - Downloaded 71079344 bytes. 04:58:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:58:27 INFO - mkdir: /builds/slave/test/properties 04:58:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:58:27 INFO - Writing to file /builds/slave/test/properties/build_url 04:58:27 INFO - Contents: 04:58:27 INFO - build_url:https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:58:27 INFO - Running post-action listener: _resource_record_post_action 04:58:27 INFO - Running post-action listener: set_extra_try_arguments 04:58:27 INFO - [mozharness: 2017-04-19 11:58:27.912674Z] Finished download-and-extract step (success) 04:58:27 INFO - [mozharness: 2017-04-19 11:58:27.912818Z] Running populate-webroot step. 04:58:27 INFO - Running pre-action listener: _resource_record_pre_action 04:58:27 INFO - Running main action method: populate_webroot 04:58:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:58:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:58:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:58:27 INFO - '--tppagecycles', 04:58:27 INFO - '7'], 04:58:27 INFO - 'tests': ['tsvgm']}}, 04:58:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:58:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:58:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:58:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:58:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:58:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:58:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:58:27 INFO - 'talos_options': ['--disable-e10s'], 04:58:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:58:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:58:27 INFO - 'talos_options': ['--disable-e10s'], 04:58:27 INFO - 'tests': ['damp', 'tps']}, 04:58:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:58:27 INFO - 'tests': ['damp', 'tps']}, 04:58:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:58:27 INFO - 'tests': ['dromaeo_dom']}, 04:58:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:58:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:58:27 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:58:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:58:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:58:27 INFO - 'tests': ['a11yr', 04:58:27 INFO - 'ts_paint', 04:58:27 INFO - 'tpaint', 04:58:27 INFO - 'sessionrestore', 04:58:27 INFO - 'sessionrestore_no_auto_restore', 04:58:27 INFO - 'tabpaint']}, 04:58:27 INFO - 'other-e10s': {'tests': ['a11yr', 04:58:27 INFO - 'ts_paint', 04:58:27 INFO - 'tpaint', 04:58:27 INFO - 'sessionrestore', 04:58:27 INFO - 'sessionrestore_no_auto_restore', 04:58:27 INFO - 'tabpaint']}, 04:58:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:58:27 INFO - 'ts_paint', 04:58:27 INFO - 'tpaint', 04:58:27 INFO - 'sessionrestore', 04:58:27 INFO - 'sessionrestore_no_auto_restore', 04:58:27 INFO - 'tabpaint']}, 04:58:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:58:27 INFO - 'ts_paint', 04:58:27 INFO - 'tpaint', 04:58:27 INFO - 'sessionrestore', 04:58:27 INFO - 'sessionrestore_no_auto_restore', 04:58:27 INFO - 'tabpaint']}, 04:58:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:58:27 INFO - 'tests': ['a11yr', 04:58:27 INFO - 'ts_paint', 04:58:27 INFO - 'tpaint', 04:58:27 INFO - 'sessionrestore', 04:58:27 INFO - 'sessionrestore_no_auto_restore', 04:58:27 INFO - 'tabpaint']}, 04:58:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:58:27 INFO - 'tests': ['a11yr', 04:58:27 INFO - 'ts_paint', 04:58:27 INFO - 'tpaint', 04:58:27 INFO - 'sessionrestore', 04:58:27 INFO - 'sessionrestore_no_auto_restore', 04:58:27 INFO - 'tabpaint']}, 04:58:27 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:58:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:58:27 INFO - 'bloom_basic_ref']}, 04:58:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:58:27 INFO - 'tests': ['tsvgx', 04:58:27 INFO - 'tsvgr_opacity', 04:58:27 INFO - 'tart', 04:58:27 INFO - 'tscrollx', 04:58:27 INFO - 'cart', 04:58:27 INFO - 'tsvg_static']}, 04:58:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:58:27 INFO - 'tsvgr_opacity', 04:58:27 INFO - 'tart', 04:58:27 INFO - 'tscrollx', 04:58:27 INFO - 'cart', 04:58:27 INFO - 'tsvg_static']}, 04:58:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:58:27 INFO - 'talos_options': ['--disable-e10s'], 04:58:27 INFO - 'tests': ['tp5o']}, 04:58:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:58:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:58:27 INFO - 'talos_options': ['--disable-e10s', 04:58:27 INFO - '--xperf_path', 04:58:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:27 INFO - 'tests': ['tp5n']}, 04:58:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:58:27 INFO - 'talos_options': ['--xperf_path', 04:58:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:27 INFO - 'tests': ['tp5n']}}, 04:58:27 INFO - 'talos.zip': {'path': '', 04:58:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:58:27 INFO - Running post-action listener: _resource_record_post_action 04:58:27 INFO - [mozharness: 2017-04-19 11:58:27.931754Z] Finished populate-webroot step (success) 04:58:27 INFO - [mozharness: 2017-04-19 11:58:27.931892Z] Running create-virtualenv step. 04:58:27 INFO - Running pre-action listener: _resource_record_pre_action 04:58:27 INFO - Running main action method: create_virtualenv 04:58:27 INFO - Creating virtualenv /builds/slave/test/build/venv 04:58:27 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:58:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:58:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:58:28 INFO - Using real prefix '/tools/python27' 04:58:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:58:28 INFO - Installing distribute.............................................................................................................................................................................................done. 04:58:31 INFO - Installing pip.................done. 04:58:31 INFO - Return code: 0 04:58:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:58:31 INFO - Reading from file tmpfile_stdout 04:58:31 INFO - Output received: 04:58:31 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:58:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58: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:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d0d87650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f560d30>, '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 0x10f486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f555be8>, '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.elB6rdnwTZ/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.BN9o00orkH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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:58:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:58:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elB6rdnwTZ/Render', 04:58:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:32 INFO - 'HOME': '/Users/cltbld', 04:58:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:32 INFO - 'LOGNAME': 'cltbld', 04:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:32 INFO - 'MOZ_NO_REMOTE': '1', 04:58:32 INFO - 'NO_EM_RESTART': '1', 04:58:32 INFO - 'PAGER': '/bin/cat', 04:58:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:32 INFO - 'PWD': '/builds/slave/test', 04:58:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:32 INFO - 'SHELL': '/bin/bash', 04:58:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BN9o00orkH/Listeners', 04:58:32 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:58:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:32 INFO - 'USER': 'cltbld', 04:58:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:32 INFO - 'XPC_FLAGS': '0x0', 04:58:32 INFO - 'XPC_SERVICE_NAME': '0', 04:58:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:58:32 INFO - Cleaning up... 04:58:32 INFO - Return code: 0 04:58:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:58: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:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58: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:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d0d87650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f560d30>, '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 0x10f486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f555be8>, '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.elB6rdnwTZ/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.BN9o00orkH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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:58:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:58:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elB6rdnwTZ/Render', 04:58:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:32 INFO - 'HOME': '/Users/cltbld', 04:58:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:32 INFO - 'LOGNAME': 'cltbld', 04:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:32 INFO - 'MOZ_NO_REMOTE': '1', 04:58:32 INFO - 'NO_EM_RESTART': '1', 04:58:32 INFO - 'PAGER': '/bin/cat', 04:58:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:32 INFO - 'PWD': '/builds/slave/test', 04:58:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:32 INFO - 'SHELL': '/bin/bash', 04:58:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BN9o00orkH/Listeners', 04:58:32 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:58:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:32 INFO - 'USER': 'cltbld', 04:58:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:32 INFO - 'XPC_FLAGS': '0x0', 04:58:32 INFO - 'XPC_SERVICE_NAME': '0', 04:58:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:32 INFO - Downloading/unpacking psutil>=3.1.1 04:58: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:58: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:58: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:58: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:58: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:58: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:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:58:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:38 INFO - Installing collected packages: psutil 04:58:38 INFO - Running setup.py install for psutil 04:58:38 INFO - building 'psutil._psutil_osx' extension 04:58:38 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:58:38 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:58:38 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:58:39 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:58:39 INFO - building 'psutil._psutil_posix' extension 04:58:39 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:58:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:58:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:58:39 INFO - ^ 04:58:39 INFO - 1 warning generated. 04:58:39 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:58:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:39 INFO - Successfully installed psutil 04:58:39 INFO - Cleaning up... 04:58:39 INFO - Return code: 0 04:58:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:58: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:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58: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:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:39 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 0x10f782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d0d87650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f560d30>, '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 0x10f486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f555be8>, '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.elB6rdnwTZ/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.BN9o00orkH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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:58:39 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:58:39 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:58:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elB6rdnwTZ/Render', 04:58:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:39 INFO - 'HOME': '/Users/cltbld', 04:58:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:39 INFO - 'LOGNAME': 'cltbld', 04:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:39 INFO - 'MOZ_NO_REMOTE': '1', 04:58:39 INFO - 'NO_EM_RESTART': '1', 04:58:39 INFO - 'PAGER': '/bin/cat', 04:58:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:39 INFO - 'PWD': '/builds/slave/test', 04:58:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:39 INFO - 'SHELL': '/bin/bash', 04:58:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BN9o00orkH/Listeners', 04:58:39 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:58:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:39 INFO - 'USER': 'cltbld', 04:58:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:39 INFO - 'XPC_FLAGS': '0x0', 04:58:39 INFO - 'XPC_SERVICE_NAME': '0', 04:58:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:58:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:58:43 INFO - Installing collected packages: mozsystemmonitor 04:58:43 INFO - Running setup.py install for mozsystemmonitor 04:58:43 INFO - Successfully installed mozsystemmonitor 04:58:43 INFO - Cleaning up... 04:58:43 INFO - Return code: 0 04:58:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:58: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:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58: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:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:43 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 0x10f782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d0d87650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f560d30>, '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 0x10f486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f555be8>, '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.elB6rdnwTZ/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.BN9o00orkH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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:58:43 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:58:43 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:58:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elB6rdnwTZ/Render', 04:58:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:43 INFO - 'HOME': '/Users/cltbld', 04:58:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:43 INFO - 'LOGNAME': 'cltbld', 04:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:43 INFO - 'MOZ_NO_REMOTE': '1', 04:58:43 INFO - 'NO_EM_RESTART': '1', 04:58:43 INFO - 'PAGER': '/bin/cat', 04:58:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:43 INFO - 'PWD': '/builds/slave/test', 04:58:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:43 INFO - 'SHELL': '/bin/bash', 04:58:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BN9o00orkH/Listeners', 04:58:43 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:58:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:43 INFO - 'USER': 'cltbld', 04:58:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:43 INFO - 'XPC_FLAGS': '0x0', 04:58:43 INFO - 'XPC_SERVICE_NAME': '0', 04:58:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:44 INFO - Downloading/unpacking jsonschema==2.5.1 04:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:58:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:48 INFO - Downloading functools32-3.2.3-2.tar.gz 04:58:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:58:48 INFO - warning: no files found matching '*.txt' 04:58:48 INFO - no previously-included directories found matching 'build' 04:58:48 INFO - no previously-included directories found matching 'dist' 04:58:48 INFO - no previously-included directories found matching '.git*' 04:58:48 INFO - Installing collected packages: jsonschema, functools32 04:58:48 INFO - Running setup.py install for functools32 04:58:48 INFO - warning: no files found matching '*.txt' 04:58:48 INFO - no previously-included directories found matching 'build' 04:58:48 INFO - no previously-included directories found matching 'dist' 04:58:48 INFO - no previously-included directories found matching '.git*' 04:58:48 INFO - Successfully installed jsonschema functools32 04:58:48 INFO - Cleaning up... 04:58:48 INFO - Return code: 0 04:58:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d0d87650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f560d30>, '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 0x10f486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f555be8>, '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.elB6rdnwTZ/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.BN9o00orkH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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:58:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:58:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elB6rdnwTZ/Render', 04:58:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:48 INFO - 'HOME': '/Users/cltbld', 04:58:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:48 INFO - 'LOGNAME': 'cltbld', 04:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:48 INFO - 'MOZ_NO_REMOTE': '1', 04:58:48 INFO - 'NO_EM_RESTART': '1', 04:58:48 INFO - 'PAGER': '/bin/cat', 04:58:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:48 INFO - 'PWD': '/builds/slave/test', 04:58:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:48 INFO - 'SHELL': '/bin/bash', 04:58:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BN9o00orkH/Listeners', 04:58:48 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:58:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:48 INFO - 'USER': 'cltbld', 04:58:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:48 INFO - 'XPC_FLAGS': '0x0', 04:58:48 INFO - 'XPC_SERVICE_NAME': '0', 04:58:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:58:48 INFO - Cleaning up... 04:58:48 INFO - Return code: 0 04:58:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d0d87650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f560d30>, '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 0x10f486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f555be8>, '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.elB6rdnwTZ/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.BN9o00orkH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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:58:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:58:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elB6rdnwTZ/Render', 04:58:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:48 INFO - 'HOME': '/Users/cltbld', 04:58:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:48 INFO - 'LOGNAME': 'cltbld', 04:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:48 INFO - 'MOZ_NO_REMOTE': '1', 04:58:48 INFO - 'NO_EM_RESTART': '1', 04:58:48 INFO - 'PAGER': '/bin/cat', 04:58:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:48 INFO - 'PWD': '/builds/slave/test', 04:58:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:48 INFO - 'SHELL': '/bin/bash', 04:58:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BN9o00orkH/Listeners', 04:58:48 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:58:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:48 INFO - 'USER': 'cltbld', 04:58:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:48 INFO - 'XPC_FLAGS': '0x0', 04:58:48 INFO - 'XPC_SERVICE_NAME': '0', 04:58:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:58:49 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:58:49 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:58:49 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:58:49 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:58:49 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:58:49 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:58:54 INFO - Downloading blobuploader-1.2.4.tar.gz 04:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:58:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:58:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:55 INFO - Downloading docopt-0.6.1.tar.gz 04:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:58:55 INFO - Installing collected packages: blobuploader, requests, docopt 04:58:55 INFO - Running setup.py install for blobuploader 04:58:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:58:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:58:55 INFO - Running setup.py install for requests 04:58:56 INFO - Running setup.py install for docopt 04:58:56 INFO - Successfully installed blobuploader requests docopt 04:58:56 INFO - Cleaning up... 04:58:56 INFO - Return code: 0 04:58:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d0d87650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f560d30>, '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 0x10f486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f555be8>, '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.elB6rdnwTZ/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.BN9o00orkH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elB6rdnwTZ/Render', 04:58:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:56 INFO - 'HOME': '/Users/cltbld', 04:58:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:56 INFO - 'LOGNAME': 'cltbld', 04:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:56 INFO - 'MOZ_NO_REMOTE': '1', 04:58:56 INFO - 'NO_EM_RESTART': '1', 04:58:56 INFO - 'PAGER': '/bin/cat', 04:58:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:56 INFO - 'PWD': '/builds/slave/test', 04:58:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:56 INFO - 'SHELL': '/bin/bash', 04:58:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BN9o00orkH/Listeners', 04:58:56 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:58:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:56 INFO - 'USER': 'cltbld', 04:58:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:56 INFO - 'XPC_FLAGS': '0x0', 04:58:56 INFO - 'XPC_SERVICE_NAME': '0', 04:58:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:56 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-fVTekY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:56 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-mCULO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:56 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-9xvX6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:57 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-LPXg90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:57 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-Fj2UE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:57 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-YWJYdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:57 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-w1NzT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:57 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-c6IasE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:57 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-3NZma1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:57 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-XUBqeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:57 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-P5PL08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:57 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-pIvCcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:57 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-JWd3Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:58 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-S5vwzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:58 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-UD4Ry9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:58 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-MBkuc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:58 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-ky6C7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:58:58 INFO - Running setup.py install for manifestparser 04:58:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:58:58 INFO - Running setup.py install for mozcrash 04:58:58 INFO - Running setup.py install for mozdebug 04:58:58 INFO - Running setup.py install for mozdevice 04:58:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:58:59 INFO - Running setup.py install for mozfile 04:58:59 INFO - Running setup.py install for mozhttpd 04:58:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:58:59 INFO - Running setup.py install for mozinfo 04:58:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:58:59 INFO - Running setup.py install for mozInstall 04:58:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:58:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:58:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:58:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:58:59 INFO - Running setup.py install for mozleak 04:58:59 INFO - Running setup.py install for mozlog 04:58:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:58:59 INFO - Running setup.py install for moznetwork 04:59:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:59:00 INFO - Running setup.py install for mozprocess 04:59:00 INFO - Running setup.py install for mozprofile 04:59:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:59:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:59:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:59:00 INFO - Running setup.py install for mozrunner 04:59:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:59:00 INFO - Running setup.py install for mozscreenshot 04:59:00 INFO - Running setup.py install for moztest 04:59:00 INFO - Running setup.py install for mozversion 04:59:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:59:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:59:01 INFO - Cleaning up... 04:59:01 INFO - Return code: 0 04:59:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59: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:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59: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:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d0d87650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f560d30>, '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 0x10f486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f555be8>, '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.elB6rdnwTZ/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.BN9o00orkH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:59:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elB6rdnwTZ/Render', 04:59:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:01 INFO - 'HOME': '/Users/cltbld', 04:59:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:01 INFO - 'LOGNAME': 'cltbld', 04:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:01 INFO - 'MOZ_NO_REMOTE': '1', 04:59:01 INFO - 'NO_EM_RESTART': '1', 04:59:01 INFO - 'PAGER': '/bin/cat', 04:59:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:01 INFO - 'PWD': '/builds/slave/test', 04:59:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:01 INFO - 'SHELL': '/bin/bash', 04:59:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BN9o00orkH/Listeners', 04:59:01 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:59:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:01 INFO - 'USER': 'cltbld', 04:59:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:01 INFO - 'XPC_FLAGS': '0x0', 04:59:01 INFO - 'XPC_SERVICE_NAME': '0', 04:59:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:59:01 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-5nr5En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:59:01 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-SXoznp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:59:01 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-3IbL1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:59:01 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-pARkoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:59:01 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-ATXnY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:59:01 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-rl6zNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:59:02 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:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:59:02 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-zG37S_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:59:02 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-3KH_UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:59:02 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-D9F41J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:59:02 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-X214J5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:59:02 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-MeqLAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:59:02 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-LPWreu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:59:02 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-1n1oDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:59:02 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-IEn_pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:02 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-bmzP5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:59:02 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-R2qGMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:59:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-KhmhJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:59:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:06 INFO - Downloading blessings-1.6.tar.gz 04:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:59:07 INFO - Installing collected packages: blessings 04:59:07 INFO - Running setup.py install for blessings 04:59:07 INFO - Successfully installed blessings 04:59:07 INFO - Cleaning up... 04:59:07 INFO - Return code: 0 04:59:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:59:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:59:07 INFO - Reading from file tmpfile_stdout 04:59:07 INFO - Current package versions: 04:59:07 INFO - blessings == 1.6 04:59:07 INFO - blobuploader == 1.2.4 04:59:07 INFO - docopt == 0.6.1 04:59:07 INFO - functools32 == 3.2.3-2 04:59:07 INFO - jsonschema == 2.5.1 04:59:07 INFO - manifestparser == 1.1 04:59:07 INFO - mozInstall == 1.12 04:59:07 INFO - mozcrash == 1.0 04:59:07 INFO - mozdebug == 0.1 04:59:07 INFO - mozdevice == 0.50 04:59:07 INFO - mozfile == 1.2 04:59:07 INFO - mozhttpd == 0.7 04:59:07 INFO - mozinfo == 0.9 04:59:07 INFO - mozleak == 0.1 04:59:07 INFO - mozlog == 3.4 04:59:07 INFO - moznetwork == 0.27 04:59:07 INFO - mozprocess == 0.25 04:59:07 INFO - mozprofile == 0.28 04:59:07 INFO - mozrunner == 6.13 04:59:07 INFO - mozscreenshot == 0.1 04:59:07 INFO - mozsystemmonitor == 0.3 04:59:07 INFO - moztest == 0.8 04:59:07 INFO - mozversion == 1.4 04:59:07 INFO - psutil == 3.1.1 04:59:07 INFO - requests == 1.2.3 04:59:07 INFO - wsgiref == 0.1.2 04:59:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:59:07 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:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:07 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:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:07 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 0x10f782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d0d87650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f560d30>, '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 0x10f486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f555be8>, '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.elB6rdnwTZ/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.BN9o00orkH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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:59:07 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:59:07 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:59:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elB6rdnwTZ/Render', 04:59:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:07 INFO - 'HOME': '/Users/cltbld', 04:59:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:07 INFO - 'LOGNAME': 'cltbld', 04:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:07 INFO - 'MOZ_NO_REMOTE': '1', 04:59:07 INFO - 'NO_EM_RESTART': '1', 04:59:07 INFO - 'PAGER': '/bin/cat', 04:59:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:07 INFO - 'PWD': '/builds/slave/test', 04:59:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:07 INFO - 'SHELL': '/bin/bash', 04:59:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BN9o00orkH/Listeners', 04:59:07 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:59:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:07 INFO - 'USER': 'cltbld', 04:59:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:07 INFO - 'XPC_FLAGS': '0x0', 04:59:07 INFO - 'XPC_SERVICE_NAME': '0', 04:59:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:07 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:59:07 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:59:07 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:59:07 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:59:07 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:59:07 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:59:07 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:59:07 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:59:07 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:59:07 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:59:07 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:59:07 INFO - Cleaning up... 04:59:07 INFO - Return code: 0 04:59:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:59:07 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:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:07 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:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:07 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 0x10f782b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f785768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d0d87650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f560d30>, '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 0x10f486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f555be8>, '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.elB6rdnwTZ/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.BN9o00orkH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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:59:07 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:59:07 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:59:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elB6rdnwTZ/Render', 04:59:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:07 INFO - 'HOME': '/Users/cltbld', 04:59:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:07 INFO - 'LOGNAME': 'cltbld', 04:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:07 INFO - 'MOZ_NO_REMOTE': '1', 04:59:07 INFO - 'NO_EM_RESTART': '1', 04:59:07 INFO - 'PAGER': '/bin/cat', 04:59:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:07 INFO - 'PWD': '/builds/slave/test', 04:59:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:07 INFO - 'SHELL': '/bin/bash', 04:59:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BN9o00orkH/Listeners', 04:59:07 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:59:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:07 INFO - 'USER': 'cltbld', 04:59:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:07 INFO - 'XPC_FLAGS': '0x0', 04:59:07 INFO - 'XPC_SERVICE_NAME': '0', 04:59:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:59:08 INFO - Cleaning up... 04:59:08 INFO - Return code: 0 04:59:08 INFO - Running post-action listener: _resource_record_post_action 04:59:08 INFO - Running post-action listener: _start_resource_monitoring 04:59:08 INFO - Starting resource monitoring. 04:59:08 INFO - [mozharness: 2017-04-19 11:59:08.214493Z] Finished create-virtualenv step (success) 04:59:08 INFO - [mozharness: 2017-04-19 11:59:08.215463Z] Running install step. 04:59:08 INFO - Running pre-action listener: _resource_record_pre_action 04:59:08 INFO - Running main action method: install 04:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:59:08 INFO - Reading from file tmpfile_stdout 04:59:08 INFO - Detecting whether we're running mozinstall >=1.0... 04:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:59:08 INFO - Reading from file tmpfile_stdout 04:59:08 INFO - Output received: 04:59:08 INFO - Usage: mozinstall [options] installer 04:59:08 INFO - Options: 04:59:08 INFO - -h, --help show this help message and exit 04:59:08 INFO - -d DEST, --destination=DEST 04:59:08 INFO - Directory to install application into. [default: 04:59:08 INFO - "/builds/slave/test"] 04:59:08 INFO - --app=APP Application being installed. [default: firefox] 04:59:08 INFO - mkdir: /builds/slave/test/build/application 04:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:59:28 INFO - Reading from file tmpfile_stdout 04:59:28 INFO - Output received: 04:59:28 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:59:28 INFO - Running post-action listener: _resource_record_post_action 04:59:28 INFO - [mozharness: 2017-04-19 11:59:28.673576Z] Finished install step (success) 04:59:28 INFO - [mozharness: 2017-04-19 11:59:28.673725Z] Running run-tests step. 04:59:28 INFO - Running pre-action listener: _resource_record_pre_action 04:59:28 INFO - Running main action method: run_tests 04:59:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:28 INFO - 2017-04-19 04:59:28.688 screenresolution[1954:9833] starting screenresolution argv=screenresolution get 04:59:28 INFO - 2017-04-19 04:59:28.691 screenresolution[1954:9833] Display 0: 1600x1200x32@60 04:59:28 INFO - 2017-04-19 04:59:28.696 screenresolution[1955:9836] starting screenresolution argv=screenresolution list 04:59:28 INFO - Available Modes on Display 0 04:59:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:28 INFO - Intel Iris: 04:59:28 INFO - Chipset Model: Intel Iris 04:59:28 INFO - Type: GPU 04:59:28 INFO - Bus: Built-In 04:59:28 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:28 INFO - Vendor: Intel (0x8086) 04:59:28 INFO - Device ID: 0x0a2e 04:59:28 INFO - Revision ID: 0x0009 04:59:28 INFO - Displays: 04:59:28 INFO - Display: 04:59:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:28 INFO - Display Serial Number: 1600x1200 60 04:59:28 INFO - Main Display: Yes 04:59:28 INFO - Mirror: Off 04:59:28 INFO - Online: Yes 04:59:28 INFO - Rotation: Supported 04:59:28 INFO - Return code: 0 04:59:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:59:28 INFO - Python 2.7.3 04:59:28 INFO - Return code: 0 04:59:28 INFO - grabbing minidump binary from tooltool 04:59:28 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:59:28 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 0x10f560d30>, '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 0x10f486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f555be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:59:28 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:59:28 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:59:28 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:59:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:59:29 INFO - Return code: 0 04:59:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:59:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:59:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:59:29 INFO - ENV: RUST_BACKTRACE is now 1 04:59:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:59:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--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:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0273 --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:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elB6rdnwTZ/Render', 04:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:29 INFO - 'HOME': '/Users/cltbld', 04:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:29 INFO - 'LOGNAME': 'cltbld', 04:59:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:59:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:29 INFO - 'MOZ_NO_REMOTE': '1', 04:59:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:59:29 INFO - 'NO_EM_RESTART': '1', 04:59:29 INFO - 'PAGER': '/bin/cat', 04:59:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:29 INFO - 'PWD': '/builds/slave/test', 04:59:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:29 INFO - 'RUST_BACKTRACE': '1', 04:59:29 INFO - 'SHELL': '/bin/bash', 04:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BN9o00orkH/Listeners', 04:59:29 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:29 INFO - 'USER': 'cltbld', 04:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:29 INFO - 'XPC_FLAGS': '0x0', 04:59:29 INFO - 'XPC_SERVICE_NAME': '0', 04:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--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:59:29 INFO - mozversion application_buildid: 20170419030223 04:59:29 INFO - mozversion application_changeset: c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e 04:59:29 INFO - mozversion application_display_name: Nightly 04:59:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:59:29 INFO - mozversion application_name: Firefox 04:59:29 INFO - mozversion application_remotingname: firefox 04:59:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:59:29 INFO - mozversion application_vendor: Mozilla 04:59:29 INFO - mozversion application_version: 55.0a1 04:59:29 INFO - mozversion platform_buildid: 20170419030223 04:59:29 INFO - mozversion platform_changeset: c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e 04:59:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:59:29 INFO - mozversion platform_version: 55.0a1 04:59:29 INFO - using testdate: 1492603169 04:59:29 INFO - actual date: 1492603169 04:59:29 INFO - starting webserver on 'localhost:49347' 04:59:29 INFO - SUITE-START | Running 2 tests 04:59:29 INFO - TEST-START | dromaeo_css 04:59:29 INFO - operating with platform_type : mac_ 04:59:29 INFO - Initialising browser for dromaeo_css test... 04:59:29 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmp9dAHTT/profile http://localhost:49347/getInfo.html) 04:59:32 INFO - PID 1965 | 2017-04-19 04:59:32.289 plugin-container[1967:10018] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a4f, name = 'com.apple.tsm.portname' 04:59:32 INFO - PID 1965 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:59:32 INFO - PID 1965 | 2017-04-19 04:59:32.290 plugin-container[1967:10018] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 04:59:32 INFO - PID 1965 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:59:32 INFO - PID 1965 | 2017-04-19 04:59:32.290 plugin-container[1967:10018] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:59:32 INFO - PID 1965 | __metrics Screen width/height:1600/1200 04:59:32 INFO - PID 1965 | colorDepth:24 04:59:32 INFO - PID 1965 | Browser inner width/height: 1024/689 04:59:32 INFO - PID 1965 | __metrics 04:59:32 ERROR - PID 1965 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3385: TypeError: this.tabs is undefined 04:59:33 INFO - TEST-INFO | 1965: exit 0 04:59:33 INFO - Browser initialized. 04:59:33 INFO - Running cycle 1/1 for dromaeo_css test... 04:59:33 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmp9dAHTT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:35 INFO - PID 1968 | 2017-04-19 04:59:35.966 plugin-container[1969:10161] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 04:59:35 INFO - PID 1968 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:59:35 INFO - PID 1968 | 2017-04-19 04:59:35.967 plugin-container[1969:10161] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.CFPasteboardClient' 04:59:35 INFO - PID 1968 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:59:35 INFO - PID 1968 | 2017-04-19 04:59:35.967 plugin-container[1969:10161] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:59:45 INFO - PID 1968 | RSS: Main: 236523520 04:59:45 INFO - PID 1968 | 05:02:50 INFO - PID 1968 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49347/tests/dromaeo/cssquery-ext.html) 05:02:52 INFO - PID 1968 | RSS: Main: 251387904 05:02:52 INFO - PID 1968 | 05:04:33 INFO - PID 1968 | ************************* 05:04:33 INFO - PID 1968 | A coding exception was thrown and uncaught in a Task. 05:04:33 INFO - PID 1968 | 05:04:33 ERROR - PID 1968 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:04:33 INFO - PID 1968 | Full stack: 05:04:33 INFO - PID 1968 | ************************* 05:04:33 INFO - PID 1968 | ************************* 05:04:33 INFO - PID 1968 | A coding exception was thrown and uncaught in a Task. 05:04:33 INFO - PID 1968 | 05:04:33 ERROR - PID 1968 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:04:33 INFO - PID 1968 | Full stack: 05:04:33 INFO - PID 1968 | ************************* 05:04:33 INFO - PID 1968 | ************************* 05:04:33 INFO - PID 1968 | A coding exception was thrown and uncaught in a Task. 05:04:33 INFO - PID 1968 | 05:04:33 ERROR - PID 1968 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:04:33 INFO - PID 1968 | Full stack: 05:04:33 INFO - PID 1968 | ************************* 05:04:33 INFO - PID 1968 | ************************* 05:04:33 INFO - PID 1968 | A coding exception was thrown and uncaught in a Task. 05:04:33 INFO - PID 1968 | 05:04:33 ERROR - PID 1968 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:04:33 INFO - PID 1968 | Full stack: 05:04:33 INFO - PID 1968 | ************************* 05:05:54 INFO - PID 1968 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-ext.html (next: http://localhost:49347/tests/dromaeo/cssquery-jquery.html) 05:05:54 INFO - PID 1968 | RSS: Main: 253612032 05:05:54 INFO - PID 1968 | 05:08:56 INFO - PID 1968 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49347/tests/dromaeo/cssquery-mootools.html) 05:08:56 INFO - PID 1968 | RSS: Main: 265629696 05:08:56 INFO - PID 1968 | 05:11:58 INFO - PID 1968 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49347/tests/dromaeo/cssquery-prototype.html) 05:11:59 INFO - PID 1968 | RSS: Main: 258183168 05:11:59 INFO - PID 1968 | 05:15:02 INFO - PID 1968 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49347/tests/dromaeo/cssquery-yui.html) 05:15:02 INFO - PID 1968 | RSS: Main: 268210176 05:15:02 INFO - PID 1968 | 05:18:04 INFO - PID 1968 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-yui.html (next: http://localhost:49347/tests/dromaeo/cssquery-dojo.html) 05:18:04 INFO - PID 1968 | RSS: Main: 262688768 05:18:04 INFO - PID 1968 | 05:18:04 INFO - PID 1968 | __start_tp_report 05:18:04 INFO - PID 1968 | _x_x_mozilla_page_load 05:18:04 INFO - PID 1968 | _x_x_mozilla_page_load_details 05:18:04 INFO - PID 1968 | |i|pagename|runs| 05:18:04 INFO - PID 1968 | |0;dojo.html;3531.8763843265483;3601.657842504963;3620.3664358737215;3629.3830048891687;3650.4524321351796;6059.0608455689435;6165;6203.348648391921;6209.751609935603;6267.2165979252595;6150.938490615093;6187.876242475148;6204.906926396107;6205.503559715224;6271.404216599416;5430.91853622196;5445;5473.397926228112;5501.752421141058;5556.416576259475;5395.649282796606;5483.945160548384;5543.556515478752;5576.86057848553;5592.4407559244155;4749.596284315838;5418.106012507971;5441.673499589998;5473.425290344497;5511.917321240185;4859.368282123337;5223.764930578133;5440.646357986719;5474.7810087596445;5483.451654834525;4011.13760541485;5357.785688572452;5404.054290499147;5414;5423.186522021689;5576.525995290405;6088.969555152196;6106.642687876592;6184.969075154595;6217.751289948396;6610.768623098216;6649.966750166266;6659.833504162386;6668.83327916806;6711.261761206312;6115.746272014227;6744.561603495807;6766.18805743314;6772.458203343721;6791.660416979132;5005.0240203160765;6145.985912324416;6234.87530249397;6326.620402775849;6346.524010699216;5983.401659833982;6527.510436717265;6838.897416538756;6871.106756121672;6875.5530890491955;6229.56393052482;6304.085907543472;6398.584092034003;6453.1610890583925;6525.771597994048;6655;6657.400833924873;6716.093327400738;6723.5293529452465;6727.66361681914;5289.444608316071;6562;6589.80230593083;6604.438622717123;6620.073189753439;6318.368163183737;6366.108744775735;6469.256035555877;6492.415682588589;6588.143541339691;5353.705546194997;5361.383440904346;5365.463453654604;5386.622936394415;5408.296921400193;4331.350297455344;4445.777711114431;4730.810767569259;4763.45220299663;4793.544613261734;6084.817455476343;6243.719032643542;6250.093736408196;6264.906026409608;6296.024116261987;6768.424683901825;6772.492063095287;6782.2200446948245;6786.694598743068;6792.42264407521;6298.118263443122;6320.27316858558;6324.652144132025;6327.4938004959495;6346.428821406095;5688.9715551422805;5783.739731712083;5796.855078623068;5949;5962.135490353874;5659.434056594308;6736.461083113437;6779.254282029072;6858.177018757781;6878.209005964378;5572.219889215432;6733.360330768569;6755.189377274562;6767.695453704693;6773.05177275172;6883.7590684325805;6890.8621827562165;6915.066466027022;6966.79099627012;6986.615736134561;6364.681765911593;6453.774117906039;6505.121808555785;6583.078369028244;6587.4071333580205;6589.374009469093;6734.595924244561;6758.357955994173;6772.051912732123;6789.762358317435;5744.253247077853;6252.749890004349;6265.154204182377;6292.779752708633;6375.171227740364;6309;6503.2846386898345;6505.447037001908;6540.345965403612;6542.149520562297;6190.7523699051535;6253.280872699698;6262.624242545462;6289.937100628935;6342.23893132827;6181.84545386369;6495.642739649175;6543.672816359068;6556.737730490918;6562.8359291018105;5340.279062326536;6367.936320636734;6377.23473183221;6397.680115994275;6478.2550006749825 05:18:04 INFO - PID 1968 | |1;ext.html;747.122131495493;789.905211374635;818.5620692929284;1242.217403036087;1259.124908188809;37337.06657333564;37961.24077518448;37998.43002354967;38116;38128.85613431598;37932.43101353475;38240.80879595605;38277.04307392317;38359.80820095903;38423.615763842354;7881.369490440766;8042.5978701065005;8353.791155221108;8604.967403911509;8628.784280393009;8467.66129354825;8555;8570.828583428327;8596.699115530957;8600.56997150143;8509.574521273942;8575.442596231256;8586.398952073358;8588;8589.484630922134;8540.743777686648;8576.485410875304;8586.44188127776;8588.441751286146;8594.484330940133;8404.991401031853;8415.957920210421;8451.32389408852;8458.450200736994;8473.279771219453;36975;37204.81397593022;37246.88259352224;37275;37284.62715372839;3609.5668519777532;3649.5255616769914;3650.324689932371;3652.36083685354;3657.8902632921054;30310.54534181967;30634.69365306341;30699.693003069908;30716.53925191124;30752.692473075207;3144.606924134483;3192.4892017277357;3195.201199700075;3206.9358612827846;3213.935721285585;234956;239210;266017.9999999981;270534.4732763354;270907;36871.631283687355;46756.766216168704;46902.061958760634;47044;47884.760576196895;49204.75397622989;49293.76765580889;49330.013399732525;49389;49451;13739.450421983209;13786.241756703277;13863.306834658428;13908.304584770722;13921.095128816594;11231.21381503287;11326.037286830711;11345.09239260857;11346.0355869752;11381.943090284496;10752.731181720363;13421.932890335682;13432.9253659707;13434.32828358578;13514.729705406033;5996.850078748066;6010.158577799111;6030.879382412327;6060.000099983541;6073.51411887048;983.1741337276721;1039.73486760877;1041.8385150301565;1063.3460421840666;1074.6292529077455;21979.560408791735;24389.878050609634;24436.633450498255;24557.87721061383;24759.87620061888;1136.1478890831877;1136.2841409911703;1153.140910022039;1166.8658104317942;1169.5964892112208;10098.747531311776;12403.689907752198;12534.686632834251;12593.87406125927;12625.242485450903;252992;305617;306275;306430;306723;51488;51683.22475162875;51699;51734.74132629313;51772.48227517752;1486.182599570232;1529.4264650755968;1539.2688472975472;1542.8611424971807;1553.852384023516;23738.643920341554;23750.762492374855;23786.40533986595;23867.880660596587;23907.641385378884;36475.27049458943;36484.63515364812;36583.08542286464;36666.45000324944;36681.816590917944;243581;244654;244708;245573.54426456222;245652;32519.837400812845;33330.83334583312;33820.83089584536;33877;33896.81361152348;43721.56278437302;44190.77904610585;44432.33351499665;44580.77709611431;44708.776456118816;30034.54948175823;30043.849780751832;30670.84664576752;30945.690543094282;31085.22286942754;24729.381765456008;30671.693283066885;30694.539581906734;30784.53823192699;30939.535906960962;35999.820000899825;36027.27945441129;36181.457278140326;36494.087647809014;36816.44775328426;30001.549976750804;31057.844710776302;31174.68825311718;31232.531512027792;31257.37485250328;23331;24140.87929560341;24414.06932784656;24769.876150619133;24783.87608061948 05:18:04 INFO - PID 1968 | |2;jquery.html;429.2316753012108;431.9568043195681;435.223126718807;453.50567881009704;454.63629096722616;19513.99999999998;21178.25876094337;21716.89141554292;21888.671669924923;22012.779872201274;22038.669419958715;22180.778192218073;22419.55160896781;22454;23469.882650586722;6071.058985857188;6229.875402491947;6309.905351419732;6316.810495685137;6324.462420694246;5967;6164.5376596755195;6248.31268560458;6255.280642726077;6257.405546473101;5953.404659534055;6105.32841387447;6163.599366041215;6213.440790328869;6218.31598524162;6075.33171351151;6169.352218017133;6181.165542651729;6181.227346581677;6183.288921773986;5424.647397919122;5442.183672449164;5473.9452605474235;5505.394406615269;5506.311711036121;26445.867770661214;26594;26630.46739065208;26741;27018.72981270182;2047.9043711614215;2239.193890199543;2318.9072437102495;2321.3268152235833;2324.407276144589;17215.311387544483;17345.04602246876;17579.472615821418;17848.643027139384;17962.91018544912;2170.587588358207;2200.4168895242774;2238.2837492002564;2246.9887650561805;2250.707408036961;139411.6058839419;140075.29962350224;140403.5959640411;140739;142391;12274.754504909852;12641.747165056648;12714.364281785874;12798.104132710621;12803.295818729874;16026.515890037062;16285.592860178353;16301.592460188353;16308.064548381168;16312.836871631369;8743;8955.373123881265;8968.641254349883;8977.551122443982;9099.272058235325;8396.160383961676;8487.575621218914;8492.193241642035;8683.609237584324;8685.609147588373;7090.652775972652;7114.608696521637;7808;7894.210578942175;7900.920990790019;2160.2763074370264;2165.220520612578;2173.7065496158134;2174.4889950861534;2194.4075099722986;864.0365991919091;1004.688546550557;1022.2077889635443;1027.1679939249232;1060.3213943076437;20677.793222067587;21620.027098780592;21695.457613559473;21722.674159887298;21836.89081554614;1038.5897570459626;1041.317936751429;1069.550788668761;1072.6031368393587;1086.3481910853582;8822.77943051416;10661.307015043998;11061.72345691348;11182.552697891993;11230;549515;549526;554450;556851;567061;125289.1206631883;130865;132374.67625323817;136974.26051479115;138768;1110.8222684370462;1186.2704436771323;1227.8096894981293;1231.58741821489;1234.4259919137824;17921;18072.72890906611;18228;18273.634527309645;18453;46366.30450543177;50392.23627173031;57846;58079;58438;75407.24592754222;75822.24177758151;77037.61481192558;77155;80116;7381.409487241115;8815.911840881508;8876.689315873913;8909.688160914337;9015.77460563465;10747.355158690503;13428.597142085753;13635.590932272047;14095.013349065466;14136.858631413554;11665.475053622777;11674.182807203415;11907.166498345032;11935;11957.222780519238;10720.19598530129;10949.343039417661;11148.442577870912;11523.827142593036;11944.462499187384;10273.897261027294;11548.364839933884;11572.826407604061;12398.380080996094;12534.623961281177;8857.734267971971;8956.955215223883;9220.290587867978;9245.306602004743;9314.394564353295;11691.473883675086;11874.168808183344;12144.089193310361;12156.574519891761;12261.938690306491 05:18:04 INFO - PID 1968 | |3;mootools.html;1184.8696643369221;1302.583173384517;1369.3495589594938;1406.964825879353;1409.4503143773927;11275.83086253706;11639.476223569938;11740.471678774466;11760.470778814952;11828.704282392944;11614.709632259197;11778.998785103277;11816.172867899251;11824.7635047299;11874.881251187486;2505.523950449418;2530.936726581841;2540.9745902541017;2542.1102614085107;2543.580309248981;2464.778169964703;2482.466269752003;2529;2530.3421110511217;2534.569123249052;2453.582890908541;2504.536660717764;2532.2529853693113;2532.2656429635385;2543.758342957416;2407.2537513370826;2483.6026235802274;2493.6882889638796;2506.3984643685385;2517.307740371394;2310.9653355199684;2327.97672023281;2331.8367714260007;2339.836211465198;2434.6104623260194;11753.706157346049;11817.054635629129;11824.231424957436;11836.99385552229;11848.763024739457;6557.901631475532;6736.696848641823;6753.966230168867;6770.898436523456;6786.219584747768;3700.9074773130887;3991.261616600938;4281.871543853658;4335.284678028122;4364.454443194601;1236.110000799423;1237.4678888078122;1268.6638040919163;1281.135233717237;1283.6919139406568;15950.441734539236;16089.954152980019;16160.838391616051;16208.675826483523;16542.255598497977;4925.236588328815;5253.579713622978;5321.5476684482255;5561.304836895388;5591.41290164535;12417.689557760948;12465.252084874937;12472.81290780639;12475.189112707645;12478.875211247952;6600.966995164993;6669.866602667919;6670.366315200048;6673.099131617169;6676.132102826601;5980.940190598125;6108.847278818065;6132.865419897334;6158.599691020069;6193.473554747807;4278.122984788111;4408.316710909814;4462.843800466968;4487.237169681162;4508.661850361171;1275.2730943362194;1281.135233717237;1283.781757101295;1291.6060601516629;1292.1471828593083;781.8319061401826;801.4470015689155;806.6128258435983;815.6981916690862;834.4951304460835;6088.4824789893355;6094.8171554853425;6313.652749098752;6346.174997250328;6368.872622547523;484.65589431504026;591.5297338615811;592.5111782779225;602.3584882100549;606.0666573476797;3818.255440189192;4105.486814148231;4213.367994800743;4301.956980430218;4381.342798580238;12347.75304493905;14510.694037536672;15130.319135638923;15135.167565783988;15197.012194207342;12022.398880055962;14461.566153015427;14969.700605987819;15054.548363549111;15142.54572362831;7475.813104672427;8433.409661323649;8672.78318042054;8676.566171691391;8704.303655707528;6083.6349819011;6714.899276510759;6927.480438966997;7005;7095.97108419266;12399.628011159679;12740.4266807992;12826.358682066046;12836;12894.29081400532;10709.785804284027;12864.807027894776;12895.806562901376;13001.804972925604;13191.34043297812;9441.008694087022;9540.045995400404;9638.084381983701;9655.662051828152;9694.709158725249;10627.309224900357;10679.412632305297;10726.839097413702;10752.462376881282;10766.138708903425;9117.179453849185;9171.495567743572;9184.943731470967;9215.078492150731;9295.72112836616;8892.33307501927;8950.23922966555;8953.373263871466;9000.68497602607;9099.590518426554;8009.199080092178;8220.83558328842;8226.588670566567;8231.46495477792;8239.093699692909;5971.193888825127;5995;6104.145419641165;6149.569530132848;6196.442320191204;4953.678010929278;5494.36814766307;5959.880802383841;6188.8762224754355;6198.442140207403 05:18:04 INFO - PID 1968 | |4;prototype.html;389.6824088367982;396.57368329046267;397.64808144791857;399.5086044165676;403.7799399327366;5172.78439566702;5639.605227634067;6347.714352854121;6351.269603995542;6376.489880809536;5887.925091626861;6107.938920610793;6119.479844213236;6133.386661333876;6189.319174890769;4129.648979836717;4666.370040044584;4680.812767489305;4698.718076915396;4740.90518189636;3554.484599733037;3853.9229215415676;4729.881752956169;4731.243001119821;4757.595604373615;4496.190685676577;4612.19286624841;4626.768661566908;4661.673682842203;4688.531146885318;4082.632073397452;4594.287885377772;4613.070700105423;4620.699654522446;4642.79107440166;3865.3428917083884;3906.448986930223;4095.7337773044655;4096.566201829336;4117.341225403951;5326.280952071498;5684.943150568482;5957.914729844563;6029.788957386514;6121.816345509642;4451.666125040635;5379.838604841861;5418.485243901823;5423.2136340230445;5423.654324440414;5822.475977162076;6361.650109243989;6608.867822643569;6615.768448104342;6618.874791285493;3648.905328401469;3775.886113596468;4336.414584031147;4345.391645169679;4365.948004437909;6358;6636;6720.596764194115;6923.861522769566;7007.754728584475;4415.911681766347;4416.536263692266;4461.57615026572;4462.576055274743;4463.799129039201;4526.683132180781;4529.524399937959;4537.523560026216;4543.568361005699;4549.613282870927;4310.547392523803;5330.466953304638;5368.704721240291;5379.112446446293;5388;6431.614103153732;6563.409293163638;6619.834504137339;6663.300353462913;6694.263631000586;1406.599119251029;1448.3699590678088;1545.7372246718085;1550.139672481761;1552.4488806473764;986.8766404199475;998.6854140945579;1017.2777328097134;1019.8674172357695;1020.4387586827364;6319.368063193644;6345.524085693592;6354.17395738551;6358.8410289742205;6381.202349706286;5503.807366742225;5981.222441082631;6560.835979100465;6601.240857301375;6805.557638753465;5804.390538993345;6266.561340706106;6292.307846136921;6301.338359472281;6310.432061114522;3093.458644737162;3567.7502574819514;3570.2680950405106;3573.535440392732;3589.4795254687924;6453.386928241809;6846.8576511210995;6943.756968506179;7113.5376200547835;7148.499605027702;6913.965430172817;6980.162380514371;6985.3713165815325;7038.577685338896;7042.366187043191;5854.326752423526;6806.285340039323;7029.297070293134;7066.9752885832295;7156.713731450788;6790.72837086511;6844.623545705034;6872.41584465326;6874.896876546756;6934.549254298455;5482.725863706878;5637.548996080386;6009.609375390585;6478.902816457851;6797.89803152963;6361.554691171574;6836.863262734618;7034.261402552658;7170.318819712119;7209.531380460253;3870.9935416791272;4078.1028173801715;4129.339305711072;4418.779061046999;4437.689361744647;5290.44450332725;6001.129836173643;6226.3151053385;6518.315576864361;6758.222804377363;5387.3804512481565;5501.4223506532835;6441.452476539359;6607;6618.8345291368105;5517.944820551743;6573.455238018966;6616.867662646624;6619.470442364695;6621.801345959629;5831.446012628793;6033.064874944391;6157.476614487819;6398.79241661626;6482.416582507597;5920.7205225987445;6552.868942621216;6553.180852393451;6568.376004279586;6604.273529911802;6203.844903877439;6341.8097457076365;6371.522135839923;6385.265694445198;6385.45723613498 05:18:04 INFO - PID 1968 | |5;yui.html;808.9271965523109;819.2749416766162;824.8391563645091;844.7507985144382;845.8646616541355;14800.259987000662;15173.317200725965;15208.619784505392;17968.910155449204;18619.441416757487;17024;17389.217485213165;17470.126493675296;17494.912525437354;17546.210420531075;940.9482478463682;965.6813251626982;969.5782334684435;973.3478569358512;976.2385339435252;974.7758015656368;984.7095106943433;984.9458279794644;987.072152176955;991.2317953585992;1046.241474930673;1047.1884289675525;1047.8113939490888;1048.6958781953224;1049.669354153443;1034.1829954336065;1042.3641578637064;1043.3374806997535;1043.6034306963343;1043.9530221139992;746.9626518674099;753.8303881626645;760.8250102476406;768.2701433638066;769.4690663442207;16707.164641767864;16899.91550042242;16999.23503442348;17070.231839567125;17096.059716715576;15585.831062670344;16522.58693532659;16757.581060473465;17090.31638734449;17105.802593818436;11797.941010294893;13772.724545509034;13816.309184540733;13819.447222111103;13843.515476958359;3465.6187819339852;3553.34263161316;3592.7485076044686;3600.135967367839;3606.855725770966;113530.86469135285;117590;120105.79894201034;121231;121483;13221.405036773369;13528.59414217575;13552.322383880766;13566.999999999802;13578.981576381811;23823.761762382153;24529.754702453105;24704.13535526284;24993;24997.625035624482;7646.8088297793;7919.168487308865;7927.682892684344;7936.365090792723;7947.602619868983;3860.5946375630156;3892.065904182976;3958.0302825807285;3974.6224108709625;3980.20395920817;4195.895102622398;4338.110687309158;4341.891452713708;4346.239408103569;4354.303311470213;919.4253591505309;943.528235882059;948.1892981500855;958.0276019839868;959.3716115944068;626.8182227154166;627.1877918096077;634.1977398590694;643.5430844100647;668.4785867023729;10853.674389768319;11896.940515297369;11935;11960.282383057045;12070.879291207151;573.2833957553058;618.9632365787288;641.8010416770816;650.3951325267547;652.3118110393485;4896.4858689837765;5141.126008578551;5319.760610772524;5399.973000135053;5428.565714742811;72644;97557;99179;101574;101838.49080754549;65662.67168664222;85038.17328220245;85331;86346.13653863381;91353.54323228341;76586.85119723208;77874.61062694651;78238.60880695673;78293;78585.21414785893;9151.359404841598;10900.182486313399;10996.450177491253;11079.340958170142;11200.103991680484;41004.384934226604;41411;41717;42398.51605193927;42556;53052.20421693755;53156.734216328674;53520.73239633777;53522.929541409736;54165.729171355466;11995.700107497383;13939.790903136663;13979.720405591628;14223.64440888986;14250.643733906736;15417;15533.533993980198;15659.217039148225;15714.449994250146;15745.763813542577;12245.938770306091;14234.501792437215;14283.28583570838;14404.783928241295;14683.48607798722;14313.856861431252;14437.205953672648;14485.710285794014;14579.125252484884;14628.488002919847;14086.943479238893;14240.928795355956;14334.641633959234;14338.928305358406;14362.85637143657;10567.471626418495;10595.94702026485;10599.682009539727;10712.785744285227;10773.461326933779;9311.72064838056;11358.716032099264;11430.771384572428;11473.885261147281;11655.708607284885 05:18:04 INFO - PID 1968 | __end_tp_report 05:18:04 INFO - PID 1968 | __start_cc_report 05:18:04 INFO - PID 1968 | _x_x_mozilla_cycle_collect,421 05:18:04 INFO - PID 1968 | __end_cc_report 05:18:04 INFO - PID 1968 | __startTimestamp1492604284703__endTimestamp 05:18:04 INFO - PID 1968 | 05:18:04 INFO - PID 1968 | ------- Summary: start ------- 05:18:04 INFO - PID 1968 | Number of tests: 6 05:18:04 INFO - PID 1968 | 05:18:04 INFO - PID 1968 | [#0] dojo.html Cycles:165 Average:6077.60 Median:6292.78 stddev:740.46 (11.8%) stddev-sans-first:715.29 05:18:04 INFO - PID 1968 | Values: 3531.9 3601.7 3620.4 3629.4 3650.5 6059.1 6165.0 6203.3 6209.8 6267.2 6150.9 6187.9 6204.9 6205.5 6271.4 5430.9 5445.0 5473.4 5501.8 5556.4 5395.6 5483.9 5543.6 5576.9 5592.4 4749.6 5418.1 5441.7 5473.4 5511.9 4859.4 5223.8 5440.6 5474.8 5483.5 4011.1 5357.8 5404.1 5414.0 5423.2 5576.5 6089.0 6106.6 6185.0 6217.8 6610.8 6650.0 6659.8 6668.8 6711.3 6115.7 6744.6 6766.2 6772.5 6791.7 5005.0 6146.0 6234.9 6326.6 6346.5 5983.4 6527.5 6838.9 6871.1 6875.6 6229.6 6304.1 6398.6 6453.2 6525.8 6655.0 6657.4 6716.1 6723.5 6727.7 5289.4 6562.0 6589.8 6604.4 6620.1 6318.4 6366.1 6469.3 6492.4 6588.1 5353.7 5361.4 5365.5 5386.6 5408.3 4331.4 4445.8 4730.8 4763.5 4793.5 6084.8 6243.7 6250.1 6264.9 6296.0 6768.4 6772.5 6782.2 6786.7 6792.4 6298.1 6320.3 6324.7 6327.5 6346.4 5689.0 5783.7 5796.9 5949.0 5962.1 5659.4 6736.5 6779.3 6858.2 6878.2 5572.2 6733.4 6755.2 6767.7 6773.1 6883.8 6890.9 6915.1 6966.8 6986.6 6364.7 6453.8 6505.1 6583.1 6587.4 6589.4 6734.6 6758.4 6772.1 6789.8 5744.3 6252.7 6265.2 6292.8 6375.2 6309.0 6503.3 6505.4 6540.3 6542.1 6190.8 6253.3 6262.6 6289.9 6342.2 6181.8 6495.6 6543.7 6556.7 6562.8 5340.3 6367.9 6377.2 6397.7 6478.3 05:18:04 INFO - PID 1968 | 05:18:04 INFO - PID 1968 | [#1] ext.html Cycles:180 Average:41968.67 Median:17866.89 stddev:69718.64 (390.2%) stddev-sans-first:69845.52 05:18:04 INFO - PID 1968 | Values: 747.1 789.9 818.6 1242.2 1259.1 37337.1 37961.2 37998.4 38116.0 38128.9 37932.4 38240.8 38277.0 38359.8 38423.6 7881.4 8042.6 8353.8 8605.0 8628.8 8467.7 8555.0 8570.8 8596.7 8600.6 8509.6 8575.4 8586.4 8588.0 8589.5 8540.7 8576.5 8586.4 8588.4 8594.5 8405.0 8416.0 8451.3 8458.5 8473.3 36975.0 37204.8 37246.9 37275.0 37284.6 3609.6 3649.5 3650.3 3652.4 3657.9 30310.5 30634.7 30699.7 30716.5 30752.7 3144.6 3192.5 3195.2 3206.9 3213.9 234956.0 239210.0 266018.0 270534.5 270907.0 36871.6 46756.8 46902.1 47044.0 47884.8 49204.8 49293.8 49330.0 49389.0 49451.0 13739.5 13786.2 13863.3 13908.3 13921.1 11231.2 11326.0 11345.1 11346.0 11381.9 10752.7 13421.9 13432.9 13434.3 13514.7 5996.9 6010.2 6030.9 6060.0 6073.5 983.2 1039.7 1041.8 1063.3 1074.6 21979.6 24389.9 24436.6 24557.9 24759.9 1136.1 1136.3 1153.1 1166.9 1169.6 10098.7 12403.7 12534.7 12593.9 12625.2 252992.0 305617.0 306275.0 306430.0 306723.0 51488.0 51683.2 51699.0 51734.7 51772.5 1486.2 1529.4 1539.3 1542.9 1553.9 23738.6 23750.8 23786.4 23867.9 23907.6 36475.3 36484.6 36583.1 36666.5 36681.8 243581.0 244654.0 244708.0 245573.5 245652.0 32519.8 33330.8 33820.8 33877.0 33896.8 43721.6 44190.8 44432.3 44580.8 44708.8 30034.5 30043.8 30670.8 30945.7 31085.2 24729.4 30671.7 30694.5 30784.5 30939.5 35999.8 36027.3 36181.5 36494.1 36816.4 30001.5 31057.8 31174.7 31232.5 31257.4 23331.0 24140.9 24414.1 24769.9 24783.9 05:18:04 INFO - PID 1968 | 05:18:04 INFO - PID 1968 | [#2] jquery.html Cycles:180 Average:35300.02 Median:22025.72 stddev:93758.19 (425.7%) stddev-sans-first:93984.64 05:18:04 INFO - PID 1968 | Values: 429.2 432.0 435.2 453.5 454.6 19514.0 21178.3 21716.9 21888.7 22012.8 22038.7 22180.8 22419.6 22454.0 23469.9 6071.1 6229.9 6309.9 6316.8 6324.5 5967.0 6164.5 6248.3 6255.3 6257.4 5953.4 6105.3 6163.6 6213.4 6218.3 6075.3 6169.4 6181.2 6181.2 6183.3 5424.6 5442.2 5473.9 5505.4 5506.3 26445.9 26594.0 26630.5 26741.0 27018.7 2047.9 2239.2 2318.9 2321.3 2324.4 17215.3 17345.0 17579.5 17848.6 17962.9 2170.6 2200.4 2238.3 2247.0 2250.7 139411.6 140075.3 140403.6 140739.0 142391.0 12274.8 12641.7 12714.4 12798.1 12803.3 16026.5 16285.6 16301.6 16308.1 16312.8 8743.0 8955.4 8968.6 8977.6 9099.3 8396.2 8487.6 8492.2 8683.6 8685.6 7090.7 7114.6 7808.0 7894.2 7900.9 2160.3 2165.2 2173.7 2174.5 2194.4 864.0 1004.7 1022.2 1027.2 1060.3 20677.8 21620.0 21695.5 21722.7 21836.9 1038.6 1041.3 1069.6 1072.6 1086.3 8822.8 10661.3 11061.7 11182.6 11230.0 549515.0 549526.0 554450.0 556851.0 567061.0 125289.1 130865.0 132374.7 136974.3 138768.0 1110.8 1186.3 1227.8 1231.6 1234.4 17921.0 18072.7 18228.0 18273.6 18453.0 46366.3 50392.2 57846.0 58079.0 58438.0 75407.2 75822.2 77037.6 77155.0 80116.0 7381.4 8815.9 8876.7 8909.7 9015.8 10747.4 13428.6 13635.6 14095.0 14136.9 11665.5 11674.2 11907.2 11935.0 11957.2 10720.2 10949.3 11148.4 11523.8 11944.5 10273.9 11548.4 11572.8 12398.4 12534.6 8857.7 8957.0 9220.3 9245.3 9314.4 11691.5 11874.2 12144.1 12156.6 12261.9 05:18:04 INFO - PID 1968 | 05:18:04 INFO - PID 1968 | [#3] mootools.html Cycles:180 Average:7029.89 Median:3759.58 stddev:4425.46 (117.7%) stddev-sans-first:4416.07 05:18:04 INFO - PID 1968 | Values: 1184.9 1302.6 1369.3 1407.0 1409.5 11275.8 11639.5 11740.5 11760.5 11828.7 11614.7 11779.0 11816.2 11824.8 11874.9 2505.5 2530.9 2541.0 2542.1 2543.6 2464.8 2482.5 2529.0 2530.3 2534.6 2453.6 2504.5 2532.3 2532.3 2543.8 2407.3 2483.6 2493.7 2506.4 2517.3 2311.0 2328.0 2331.8 2339.8 2434.6 11753.7 11817.1 11824.2 11837.0 11848.8 6557.9 6736.7 6754.0 6770.9 6786.2 3700.9 3991.3 4281.9 4335.3 4364.5 1236.1 1237.5 1268.7 1281.1 1283.7 15950.4 16090.0 16160.8 16208.7 16542.3 4925.2 5253.6 5321.5 5561.3 5591.4 12417.7 12465.3 12472.8 12475.2 12478.9 6601.0 6669.9 6670.4 6673.1 6676.1 5980.9 6108.8 6132.9 6158.6 6193.5 4278.1 4408.3 4462.8 4487.2 4508.7 1275.3 1281.1 1283.8 1291.6 1292.1 781.8 801.4 806.6 815.7 834.5 6088.5 6094.8 6313.7 6346.2 6368.9 484.7 591.5 592.5 602.4 606.1 3818.3 4105.5 4213.4 4302.0 4381.3 12347.8 14510.7 15130.3 15135.2 15197.0 12022.4 14461.6 14969.7 15054.5 15142.5 7475.8 8433.4 8672.8 8676.6 8704.3 6083.6 6714.9 6927.5 7005.0 7096.0 12399.6 12740.4 12826.4 12836.0 12894.3 10709.8 12864.8 12895.8 13001.8 13191.3 9441.0 9540.0 9638.1 9655.7 9694.7 10627.3 10679.4 10726.8 10752.5 10766.1 9117.2 9171.5 9184.9 9215.1 9295.7 8892.3 8950.2 8953.4 9000.7 9099.6 8009.2 8220.8 8226.6 8231.5 8239.1 5971.2 5995.0 6104.1 6149.6 6196.4 4953.7 5494.4 5959.9 6188.9 6198.4 05:18:04 INFO - PID 1968 | 05:18:04 INFO - PID 1968 | [#4] prototype.html Cycles:180 Average:5297.04 Median:5969.57 stddev:1669.91 (28.0%) stddev-sans-first:1633.47 05:18:04 INFO - PID 1968 | Values: 389.7 396.6 397.6 399.5 403.8 5172.8 5639.6 6347.7 6351.3 6376.5 5887.9 6107.9 6119.5 6133.4 6189.3 4129.6 4666.4 4680.8 4698.7 4740.9 3554.5 3853.9 4729.9 4731.2 4757.6 4496.2 4612.2 4626.8 4661.7 4688.5 4082.6 4594.3 4613.1 4620.7 4642.8 3865.3 3906.4 4095.7 4096.6 4117.3 5326.3 5684.9 5957.9 6029.8 6121.8 4451.7 5379.8 5418.5 5423.2 5423.7 5822.5 6361.7 6608.9 6615.8 6618.9 3648.9 3775.9 4336.4 4345.4 4365.9 6358.0 6636.0 6720.6 6923.9 7007.8 4415.9 4416.5 4461.6 4462.6 4463.8 4526.7 4529.5 4537.5 4543.6 4549.6 4310.5 5330.5 5368.7 5379.1 5388.0 6431.6 6563.4 6619.8 6663.3 6694.3 1406.6 1448.4 1545.7 1550.1 1552.4 986.9 998.7 1017.3 1019.9 1020.4 6319.4 6345.5 6354.2 6358.8 6381.2 5503.8 5981.2 6560.8 6601.2 6805.6 5804.4 6266.6 6292.3 6301.3 6310.4 3093.5 3567.8 3570.3 3573.5 3589.5 6453.4 6846.9 6943.8 7113.5 7148.5 6914.0 6980.2 6985.4 7038.6 7042.4 5854.3 6806.3 7029.3 7067.0 7156.7 6790.7 6844.6 6872.4 6874.9 6934.5 5482.7 5637.5 6009.6 6478.9 6797.9 6361.6 6836.9 7034.3 7170.3 7209.5 3871.0 4078.1 4129.3 4418.8 4437.7 5290.4 6001.1 6226.3 6518.3 6758.2 5387.4 5501.4 6441.5 6607.0 6618.8 5517.9 6573.5 6616.9 6619.5 6621.8 5831.4 6033.1 6157.5 6398.8 6482.4 5920.7 6552.9 6553.2 6568.4 6604.3 6203.8 6341.8 6371.5 6385.3 6385.5 05:18:04 INFO - PID 1968 | 05:18:04 INFO - PID 1968 | [#5] yui.html Cycles:180 Average:20472.76 Median:24176.76 stddev:28695.18 (118.7%) stddev-sans-first:28737.69 05:18:04 INFO - PID 1968 | Values: 808.9 819.3 824.8 844.8 845.9 14800.3 15173.3 15208.6 17968.9 18619.4 17024.0 17389.2 17470.1 17494.9 17546.2 940.9 965.7 969.6 973.3 976.2 974.8 984.7 984.9 987.1 991.2 1046.2 1047.2 1047.8 1048.7 1049.7 1034.2 1042.4 1043.3 1043.6 1044.0 747.0 753.8 760.8 768.3 769.5 16707.2 16899.9 16999.2 17070.2 17096.1 15585.8 16522.6 16757.6 17090.3 17105.8 11797.9 13772.7 13816.3 13819.4 13843.5 3465.6 3553.3 3592.7 3600.1 3606.9 113530.9 117590.0 120105.8 121231.0 121483.0 13221.4 13528.6 13552.3 13567.0 13579.0 23823.8 24529.8 24704.1 24993.0 24997.6 7646.8 7919.2 7927.7 7936.4 7947.6 3860.6 3892.1 3958.0 3974.6 3980.2 4195.9 4338.1 4341.9 4346.2 4354.3 919.4 943.5 948.2 958.0 959.4 626.8 627.2 634.2 643.5 668.5 10853.7 11896.9 11935.0 11960.3 12070.9 573.3 619.0 641.8 650.4 652.3 4896.5 5141.1 5319.8 5400.0 5428.6 72644.0 97557.0 99179.0 101574.0 101838.5 65662.7 85038.2 85331.0 86346.1 91353.5 76586.9 77874.6 78238.6 78293.0 78585.2 9151.4 10900.2 10996.5 11079.3 11200.1 41004.4 41411.0 41717.0 42398.5 42556.0 53052.2 53156.7 53520.7 53522.9 54165.7 11995.7 13939.8 13979.7 14223.6 14250.6 15417.0 15533.5 15659.2 15714.4 15745.8 12245.9 14234.5 14283.3 14404.8 14683.5 14313.9 14437.2 14485.7 14579.1 14628.5 14086.9 14240.9 14334.6 14338.9 14362.9 10567.5 10595.9 10599.7 10712.8 10773.5 9311.7 11358.7 11430.8 11473.9 11655.7 05:18:04 INFO - PID 1968 | -------- Summary: end -------- 05:18:04 INFO - PID 1968 | 05:18:05 INFO - TEST-INFO | 1968: exit 0 05:18:05 INFO - TEST-OK | dromaeo_css | took 1116182ms 05:18:05 INFO - TEST-START | kraken 05:18:05 INFO - operating with platform_type : mac_ 05:18:05 INFO - Initialising browser for kraken test... 05:18:05 INFO - TEST-INFO | started process 1974 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmp0rvYUk/profile http://localhost:49347/getInfo.html) 05:18:08 INFO - PID 1974 | 2017-04-19 05:18:08.546 plugin-container[1975:12325] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 05:18:08 INFO - PID 1974 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:18:08 INFO - PID 1974 | 2017-04-19 05:18:08.547 plugin-container[1975:12325] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 05:18:08 INFO - PID 1974 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:18:08 INFO - PID 1974 | 2017-04-19 05:18:08.547 plugin-container[1975:12325] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:18:08 INFO - PID 1974 | __metrics Screen width/height:1600/1200 05:18:08 INFO - PID 1974 | colorDepth:24 05:18:08 INFO - PID 1974 | Browser inner width/height: 1024/689 05:18:08 INFO - PID 1974 | __metrics 05:18:08 ERROR - PID 1974 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3385: TypeError: this.tabs is undefined 05:18:09 INFO - TEST-INFO | 1974: exit 0 05:18:09 INFO - Browser initialized. 05:18:09 INFO - Running cycle 1/1 for kraken test... 05:18:09 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmp0rvYUk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:12 INFO - PID 1976 | 2017-04-19 05:18:12.217 plugin-container[1977:12456] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4b, name = 'com.apple.tsm.portname' 05:18:12 INFO - PID 1976 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:18:12 INFO - PID 1976 | 2017-04-19 05:18:12.218 plugin-container[1977:12456] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9017, name = 'com.apple.CFPasteboardClient' 05:18:12 INFO - PID 1976 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:18:12 INFO - PID 1976 | 2017-04-19 05:18:12.218 plugin-container[1977:12456] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:18:22 INFO - PID 1976 | RSS: Main: 235859968 05:18:22 INFO - PID 1976 | 05:18:25 INFO - PID 1976 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-beat-detection) 05:18:26 INFO - PID 1976 | RSS: Main: 248098816 05:18:26 INFO - PID 1976 | 05:18:28 INFO - PID 1976 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-dft) 05:18:29 INFO - PID 1976 | RSS: Main: 256503808 05:18:29 INFO - PID 1976 | 05:18:33 INFO - PID 1976 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-fft) 05:18:33 INFO - PID 1976 | RSS: Main: 258789376 05:18:33 INFO - PID 1976 | 05:18:35 INFO - PID 1976 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-oscillator) 05:18:36 INFO - PID 1976 | RSS: Main: 260124672 05:18:36 INFO - PID 1976 | 05:18:38 INFO - PID 1976 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:18:38 INFO - PID 1976 | RSS: Main: 260485120 05:18:38 INFO - PID 1976 | 05:18:41 INFO - PID 1976 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-darkroom) 05:18:42 INFO - PID 1976 | RSS: Main: 266080256 05:18:42 INFO - PID 1976 | 05:18:45 INFO - PID 1976 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-desaturate) 05:18:46 INFO - PID 1976 | RSS: Main: 267153408 05:18:46 INFO - PID 1976 | 05:18:49 INFO - PID 1976 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49347/tests/kraken/driver.html?testName=json-parse-financial) 05:18:50 INFO - PID 1976 | RSS: Main: 267186176 05:18:50 INFO - PID 1976 | 05:18:51 INFO - PID 1976 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49347/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:18:52 INFO - PID 1976 | RSS: Main: 266313728 05:18:52 INFO - PID 1976 | 05:18:53 INFO - PID 1976 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:18:54 INFO - PID 1976 | RSS: Main: 266338304 05:18:54 INFO - PID 1976 | 05:18:56 INFO - PID 1976 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:18:57 INFO - PID 1976 | RSS: Main: 267464704 05:18:57 INFO - PID 1976 | 05:19:00 INFO - PID 1976 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:19:01 INFO - PID 1976 | RSS: Main: 267571200 05:19:01 INFO - PID 1976 | 05:19:04 INFO - PID 1976 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:19:04 INFO - PID 1976 | RSS: Main: 267423744 05:19:04 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49347/tests/kraken/driver.html?testName=ai-astar) 05:19:06 INFO - PID 1976 | RSS: Main: 269254656 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | __start_tp_report 05:19:06 INFO - PID 1976 | _x_x_mozilla_page_load 05:19:06 INFO - PID 1976 | _x_x_mozilla_page_load_details 05:19:06 INFO - PID 1976 | |i|pagename|runs| 05:19:06 INFO - PID 1976 | |0;ai-astar;103;170;170;100;169;172;125;117;115;115 05:19:06 INFO - PID 1976 | |1;audio-beat-detection;151;116;153;171;122;150;149;114;137;118 05:19:06 INFO - PID 1976 | |2;audio-dft;264;277;225;273;280;222;205;196;195;249 05:19:06 INFO - PID 1976 | |3;audio-fft;86;50;72;116;83;89;67;63;76;60 05:19:06 INFO - PID 1976 | |4;audio-oscillator;83;71;86;72;73;63;105;56;59;74 05:19:06 INFO - PID 1976 | |5;imaging-gaussian-blur;92;85;89;97;136;128;94;91;91;92 05:19:06 INFO - PID 1976 | |6;imaging-darkroom;102;100;154;109;157;156;99;98;99;97 05:19:06 INFO - PID 1976 | |7;imaging-desaturate;92;110;91;91;94;91;91;91;90;90 05:19:06 INFO - PID 1976 | |8;json-parse-financial;51;51;49;51;51;53;51;51;50;52 05:19:06 INFO - PID 1976 | |9;json-stringify-tinderbox;59;60;59;60;64;61;58;61;57;59 05:19:06 INFO - PID 1976 | |10;stanford-crypto-aes;85;82;85;82;83;83;84;84;100;104 05:19:06 INFO - PID 1976 | |11;stanford-crypto-ccm;138;139;152;155;151;139;143;160;190;138 05:19:06 INFO - PID 1976 | |12;stanford-crypto-pbkdf2;188;194;244;194;189;190;193;183;189;185 05:19:06 INFO - PID 1976 | |13;stanford-crypto-sha256-iterative;70;90;95;77;66;69;66;68;83;104 05:19:06 INFO - PID 1976 | __end_tp_report 05:19:06 INFO - PID 1976 | __start_cc_report 05:19:06 INFO - PID 1976 | _x_x_mozilla_cycle_collect,1002 05:19:06 INFO - PID 1976 | __end_cc_report 05:19:06 INFO - PID 1976 | __startTimestamp1492604346905__endTimestamp 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | ------- Summary: start ------- 05:19:06 INFO - PID 1976 | Number of tests: 14 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | [#0] ai-astar Cycles:10 Average:135.60 Median:147.00 stddev:30.63 (20.8%) stddev-sans-first:30.13 05:19:06 INFO - PID 1976 | Values: 103.0 170.0 170.0 100.0 169.0 172.0 125.0 117.0 115.0 115.0 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:149.50 stddev:19.62 (13.1%) stddev-sans-first:20.25 05:19:06 INFO - PID 1976 | Values: 151.0 116.0 153.0 171.0 122.0 150.0 149.0 114.0 137.0 118.0 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | [#2] audio-dft Cycles:10 Average:238.60 Median:256.50 stddev:34.04 (13.3%) stddev-sans-first:34.85 05:19:06 INFO - PID 1976 | Values: 264.0 277.0 225.0 273.0 280.0 222.0 205.0 196.0 195.0 249.0 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | [#3] audio-fft Cycles:10 Average:76.20 Median:74.00 stddev:18.61 (25.1%) stddev-sans-first:19.39 05:19:06 INFO - PID 1976 | Values: 86.0 50.0 72.0 116.0 83.0 89.0 67.0 63.0 76.0 60.0 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | [#4] audio-oscillator Cycles:10 Average:74.20 Median:72.50 stddev:14.41 (19.9%) stddev-sans-first:14.93 05:19:06 INFO - PID 1976 | Values: 83.0 71.0 86.0 72.0 73.0 63.0 105.0 56.0 59.0 74.0 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | [#5] imaging-gaussian-blur Cycles:10 Average:99.50 Median:91.50 stddev:17.51 (19.1%) stddev-sans-first:18.36 05:19:06 INFO - PID 1976 | Values: 92.0 85.0 89.0 97.0 136.0 128.0 94.0 91.0 91.0 92.0 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | [#6] imaging-darkroom Cycles:10 Average:117.10 Median:127.00 stddev:26.83 (21.1%) stddev-sans-first:27.89 05:19:06 INFO - PID 1976 | Values: 102.0 100.0 154.0 109.0 157.0 156.0 99.0 98.0 99.0 97.0 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | [#7] imaging-desaturate Cycles:10 Average:93.10 Median:91.00 stddev:6.05 (6.6%) stddev-sans-first:6.40 05:19:06 INFO - PID 1976 | Values: 92.0 110.0 91.0 91.0 94.0 91.0 91.0 91.0 90.0 90.0 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:1.05 (2.1%) stddev-sans-first:1.12 05:19:06 INFO - PID 1976 | Values: 51.0 51.0 49.0 51.0 51.0 53.0 51.0 51.0 50.0 52.0 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:1.93 (3.2%) stddev-sans-first:2.03 05:19:06 INFO - PID 1976 | Values: 59.0 60.0 59.0 60.0 64.0 61.0 58.0 61.0 57.0 59.0 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:83.50 stddev:7.93 (9.5%) stddev-sans-first:8.37 05:19:06 INFO - PID 1976 | Values: 85.0 82.0 85.0 82.0 83.0 83.0 84.0 84.0 100.0 104.0 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:151.50 stddev:16.01 (10.6%) stddev-sans-first:16.33 05:19:06 INFO - PID 1976 | Values: 138.0 139.0 152.0 155.0 151.0 139.0 143.0 160.0 190.0 138.0 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.90 Median:191.50 stddev:17.63 (9.2%) stddev-sans-first:18.52 05:19:06 INFO - PID 1976 | Values: 188.0 194.0 244.0 194.0 189.0 190.0 193.0 183.0 189.0 185.0 05:19:06 INFO - PID 1976 | 05:19:06 INFO - PID 1976 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.80 Median:73.50 stddev:13.59 (18.5%) stddev-sans-first:14.03 05:19:06 INFO - PID 1976 | Values: 70.0 90.0 95.0 77.0 66.0 69.0 66.0 68.0 83.0 104.0 05:19:06 INFO - PID 1976 | -------- Summary: end -------- 05:19:06 INFO - PID 1976 | 05:19:07 INFO - TEST-INFO | 1976: exit 0 05:19:08 INFO - TEST-OK | kraken | took 62575ms 05:19:08 INFO - SUITE-END | took 1178s 05:19:08 INFO - Completed test suite (00:19:38) 05:19:08 INFO - javascript benchmark 05:19:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7763.967157816059, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3531.8763843265483, 3601.657842504963, 3620.3664358737215, 3629.3830048891687, 3650.4524321351796, 6059.0608455689435, 6165.0, 6203.348648391921, 6209.751609935603, 6267.2165979252595, 6150.938490615093, 6187.876242475148, 6204.906926396107, 6205.503559715224, 6271.404216599416, 5430.91853622196, 5445.0, 5473.397926228112, 5501.752421141058, 5556.416576259475, 5395.649282796606, 5483.945160548384, 5543.556515478752, 5576.86057848553, 5592.4407559244155, 4749.596284315838, 5418.106012507971, 5441.673499589998, 5473.425290344497, 5511.917321240185, 4859.368282123337, 5223.764930578133, 5440.646357986719, 5474.7810087596445, 5483.451654834525, 4011.13760541485, 5357.785688572452, 5404.054290499147, 5414.0, 5423.186522021689, 5576.525995290405, 6088.969555152196, 6106.642687876592, 6184.969075154595, 6217.751289948396, 6610.768623098216, 6649.966750166266, 6659.833504162386, 6668.83327916806, 6711.261761206312, 6115.746272014227, 6744.561603495807, 6766.18805743314, 6772.458203343721, 6791.660416979132, 5005.0240203160765, 6145.985912324416, 6234.87530249397, 6326.620402775849, 6346.524010699216, 5983.401659833982, 6527.510436717265, 6838.897416538756, 6871.106756121672, 6875.5530890491955, 6229.56393052482, 6304.085907543472, 6398.584092034003, 6453.1610890583925, 6525.771597994048, 6655.0, 6657.400833924873, 6716.093327400738, 6723.5293529452465, 6727.66361681914, 5289.444608316071, 6562.0, 6589.80230593083, 6604.438622717123, 6620.073189753439, 6318.368163183737, 6366.108744775735, 6469.256035555877, 6492.415682588589, 6588.143541339691, 5353.705546194997, 5361.383440904346, 5365.463453654604, 5386.622936394415, 5408.296921400193, 4331.350297455344, 4445.777711114431, 4730.810767569259, 4763.45220299663, 4793.544613261734, 6084.817455476343, 6243.719032643542, 6250.093736408196, 6264.906026409608, 6296.024116261987, 6768.424683901825, 6772.492063095287, 6782.2200446948245, 6786.694598743068, 6792.42264407521, 6298.118263443122, 6320.27316858558, 6324.652144132025, 6327.4938004959495, 6346.428821406095, 5688.9715551422805, 5783.739731712083, 5796.855078623068, 5949.0, 5962.135490353874, 5659.434056594308, 6736.461083113437, 6779.254282029072, 6858.177018757781, 6878.209005964378, 5572.219889215432, 6733.360330768569, 6755.189377274562, 6767.695453704693, 6773.05177275172, 6883.7590684325805, 6890.8621827562165, 6915.066466027022, 6966.79099627012, 6986.615736134561, 6364.681765911593, 6453.774117906039, 6505.121808555785, 6583.078369028244, 6587.4071333580205, 6589.374009469093, 6734.595924244561, 6758.357955994173, 6772.051912732123, 6789.762358317435, 5744.253247077853, 6252.749890004349, 6265.154204182377, 6292.779752708633, 6375.171227740364, 6309.0, 6503.2846386898345, 6505.447037001908, 6540.345965403612, 6542.149520562297, 6190.7523699051535, 6253.280872699698, 6262.624242545462, 6289.937100628935, 6342.23893132827, 6181.84545386369, 6495.642739649175, 6543.672816359068, 6556.737730490918, 6562.8359291018105, 5340.279062326536, 6367.936320636734, 6377.23473183221, 6397.680115994275, 6478.2550006749825], "value": 6030.833751193635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.122131495493, 789.905211374635, 818.5620692929284, 1242.217403036087, 1259.124908188809, 37337.06657333564, 37961.24077518448, 37998.43002354967, 38116.0, 38128.85613431598, 37932.43101353475, 38240.80879595605, 38277.04307392317, 38359.80820095903, 38423.615763842354, 7881.369490440766, 8042.5978701065005, 8353.791155221108, 8604.967403911509, 8628.784280393009, 8467.66129354825, 8555.0, 8570.828583428327, 8596.699115530957, 8600.56997150143, 8509.574521273942, 8575.442596231256, 8586.398952073358, 8588.0, 8589.484630922134, 8540.743777686648, 8576.485410875304, 8586.44188127776, 8588.441751286146, 8594.484330940133, 8404.991401031853, 8415.957920210421, 8451.32389408852, 8458.450200736994, 8473.279771219453, 36975.0, 37204.81397593022, 37246.88259352224, 37275.0, 37284.62715372839, 3609.5668519777532, 3649.5255616769914, 3650.324689932371, 3652.36083685354, 3657.8902632921054, 30310.54534181967, 30634.69365306341, 30699.693003069908, 30716.53925191124, 30752.692473075207, 3144.606924134483, 3192.4892017277357, 3195.201199700075, 3206.9358612827846, 3213.935721285585, 234956.0, 239210.0, 266017.9999999981, 270534.4732763354, 270907.0, 36871.631283687355, 46756.766216168704, 46902.061958760634, 47044.0, 47884.760576196895, 49204.75397622989, 49293.76765580889, 49330.013399732525, 49389.0, 49451.0, 13739.450421983209, 13786.241756703277, 13863.306834658428, 13908.304584770722, 13921.095128816594, 11231.21381503287, 11326.037286830711, 11345.09239260857, 11346.0355869752, 11381.943090284496, 10752.731181720363, 13421.932890335682, 13432.9253659707, 13434.32828358578, 13514.729705406033, 5996.850078748066, 6010.158577799111, 6030.879382412327, 6060.000099983541, 6073.51411887048, 983.1741337276721, 1039.73486760877, 1041.8385150301565, 1063.3460421840666, 1074.6292529077455, 21979.560408791735, 24389.878050609634, 24436.633450498255, 24557.87721061383, 24759.87620061888, 1136.1478890831877, 1136.2841409911703, 1153.140910022039, 1166.8658104317942, 1169.5964892112208, 10098.747531311776, 12403.689907752198, 12534.686632834251, 12593.87406125927, 12625.242485450903, 252992.0, 305617.0, 306275.0, 306430.0, 306723.0, 51488.0, 51683.22475162875, 51699.0, 51734.74132629313, 51772.48227517752, 1486.182599570232, 1529.4264650755968, 1539.2688472975472, 1542.8611424971807, 1553.852384023516, 23738.643920341554, 23750.762492374855, 23786.40533986595, 23867.880660596587, 23907.641385378884, 36475.27049458943, 36484.63515364812, 36583.08542286464, 36666.45000324944, 36681.816590917944, 243581.0, 244654.0, 244708.0, 245573.54426456222, 245652.0, 32519.837400812845, 33330.83334583312, 33820.83089584536, 33877.0, 33896.81361152348, 43721.56278437302, 44190.77904610585, 44432.33351499665, 44580.77709611431, 44708.776456118816, 30034.54948175823, 30043.849780751832, 30670.84664576752, 30945.690543094282, 31085.22286942754, 24729.381765456008, 30671.693283066885, 30694.539581906734, 30784.53823192699, 30939.535906960962, 35999.820000899825, 36027.27945441129, 36181.457278140326, 36494.087647809014, 36816.44775328426, 30001.549976750804, 31057.844710776302, 31174.68825311718, 31232.531512027792, 31257.37485250328, 23331.0, 24140.87929560341, 24414.06932784656, 24769.876150619133, 24783.87608061948], "value": 17290.522727390056, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.2316753012108, 431.9568043195681, 435.223126718807, 453.50567881009704, 454.63629096722616, 19513.99999999998, 21178.25876094337, 21716.89141554292, 21888.671669924923, 22012.779872201274, 22038.669419958715, 22180.778192218073, 22419.55160896781, 22454.0, 23469.882650586722, 6071.058985857188, 6229.875402491947, 6309.905351419732, 6316.810495685137, 6324.462420694246, 5967.0, 6164.5376596755195, 6248.31268560458, 6255.280642726077, 6257.405546473101, 5953.404659534055, 6105.32841387447, 6163.599366041215, 6213.440790328869, 6218.31598524162, 6075.33171351151, 6169.352218017133, 6181.165542651729, 6181.227346581677, 6183.288921773986, 5424.647397919122, 5442.183672449164, 5473.9452605474235, 5505.394406615269, 5506.311711036121, 26445.867770661214, 26594.0, 26630.46739065208, 26741.0, 27018.72981270182, 2047.9043711614215, 2239.193890199543, 2318.9072437102495, 2321.3268152235833, 2324.407276144589, 17215.311387544483, 17345.04602246876, 17579.472615821418, 17848.643027139384, 17962.91018544912, 2170.587588358207, 2200.4168895242774, 2238.2837492002564, 2246.9887650561805, 2250.707408036961, 139411.6058839419, 140075.29962350224, 140403.5959640411, 140739.0, 142391.0, 12274.754504909852, 12641.747165056648, 12714.364281785874, 12798.104132710621, 12803.295818729874, 16026.515890037062, 16285.592860178353, 16301.592460188353, 16308.064548381168, 16312.836871631369, 8743.0, 8955.373123881265, 8968.641254349883, 8977.551122443982, 9099.272058235325, 8396.160383961676, 8487.575621218914, 8492.193241642035, 8683.609237584324, 8685.609147588373, 7090.652775972652, 7114.608696521637, 7808.0, 7894.210578942175, 7900.920990790019, 2160.2763074370264, 2165.220520612578, 2173.7065496158134, 2174.4889950861534, 2194.4075099722986, 864.0365991919091, 1004.688546550557, 1022.2077889635443, 1027.1679939249232, 1060.3213943076437, 20677.793222067587, 21620.027098780592, 21695.457613559473, 21722.674159887298, 21836.89081554614, 1038.5897570459626, 1041.317936751429, 1069.550788668761, 1072.6031368393587, 1086.3481910853582, 8822.77943051416, 10661.307015043998, 11061.72345691348, 11182.552697891993, 11230.0, 549515.0, 549526.0, 554450.0, 556851.0, 567061.0, 125289.1206631883, 130865.0, 132374.67625323817, 136974.26051479115, 138768.0, 1110.8222684370462, 1186.2704436771323, 1227.8096894981293, 1231.58741821489, 1234.4259919137824, 17921.0, 18072.72890906611, 18228.0, 18273.634527309645, 18453.0, 46366.30450543177, 50392.23627173031, 57846.0, 58079.0, 58438.0, 75407.24592754222, 75822.24177758151, 77037.61481192558, 77155.0, 80116.0, 7381.409487241115, 8815.911840881508, 8876.689315873913, 8909.688160914337, 9015.77460563465, 10747.355158690503, 13428.597142085753, 13635.590932272047, 14095.013349065466, 14136.858631413554, 11665.475053622777, 11674.182807203415, 11907.166498345032, 11935.0, 11957.222780519238, 10720.19598530129, 10949.343039417661, 11148.442577870912, 11523.827142593036, 11944.462499187384, 10273.897261027294, 11548.364839933884, 11572.826407604061, 12398.380080996094, 12534.623961281177, 8857.734267971971, 8956.955215223883, 9220.290587867978, 9245.306602004743, 9314.394564353295, 11691.473883675086, 11874.168808183344, 12144.089193310361, 12156.574519891761, 12261.938690306491], "value": 10427.980658058554, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1184.8696643369221, 1302.583173384517, 1369.3495589594938, 1406.964825879353, 1409.4503143773927, 11275.83086253706, 11639.476223569938, 11740.471678774466, 11760.470778814952, 11828.704282392944, 11614.709632259197, 11778.998785103277, 11816.172867899251, 11824.7635047299, 11874.881251187486, 2505.523950449418, 2530.936726581841, 2540.9745902541017, 2542.1102614085107, 2543.580309248981, 2464.778169964703, 2482.466269752003, 2529.0, 2530.3421110511217, 2534.569123249052, 2453.582890908541, 2504.536660717764, 2532.2529853693113, 2532.2656429635385, 2543.758342957416, 2407.2537513370826, 2483.6026235802274, 2493.6882889638796, 2506.3984643685385, 2517.307740371394, 2310.9653355199684, 2327.97672023281, 2331.8367714260007, 2339.836211465198, 2434.6104623260194, 11753.706157346049, 11817.054635629129, 11824.231424957436, 11836.99385552229, 11848.763024739457, 6557.901631475532, 6736.696848641823, 6753.966230168867, 6770.898436523456, 6786.219584747768, 3700.9074773130887, 3991.261616600938, 4281.871543853658, 4335.284678028122, 4364.454443194601, 1236.110000799423, 1237.4678888078122, 1268.6638040919163, 1281.135233717237, 1283.6919139406568, 15950.441734539236, 16089.954152980019, 16160.838391616051, 16208.675826483523, 16542.255598497977, 4925.236588328815, 5253.579713622978, 5321.5476684482255, 5561.304836895388, 5591.41290164535, 12417.689557760948, 12465.252084874937, 12472.81290780639, 12475.189112707645, 12478.875211247952, 6600.966995164993, 6669.866602667919, 6670.366315200048, 6673.099131617169, 6676.132102826601, 5980.940190598125, 6108.847278818065, 6132.865419897334, 6158.599691020069, 6193.473554747807, 4278.122984788111, 4408.316710909814, 4462.843800466968, 4487.237169681162, 4508.661850361171, 1275.2730943362194, 1281.135233717237, 1283.781757101295, 1291.6060601516629, 1292.1471828593083, 781.8319061401826, 801.4470015689155, 806.6128258435983, 815.6981916690862, 834.4951304460835, 6088.4824789893355, 6094.8171554853425, 6313.652749098752, 6346.174997250328, 6368.872622547523, 484.65589431504026, 591.5297338615811, 592.5111782779225, 602.3584882100549, 606.0666573476797, 3818.255440189192, 4105.486814148231, 4213.367994800743, 4301.956980430218, 4381.342798580238, 12347.75304493905, 14510.694037536672, 15130.319135638923, 15135.167565783988, 15197.012194207342, 12022.398880055962, 14461.566153015427, 14969.700605987819, 15054.548363549111, 15142.54572362831, 7475.813104672427, 8433.409661323649, 8672.78318042054, 8676.566171691391, 8704.303655707528, 6083.6349819011, 6714.899276510759, 6927.480438966997, 7005.0, 7095.97108419266, 12399.628011159679, 12740.4266807992, 12826.358682066046, 12836.0, 12894.29081400532, 10709.785804284027, 12864.807027894776, 12895.806562901376, 13001.804972925604, 13191.34043297812, 9441.008694087022, 9540.045995400404, 9638.084381983701, 9655.662051828152, 9694.709158725249, 10627.309224900357, 10679.412632305297, 10726.839097413702, 10752.462376881282, 10766.138708903425, 9117.179453849185, 9171.495567743572, 9184.943731470967, 9215.078492150731, 9295.72112836616, 8892.33307501927, 8950.23922966555, 8953.373263871466, 9000.68497602607, 9099.590518426554, 8009.199080092178, 8220.83558328842, 8226.588670566567, 8231.46495477792, 8239.093699692909, 5971.193888825127, 5995.0, 6104.145419641165, 6149.569530132848, 6196.442320191204, 4953.678010929278, 5494.36814766307, 5959.880802383841, 6188.8762224754355, 6198.442140207403], "value": 5271.4547231060815, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.6824088367982, 396.57368329046267, 397.64808144791857, 399.5086044165676, 403.7799399327366, 5172.78439566702, 5639.605227634067, 6347.714352854121, 6351.269603995542, 6376.489880809536, 5887.925091626861, 6107.938920610793, 6119.479844213236, 6133.386661333876, 6189.319174890769, 4129.648979836717, 4666.370040044584, 4680.812767489305, 4698.718076915396, 4740.90518189636, 3554.484599733037, 3853.9229215415676, 4729.881752956169, 4731.243001119821, 4757.595604373615, 4496.190685676577, 4612.19286624841, 4626.768661566908, 4661.673682842203, 4688.531146885318, 4082.632073397452, 4594.287885377772, 4613.070700105423, 4620.699654522446, 4642.79107440166, 3865.3428917083884, 3906.448986930223, 4095.7337773044655, 4096.566201829336, 4117.341225403951, 5326.280952071498, 5684.943150568482, 5957.914729844563, 6029.788957386514, 6121.816345509642, 4451.666125040635, 5379.838604841861, 5418.485243901823, 5423.2136340230445, 5423.654324440414, 5822.475977162076, 6361.650109243989, 6608.867822643569, 6615.768448104342, 6618.874791285493, 3648.905328401469, 3775.886113596468, 4336.414584031147, 4345.391645169679, 4365.948004437909, 6358.0, 6636.0, 6720.596764194115, 6923.861522769566, 7007.754728584475, 4415.911681766347, 4416.536263692266, 4461.57615026572, 4462.576055274743, 4463.799129039201, 4526.683132180781, 4529.524399937959, 4537.523560026216, 4543.568361005699, 4549.613282870927, 4310.547392523803, 5330.466953304638, 5368.704721240291, 5379.112446446293, 5388.0, 6431.614103153732, 6563.409293163638, 6619.834504137339, 6663.300353462913, 6694.263631000586, 1406.599119251029, 1448.3699590678088, 1545.7372246718085, 1550.139672481761, 1552.4488806473764, 986.8766404199475, 998.6854140945579, 1017.2777328097134, 1019.8674172357695, 1020.4387586827364, 6319.368063193644, 6345.524085693592, 6354.17395738551, 6358.8410289742205, 6381.202349706286, 5503.807366742225, 5981.222441082631, 6560.835979100465, 6601.240857301375, 6805.557638753465, 5804.390538993345, 6266.561340706106, 6292.307846136921, 6301.338359472281, 6310.432061114522, 3093.458644737162, 3567.7502574819514, 3570.2680950405106, 3573.535440392732, 3589.4795254687924, 6453.386928241809, 6846.8576511210995, 6943.756968506179, 7113.5376200547835, 7148.499605027702, 6913.965430172817, 6980.162380514371, 6985.3713165815325, 7038.577685338896, 7042.366187043191, 5854.326752423526, 6806.285340039323, 7029.297070293134, 7066.9752885832295, 7156.713731450788, 6790.72837086511, 6844.623545705034, 6872.41584465326, 6874.896876546756, 6934.549254298455, 5482.725863706878, 5637.548996080386, 6009.609375390585, 6478.902816457851, 6797.89803152963, 6361.554691171574, 6836.863262734618, 7034.261402552658, 7170.318819712119, 7209.531380460253, 3870.9935416791272, 4078.1028173801715, 4129.339305711072, 4418.779061046999, 4437.689361744647, 5290.44450332725, 6001.129836173643, 6226.3151053385, 6518.315576864361, 6758.222804377363, 5387.3804512481565, 5501.4223506532835, 6441.452476539359, 6607.0, 6618.8345291368105, 5517.944820551743, 6573.455238018966, 6616.867662646624, 6619.470442364695, 6621.801345959629, 5831.446012628793, 6033.064874944391, 6157.476614487819, 6398.79241661626, 6482.416582507597, 5920.7205225987445, 6552.868942621216, 6553.180852393451, 6568.376004279586, 6604.273529911802, 6203.844903877439, 6341.8097457076365, 6371.522135839923, 6385.265694445198, 6385.45723613498], "value": 4774.779616154264, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.9271965523109, 819.2749416766162, 824.8391563645091, 844.7507985144382, 845.8646616541355, 14800.259987000662, 15173.317200725965, 15208.619784505392, 17968.910155449204, 18619.441416757487, 17024.0, 17389.217485213165, 17470.126493675296, 17494.912525437354, 17546.210420531075, 940.9482478463682, 965.6813251626982, 969.5782334684435, 973.3478569358512, 976.2385339435252, 974.7758015656368, 984.7095106943433, 984.9458279794644, 987.072152176955, 991.2317953585992, 1046.241474930673, 1047.1884289675525, 1047.8113939490888, 1048.6958781953224, 1049.669354153443, 1034.1829954336065, 1042.3641578637064, 1043.3374806997535, 1043.6034306963343, 1043.9530221139992, 746.9626518674099, 753.8303881626645, 760.8250102476406, 768.2701433638066, 769.4690663442207, 16707.164641767864, 16899.91550042242, 16999.23503442348, 17070.231839567125, 17096.059716715576, 15585.831062670344, 16522.58693532659, 16757.581060473465, 17090.31638734449, 17105.802593818436, 11797.941010294893, 13772.724545509034, 13816.309184540733, 13819.447222111103, 13843.515476958359, 3465.6187819339852, 3553.34263161316, 3592.7485076044686, 3600.135967367839, 3606.855725770966, 113530.86469135285, 117590.0, 120105.79894201034, 121231.0, 121483.0, 13221.405036773369, 13528.59414217575, 13552.322383880766, 13566.999999999802, 13578.981576381811, 23823.761762382153, 24529.754702453105, 24704.13535526284, 24993.0, 24997.625035624482, 7646.8088297793, 7919.168487308865, 7927.682892684344, 7936.365090792723, 7947.602619868983, 3860.5946375630156, 3892.065904182976, 3958.0302825807285, 3974.6224108709625, 3980.20395920817, 4195.895102622398, 4338.110687309158, 4341.891452713708, 4346.239408103569, 4354.303311470213, 919.4253591505309, 943.528235882059, 948.1892981500855, 958.0276019839868, 959.3716115944068, 626.8182227154166, 627.1877918096077, 634.1977398590694, 643.5430844100647, 668.4785867023729, 10853.674389768319, 11896.940515297369, 11935.0, 11960.282383057045, 12070.879291207151, 573.2833957553058, 618.9632365787288, 641.8010416770816, 650.3951325267547, 652.3118110393485, 4896.4858689837765, 5141.126008578551, 5319.760610772524, 5399.973000135053, 5428.565714742811, 72644.0, 97557.0, 99179.0, 101574.0, 101838.49080754549, 65662.67168664222, 85038.17328220245, 85331.0, 86346.13653863381, 91353.54323228341, 76586.85119723208, 77874.61062694651, 78238.60880695673, 78293.0, 78585.21414785893, 9151.359404841598, 10900.182486313399, 10996.450177491253, 11079.340958170142, 11200.103991680484, 41004.384934226604, 41411.0, 41717.0, 42398.51605193927, 42556.0, 53052.20421693755, 53156.734216328674, 53520.73239633777, 53522.929541409736, 54165.729171355466, 11995.700107497383, 13939.790903136663, 13979.720405591628, 14223.64440888986, 14250.643733906736, 15417.0, 15533.533993980198, 15659.217039148225, 15714.449994250146, 15745.763813542577, 12245.938770306091, 14234.501792437215, 14283.28583570838, 14404.783928241295, 14683.48607798722, 14313.856861431252, 14437.205953672648, 14485.710285794014, 14579.125252484884, 14628.488002919847, 14086.943479238893, 14240.928795355956, 14334.641633959234, 14338.928305358406, 14362.85637143657, 10567.471626418495, 10595.94702026485, 10599.682009539727, 10712.785744285227, 10773.461326933779, 9311.72064838056, 11358.716032099264, 11430.771384572428, 11473.885261147281, 11655.708607284885], "value": 8002.061197288919, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 170.0, 170.0, 100.0, 169.0, 172.0, 125.0, 117.0, 115.0, 115.0], "value": 135.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 153.0, 171.0, 122.0, 150.0, 149.0, 114.0, 137.0, 118.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [264.0, 277.0, 225.0, 273.0, 280.0, 222.0, 205.0, 196.0, 195.0, 249.0], "value": 238.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 50.0, 72.0, 116.0, 83.0, 89.0, 67.0, 63.0, 76.0, 60.0], "value": 76.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 86.0, 72.0, 73.0, 63.0, 105.0, 56.0, 59.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 85.0, 89.0, 97.0, 136.0, 128.0, 94.0, 91.0, 91.0, 92.0], "value": 99.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 100.0, 154.0, 109.0, 157.0, 156.0, 99.0, 98.0, 99.0, 97.0], "value": 117.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 110.0, 91.0, 91.0, 94.0, 91.0, 91.0, 91.0, 90.0, 90.0], "value": 93.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 49.0, 51.0, 51.0, 53.0, 51.0, 51.0, 50.0, 52.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 64.0, 61.0, 58.0, 61.0, 57.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 85.0, 82.0, 83.0, 83.0, 84.0, 84.0, 100.0, 104.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 152.0, 155.0, 151.0, 139.0, 143.0, 160.0, 190.0, 138.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 194.0, 244.0, 194.0, 189.0, 190.0, 193.0, 183.0, 189.0, 185.0], "value": 194.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 90.0, 95.0, 77.0, 66.0, 69.0, 66.0, 68.0, 83.0, 104.0], "value": 78.8, "unit": "score"}]}]} 05:19:08 INFO - Return code: 0 05:19:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:19:08 ERROR - # TBPL SUCCESS # 05:19:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:19:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:19:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:19:08 INFO - 2017-04-19 05:19:08.195 screenresolution[1983:12894] starting screenresolution argv=screenresolution get 05:19:08 INFO - 2017-04-19 05:19:08.198 screenresolution[1983:12894] Display 0: 1600x1200x32@60 05:19:08 INFO - 2017-04-19 05:19:08.204 screenresolution[1984:12897] starting screenresolution argv=screenresolution list 05:19:08 INFO - Available Modes on Display 0 05:19:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:19:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:19:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:19:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:19:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:19:08 INFO - Intel Iris: 05:19:08 INFO - Chipset Model: Intel Iris 05:19:08 INFO - Type: GPU 05:19:08 INFO - Bus: Built-In 05:19:08 INFO - VRAM (Dynamic, Max): 1536 MB 05:19:08 INFO - Vendor: Intel (0x8086) 05:19:08 INFO - Device ID: 0x0a2e 05:19:08 INFO - Revision ID: 0x0009 05:19:08 INFO - Displays: 05:19:08 INFO - Display: 05:19:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:19:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:19:08 INFO - Display Serial Number: 1600x1200 60 05:19:08 INFO - Main Display: Yes 05:19:08 INFO - Mirror: Off 05:19:08 INFO - Online: Yes 05:19:08 INFO - Rotation: Supported 05:19:08 INFO - Return code: 0 05:19:08 INFO - Running post-action listener: _resource_record_post_action 05:19:08 INFO - [mozharness: 2017-04-19 12:19:08.452927Z] Finished run-tests step (success) 05:19:08 INFO - Running post-run listener: _resource_record_post_run 05:19:08 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 553472; Write bytes: 514712576; Read time: 11; Write time: 1679 05:19:08 INFO - TinderboxPrint: CPU usage
54.1% 05:19:08 INFO - TinderboxPrint: I/O read bytes / time
553,472 / 11 05:19:08 INFO - TinderboxPrint: I/O write bytes / time
514,712,576 / 1,679 05:19:08 INFO - TinderboxPrint: CPU idle
2,203.5 (45.9%) 05:19:08 INFO - TinderboxPrint: CPU system
963.7 (20.1%) 05:19:08 INFO - TinderboxPrint: CPU user
1,630.5 (34.0%) 05:19:08 INFO - TinderboxPrint: Swap in / out
208,797,696 / 0 05:19:08 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 204042752; Write bytes: 202895360; Read time: 16201; Write time: 439 05:19:08 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 553472; Write bytes: 304972800; Read time: 11; Write time: 1210 05:19:08 INFO - Running post-run listener: _upload_blobber_files 05:19:08 INFO - Blob upload gear active. 05:19:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:19:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:19:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:19:09 INFO - (blobuploader) - INFO - Open directory for files ... 05:19:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:19:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:19:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:10 INFO - (blobuploader) - INFO - Done attempting. 05:19:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:19:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:19:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:11 INFO - (blobuploader) - INFO - Done attempting. 05:19:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:19:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:19:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:12 INFO - (blobuploader) - INFO - Done attempting. 05:19:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:19:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:19:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:19:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:19:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:19:14 INFO - (blobuploader) - INFO - Done attempting. 05:19:14 INFO - (blobuploader) - INFO - Iteration through files over. 05:19:14 INFO - Return code: 0 05:19:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:19:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:19:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccd1fb719c268b71c4d13aacad70a6def6f67247934430f9b0de5592194fe67907c703d1b50933c90787480fe357c291672b18a5616c07bea9ac14aebfa10ca1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c4edd97f1cd32301a0757dc50e15aff84f09fdd82b1231f78ce3dd9344a4f55daa4a7aa9c59ca974e386262f2f762a4a1a6687ed6aadaf1052f21341f29b7ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f79b0ce2de4e36fbd9bfb6c5f2e66b18ddb16290348a65bd319586810014c24a9582a28187ded2d2dcf807784602143fc33433e413a07672dd96982d23c7de04", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a4ee157f33e0ed8f74271167eeac5ebdfd4702a84ed2d1a7b8baf2fa83e792e7adb66be64842add0f9fc091fe4bb62f8e22cfc389f2ef29c1c6a5e9983279c3"} 05:19:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:19:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:19:14 INFO - Contents: 05:19:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccd1fb719c268b71c4d13aacad70a6def6f67247934430f9b0de5592194fe67907c703d1b50933c90787480fe357c291672b18a5616c07bea9ac14aebfa10ca1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c4edd97f1cd32301a0757dc50e15aff84f09fdd82b1231f78ce3dd9344a4f55daa4a7aa9c59ca974e386262f2f762a4a1a6687ed6aadaf1052f21341f29b7ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f79b0ce2de4e36fbd9bfb6c5f2e66b18ddb16290348a65bd319586810014c24a9582a28187ded2d2dcf807784602143fc33433e413a07672dd96982d23c7de04", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a4ee157f33e0ed8f74271167eeac5ebdfd4702a84ed2d1a7b8baf2fa83e792e7adb66be64842add0f9fc091fe4bb62f8e22cfc389f2ef29c1c6a5e9983279c3"} 05:19:14 INFO - Running post-run listener: copy_logs_to_upload_dir 05:19:14 INFO - Copying logs to upload dir... 05:19:14 INFO - mkdir: /builds/slave/test/build/upload/logs 05:19:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1301.701090 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2017-04-19 05:19:14.955182) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 05:19:14.963209) ========= 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.elB6rdnwTZ/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.BN9o00orkH/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccd1fb719c268b71c4d13aacad70a6def6f67247934430f9b0de5592194fe67907c703d1b50933c90787480fe357c291672b18a5616c07bea9ac14aebfa10ca1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c4edd97f1cd32301a0757dc50e15aff84f09fdd82b1231f78ce3dd9344a4f55daa4a7aa9c59ca974e386262f2f762a4a1a6687ed6aadaf1052f21341f29b7ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f79b0ce2de4e36fbd9bfb6c5f2e66b18ddb16290348a65bd319586810014c24a9582a28187ded2d2dcf807784602143fc33433e413a07672dd96982d23c7de04", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a4ee157f33e0ed8f74271167eeac5ebdfd4702a84ed2d1a7b8baf2fa83e792e7adb66be64842add0f9fc091fe4bb62f8e22cfc389f2ef29c1c6a5e9983279c3"} build_url:https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011426 build_url: 'https://queue.taskcluster.net/v1/task/dlkVjhs4RASjUA-gaYLcnQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccd1fb719c268b71c4d13aacad70a6def6f67247934430f9b0de5592194fe67907c703d1b50933c90787480fe357c291672b18a5616c07bea9ac14aebfa10ca1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c4edd97f1cd32301a0757dc50e15aff84f09fdd82b1231f78ce3dd9344a4f55daa4a7aa9c59ca974e386262f2f762a4a1a6687ed6aadaf1052f21341f29b7ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f79b0ce2de4e36fbd9bfb6c5f2e66b18ddb16290348a65bd319586810014c24a9582a28187ded2d2dcf807784602143fc33433e413a07672dd96982d23c7de04", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a4ee157f33e0ed8f74271167eeac5ebdfd4702a84ed2d1a7b8baf2fa83e792e7adb66be64842add0f9fc091fe4bb62f8e22cfc389f2ef29c1c6a5e9983279c3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 05:19:15.004127) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 05:19:15.004576) ========= 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.elB6rdnwTZ/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.BN9o00orkH/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.004598 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 05:19:15.056479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 05:19:15.056804) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 05:19:15.057168) ========= ========= Total master_lag: 0.22 =========