builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0166 starttime: 1492051997.31 results: success (0) buildid: 20170412182108 builduid: 29d4077b49d94384ae5de16fe32fab32 revision: aca6b2a5a2ab3338436c9e819dc2244a022b6425 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 19:53:17.315225) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 19:53:17.315689) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 19:53:17.315963) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 19:53:17.344847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 19:53:17.345791) ========= 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.Si91sh4VS5/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.WB48aHEIRN/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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-12 19:53:17-- 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% 28.5M=0s 2017-04-12 19:53:17 (28.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.161157 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 19:53:17.534087) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 19:53:17.534449) ========= 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.Si91sh4VS5/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.WB48aHEIRN/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.029121 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 19:53:17.586730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-12 19:53:17.587206) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev aca6b2a5a2ab3338436c9e819dc2244a022b6425 --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 aca6b2a5a2ab3338436c9e819dc2244a022b6425 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Si91sh4VS5/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.WB48aHEIRN/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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-12 19:53:17,696 truncating revision to first 12 chars 2017-04-12 19:53:17,696 Setting DEBUG logging. 2017-04-12 19:53:17,696 attempt 1/10 2017-04-12 19:53:17,697 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/aca6b2a5a2ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-12 19:53:18,768 unpacking tar archive at: mozilla-central-aca6b2a5a2ab/testing/mozharness/ program finished with exit code 0 elapsedTime=1.366273 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-12 19:53:18.979483) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 19:53:18.979912) ========= script_repo_revision: aca6b2a5a2ab3338436c9e819dc2244a022b6425 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 19:53:18.980414) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 19:53:18.980738) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 19:53:19.003280) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-12 19:53:19.003883) ========= /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.Si91sh4VS5/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.WB48aHEIRN/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 19:53:19 INFO - MultiFileLogger online at 20170412 19:53:19 in /builds/slave/test 19:53:19 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 19:53:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:53:19 INFO - {'append_to_log': False, 19:53:19 INFO - 'base_work_dir': '/builds/slave/test', 19:53:19 INFO - 'blob_upload_branch': 'Firefox', 19:53:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:53:19 INFO - 'branch': 'Firefox', 19:53:19 INFO - 'buildbot_json_path': 'buildprops.json', 19:53:19 INFO - 'config_files': ('talos/mac_config.py',), 19:53:19 INFO - 'default_actions': ('clobber', 19:53:19 INFO - 'read-buildbot-config', 19:53:19 INFO - 'download-and-extract', 19:53:19 INFO - 'populate-webroot', 19:53:19 INFO - 'create-virtualenv', 19:53:19 INFO - 'install', 19:53:19 INFO - 'run-tests'), 19:53:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:53:19 INFO - 'download_minidump_stackwalk': True, 19:53:19 INFO - 'download_symbols': 'ondemand', 19:53:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:53:19 INFO - 'tooltool.py': '/tools/tooltool.py', 19:53:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:53:19 INFO - '/tools/misc-python/virtualenv.py')}, 19:53:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:53:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:53:19 INFO - 'gecko_profile': False, 19:53:19 INFO - 'gecko_profile_interval': 0, 19:53:19 INFO - 'installer_path': 'installer.exe', 19:53:19 INFO - 'log_level': 'info', 19:53:19 INFO - 'log_name': 'talos', 19:53:19 INFO - 'log_to_console': True, 19:53:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:53:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:53:19 INFO - 'opt_config_files': (), 19:53:19 INFO - 'pip_index': False, 19:53:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:53:19 INFO - 'cmd': ('bash', 19:53:19 INFO - '-c', 19:53:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:53:19 INFO - 'enabled': True, 19:53:19 INFO - 'halt_on_failure': False, 19:53:19 INFO - 'name': 'check_screen_resolution'},), 19:53:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:53:19 INFO - 'cmd': ('bash', 19:53:19 INFO - '-c', 19:53:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:53:19 INFO - 'enabled': True, 19:53:19 INFO - 'halt_on_failure': False, 19:53:19 INFO - 'name': 'check_screen_resolution'},), 19:53:19 INFO - 'run_cmd_checks_enabled': True, 19:53:19 INFO - 'suite': 'dromaeojs-e10s', 19:53:19 INFO - 'system_bits': '32', 19:53:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:53:19 INFO - 'title': 't-yosemite-r7-0166', 19:53:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:53:19 INFO - 'use_talos_json': True, 19:53:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:53:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:53:19 INFO - 'work_dir': 'build'} 19:53:19 INFO - [mozharness: 2017-04-13 02:53:19.229774Z] Running clobber step. 19:53:19 INFO - Running pre-action listener: _resource_record_pre_action 19:53:19 INFO - Running main action method: clobber 19:53:19 INFO - rmtree: /builds/slave/test/build 19:53:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:53:21 INFO - Running post-action listener: _resource_record_post_action 19:53:21 INFO - [mozharness: 2017-04-13 02:53:21.735227Z] Finished clobber step (success) 19:53:21 INFO - [mozharness: 2017-04-13 02:53:21.735304Z] Running read-buildbot-config step. 19:53:21 INFO - Running pre-action listener: _resource_record_pre_action 19:53:21 INFO - Running main action method: read_buildbot_config 19:53:21 INFO - Using buildbot properties: 19:53:21 INFO - { 19:53:21 INFO - "project": "", 19:53:21 INFO - "product": "firefox", 19:53:21 INFO - "script_repo_revision": "production", 19:53:21 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 19:53:21 INFO - "repository": "", 19:53:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 19:53:21 INFO - "buildid": "20170412182108", 19:53:21 INFO - "pgo_build": "False", 19:53:21 INFO - "basedir": "/builds/slave/test", 19:53:21 INFO - "buildnumber": 12, 19:53:21 INFO - "slavename": "t-yosemite-r7-0166", 19:53:21 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 19:53:21 INFO - "platform": "yosemite_r7", 19:53:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:53:21 INFO - "branch": "mozilla-central", 19:53:21 INFO - "repo_path": "mozilla-central", 19:53:21 INFO - "revision": "aca6b2a5a2ab3338436c9e819dc2244a022b6425", 19:53:21 INFO - "stage_platform": "macosx64", 19:53:21 INFO - "builduid": "29d4077b49d94384ae5de16fe32fab32", 19:53:21 INFO - "slavebuilddir": "test" 19:53:21 INFO - } 19:53:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 19:53:21 INFO - Running post-action listener: _resource_record_post_action 19:53:21 INFO - [mozharness: 2017-04-13 02:53:21.738506Z] Finished read-buildbot-config step (success) 19:53:21 INFO - [mozharness: 2017-04-13 02:53:21.738618Z] Running download-and-extract step. 19:53:21 INFO - Running pre-action listener: _resource_record_pre_action 19:53:21 INFO - Running main action method: download_and_extract 19:53:21 INFO - mkdir: /builds/slave/test/build/tests 19:53:21 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')]} 19:53:21 INFO - trying https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 19:53:21 INFO - Downloading https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/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 19:53:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/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 19:53:23 INFO - Downloaded 1325 bytes. 19:53:23 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 19:53:23 INFO - Using the following test package requirements: 19:53:23 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:53:23 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 19:53:23 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:53:23 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:53:23 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 19:53:23 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:53:23 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 19:53:23 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:53:23 INFO - u'jsshell-mac.zip'], 19:53:23 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:53:23 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 19:53:23 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:53:23 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:53:23 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 19:53:23 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:53:23 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 19:53:23 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:53:23 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 19:53:23 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:53:23 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 19:53:23 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:53:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:53:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:53:23 INFO - Fetch https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:53:24 INFO - Expected file size: 52597222 19:53:24 INFO - Obtained file size: 52597222 19:53:41 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 19:53:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:53:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:53:41 INFO - Fetch https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:53:42 INFO - Expected file size: 52597222 19:53:42 INFO - Obtained file size: 52597222 19:53:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 19:53:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:53:58 INFO - Fetch https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 19:53:59 INFO - Expected file size: 14407739 19:53:59 INFO - Obtained file size: 14407739 19:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:54:00 INFO - trying https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:54:00 INFO - Downloading https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 19:54:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/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 19:54:02 INFO - Downloaded 71050342 bytes. 19:54:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:54:02 INFO - mkdir: /builds/slave/test/properties 19:54:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:54:02 INFO - Writing to file /builds/slave/test/properties/build_url 19:54:02 INFO - Contents: 19:54:02 INFO - build_url:https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:54:02 INFO - Running post-action listener: _resource_record_post_action 19:54:02 INFO - Running post-action listener: set_extra_try_arguments 19:54:02 INFO - [mozharness: 2017-04-13 02:54:02.995014Z] Finished download-and-extract step (success) 19:54:02 INFO - [mozharness: 2017-04-13 02:54:02.995138Z] Running populate-webroot step. 19:54:02 INFO - Running pre-action listener: _resource_record_pre_action 19:54:02 INFO - Running main action method: populate_webroot 19:54:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:54:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:54:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:54:03 INFO - '--tppagecycles', 19:54:03 INFO - '7'], 19:54:03 INFO - 'tests': ['tsvgm']}}, 19:54:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:54:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:54:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:54:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:54:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:54:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:54:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:54:03 INFO - 'talos_options': ['--disable-e10s'], 19:54:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:54:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:54:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:54:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:54:03 INFO - 'talos_options': ['--disable-e10s'], 19:54:03 INFO - 'tests': ['damp', 'tps']}, 19:54:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:54:03 INFO - 'tests': ['damp', 'tps']}, 19:54:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:54:03 INFO - 'tests': ['dromaeo_dom']}, 19:54:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:54:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:54:03 INFO - 'tests': ['basic_compositor_video']}, 19:54:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:54:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:54:03 INFO - 'tests': ['a11yr', 19:54:03 INFO - 'ts_paint', 19:54:03 INFO - 'tpaint', 19:54:03 INFO - 'sessionrestore', 19:54:03 INFO - 'sessionrestore_no_auto_restore', 19:54:03 INFO - 'tabpaint']}, 19:54:03 INFO - 'other-e10s': {'tests': ['a11yr', 19:54:03 INFO - 'ts_paint', 19:54:03 INFO - 'tpaint', 19:54:03 INFO - 'sessionrestore', 19:54:03 INFO - 'sessionrestore_no_auto_restore', 19:54:03 INFO - 'tabpaint']}, 19:54:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:54:03 INFO - 'ts_paint', 19:54:03 INFO - 'tpaint', 19:54:03 INFO - 'sessionrestore', 19:54:03 INFO - 'sessionrestore_no_auto_restore', 19:54:03 INFO - 'tabpaint']}, 19:54:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:54:03 INFO - 'ts_paint', 19:54:03 INFO - 'tpaint', 19:54:03 INFO - 'sessionrestore', 19:54:03 INFO - 'sessionrestore_no_auto_restore', 19:54:03 INFO - 'tabpaint']}, 19:54:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:54:03 INFO - 'tests': ['a11yr', 19:54:03 INFO - 'ts_paint', 19:54:03 INFO - 'tpaint', 19:54:03 INFO - 'sessionrestore', 19:54:03 INFO - 'sessionrestore_no_auto_restore', 19:54:03 INFO - 'tabpaint']}, 19:54:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:54:03 INFO - 'tests': ['a11yr', 19:54:03 INFO - 'ts_paint', 19:54:03 INFO - 'tpaint', 19:54:03 INFO - 'sessionrestore', 19:54:03 INFO - 'sessionrestore_no_auto_restore', 19:54:03 INFO - 'tabpaint']}, 19:54:03 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 19:54:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 19:54:03 INFO - 'bloom_basic_ref']}, 19:54:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:54:03 INFO - 'tests': ['tsvgx', 19:54:03 INFO - 'tsvgr_opacity', 19:54:03 INFO - 'tart', 19:54:03 INFO - 'tscrollx', 19:54:03 INFO - 'cart', 19:54:03 INFO - 'tsvg_static']}, 19:54:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:54:03 INFO - 'tsvgr_opacity', 19:54:03 INFO - 'tart', 19:54:03 INFO - 'tscrollx', 19:54:03 INFO - 'cart', 19:54:03 INFO - 'tsvg_static']}, 19:54:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:54:03 INFO - 'talos_options': ['--disable-e10s'], 19:54:03 INFO - 'tests': ['tp5o']}, 19:54:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:54:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:54:03 INFO - 'talos_options': ['--disable-e10s', 19:54:03 INFO - '--xperf_path', 19:54:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:54:03 INFO - 'tests': ['tp5n']}, 19:54:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:54:03 INFO - 'talos_options': ['--xperf_path', 19:54:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:54:03 INFO - 'tests': ['tp5n']}}, 19:54:03 INFO - 'talos.zip': {'path': '', 19:54:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:54:03 INFO - Running post-action listener: _resource_record_post_action 19:54:03 INFO - [mozharness: 2017-04-13 02:54:03.014211Z] Finished populate-webroot step (success) 19:54:03 INFO - [mozharness: 2017-04-13 02:54:03.014319Z] Running create-virtualenv step. 19:54:03 INFO - Running pre-action listener: _resource_record_pre_action 19:54:03 INFO - Running main action method: create_virtualenv 19:54:03 INFO - Creating virtualenv /builds/slave/test/build/venv 19:54:03 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 19:54:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:54:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:54:03 INFO - Using real prefix '/tools/python27' 19:54:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:54:03 INFO - Installing distribute.............................................................................................................................................................................................done. 19:54:06 INFO - Installing pip.................done. 19:54:06 INFO - Return code: 0 19:54:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:54:07 INFO - Reading from file tmpfile_stdout 19:54:07 INFO - Output received: 19:54:07 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) 19:54:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:54: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')]} 19:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54: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')]} 19:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd113cbb1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd3d30>, '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 0x10dafadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc8be8>, '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.Si91sh4VS5/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.WB48aHEIRN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 19:54: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', 'pip>=1.5'] in /builds/slave/test/build 19:54: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 pip>=1.5 19:54:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Si91sh4VS5/Render', 19:54:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:54:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:54:07 INFO - 'HOME': '/Users/cltbld', 19:54:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:54:07 INFO - 'LOGNAME': 'cltbld', 19:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:07 INFO - 'MOZ_NO_REMOTE': '1', 19:54:07 INFO - 'NO_EM_RESTART': '1', 19:54:07 INFO - 'PAGER': '/bin/cat', 19:54:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:07 INFO - 'PWD': '/builds/slave/test', 19:54:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:54:07 INFO - 'SHELL': '/bin/bash', 19:54:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WB48aHEIRN/Listeners', 19:54:07 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 19:54:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:54:07 INFO - 'USER': 'cltbld', 19:54:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:54:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:07 INFO - 'XPC_FLAGS': '0x0', 19:54:07 INFO - 'XPC_SERVICE_NAME': '0', 19:54:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:07 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 19:54:07 INFO - Cleaning up... 19:54:07 INFO - Return code: 0 19:54:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:54: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')]} 19:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54: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')]} 19:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54: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', '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 0x10ddf5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd113cbb1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd3d30>, '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 0x10dafadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc8be8>, '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.Si91sh4VS5/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.WB48aHEIRN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 19:54: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:54: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 psutil>=3.1.1 19:54:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Si91sh4VS5/Render', 19:54:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:54:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:54:07 INFO - 'HOME': '/Users/cltbld', 19:54:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:54:07 INFO - 'LOGNAME': 'cltbld', 19:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:07 INFO - 'MOZ_NO_REMOTE': '1', 19:54:07 INFO - 'NO_EM_RESTART': '1', 19:54:07 INFO - 'PAGER': '/bin/cat', 19:54:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:07 INFO - 'PWD': '/builds/slave/test', 19:54:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:54:07 INFO - 'SHELL': '/bin/bash', 19:54:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WB48aHEIRN/Listeners', 19:54:07 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 19:54:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:54:07 INFO - 'USER': 'cltbld', 19:54:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:54:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:07 INFO - 'XPC_FLAGS': '0x0', 19:54:07 INFO - 'XPC_SERVICE_NAME': '0', 19:54:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:07 INFO - Downloading/unpacking psutil>=3.1.1 19:54:07 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 19:54:07 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 19:54:07 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 19:54:07 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 19:54:07 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 19:54:07 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 19:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:54:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:54:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:54:11 INFO - Installing collected packages: psutil 19:54:11 INFO - Running setup.py install for psutil 19:54:11 INFO - building 'psutil._psutil_osx' extension 19:54:11 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 19:54:11 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 19:54:11 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 19:54:11 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 19:54:12 INFO - building 'psutil._psutil_posix' extension 19:54:12 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 19:54:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:54:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:54:12 INFO - ^ 19:54:12 INFO - 1 warning generated. 19:54:12 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 19:54:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:54:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:54:12 INFO - Successfully installed psutil 19:54:12 INFO - Cleaning up... 19:54:12 INFO - Return code: 0 19:54:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:54:12 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')]} 19:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:12 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')]} 19:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:12 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 0x10ddf5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd113cbb1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd3d30>, '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 0x10dafadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc8be8>, '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.Si91sh4VS5/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.WB48aHEIRN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 19:54:12 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 19:54:12 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 19:54:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Si91sh4VS5/Render', 19:54:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:54:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:54:12 INFO - 'HOME': '/Users/cltbld', 19:54:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:54:12 INFO - 'LOGNAME': 'cltbld', 19:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:12 INFO - 'MOZ_NO_REMOTE': '1', 19:54:12 INFO - 'NO_EM_RESTART': '1', 19:54:12 INFO - 'PAGER': '/bin/cat', 19:54:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:12 INFO - 'PWD': '/builds/slave/test', 19:54:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:54:12 INFO - 'SHELL': '/bin/bash', 19:54:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WB48aHEIRN/Listeners', 19:54:12 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 19:54:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:54:12 INFO - 'USER': 'cltbld', 19:54:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:54:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:12 INFO - 'XPC_FLAGS': '0x0', 19:54:12 INFO - 'XPC_SERVICE_NAME': '0', 19:54:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:54:12 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 19:54:12 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 19:54:12 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 19:54:12 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 19:54:12 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 19:54:12 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 19:54:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:54:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:54:15 INFO - Installing collected packages: mozsystemmonitor 19:54:15 INFO - Running setup.py install for mozsystemmonitor 19:54:15 INFO - Successfully installed mozsystemmonitor 19:54:15 INFO - Cleaning up... 19:54:16 INFO - Return code: 0 19:54:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:54:16 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')]} 19:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:16 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')]} 19:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:16 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 0x10ddf5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd113cbb1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd3d30>, '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 0x10dafadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc8be8>, '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.Si91sh4VS5/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.WB48aHEIRN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 19:54:16 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 19:54:16 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 19:54:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Si91sh4VS5/Render', 19:54:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:54:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:54:16 INFO - 'HOME': '/Users/cltbld', 19:54:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:54:16 INFO - 'LOGNAME': 'cltbld', 19:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:16 INFO - 'MOZ_NO_REMOTE': '1', 19:54:16 INFO - 'NO_EM_RESTART': '1', 19:54:16 INFO - 'PAGER': '/bin/cat', 19:54:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:16 INFO - 'PWD': '/builds/slave/test', 19:54:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:54:16 INFO - 'SHELL': '/bin/bash', 19:54:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WB48aHEIRN/Listeners', 19:54:16 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 19:54:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:54:16 INFO - 'USER': 'cltbld', 19:54:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:54:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:16 INFO - 'XPC_FLAGS': '0x0', 19:54:16 INFO - 'XPC_SERVICE_NAME': '0', 19:54:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:16 INFO - Downloading/unpacking jsonschema==2.5.1 19:54:16 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 19:54:16 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 19:54:16 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 19:54:16 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 19:54:16 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 19:54:16 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 19:54:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:54:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:54:19 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 19:54:19 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 19:54:19 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 19:54:19 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 19:54:19 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 19:54:19 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 19:54:19 INFO - Downloading functools32-3.2.3-2.tar.gz 19:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:54:19 INFO - warning: no files found matching '*.txt' 19:54:19 INFO - no previously-included directories found matching 'build' 19:54:19 INFO - no previously-included directories found matching 'dist' 19:54:19 INFO - no previously-included directories found matching '.git*' 19:54:19 INFO - Installing collected packages: jsonschema, functools32 19:54:19 INFO - Running setup.py install for functools32 19:54:20 INFO - warning: no files found matching '*.txt' 19:54:20 INFO - no previously-included directories found matching 'build' 19:54:20 INFO - no previously-included directories found matching 'dist' 19:54:20 INFO - no previously-included directories found matching '.git*' 19:54:20 INFO - Successfully installed jsonschema functools32 19:54:20 INFO - Cleaning up... 19:54:20 INFO - Return code: 0 19:54:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:20 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 0x10ddf5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd113cbb1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd3d30>, '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 0x10dafadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc8be8>, '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.Si91sh4VS5/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.WB48aHEIRN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 19:54:20 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 19:54:20 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 19:54:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Si91sh4VS5/Render', 19:54:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:54:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:54:20 INFO - 'HOME': '/Users/cltbld', 19:54:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:54:20 INFO - 'LOGNAME': 'cltbld', 19:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:20 INFO - 'MOZ_NO_REMOTE': '1', 19:54:20 INFO - 'NO_EM_RESTART': '1', 19:54:20 INFO - 'PAGER': '/bin/cat', 19:54:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:20 INFO - 'PWD': '/builds/slave/test', 19:54:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:54:20 INFO - 'SHELL': '/bin/bash', 19:54:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WB48aHEIRN/Listeners', 19:54:20 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 19:54:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:54:20 INFO - 'USER': 'cltbld', 19:54:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:54:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:20 INFO - 'XPC_FLAGS': '0x0', 19:54:20 INFO - 'XPC_SERVICE_NAME': '0', 19:54:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:54:20 INFO - Cleaning up... 19:54:20 INFO - Return code: 0 19:54:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:20 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 0x10ddf5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd113cbb1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd3d30>, '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 0x10dafadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc8be8>, '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.Si91sh4VS5/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.WB48aHEIRN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 19:54:20 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 19:54:20 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 19:54:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Si91sh4VS5/Render', 19:54:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:54:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:54:20 INFO - 'HOME': '/Users/cltbld', 19:54:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:54:20 INFO - 'LOGNAME': 'cltbld', 19:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:20 INFO - 'MOZ_NO_REMOTE': '1', 19:54:20 INFO - 'NO_EM_RESTART': '1', 19:54:20 INFO - 'PAGER': '/bin/cat', 19:54:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:20 INFO - 'PWD': '/builds/slave/test', 19:54:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:54:20 INFO - 'SHELL': '/bin/bash', 19:54:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WB48aHEIRN/Listeners', 19:54:20 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 19:54:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:54:20 INFO - 'USER': 'cltbld', 19:54:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:54:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:20 INFO - 'XPC_FLAGS': '0x0', 19:54:20 INFO - 'XPC_SERVICE_NAME': '0', 19:54:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:20 INFO - Downloading/unpacking blobuploader==1.2.4 19:54:20 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 19:54:20 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 19:54:20 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 19:54:20 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 19:54:20 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 19:54:20 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 19:54:23 INFO - Downloading blobuploader-1.2.4.tar.gz 19:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:54:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:54:23 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 19:54:23 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 19:54:23 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 19:54:23 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 19:54:23 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 19:54:23 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 19:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:54:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:54:24 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 19:54:24 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 19:54:24 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 19:54:24 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 19:54:24 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 19:54:24 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 19:54:24 INFO - Downloading docopt-0.6.1.tar.gz 19:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:54:24 INFO - Installing collected packages: blobuploader, requests, docopt 19:54:24 INFO - Running setup.py install for blobuploader 19:54:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:54:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:54:24 INFO - Running setup.py install for requests 19:54:25 INFO - Running setup.py install for docopt 19:54:25 INFO - Successfully installed blobuploader requests docopt 19:54:25 INFO - Cleaning up... 19:54:25 INFO - Return code: 0 19:54:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:25 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 0x10ddf5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd113cbb1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd3d30>, '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 0x10dafadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc8be8>, '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.Si91sh4VS5/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.WB48aHEIRN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 19:54:25 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 19:54:25 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 19:54:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Si91sh4VS5/Render', 19:54:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:54:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:54:25 INFO - 'HOME': '/Users/cltbld', 19:54:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:54:25 INFO - 'LOGNAME': 'cltbld', 19:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:25 INFO - 'MOZ_NO_REMOTE': '1', 19:54:25 INFO - 'NO_EM_RESTART': '1', 19:54:25 INFO - 'PAGER': '/bin/cat', 19:54:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:25 INFO - 'PWD': '/builds/slave/test', 19:54:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:54:25 INFO - 'SHELL': '/bin/bash', 19:54:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WB48aHEIRN/Listeners', 19:54:25 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 19:54:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:54:25 INFO - 'USER': 'cltbld', 19:54:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:54:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:25 INFO - 'XPC_FLAGS': '0x0', 19:54:25 INFO - 'XPC_SERVICE_NAME': '0', 19:54:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:54:25 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Di8QLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:54:25 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-7IoBGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:54:26 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-laGqXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:54:26 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-zLptJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:54:26 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-HzKjCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:54:26 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-eEyYDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:54:26 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-TKAUSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:54:26 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-B9aIzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:54:26 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-48acLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:54:26 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-3zdBO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:54:26 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-MMPYxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:54:26 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-C8fVP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:54:27 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-qv0KDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:54:27 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-c7smri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:54:27 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-jM83o6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:54:27 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-RkFPuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:54:27 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-NKYvGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:54:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:54:27 INFO - Running setup.py install for manifestparser 19:54:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:54:27 INFO - Running setup.py install for mozcrash 19:54:27 INFO - Running setup.py install for mozdebug 19:54:27 INFO - Running setup.py install for mozdevice 19:54:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:54:28 INFO - Running setup.py install for mozfile 19:54:28 INFO - Running setup.py install for mozhttpd 19:54:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:54:28 INFO - Running setup.py install for mozinfo 19:54:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:54:28 INFO - Running setup.py install for mozInstall 19:54:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:54:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:54:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:54:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:54:28 INFO - Running setup.py install for mozleak 19:54:28 INFO - Running setup.py install for mozlog 19:54:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:54:29 INFO - Running setup.py install for moznetwork 19:54:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:54:29 INFO - Running setup.py install for mozprocess 19:54:29 INFO - Running setup.py install for mozprofile 19:54:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:54:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:54:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:54:29 INFO - Running setup.py install for mozrunner 19:54:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:54:29 INFO - Running setup.py install for mozscreenshot 19:54:29 INFO - Running setup.py install for moztest 19:54:29 INFO - Running setup.py install for mozversion 19:54:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:54:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:54:30 INFO - Cleaning up... 19:54:30 INFO - Return code: 0 19:54:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:54:30 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')]} 19:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:30 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')]} 19:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:30 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 0x10ddf5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd113cbb1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd3d30>, '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 0x10dafadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc8be8>, '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.Si91sh4VS5/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.WB48aHEIRN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 19:54:30 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 19:54:30 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 19:54:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Si91sh4VS5/Render', 19:54:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:54:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:54:30 INFO - 'HOME': '/Users/cltbld', 19:54:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:54:30 INFO - 'LOGNAME': 'cltbld', 19:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:30 INFO - 'MOZ_NO_REMOTE': '1', 19:54:30 INFO - 'NO_EM_RESTART': '1', 19:54:30 INFO - 'PAGER': '/bin/cat', 19:54:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:30 INFO - 'PWD': '/builds/slave/test', 19:54:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:54:30 INFO - 'SHELL': '/bin/bash', 19:54:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WB48aHEIRN/Listeners', 19:54:30 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 19:54:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:54:30 INFO - 'USER': 'cltbld', 19:54:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:54:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:30 INFO - 'XPC_FLAGS': '0x0', 19:54:30 INFO - 'XPC_SERVICE_NAME': '0', 19:54:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:54:30 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-C0QImZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:54:30 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)) 19:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:54:30 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-51WxPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:54:30 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)) 19:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:54:30 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-b1IN4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:54:30 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)) 19:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:54:30 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-BlWveT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:54:30 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)) 19:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:54:30 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-653HBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:54:30 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)) 19:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:54:30 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-gPk6uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:54:31 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)) 19:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:54:31 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-coFs2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:54:31 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)) 19:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:54:31 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-YZYqBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:54:31 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)) 19:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:54:31 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-v99wtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:54:31 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)) 19:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:54:31 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-MRin8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:54:31 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)) 19:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:54:31 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-c7KN20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:54:31 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)) 19:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:54:31 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-QsbaJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:54:31 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)) 19:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:54:31 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-H7Hgec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:54:31 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)) 19:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:54:31 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Kk2r_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:54:31 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)) 19:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:54:31 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-RvYQWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:54:32 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)) 19:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:54:32 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-YT0T4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:54:32 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)) 19:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:54:32 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-BCo9ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:54:32 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)) 19:54:32 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)) 19:54:32 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)) 19:54:32 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)) 19:54:32 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)) 19:54:32 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)) 19:54:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:54: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 19:54: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 19:54: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 19:54: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 19:54: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 19:54: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 19:54:35 INFO - Downloading blessings-1.6.tar.gz 19:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:54:35 INFO - Installing collected packages: blessings 19:54:35 INFO - Running setup.py install for blessings 19:54:35 INFO - Successfully installed blessings 19:54:35 INFO - Cleaning up... 19:54:35 INFO - Return code: 0 19:54:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:54:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:54:35 INFO - Reading from file tmpfile_stdout 19:54:35 INFO - Current package versions: 19:54:35 INFO - blessings == 1.6 19:54:35 INFO - blobuploader == 1.2.4 19:54:35 INFO - docopt == 0.6.1 19:54:35 INFO - functools32 == 3.2.3-2 19:54:35 INFO - jsonschema == 2.5.1 19:54:35 INFO - manifestparser == 1.1 19:54:35 INFO - mozInstall == 1.12 19:54:35 INFO - mozcrash == 1.0 19:54:35 INFO - mozdebug == 0.1 19:54:35 INFO - mozdevice == 0.50 19:54:35 INFO - mozfile == 1.2 19:54:35 INFO - mozhttpd == 0.7 19:54:35 INFO - mozinfo == 0.9 19:54:35 INFO - mozleak == 0.1 19:54:35 INFO - mozlog == 3.4 19:54:35 INFO - moznetwork == 0.27 19:54:35 INFO - mozprocess == 0.25 19:54:35 INFO - mozprofile == 0.28 19:54:35 INFO - mozrunner == 6.13 19:54:35 INFO - mozscreenshot == 0.1 19:54:35 INFO - mozsystemmonitor == 0.3 19:54:35 INFO - moztest == 0.8 19:54:35 INFO - mozversion == 1.4 19:54:35 INFO - psutil == 3.1.1 19:54:35 INFO - requests == 1.2.3 19:54:35 INFO - wsgiref == 0.1.2 19:54:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:54: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')]} 19:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54: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')]} 19:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:35 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 0x10ddf5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd113cbb1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd3d30>, '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 0x10dafadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc8be8>, '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.Si91sh4VS5/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.WB48aHEIRN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 19:54:35 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 19:54:35 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 19:54:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Si91sh4VS5/Render', 19:54:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:54:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:54:35 INFO - 'HOME': '/Users/cltbld', 19:54:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:54:35 INFO - 'LOGNAME': 'cltbld', 19:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:35 INFO - 'MOZ_NO_REMOTE': '1', 19:54:35 INFO - 'NO_EM_RESTART': '1', 19:54:35 INFO - 'PAGER': '/bin/cat', 19:54:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:35 INFO - 'PWD': '/builds/slave/test', 19:54:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:54:35 INFO - 'SHELL': '/bin/bash', 19:54:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WB48aHEIRN/Listeners', 19:54:35 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 19:54:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:54:35 INFO - 'USER': 'cltbld', 19:54:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:54:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:35 INFO - 'XPC_FLAGS': '0x0', 19:54:35 INFO - 'XPC_SERVICE_NAME': '0', 19:54:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:35 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)) 19:54:35 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)) 19:54:35 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)) 19:54:35 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)) 19:54:35 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)) 19:54:35 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)) 19:54:35 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)) 19:54:35 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)) 19:54:35 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)) 19:54:35 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)) 19:54:35 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)) 19:54:35 INFO - Cleaning up... 19:54:35 INFO - Return code: 0 19:54:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:54: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')]} 19:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54: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')]} 19:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:35 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 0x10ddf5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd113cbb1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd3d30>, '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 0x10dafadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc8be8>, '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.Si91sh4VS5/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.WB48aHEIRN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 19:54:35 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 19:54:35 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 19:54:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Si91sh4VS5/Render', 19:54:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:54:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:54:35 INFO - 'HOME': '/Users/cltbld', 19:54:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:54:35 INFO - 'LOGNAME': 'cltbld', 19:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:35 INFO - 'MOZ_NO_REMOTE': '1', 19:54:35 INFO - 'NO_EM_RESTART': '1', 19:54:35 INFO - 'PAGER': '/bin/cat', 19:54:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:35 INFO - 'PWD': '/builds/slave/test', 19:54:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:54:35 INFO - 'SHELL': '/bin/bash', 19:54:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WB48aHEIRN/Listeners', 19:54:35 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 19:54:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:54:35 INFO - 'USER': 'cltbld', 19:54:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:54:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:35 INFO - 'XPC_FLAGS': '0x0', 19:54:35 INFO - 'XPC_SERVICE_NAME': '0', 19:54:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:54:36 INFO - Cleaning up... 19:54:36 INFO - Return code: 0 19:54:36 INFO - Running post-action listener: _resource_record_post_action 19:54:36 INFO - Running post-action listener: _start_resource_monitoring 19:54:36 INFO - Starting resource monitoring. 19:54:36 INFO - [mozharness: 2017-04-13 02:54:36.281017Z] Finished create-virtualenv step (success) 19:54:36 INFO - [mozharness: 2017-04-13 02:54:36.281965Z] Running install step. 19:54:36 INFO - Running pre-action listener: _resource_record_pre_action 19:54:36 INFO - Running main action method: install 19:54:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:54:36 INFO - Reading from file tmpfile_stdout 19:54:36 INFO - Detecting whether we're running mozinstall >=1.0... 19:54:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:54:36 INFO - Reading from file tmpfile_stdout 19:54:36 INFO - Output received: 19:54:36 INFO - Usage: mozinstall [options] installer 19:54:36 INFO - Options: 19:54:36 INFO - -h, --help show this help message and exit 19:54:36 INFO - -d DEST, --destination=DEST 19:54:36 INFO - Directory to install application into. [default: 19:54:36 INFO - "/builds/slave/test"] 19:54:36 INFO - --app=APP Application being installed. [default: firefox] 19:54:36 INFO - mkdir: /builds/slave/test/build/application 19:54:36 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'] 19:54:36 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 19:54:56 INFO - Reading from file tmpfile_stdout 19:54:56 INFO - Output received: 19:54:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:54:56 INFO - Running post-action listener: _resource_record_post_action 19:54:56 INFO - [mozharness: 2017-04-13 02:54:56.382305Z] Finished install step (success) 19:54:56 INFO - [mozharness: 2017-04-13 02:54:56.382431Z] Running run-tests step. 19:54:56 INFO - Running pre-action listener: _resource_record_pre_action 19:54:56 INFO - Running main action method: run_tests 19:54:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:54:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:54:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:54:56 INFO - 2017-04-12 19:54:56.396 screenresolution[1630:7516] starting screenresolution argv=screenresolution get 19:54:56 INFO - 2017-04-12 19:54:56.399 screenresolution[1630:7516] Display 0: 1600x1200x32@60 19:54:56 INFO - 2017-04-12 19:54:56.405 screenresolution[1631:7518] starting screenresolution argv=screenresolution list 19:54:56 INFO - Available Modes on Display 0 19:54:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:54:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:54:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:54:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:54:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:54:56 INFO - Intel Iris: 19:54:56 INFO - Chipset Model: Intel Iris 19:54:56 INFO - Type: GPU 19:54:56 INFO - Bus: Built-In 19:54:56 INFO - VRAM (Dynamic, Max): 1536 MB 19:54:56 INFO - Vendor: Intel (0x8086) 19:54:56 INFO - Device ID: 0x0a2e 19:54:56 INFO - Revision ID: 0x0009 19:54:56 INFO - Displays: 19:54:56 INFO - Display: 19:54:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:54:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:54:56 INFO - Display Serial Number: 1600x1200 60 19:54:56 INFO - Main Display: Yes 19:54:56 INFO - Mirror: Off 19:54:56 INFO - Online: Yes 19:54:56 INFO - Rotation: Supported 19:54:56 INFO - Return code: 0 19:54:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:54:56 INFO - Python 2.7.3 19:54:56 INFO - Return code: 0 19:54:56 INFO - grabbing minidump binary from tooltool 19:54: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')]} 19:54:56 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 0x10dbd3d30>, '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 0x10dafadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:54:56 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 19:54:56 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 19:54:56 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 19:54:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:54:56 INFO - Return code: 0 19:54:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:54:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:54:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:54:56 INFO - ENV: RUST_BACKTRACE is now 1 19:54:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:54:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:54:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0166', '--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 19:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0166 --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 19:54:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Si91sh4VS5/Render', 19:54:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:54:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:54:56 INFO - 'HOME': '/Users/cltbld', 19:54:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:54:56 INFO - 'LOGNAME': 'cltbld', 19:54:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:54:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:56 INFO - 'MOZ_NO_REMOTE': '1', 19:54:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:54:56 INFO - 'NO_EM_RESTART': '1', 19:54:56 INFO - 'PAGER': '/bin/cat', 19:54:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:56 INFO - 'PWD': '/builds/slave/test', 19:54:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:54:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:54:56 INFO - 'RUST_BACKTRACE': '1', 19:54:56 INFO - 'SHELL': '/bin/bash', 19:54:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WB48aHEIRN/Listeners', 19:54:56 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 19:54:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:54:56 INFO - 'USER': 'cltbld', 19:54:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:54:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:56 INFO - 'XPC_FLAGS': '0x0', 19:54:56 INFO - 'XPC_SERVICE_NAME': '0', 19:54:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:54:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0166', '--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 19:54:56 INFO - mozversion application_buildid: 20170412182108 19:54:56 INFO - mozversion application_changeset: aca6b2a5a2ab3338436c9e819dc2244a022b6425 19:54:56 INFO - mozversion application_display_name: Nightly 19:54:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:54:56 INFO - mozversion application_name: Firefox 19:54:56 INFO - mozversion application_remotingname: firefox 19:54:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:54:57 INFO - mozversion application_vendor: Mozilla 19:54:57 INFO - mozversion application_version: 55.0a1 19:54:57 INFO - mozversion platform_buildid: 20170412182108 19:54:57 INFO - mozversion platform_changeset: aca6b2a5a2ab3338436c9e819dc2244a022b6425 19:54:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:54:57 INFO - mozversion platform_version: 55.0a1 19:54:57 INFO - using testdate: 1492052096 19:54:57 INFO - actual date: 1492052096 19:54:57 INFO - starting webserver on 'localhost:49251' 19:54:57 INFO - SUITE-START | Running 2 tests 19:54:57 INFO - TEST-START | dromaeo_css 19:54:57 INFO - operating with platform_type : mac_ 19:54:57 INFO - Initialising browser for dromaeo_css test... 19:54:57 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmp6nJP48/profile http://localhost:49251/getInfo.html) 19:55:00 INFO - PID 1641 | 2017-04-12 19:55:00.103 plugin-container[1643:7709] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 19:55:00 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:55:00 INFO - PID 1641 | 2017-04-12 19:55:00.106 plugin-container[1643:7709] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940f, name = 'com.apple.CFPasteboardClient' 19:55:00 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:55:00 INFO - PID 1641 | 2017-04-12 19:55:00.106 plugin-container[1643:7709] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:55:00 INFO - PID 1641 | __metrics Screen width/height:1600/1200 19:55:00 INFO - PID 1641 | colorDepth:24 19:55:00 INFO - PID 1641 | Browser inner width/height: 1024/689 19:55:00 INFO - PID 1641 | __metrics 19:55:00 ERROR - PID 1641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 19:55:01 INFO - TEST-INFO | 1641: exit 0 19:55:01 INFO - Browser initialized. 19:55:01 INFO - Running cycle 1/1 for dromaeo_css test... 19:55:01 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmp6nJP48/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:55:03 INFO - PID 1644 | 2017-04-12 19:55:03.726 plugin-container[1645:7843] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 19:55:03 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:55:03 INFO - PID 1644 | 2017-04-12 19:55:03.727 plugin-container[1645:7843] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 19:55:03 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:55:03 INFO - PID 1644 | 2017-04-12 19:55:03.727 plugin-container[1645:7843] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:55:13 INFO - PID 1644 | RSS: Main: 234831872 19:55:13 INFO - PID 1644 | 19:58:16 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49251/tests/dromaeo/cssquery-ext.html) 19:58:18 INFO - PID 1644 | RSS: Main: 254410752 19:58:18 INFO - PID 1644 | 20:00:01 INFO - PID 1644 | ************************* 20:00:01 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 20:00:01 INFO - PID 1644 | 20:00:01 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:00:01 INFO - PID 1644 | Full stack: 20:00:01 INFO - PID 1644 | ************************* 20:00:01 INFO - PID 1644 | ************************* 20:00:01 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 20:00:01 INFO - PID 1644 | 20:00:01 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:00:01 INFO - PID 1644 | Full stack: 20:00:01 INFO - PID 1644 | ************************* 20:00:01 INFO - PID 1644 | ************************* 20:00:01 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 20:00:01 INFO - PID 1644 | 20:00:01 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:00:01 INFO - PID 1644 | Full stack: 20:00:01 INFO - PID 1644 | ************************* 20:00:01 INFO - PID 1644 | ************************* 20:00:01 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 20:00:01 INFO - PID 1644 | 20:00:01 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:00:01 INFO - PID 1644 | Full stack: 20:00:01 INFO - PID 1644 | ************************* 20:01:19 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-ext.html (next: http://localhost:49251/tests/dromaeo/cssquery-jquery.html) 20:01:20 INFO - PID 1644 | RSS: Main: 261058560 20:01:20 INFO - PID 1644 | 20:04:22 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49251/tests/dromaeo/cssquery-mootools.html) 20:04:22 INFO - PID 1644 | RSS: Main: 272515072 20:04:22 INFO - PID 1644 | 20:07:24 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49251/tests/dromaeo/cssquery-prototype.html) 20:07:25 INFO - PID 1644 | RSS: Main: 265490432 20:07:25 INFO - PID 1644 | 20:10:27 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49251/tests/dromaeo/cssquery-yui.html) 20:10:28 INFO - PID 1644 | RSS: Main: 276291584 20:10:28 INFO - PID 1644 | 20:13:30 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-yui.html (next: http://localhost:49251/tests/dromaeo/cssquery-dojo.html) 20:13:30 INFO - PID 1644 | RSS: Main: 270135296 20:13:30 INFO - PID 1644 | 20:13:30 INFO - PID 1644 | __start_tp_report 20:13:30 INFO - PID 1644 | _x_x_mozilla_page_load 20:13:30 INFO - PID 1644 | _x_x_mozilla_page_load_details 20:13:30 INFO - PID 1644 | |i|pagename|runs| 20:13:30 INFO - PID 1644 | |0;dojo.html;3526.382882995475;3529.8058606776626;3562.3053504566606;3564.964350356499;3580.982095089526;6059.636421814695;6164.476019538333;6173.228346456693;6191.659458729768;6212.068189771537;6109.16175461965;6115.544587952002;6118.527810132507;6133;6137.987232106697;5317.521423071932;5399.730013499329;5429.348478182604;5435.076037073687;5525.392206857243;5493.368262649807;5504.4770746778995;5507.091329930557;5520.889582208353;5532.585056120787;542.2612025020587;4725.3384526166365;5310.283111779899;5348.491893270133;5502.119660854264;4358.346248062784;5396.460353964611;5410.606823586889;5422.024035673578;5469.425710300441;5339.813106541291;5344.866378340534;5352.250684904077;5361.973190134064;5424.457554244584;4451.532589078132;6051.425114614149;6092.7562897484495;6141.600795948294;6261.968690156566;6388.425041746219;6441.194850643669;6548;6600.075989361493;6659.4006539411685;6725.125733654593;6735.932640673628;6754.493412993996;6756.966215168942;6762.357576030269;6232.345603711636;6235.314115447297;6255.749770009194;6263.248410190807;6269.185005949197;6582.3746744059235;6694.765683201064;6788.9660551696925;6830.21452532965;6874.793756187322;5600.775968961278;6486.416222539994;6512.153420055457;6530.216374035052;6565.704543295563;6446.194225721785;6523.543351965317;6530.216374035052;6741.730330786713;6783.728650854009;5535.723213839373;6487.805365839033;6575.375339342851;6588.934110658832;6599.934000660028;6349.365063493614;6416.165898433173;6457.257415397289;6592.24189218246;6613.834654133589;5277.261183434322;5321.308229930084;5345.278387417648;5351.946480535223;5361.08861493547;4011.438398624195;4725.763711814396;4729.527047295312;4734.692245004064;4768.523147685204;5589.469000444951;5851.707414629252;6260.092286618415;6321.589096708699;6378.362163783585;6603.108580341688;6689.76585819494;6702.497312701566;6708.19501659804;6709.4296984755865;6349.682515874188;6359.904601430982;6368.5860419072615;6368.872622547616;6394.072859435356;5805.88388232233;5882.058870580687;5887.911681324784;5894.086416605433;5902.704864756745;6572.934270657328;6660.267370589231;6796.490263230178;6853.931460685529;6860.279670634512;6718.596884186769;6735.6968936397;6736.494762892705;6749.966250168718;6766.458683305422;6827.863442731217;6857.485688573277;6890.931090689029;6906.930930690629;6920.4809639276245;6342.682865856781;6440.549161558646;6536.934630653823;6558.672066396565;6562.967185164043;5972.313183983897;6114.297368146176;6667.49993750461;6704.932950670626;6729.1252137221845;5582.972085139549;6130.47890929276;6487.416132548094;6492.28584855656;6498;5437.211604317273;6442.806715798533;6467.159269294962;6500.902486462802;6510.967445162744;5470.617056806144;6197.070439434121;6372.044193371032;6376.681165941592;6387.584806987531;6265.686715664289;6460.967695161494;6494.318096599978;6496.805095847132;6497.902531462127;5460.5904557159165;6201.937980620136;6303.086052522267;6313.179286692701;6331.715072821642 20:13:30 INFO - PID 1644 | |1;ext.html;720.7657511308822;763.7861398808334;818.877168424736;1278.194737315491;1281.9615411537652;31395.529067064013;37365.50537978481;38566.22867542647;38683.806580967124;38701.806490967574;28446.573301400495;39158.41262381067;39610.40584391236;39671.80164099183;41973.74078777634;8104.473209241395;8246.670133194695;8257.876131858027;8262.958685206566;8749.300055995505;8740.737777866643;8763.649454021832;8825.338099642553;8850.911490885073;8882.555872206396;8830.470171789713;8832.779180520474;8919.018907920123;8963.148500892405;8969.730908072735;8787.648494060262;8881;8894.73315800527;8911.95544022279;8913.108689131068;8573.52845593492;8647.481151130953;8685.826283474358;8696.260817830493;8724.171203735636;37755.244895102216;37894.62105378966;37967.810160949295;38090.80954595237;38233.0441738956;3662.3224703429682;3664.175560498893;3705.870294539678;3709.7774133552075;3711.0722319420147;30980.38039239225;31458.05625831229;31589.526157107663;31631;31729.524057139162;3175.5712978747806;3197.5683282756763;3217.276112874608;3219.4044101841;3225.4677978133814;241236;243137;269510.65244673844;289438;289530.7617309563;40681.79659101686;40690.59309406868;49206;49522.75238623784;49589.51231463062;40270;51064.234036489484;51368.229476557884;51393.229101563506;51434.48565514372;14185.361658725382;14333.996620236483;14399.92800035993;14414.783778243334;15055.096694198382;11588.536458541565;11684;11725.706857328465;11751.942325190603;11765;10936.398498082683;13432.052352408846;13465.259410732308;13478.663033424244;13522.459101635824;5950.137230101697;5963.194968679173;5966.373530779292;5969.074793407029;6022.939770602326;913.2739472119681;931.2596485793811;1041.422010784007;1043.5721354244724;1094.4308959341258;23973.160939367386;30846.383072338427;31331.37337253242;31403.214919627193;31513.212169695482;1115.2917897135378;1117.1063149480547;1143.4397145398696;1146.48408216303;1163.2787671643634;12756.170848894792;13042.41309141091;13049.934750326187;13080.738385232242;13167.67080822968;354523;361409;362977;364122.5381619278;366974;55827;56051;56096.43903560994;56130.719346403006;56192.595185119884;1460.9488667896574;1490.5602847160114;1525.5652139140514;1532.0577844625698;1544.2047345617016;24510.387240319134;24533;24673.87663061673;24701;24714.50570988606;40541.79729101453;46731.29903051389;47999.280010799164;48007.5199248017;48039.519604804904;232015;234368;234805;234943;235015.82492088113;31062.534061988637;31613.36773264568;35443.82278088593;36228.63771362358;36902.44646330361;44401.445949391615;44446;44925;45255.77372113118;45312.77343613261;30722.078337649906;30774.53838192384;30940.845295773375;31282.464042714135;31336.21659458532;26489.735102648727;30836.69163308338;31623.57693903734;32353;32854;38782.03044923899;38792.61207388003;38867.80566097151;38898;39008;28584.428311434072;29558.852205738833;30816;31124.910628127906;31393.058208253788;23130.421739456648;24907.62638560459;24969.75030249747;25014.624780627943;25113.87443062773 20:13:30 INFO - PID 1644 | |2;jquery.html;403.4714523973595;428.3596023944204;434.1729006243106;439.4616594671527;443.62735302346033;19816.405507834752;21212;22077.33767986959;22229.888505574716;22240.88879555604;21664.783352166472;21756.3473095807;22122.88938555309;22228.555428891414;22728.204512842054;5545.473180047889;6203.751849925998;6336.778212762554;6411.198600174978;6415.358464153571;6159.90760138596;6286.177008667481;6328.208973878265;6372;6373.5857169283845;6017.939820601781;6254.093156492306;6293.5279854010905;6329.303776584595;6332.746690132389;5817.156512305692;5953.702314884238;6235.937640623603;6250.687465626723;6362.491000719931;5614.27014488118;5614.522765564931;5621.943780562224;5665.348484924204;5674.574406919456;22401.887990560106;26196.476070478482;27450.45099098027;27916.302092447648;28223;2178.74944381395;2242.65238887971;2254;2259.4916143867663;2260.660900864867;14349.569512914524;17539.73690394645;17688.380906668204;17713.114344282734;18286.085695715294;2160.8163306119;2166.1118941234176;2194.7366316042016;2222.833287503444;2226.076178385968;128107;157923;159738.20130899388;161127;162074;12386.194897331645;13154.539591114266;13167.802482962763;13169.275689837152;13171.341432928315;16830.663386732198;16843;16917.06956117401;16933.83066169347;16990.32038718462;8932.642694292155;9251;9283.39657922233;9294.349395542247;9381.249500039981;8819.162179592928;8823.338249631302;8860.556972151495;8939.508327042075;8988.685396011238;7989.161138080534;8056.194380562014;8087.919120808834;8137.674493020331;8149.7147599833725;1970.7240986261934;2189.4854709143337;2201.8238540916686;2207.6026315263407;2369.6919400477827;914.29599208609;930;932.4964519159713;940.3840484482674;948.848184290524;17572.33062859026;19816.801831981786;20316.08577614011;20511.692324615142;20627.79372206289;845.754731127966;877.7805548612847;925.4539821505344;966.3139171188535;968.5544649461327;9078.682246121487;10485;10489.790204195873;10511.316764410289;10549.736256593647;659856;671408.8577342688;685698;689103;695196;142907.85638215436;144207;148165.85087820273;155567.22216388845;171929;1199.094683513959;1212.6240865331774;1257.0509265504668;1258.7293731847697;1259.659891829201;20248.987550622704;22128;22440.10239590398;22459.550808984055;22512.32463026112;56877.431225687214;62742;63444;65071.67464162649;66623;88131;90086.54956725174;90975;91405;92138.61792073258;7491.76385896321;8903.910960890309;9169.724908252763;9183.219426348835;9260.583273752833;14589.343479543233;14705.338259778122;14739.92630036843;15105.697886042437;15123.924380378028;12059.336736479578;12157.1489995703;12273.386330683608;12286.38568071575;12313.44589493457;11095.72260693489;11676.532938682358;11678.24091434054;11682.591109311134;11966.880331196924;10263;12268.263904165779;12331.383430828244;12695.746085078432;12770.169938953939;8464.53445060503;8791.68124781288;9097.09029097085;9132.041135680658;9214.262858971133;12224.938875305923;12228.633141005785;12247.816282755944;12309.44607492683;12344.938275308567 20:13:30 INFO - PID 1644 | |3;mootools.html;1386.4869998100705;1430.0990376063085;1440.7190597833421;1442.761944279194;1463.3414963266532;11445.427728613568;11740.060795136389;11831.822522662156;11856.585019524318;12144.878551214508;11728;11849.348285844275;11895;11899.988500977406;11933.940330298336;2466;2516.949661006788;2517.8363406378617;2520.4329025969196;2527.41869370045;2439.0731522021606;2458.938526536842;2483.4412257242066;2494.0397946790526;2507.323022783847;2453.521563295158;2457.9799383255927;2474.1093206445667;2501.7248102708777;2507.3982244261338;2444.2056331692092;2449.889754961031;2472.863992480413;2481.3548477395916;2484.329231107609;2150.602138604363;2412.49337639096;2477.3930387055107;2487.9253622391357;2525.45702673926;11912.761744765055;11942.984846288076;11983;11994.580189693319;12021.93989030058;6491.967540162269;6690.63201523916;6715.46276297895;6724.394804467573;6743.865122697519;4085.346344584882;4350.303951367766;4386.517483076859;4415.315626077963;4426.513083560806;1113.5545781687308;1230.7630831014774;1250.6935800728788;1294.5210272199251;1299.6425982854696;12075.57735479254;13795;16079.517614471584;16151.273192706356;16808.243629036722;5495.258140151029;5625.46558076982;5691.800786972436;5796.971015144982;5800.651960882361;12348.876511234952;12437;12449.688757781129;12457.688557786129;12469.625911222496;6549.083128362033;6552.737890484423;6554.573952693059;6556.147700798866;6557.5081868860025;5933.2880054393745;6052.152698622196;6145.262568491809;6185.567010309235;6243.063540468966;4382.583654552813;4425.269830478;4454.797204754763;4501.954980450219;4543.772811359485;1275.1456524128855;1293.6377814212035;1294.3334182895817;1310.6133690561308;1312.6915174933883;777.7744454108246;785.2853902948403;805.3571162249635;818.059231883327;832.6045128563884;4837;5512.173174023848;5514.869451762379;6173.382661733791;6369.585976911486;487.22531175430527;597.6951754605095;599.0893841361194;611.3458599298708;613.7084884679741;4029.6171863672903;4291.763952982554;4320.719153255029;4447.355133505624;4470.173017991682;14817.481028225227;14954;15424.997375170802;15457.922710386376;15488.303026363841;14954.102753834588;14961.102333860003;15343.616409589626;15350.692986140215;15359.462418815288;9501.287403444907;10834.970677785597;10945.83581246282;11129.165312601588;11144.665660030212;5866.5893387464175;6752.683226770732;7119.466040046914;7166.820829479305;7274.454415918722;13651.976101792206;13981.23103229332;14011.159330440207;14053.648658783612;14155.575332740034;13953;14007.369668364745;14112.78830817518;14231.501897433955;14282.428702852185;8822.338324625807;9423.38747981379;9608.13526782593;9853.359531630422;9895.604175832887;8333.374996875138;10454.529546170592;10541.945805419396;10594;10597.099246564128;9315.906840931504;9333.626654933998;9377.437353758796;9388.014258502759;9501.382410143318;9163.49600771964;9189.494577798285;9216.170544651013;9270.304727145356;9301.906980930104;8277.130901255523;8353.331733461187;8448.83102337962;8453.915460845314;8462.238398544161;4961.305417241517;6061.848453788514;6088.786892458743;6229.283632382334;6242.250929888442;5501.642393244426;6145.8156255312415;6232.940400131898;6269.467095296951;6502.642354670538 20:13:30 INFO - PID 1644 | |4;prototype.html;410.6468437144056;413.5926112778913;416.02649799469236;419.82239817312427;424.26390212980476;6159.322474527804;6161.258240083165;6190.535709821759;6196.597221180631;6206.286277078138;5485.259489968853;5990.610610310327;6024.457798798107;6040.456358927696;6062.333143354227;4680.812767489297;4681.7190968542;4689.2966055091665;4690.882727931812;4699.412573428322;4076.8165432555606;4275.46556680415;4336.522982471925;4719.315699223611;4734.431868175807;4426.712263702865;4430.889227769299;4446.533114023029;4459.595227503342;4467;4442.62237709795;4449.710768800018;4458.509563947963;4467.821287148527;4473.507914129443;3212.855421506038;3250.7236884864815;3877.379619260933;3902.609739026103;3912.39357899526;5458.5087342139;5866.589338746289;5891.823245302605;5901.586888917777;5918.082697181943;5341.786328546892;5344.278522399504;5344.305240318772;5383.919241211385;5383.977044361559;5676.574256930747;5887.175795388649;6207.658578778165;6490.253620833618;6512.967435162841;3861.710371722132;4357.934630980538;4379.233634114017;4392.363107349416;4399.868003959887;5962.97018514909;6541.34586541342;6794;6814.047852245735;6907.585544867324;3679.521662183899;3725.9194833498523;4283.464566929134;4440.3339499074755;4446.666500012512;4507;4523;4530.954690453119;4544.454665440102;4549.6360291176625;4428.424304840414;4613.354130421677;4960.826371077067;5367.275417818544;5380.2736630555155;5159.922601160985;5390.434004429557;6482.578632388974;6525.967370163119;6535.771248006297;1202.5911190195375;1266.1769849597652;1519.4150252153001;1539.8229203641501;1541.745611974034;882.2412725056446;959.6737109382843;1017.3285631483186;1020.9540570674337;1037.2842738510556;5958.910616340759;6193.194884664965;6198.163247961557;6237.781677641261;6257;5906.40935906406;6724.327567243236;6734.3602357775935;6760.7295708172105;6764.627945462948;5951.3751056139345;6016.548758843104;6115.296740874767;6179.3315804733365;6239.719212635442;3470.340635279289;3496.5104885316077;3514.7522629466685;3518.894433167009;3524.4008518551395;6295.276043254993;6686.231083425371;6834;6861.020608047321;6957.956306553956;5597.8600534986135;5968.80623875218;6397.464608493928;6719.462443004548;6928.302565871293;5312.103565042799;5683.914741278884;6170.56806023583;6460.612363258219;6537.8692426152165;6061.696915154313;6212.782552610637;6750.189977202767;6766.594004359754;6804.795856124324;5161.612879034163;6426.4537514311805;6656.567323123982;6682.599044057372;6723.016710070443;6095.262850087704;6325.810225693236;6751.459883209233;6925.376716095374;7040;3573.7319701022006;4018.3323920573803;4116.485439320085;4478.484974228006;4486.730796152241;5708.4862362387585;5895.587308888336;6683.732650694113;6747.730090796509;6799.93200067993;6001.90997135052;6506.837329066811;6527.421668441034;6554;6556.311587283458;5660.490555849993;6521.739130434729;6530.412262896362;6531.608103513804;6578.638174900235;5545.639533430475;6118.663473509;6187.514052312038;6304.275008374096;6392.808215753535;5423.566114710735;6527.5430719849155;6562.278149403466;6575;6594.373534514213;5804.564657650778;6220.813375598739;6234.415201344437;6322.114903913363;6349.14286571307 20:13:30 INFO - PID 1644 | |5;yui.html;771.6488997506134;830.4560512864068;835.761807884753;872.0712441250068;875.5009644502634;15645;15989;16026.679466410666;18161.90919045403;18844;17873.016984065904;18004.369847055357;18031.639367212647;18221.180046897887;18675.906620466914;991.1179050644931;998.9621172807482;1017.1405162637597;1017.3692310767335;1019.9949000254989;1012.4380968562444;1034.8499467577196;1042.249580302185;1044.2742294105599;1044.4307852220559;1102.5314241447352;1106.7011906785162;1107.1143085531583;1107.241539545414;1112.3492756737319;1087.635642059903;1095.2059756676426;1098;1101.7741363020561;1102.0852692265441;790.7548659915444;801.0067516279771;802.2458888644655;803.2931020701803;803.5620586780219;16626.25181866819;16906.070166140857;17042.23309951055;17125.65748685032;17174.141292935426;16909.23908424124;17209;17332.82667173337;17351.56621084483;17370.131493425277;13573.389197486136;13706.52027179054;13860.306984650728;13870.237136957463;13884.722305553933;3118.438681037412;3309.1065412338776;3330.6003279606603;3431.1936694876686;3522.2955408918065;97775.51112244393;107721.46139269332;118251;119311;119751;12140.575079872338;12402.821731935452;13412.865871341357;13659.521916732867;13662.521811736542;24325.391865203157;25550.744492555208;25672.101476448235;25993;26054.34864128374;7861.606919653995;9066.682666106655;9179.95410022959;9189.3108016899;9192.862107068398;4372.584604462571;4651.558101980307;4829.010052939139;4832.830850920272;4923.08922849274;4286.828526858891;4367.082912588328;4390.846320378835;4393.319035549431;4410.845620403271;933.1368484152132;964.1033838530094;964.262339310428;970.6214576315101;971.6696323250129;643.9130717353191;667.9031540426708;675.5541342713785;680.2721088435327;685.3900028974217;10912.508937097691;10912.727181820517;12086.274823510617;12086.395680215954;12103.697407564881;647.4755448087064;649.1334069017914;651.212033439534;665.670493105906;680.3740558686021;5238.869028274247;5360.91958620621;5430.56555475561;5533.505953392561;5702.600817942704;77789.61105194438;93828.65428364345;102768.48615756874;103733.48133259437;105804.47097764615;67190.66404668044;84021.73967390494;86823.69764453538;88682;89642;82861.17138828535;83296;84992.99999999876;85396.14603854006;86099;10638.255322127377;11316.434178291218;11580.073594112619;12303.815442768187;12681.80977285323;36857;37260;37306.81346593249;38515.42226866543;40647.59352406438;65657.34342656512;66481.66759166367;67870;67903.66048169727;68031.65984170047;13986.230757308445;16496.67006659836;16796.328146873988;16885.986840789592;16920;18439.90780046145;18465;18467.984260865243;18503;18714.71927921055;16218.945768525007;16846.9891806492;16987.83012169912;17102.743458848377;17261.79167458266;16307;16966.981981081175;17168.656626867643;17247.396341128002;17276.481705548853;16261.837381626505;16601.41895033668;16697.926900671635;16855.747163792308;16998.405055822986;11578.131640127192;11706.297622142698;12071.456784444897;12232.204906681038;12269.263844169378;12122.696932576757;12127.272363658209;13301.201927884358;13939.372728227052;14184.219867907364 20:13:30 INFO - PID 1644 | __end_tp_report 20:13:30 INFO - PID 1644 | __start_cc_report 20:13:30 INFO - PID 1644 | _x_x_mozilla_cycle_collect,423 20:13:30 INFO - PID 1644 | __end_cc_report 20:13:30 INFO - PID 1644 | __startTimestamp1492053210646__endTimestamp 20:13:30 INFO - PID 1644 | 20:13:30 INFO - PID 1644 | ------- Summary: start ------- 20:13:30 INFO - PID 1644 | Number of tests: 6 20:13:30 INFO - PID 1644 | 20:13:30 INFO - PID 1644 | [#0] dojo.html Cycles:165 Average:6029.15 Median:6321.59 stddev:856.48 (13.5%) stddev-sans-first:836.30 20:13:30 INFO - PID 1644 | Values: 3526.4 3529.8 3562.3 3565.0 3581.0 6059.6 6164.5 6173.2 6191.7 6212.1 6109.2 6115.5 6118.5 6133.0 6138.0 5317.5 5399.7 5429.3 5435.1 5525.4 5493.4 5504.5 5507.1 5520.9 5532.6 542.3 4725.3 5310.3 5348.5 5502.1 4358.3 5396.5 5410.6 5422.0 5469.4 5339.8 5344.9 5352.3 5362.0 5424.5 4451.5 6051.4 6092.8 6141.6 6262.0 6388.4 6441.2 6548.0 6600.1 6659.4 6725.1 6735.9 6754.5 6757.0 6762.4 6232.3 6235.3 6255.7 6263.2 6269.2 6582.4 6694.8 6789.0 6830.2 6874.8 5600.8 6486.4 6512.2 6530.2 6565.7 6446.2 6523.5 6530.2 6741.7 6783.7 5535.7 6487.8 6575.4 6588.9 6599.9 6349.4 6416.2 6457.3 6592.2 6613.8 5277.3 5321.3 5345.3 5351.9 5361.1 4011.4 4725.8 4729.5 4734.7 4768.5 5589.5 5851.7 6260.1 6321.6 6378.4 6603.1 6689.8 6702.5 6708.2 6709.4 6349.7 6359.9 6368.6 6368.9 6394.1 5805.9 5882.1 5887.9 5894.1 5902.7 6572.9 6660.3 6796.5 6853.9 6860.3 6718.6 6735.7 6736.5 6750.0 6766.5 6827.9 6857.5 6890.9 6906.9 6920.5 6342.7 6440.5 6536.9 6558.7 6563.0 5972.3 6114.3 6667.5 6704.9 6729.1 5583.0 6130.5 6487.4 6492.3 6498.0 5437.2 6442.8 6467.2 6500.9 6511.0 5470.6 6197.1 6372.0 6376.7 6387.6 6265.7 6461.0 6494.3 6496.8 6497.9 5460.6 6201.9 6303.1 6313.2 6331.7 20:13:30 INFO - PID 1644 | 20:13:30 INFO - PID 1644 | [#1] ext.html Cycles:180 Average:44633.07 Median:357966.00 stddev:76882.19 (21.5%) stddev-sans-first:77027.16 20:13:30 INFO - PID 1644 | Values: 720.8 763.8 818.9 1278.2 1282.0 31395.5 37365.5 38566.2 38683.8 38701.8 28446.6 39158.4 39610.4 39671.8 41973.7 8104.5 8246.7 8257.9 8263.0 8749.3 8740.7 8763.6 8825.3 8850.9 8882.6 8830.5 8832.8 8919.0 8963.1 8969.7 8787.6 8881.0 8894.7 8912.0 8913.1 8573.5 8647.5 8685.8 8696.3 8724.2 37755.2 37894.6 37967.8 38090.8 38233.0 3662.3 3664.2 3705.9 3709.8 3711.1 30980.4 31458.1 31589.5 31631.0 31729.5 3175.6 3197.6 3217.3 3219.4 3225.5 241236.0 243137.0 269510.7 289438.0 289530.8 40681.8 40690.6 49206.0 49522.8 49589.5 40270.0 51064.2 51368.2 51393.2 51434.5 14185.4 14334.0 14399.9 14414.8 15055.1 11588.5 11684.0 11725.7 11751.9 11765.0 10936.4 13432.1 13465.3 13478.7 13522.5 5950.1 5963.2 5966.4 5969.1 6022.9 913.3 931.3 1041.4 1043.6 1094.4 23973.2 30846.4 31331.4 31403.2 31513.2 1115.3 1117.1 1143.4 1146.5 1163.3 12756.2 13042.4 13049.9 13080.7 13167.7 354523.0 361409.0 362977.0 364122.5 366974.0 55827.0 56051.0 56096.4 56130.7 56192.6 1460.9 1490.6 1525.6 1532.1 1544.2 24510.4 24533.0 24673.9 24701.0 24714.5 40541.8 46731.3 47999.3 48007.5 48039.5 232015.0 234368.0 234805.0 234943.0 235015.8 31062.5 31613.4 35443.8 36228.6 36902.4 44401.4 44446.0 44925.0 45255.8 45312.8 30722.1 30774.5 30940.8 31282.5 31336.2 26489.7 30836.7 31623.6 32353.0 32854.0 38782.0 38792.6 38867.8 38898.0 39008.0 28584.4 29558.9 30816.0 31124.9 31393.1 23130.4 24907.6 24969.8 25014.6 25113.9 20:13:30 INFO - PID 1644 | 20:13:30 INFO - PID 1644 | [#2] jquery.html Cycles:180 Average:40464.78 Median:2256.75 stddev:114350.51 (5067.1%) stddev-sans-first:114631.73 20:13:30 INFO - PID 1644 | Values: 403.5 428.4 434.2 439.5 443.6 19816.4 21212.0 22077.3 22229.9 22240.9 21664.8 21756.3 22122.9 22228.6 22728.2 5545.5 6203.8 6336.8 6411.2 6415.4 6159.9 6286.2 6328.2 6372.0 6373.6 6017.9 6254.1 6293.5 6329.3 6332.7 5817.2 5953.7 6235.9 6250.7 6362.5 5614.3 5614.5 5621.9 5665.3 5674.6 22401.9 26196.5 27450.5 27916.3 28223.0 2178.7 2242.7 2254.0 2259.5 2260.7 14349.6 17539.7 17688.4 17713.1 18286.1 2160.8 2166.1 2194.7 2222.8 2226.1 128107.0 157923.0 159738.2 161127.0 162074.0 12386.2 13154.5 13167.8 13169.3 13171.3 16830.7 16843.0 16917.1 16933.8 16990.3 8932.6 9251.0 9283.4 9294.3 9381.2 8819.2 8823.3 8860.6 8939.5 8988.7 7989.2 8056.2 8087.9 8137.7 8149.7 1970.7 2189.5 2201.8 2207.6 2369.7 914.3 930.0 932.5 940.4 948.8 17572.3 19816.8 20316.1 20511.7 20627.8 845.8 877.8 925.5 966.3 968.6 9078.7 10485.0 10489.8 10511.3 10549.7 659856.0 671408.9 685698.0 689103.0 695196.0 142907.9 144207.0 148165.9 155567.2 171929.0 1199.1 1212.6 1257.1 1258.7 1259.7 20249.0 22128.0 22440.1 22459.6 22512.3 56877.4 62742.0 63444.0 65071.7 66623.0 88131.0 90086.5 90975.0 91405.0 92138.6 7491.8 8903.9 9169.7 9183.2 9260.6 14589.3 14705.3 14739.9 15105.7 15123.9 12059.3 12157.1 12273.4 12286.4 12313.4 11095.7 11676.5 11678.2 11682.6 11966.9 10263.0 12268.3 12331.4 12695.7 12770.2 8464.5 8791.7 9097.1 9132.0 9214.3 12224.9 12228.6 12247.8 12309.4 12344.9 20:13:30 INFO - PID 1644 | 20:13:30 INFO - PID 1644 | [#3] mootools.html Cycles:180 Average:7202.66 Median:2522.94 stddev:4582.07 (181.6%) stddev-sans-first:4574.08 20:13:30 INFO - PID 1644 | Values: 1386.5 1430.1 1440.7 1442.8 1463.3 11445.4 11740.1 11831.8 11856.6 12144.9 11728.0 11849.3 11895.0 11900.0 11933.9 2466.0 2516.9 2517.8 2520.4 2527.4 2439.1 2458.9 2483.4 2494.0 2507.3 2453.5 2458.0 2474.1 2501.7 2507.4 2444.2 2449.9 2472.9 2481.4 2484.3 2150.6 2412.5 2477.4 2487.9 2525.5 11912.8 11943.0 11983.0 11994.6 12021.9 6492.0 6690.6 6715.5 6724.4 6743.9 4085.3 4350.3 4386.5 4415.3 4426.5 1113.6 1230.8 1250.7 1294.5 1299.6 12075.6 13795.0 16079.5 16151.3 16808.2 5495.3 5625.5 5691.8 5797.0 5800.7 12348.9 12437.0 12449.7 12457.7 12469.6 6549.1 6552.7 6554.6 6556.1 6557.5 5933.3 6052.2 6145.3 6185.6 6243.1 4382.6 4425.3 4454.8 4502.0 4543.8 1275.1 1293.6 1294.3 1310.6 1312.7 777.8 785.3 805.4 818.1 832.6 4837.0 5512.2 5514.9 6173.4 6369.6 487.2 597.7 599.1 611.3 613.7 4029.6 4291.8 4320.7 4447.4 4470.2 14817.5 14954.0 15425.0 15457.9 15488.3 14954.1 14961.1 15343.6 15350.7 15359.5 9501.3 10835.0 10945.8 11129.2 11144.7 5866.6 6752.7 7119.5 7166.8 7274.5 13652.0 13981.2 14011.2 14053.6 14155.6 13953.0 14007.4 14112.8 14231.5 14282.4 8822.3 9423.4 9608.1 9853.4 9895.6 8333.4 10454.5 10541.9 10594.0 10597.1 9315.9 9333.6 9377.4 9388.0 9501.4 9163.5 9189.5 9216.2 9270.3 9301.9 8277.1 8353.3 8448.8 8453.9 8462.2 4961.3 6061.8 6088.8 6229.3 6242.3 5501.6 6145.8 6232.9 6269.5 6502.6 20:13:30 INFO - PID 1644 | 20:13:30 INFO - PID 1644 | [#4] prototype.html Cycles:180 Average:5200.82 Median:5898.59 stddev:1628.75 (27.6%) stddev-sans-first:1593.14 20:13:30 INFO - PID 1644 | Values: 410.6 413.6 416.0 419.8 424.3 6159.3 6161.3 6190.5 6196.6 6206.3 5485.3 5990.6 6024.5 6040.5 6062.3 4680.8 4681.7 4689.3 4690.9 4699.4 4076.8 4275.5 4336.5 4719.3 4734.4 4426.7 4430.9 4446.5 4459.6 4467.0 4442.6 4449.7 4458.5 4467.8 4473.5 3212.9 3250.7 3877.4 3902.6 3912.4 5458.5 5866.6 5891.8 5901.6 5918.1 5341.8 5344.3 5344.3 5383.9 5384.0 5676.6 5887.2 6207.7 6490.3 6513.0 3861.7 4357.9 4379.2 4392.4 4399.9 5963.0 6541.3 6794.0 6814.0 6907.6 3679.5 3725.9 4283.5 4440.3 4446.7 4507.0 4523.0 4531.0 4544.5 4549.6 4428.4 4613.4 4960.8 5367.3 5380.3 5159.9 5390.4 6482.6 6526.0 6535.8 1202.6 1266.2 1519.4 1539.8 1541.7 882.2 959.7 1017.3 1021.0 1037.3 5958.9 6193.2 6198.2 6237.8 6257.0 5906.4 6724.3 6734.4 6760.7 6764.6 5951.4 6016.5 6115.3 6179.3 6239.7 3470.3 3496.5 3514.8 3518.9 3524.4 6295.3 6686.2 6834.0 6861.0 6958.0 5597.9 5968.8 6397.5 6719.5 6928.3 5312.1 5683.9 6170.6 6460.6 6537.9 6061.7 6212.8 6750.2 6766.6 6804.8 5161.6 6426.5 6656.6 6682.6 6723.0 6095.3 6325.8 6751.5 6925.4 7040.0 3573.7 4018.3 4116.5 4478.5 4486.7 5708.5 5895.6 6683.7 6747.7 6799.9 6001.9 6506.8 6527.4 6554.0 6556.3 5660.5 6521.7 6530.4 6531.6 6578.6 5545.6 6118.7 6187.5 6304.3 6392.8 5423.6 6527.5 6562.3 6575.0 6594.4 5804.6 6220.8 6234.4 6322.1 6349.1 20:13:30 INFO - PID 1644 | 20:13:30 INFO - PID 1644 | [#5] yui.html Cycles:180 Average:21466.65 Median:18096.77 stddev:29036.43 (160.5%) stddev-sans-first:29076.30 20:13:30 INFO - PID 1644 | Values: 771.6 830.5 835.8 872.1 875.5 15645.0 15989.0 16026.7 18161.9 18844.0 17873.0 18004.4 18031.6 18221.2 18675.9 991.1 999.0 1017.1 1017.4 1020.0 1012.4 1034.8 1042.2 1044.3 1044.4 1102.5 1106.7 1107.1 1107.2 1112.3 1087.6 1095.2 1098.0 1101.8 1102.1 790.8 801.0 802.2 803.3 803.6 16626.3 16906.1 17042.2 17125.7 17174.1 16909.2 17209.0 17332.8 17351.6 17370.1 13573.4 13706.5 13860.3 13870.2 13884.7 3118.4 3309.1 3330.6 3431.2 3522.3 97775.5 107721.5 118251.0 119311.0 119751.0 12140.6 12402.8 13412.9 13659.5 13662.5 24325.4 25550.7 25672.1 25993.0 26054.3 7861.6 9066.7 9180.0 9189.3 9192.9 4372.6 4651.6 4829.0 4832.8 4923.1 4286.8 4367.1 4390.8 4393.3 4410.8 933.1 964.1 964.3 970.6 971.7 643.9 667.9 675.6 680.3 685.4 10912.5 10912.7 12086.3 12086.4 12103.7 647.5 649.1 651.2 665.7 680.4 5238.9 5360.9 5430.6 5533.5 5702.6 77789.6 93828.7 102768.5 103733.5 105804.5 67190.7 84021.7 86823.7 88682.0 89642.0 82861.2 83296.0 84993.0 85396.1 86099.0 10638.3 11316.4 11580.1 12303.8 12681.8 36857.0 37260.0 37306.8 38515.4 40647.6 65657.3 66481.7 67870.0 67903.7 68031.7 13986.2 16496.7 16796.3 16886.0 16920.0 18439.9 18465.0 18468.0 18503.0 18714.7 16218.9 16847.0 16987.8 17102.7 17261.8 16307.0 16967.0 17168.7 17247.4 17276.5 16261.8 16601.4 16697.9 16855.7 16998.4 11578.1 11706.3 12071.5 12232.2 12269.3 12122.7 12127.3 13301.2 13939.4 14184.2 20:13:30 INFO - PID 1644 | -------- Summary: end -------- 20:13:30 INFO - PID 1644 | 20:13:31 INFO - TEST-INFO | 1644: exit 0 20:13:31 INFO - TEST-OK | dromaeo_css | took 1114287ms 20:13:31 INFO - TEST-START | kraken 20:13:31 INFO - operating with platform_type : mac_ 20:13:31 INFO - Initialising browser for kraken test... 20:13:31 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmptsNRNw/profile http://localhost:49251/getInfo.html) 20:13:34 INFO - PID 1656 | 2017-04-12 20:13:34.326 plugin-container[1657:10333] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8833, name = 'com.apple.tsm.portname' 20:13:34 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:13:34 INFO - PID 1656 | 2017-04-12 20:13:34.331 plugin-container[1657:10333] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 20:13:34 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:13:34 INFO - PID 1656 | 2017-04-12 20:13:34.331 plugin-container[1657:10333] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:13:34 INFO - PID 1656 | __metrics Screen width/height:1600/1200 20:13:34 INFO - PID 1656 | colorDepth:24 20:13:34 INFO - PID 1656 | Browser inner width/height: 1024/689 20:13:34 INFO - PID 1656 | __metrics 20:13:34 ERROR - PID 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 20:13:35 INFO - TEST-INFO | 1656: exit 0 20:13:35 INFO - Browser initialized. 20:13:35 INFO - Running cycle 1/1 for kraken test... 20:13:35 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmptsNRNw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:13:38 INFO - PID 1658 | 2017-04-12 20:13:38.115 plugin-container[1659:10450] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443b, name = 'com.apple.tsm.portname' 20:13:38 INFO - PID 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:13:38 INFO - PID 1658 | 2017-04-12 20:13:38.115 plugin-container[1659:10450] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8847, name = 'com.apple.CFPasteboardClient' 20:13:38 INFO - PID 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:13:38 INFO - PID 1658 | 2017-04-12 20:13:38.115 plugin-container[1659:10450] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:13:47 INFO - PID 1658 | RSS: Main: 235290624 20:13:47 INFO - PID 1658 | 20:13:50 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection) 20:13:51 INFO - PID 1658 | RSS: Main: 249049088 20:13:51 INFO - PID 1658 | 20:13:54 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-dft) 20:13:55 INFO - PID 1658 | RSS: Main: 257507328 20:13:55 INFO - PID 1658 | 20:13:58 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-fft) 20:13:59 INFO - PID 1658 | RSS: Main: 260325376 20:13:59 INFO - PID 1658 | 20:14:01 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator) 20:14:02 INFO - PID 1658 | RSS: Main: 262459392 20:14:02 INFO - PID 1658 | 20:14:04 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:14:04 INFO - PID 1658 | RSS: Main: 263073792 20:14:04 INFO - PID 1658 | 20:14:07 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom) 20:14:08 INFO - PID 1658 | RSS: Main: 268218368 20:14:08 INFO - PID 1658 | 20:14:11 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate) 20:14:12 INFO - PID 1658 | RSS: Main: 269426688 20:14:12 INFO - PID 1658 | 20:14:15 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial) 20:14:16 INFO - PID 1658 | RSS: Main: 268873728 20:14:16 INFO - PID 1658 | 20:14:17 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:14:18 INFO - PID 1658 | RSS: Main: 268730368 20:14:18 INFO - PID 1658 | 20:14:20 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:14:20 INFO - PID 1658 | RSS: Main: 268689408 20:14:20 INFO - PID 1658 | 20:14:22 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:14:23 INFO - PID 1658 | RSS: Main: 268877824 20:14:23 INFO - PID 1658 | 20:14:26 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:14:27 INFO - PID 1658 | RSS: Main: 269156352 20:14:27 INFO - PID 1658 | 20:14:30 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:14:31 INFO - PID 1658 | RSS: Main: 269099008 20:14:31 INFO - PID 1658 | 20:14:32 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49251/tests/kraken/driver.html?testName=ai-astar) 20:14:33 INFO - PID 1658 | RSS: Main: 272326656 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | __start_tp_report 20:14:33 INFO - PID 1658 | _x_x_mozilla_page_load 20:14:33 INFO - PID 1658 | _x_x_mozilla_page_load_details 20:14:33 INFO - PID 1658 | |i|pagename|runs| 20:14:33 INFO - PID 1658 | |0;ai-astar;103;120;116;135;167;94;154;167;136;133 20:14:33 INFO - PID 1658 | |1;audio-beat-detection;146;111;119;196;115;137;110;146;165;146 20:14:33 INFO - PID 1658 | |2;audio-dft;216;264;272;239;197;198;197;192;195;203 20:14:33 INFO - PID 1658 | |3;audio-fft;82;60;78;78;67;53;79;86;100;91 20:14:33 INFO - PID 1658 | |4;audio-oscillator;85;71;84;72;71;71;87;88;105;114 20:14:33 INFO - PID 1658 | |5;imaging-gaussian-blur;88;89;136;94;122;92;136;102;90;87 20:14:33 INFO - PID 1658 | |6;imaging-darkroom;94;96;97;97;101;97;98;98;95;97 20:14:33 INFO - PID 1658 | |7;imaging-desaturate;121;87;148;85;145;146;97;146;95;146 20:14:33 INFO - PID 1658 | |8;json-parse-financial;53;51;50;52;52;52;51;52;52;52 20:14:33 INFO - PID 1658 | |9;json-stringify-tinderbox;57;59;59;66;68;64;58;57;59;58 20:14:33 INFO - PID 1658 | |10;stanford-crypto-aes;84;86;88;86;87;86;84;83;86;83 20:14:33 INFO - PID 1658 | |11;stanford-crypto-ccm;136;146;153;143;147;150;156;147;202;154 20:14:33 INFO - PID 1658 | |12;stanford-crypto-pbkdf2;227;214;190;189;222;233;183;190;186;185 20:14:33 INFO - PID 1658 | |13;stanford-crypto-sha256-iterative;71;68;62;60;82;62;83;102;75;95 20:14:33 INFO - PID 1658 | __end_tp_report 20:14:33 INFO - PID 1658 | __start_cc_report 20:14:33 INFO - PID 1658 | _x_x_mozilla_cycle_collect,1005 20:14:33 INFO - PID 1658 | __end_cc_report 20:14:33 INFO - PID 1658 | __startTimestamp1492053273175__endTimestamp 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | ------- Summary: start ------- 20:14:33 INFO - PID 1658 | Number of tests: 14 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | [#0] ai-astar Cycles:10 Average:132.50 Median:145.00 stddev:25.04 (17.3%) stddev-sans-first:24.18 20:14:33 INFO - PID 1658 | Values: 103.0 120.0 116.0 135.0 167.0 94.0 154.0 167.0 136.0 133.0 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:146.00 stddev:27.24 (18.7%) stddev-sans-first:28.77 20:14:33 INFO - PID 1658 | Values: 146.0 111.0 119.0 196.0 115.0 137.0 110.0 146.0 165.0 146.0 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | [#2] audio-dft Cycles:10 Average:217.30 Median:209.50 stddev:30.16 (14.4%) stddev-sans-first:31.98 20:14:33 INFO - PID 1658 | Values: 216.0 264.0 272.0 239.0 197.0 198.0 197.0 192.0 195.0 203.0 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | [#3] audio-fft Cycles:10 Average:77.40 Median:78.50 stddev:14.14 (18.0%) stddev-sans-first:14.90 20:14:33 INFO - PID 1658 | Values: 82.0 60.0 78.0 78.0 67.0 53.0 79.0 86.0 100.0 91.0 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | [#4] audio-oscillator Cycles:10 Average:84.80 Median:78.00 stddev:14.95 (19.2%) stddev-sans-first:15.86 20:14:33 INFO - PID 1658 | Values: 85.0 71.0 84.0 72.0 71.0 71.0 87.0 88.0 105.0 114.0 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:103.60 Median:88.50 stddev:19.96 (22.5%) stddev-sans-first:20.35 20:14:33 INFO - PID 1658 | Values: 88.0 89.0 136.0 94.0 122.0 92.0 136.0 102.0 90.0 87.0 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | [#6] imaging-darkroom Cycles:10 Average:97.00 Median:97.00 stddev:1.89 (1.9%) stddev-sans-first:1.66 20:14:33 INFO - PID 1658 | Values: 94.0 96.0 97.0 97.0 101.0 97.0 98.0 98.0 95.0 97.0 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | [#7] imaging-desaturate Cycles:10 Average:121.60 Median:116.50 stddev:27.65 (23.7%) stddev-sans-first:29.33 20:14:33 INFO - PID 1658 | Values: 121.0 87.0 148.0 85.0 145.0 146.0 97.0 146.0 95.0 146.0 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.73 20:14:33 INFO - PID 1658 | Values: 53.0 51.0 50.0 52.0 52.0 52.0 51.0 52.0 52.0 52.0 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:59.00 stddev:3.98 (6.7%) stddev-sans-first:4.01 20:14:33 INFO - PID 1658 | Values: 57.0 59.0 59.0 66.0 68.0 64.0 58.0 57.0 59.0 58.0 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:86.00 stddev:1.70 (2.0%) stddev-sans-first:1.74 20:14:33 INFO - PID 1658 | Values: 84.0 86.0 88.0 86.0 87.0 86.0 84.0 83.0 86.0 83.0 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:151.50 stddev:18.04 (11.9%) stddev-sans-first:18.00 20:14:33 INFO - PID 1658 | Values: 136.0 146.0 153.0 143.0 147.0 150.0 156.0 147.0 202.0 154.0 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.90 Median:202.00 stddev:19.70 (9.8%) stddev-sans-first:18.68 20:14:33 INFO - PID 1658 | Values: 227.0 214.0 190.0 189.0 222.0 233.0 183.0 190.0 186.0 185.0 20:14:33 INFO - PID 1658 | 20:14:33 INFO - PID 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:73.00 stddev:14.38 (19.7%) stddev-sans-first:15.13 20:14:33 INFO - PID 1658 | Values: 71.0 68.0 62.0 60.0 82.0 62.0 83.0 102.0 75.0 95.0 20:14:33 INFO - PID 1658 | -------- Summary: end -------- 20:14:33 INFO - PID 1658 | 20:14:34 INFO - TEST-INFO | 1658: exit 0 20:14:34 INFO - TEST-OK | kraken | took 62978ms 20:14:34 INFO - SUITE-END | took 1177s 20:14:34 INFO - Completed test suite (00:19:37) 20:14:34 INFO - javascript benchmark 20:14:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7914.748325913701, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3526.382882995475, 3529.8058606776626, 3562.3053504566606, 3564.964350356499, 3580.982095089526, 6059.636421814695, 6164.476019538333, 6173.228346456693, 6191.659458729768, 6212.068189771537, 6109.16175461965, 6115.544587952002, 6118.527810132507, 6133.0, 6137.987232106697, 5317.521423071932, 5399.730013499329, 5429.348478182604, 5435.076037073687, 5525.392206857243, 5493.368262649807, 5504.4770746778995, 5507.091329930557, 5520.889582208353, 5532.585056120787, 542.2612025020587, 4725.3384526166365, 5310.283111779899, 5348.491893270133, 5502.119660854264, 4358.346248062784, 5396.460353964611, 5410.606823586889, 5422.024035673578, 5469.425710300441, 5339.813106541291, 5344.866378340534, 5352.250684904077, 5361.973190134064, 5424.457554244584, 4451.532589078132, 6051.425114614149, 6092.7562897484495, 6141.600795948294, 6261.968690156566, 6388.425041746219, 6441.194850643669, 6548.0, 6600.075989361493, 6659.4006539411685, 6725.125733654593, 6735.932640673628, 6754.493412993996, 6756.966215168942, 6762.357576030269, 6232.345603711636, 6235.314115447297, 6255.749770009194, 6263.248410190807, 6269.185005949197, 6582.3746744059235, 6694.765683201064, 6788.9660551696925, 6830.21452532965, 6874.793756187322, 5600.775968961278, 6486.416222539994, 6512.153420055457, 6530.216374035052, 6565.704543295563, 6446.194225721785, 6523.543351965317, 6530.216374035052, 6741.730330786713, 6783.728650854009, 5535.723213839373, 6487.805365839033, 6575.375339342851, 6588.934110658832, 6599.934000660028, 6349.365063493614, 6416.165898433173, 6457.257415397289, 6592.24189218246, 6613.834654133589, 5277.261183434322, 5321.308229930084, 5345.278387417648, 5351.946480535223, 5361.08861493547, 4011.438398624195, 4725.763711814396, 4729.527047295312, 4734.692245004064, 4768.523147685204, 5589.469000444951, 5851.707414629252, 6260.092286618415, 6321.589096708699, 6378.362163783585, 6603.108580341688, 6689.76585819494, 6702.497312701566, 6708.19501659804, 6709.4296984755865, 6349.682515874188, 6359.904601430982, 6368.5860419072615, 6368.872622547616, 6394.072859435356, 5805.88388232233, 5882.058870580687, 5887.911681324784, 5894.086416605433, 5902.704864756745, 6572.934270657328, 6660.267370589231, 6796.490263230178, 6853.931460685529, 6860.279670634512, 6718.596884186769, 6735.6968936397, 6736.494762892705, 6749.966250168718, 6766.458683305422, 6827.863442731217, 6857.485688573277, 6890.931090689029, 6906.930930690629, 6920.4809639276245, 6342.682865856781, 6440.549161558646, 6536.934630653823, 6558.672066396565, 6562.967185164043, 5972.313183983897, 6114.297368146176, 6667.49993750461, 6704.932950670626, 6729.1252137221845, 5582.972085139549, 6130.47890929276, 6487.416132548094, 6492.28584855656, 6498.0, 5437.211604317273, 6442.806715798533, 6467.159269294962, 6500.902486462802, 6510.967445162744, 5470.617056806144, 6197.070439434121, 6372.044193371032, 6376.681165941592, 6387.584806987531, 6265.686715664289, 6460.967695161494, 6494.318096599978, 6496.805095847132, 6497.902531462127, 5460.5904557159165, 6201.937980620136, 6303.086052522267, 6313.179286692701, 6331.715072821642], "value": 5973.886835088465, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.7657511308822, 763.7861398808334, 818.877168424736, 1278.194737315491, 1281.9615411537652, 31395.529067064013, 37365.50537978481, 38566.22867542647, 38683.806580967124, 38701.806490967574, 28446.573301400495, 39158.41262381067, 39610.40584391236, 39671.80164099183, 41973.74078777634, 8104.473209241395, 8246.670133194695, 8257.876131858027, 8262.958685206566, 8749.300055995505, 8740.737777866643, 8763.649454021832, 8825.338099642553, 8850.911490885073, 8882.555872206396, 8830.470171789713, 8832.779180520474, 8919.018907920123, 8963.148500892405, 8969.730908072735, 8787.648494060262, 8881.0, 8894.73315800527, 8911.95544022279, 8913.108689131068, 8573.52845593492, 8647.481151130953, 8685.826283474358, 8696.260817830493, 8724.171203735636, 37755.244895102216, 37894.62105378966, 37967.810160949295, 38090.80954595237, 38233.0441738956, 3662.3224703429682, 3664.175560498893, 3705.870294539678, 3709.7774133552075, 3711.0722319420147, 30980.38039239225, 31458.05625831229, 31589.526157107663, 31631.0, 31729.524057139162, 3175.5712978747806, 3197.5683282756763, 3217.276112874608, 3219.4044101841, 3225.4677978133814, 241236.0, 243137.0, 269510.65244673844, 289438.0, 289530.7617309563, 40681.79659101686, 40690.59309406868, 49206.0, 49522.75238623784, 49589.51231463062, 40270.0, 51064.234036489484, 51368.229476557884, 51393.229101563506, 51434.48565514372, 14185.361658725382, 14333.996620236483, 14399.92800035993, 14414.783778243334, 15055.096694198382, 11588.536458541565, 11684.0, 11725.706857328465, 11751.942325190603, 11765.0, 10936.398498082683, 13432.052352408846, 13465.259410732308, 13478.663033424244, 13522.459101635824, 5950.137230101697, 5963.194968679173, 5966.373530779292, 5969.074793407029, 6022.939770602326, 913.2739472119681, 931.2596485793811, 1041.422010784007, 1043.5721354244724, 1094.4308959341258, 23973.160939367386, 30846.383072338427, 31331.37337253242, 31403.214919627193, 31513.212169695482, 1115.2917897135378, 1117.1063149480547, 1143.4397145398696, 1146.48408216303, 1163.2787671643634, 12756.170848894792, 13042.41309141091, 13049.934750326187, 13080.738385232242, 13167.67080822968, 354523.0, 361409.0, 362977.0, 364122.5381619278, 366974.0, 55827.0, 56051.0, 56096.43903560994, 56130.719346403006, 56192.595185119884, 1460.9488667896574, 1490.5602847160114, 1525.5652139140514, 1532.0577844625698, 1544.2047345617016, 24510.387240319134, 24533.0, 24673.87663061673, 24701.0, 24714.50570988606, 40541.79729101453, 46731.29903051389, 47999.280010799164, 48007.5199248017, 48039.519604804904, 232015.0, 234368.0, 234805.0, 234943.0, 235015.82492088113, 31062.534061988637, 31613.36773264568, 35443.82278088593, 36228.63771362358, 36902.44646330361, 44401.445949391615, 44446.0, 44925.0, 45255.77372113118, 45312.77343613261, 30722.078337649906, 30774.53838192384, 30940.845295773375, 31282.464042714135, 31336.21659458532, 26489.735102648727, 30836.69163308338, 31623.57693903734, 32353.0, 32854.0, 38782.03044923899, 38792.61207388003, 38867.80566097151, 38898.0, 39008.0, 28584.428311434072, 29558.852205738833, 30816.0, 31124.910628127906, 31393.058208253788, 23130.421739456648, 24907.62638560459, 24969.75030249747, 25014.624780627943, 25113.87443062773], "value": 17865.66825844075, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.4714523973595, 428.3596023944204, 434.1729006243106, 439.4616594671527, 443.62735302346033, 19816.405507834752, 21212.0, 22077.33767986959, 22229.888505574716, 22240.88879555604, 21664.783352166472, 21756.3473095807, 22122.88938555309, 22228.555428891414, 22728.204512842054, 5545.473180047889, 6203.751849925998, 6336.778212762554, 6411.198600174978, 6415.358464153571, 6159.90760138596, 6286.177008667481, 6328.208973878265, 6372.0, 6373.5857169283845, 6017.939820601781, 6254.093156492306, 6293.5279854010905, 6329.303776584595, 6332.746690132389, 5817.156512305692, 5953.702314884238, 6235.937640623603, 6250.687465626723, 6362.491000719931, 5614.27014488118, 5614.522765564931, 5621.943780562224, 5665.348484924204, 5674.574406919456, 22401.887990560106, 26196.476070478482, 27450.45099098027, 27916.302092447648, 28223.0, 2178.74944381395, 2242.65238887971, 2254.0, 2259.4916143867663, 2260.660900864867, 14349.569512914524, 17539.73690394645, 17688.380906668204, 17713.114344282734, 18286.085695715294, 2160.8163306119, 2166.1118941234176, 2194.7366316042016, 2222.833287503444, 2226.076178385968, 128107.0, 157923.0, 159738.20130899388, 161127.0, 162074.0, 12386.194897331645, 13154.539591114266, 13167.802482962763, 13169.275689837152, 13171.341432928315, 16830.663386732198, 16843.0, 16917.06956117401, 16933.83066169347, 16990.32038718462, 8932.642694292155, 9251.0, 9283.39657922233, 9294.349395542247, 9381.249500039981, 8819.162179592928, 8823.338249631302, 8860.556972151495, 8939.508327042075, 8988.685396011238, 7989.161138080534, 8056.194380562014, 8087.919120808834, 8137.674493020331, 8149.7147599833725, 1970.7240986261934, 2189.4854709143337, 2201.8238540916686, 2207.6026315263407, 2369.6919400477827, 914.29599208609, 930.0, 932.4964519159713, 940.3840484482674, 948.848184290524, 17572.33062859026, 19816.801831981786, 20316.08577614011, 20511.692324615142, 20627.79372206289, 845.754731127966, 877.7805548612847, 925.4539821505344, 966.3139171188535, 968.5544649461327, 9078.682246121487, 10485.0, 10489.790204195873, 10511.316764410289, 10549.736256593647, 659856.0, 671408.8577342688, 685698.0, 689103.0, 695196.0, 142907.85638215436, 144207.0, 148165.85087820273, 155567.22216388845, 171929.0, 1199.094683513959, 1212.6240865331774, 1257.0509265504668, 1258.7293731847697, 1259.659891829201, 20248.987550622704, 22128.0, 22440.10239590398, 22459.550808984055, 22512.32463026112, 56877.431225687214, 62742.0, 63444.0, 65071.67464162649, 66623.0, 88131.0, 90086.54956725174, 90975.0, 91405.0, 92138.61792073258, 7491.76385896321, 8903.910960890309, 9169.724908252763, 9183.219426348835, 9260.583273752833, 14589.343479543233, 14705.338259778122, 14739.92630036843, 15105.697886042437, 15123.924380378028, 12059.336736479578, 12157.1489995703, 12273.386330683608, 12286.38568071575, 12313.44589493457, 11095.72260693489, 11676.532938682358, 11678.24091434054, 11682.591109311134, 11966.880331196924, 10263.0, 12268.263904165779, 12331.383430828244, 12695.746085078432, 12770.169938953939, 8464.53445060503, 8791.68124781288, 9097.09029097085, 9132.041135680658, 9214.262858971133, 12224.938875305923, 12228.633141005785, 12247.816282755944, 12309.44607492683, 12344.938275308567], "value": 10735.270032517263, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.4869998100705, 1430.0990376063085, 1440.7190597833421, 1442.761944279194, 1463.3414963266532, 11445.427728613568, 11740.060795136389, 11831.822522662156, 11856.585019524318, 12144.878551214508, 11728.0, 11849.348285844275, 11895.0, 11899.988500977406, 11933.940330298336, 2466.0, 2516.949661006788, 2517.8363406378617, 2520.4329025969196, 2527.41869370045, 2439.0731522021606, 2458.938526536842, 2483.4412257242066, 2494.0397946790526, 2507.323022783847, 2453.521563295158, 2457.9799383255927, 2474.1093206445667, 2501.7248102708777, 2507.3982244261338, 2444.2056331692092, 2449.889754961031, 2472.863992480413, 2481.3548477395916, 2484.329231107609, 2150.602138604363, 2412.49337639096, 2477.3930387055107, 2487.9253622391357, 2525.45702673926, 11912.761744765055, 11942.984846288076, 11983.0, 11994.580189693319, 12021.93989030058, 6491.967540162269, 6690.63201523916, 6715.46276297895, 6724.394804467573, 6743.865122697519, 4085.346344584882, 4350.303951367766, 4386.517483076859, 4415.315626077963, 4426.513083560806, 1113.5545781687308, 1230.7630831014774, 1250.6935800728788, 1294.5210272199251, 1299.6425982854696, 12075.57735479254, 13795.0, 16079.517614471584, 16151.273192706356, 16808.243629036722, 5495.258140151029, 5625.46558076982, 5691.800786972436, 5796.971015144982, 5800.651960882361, 12348.876511234952, 12437.0, 12449.688757781129, 12457.688557786129, 12469.625911222496, 6549.083128362033, 6552.737890484423, 6554.573952693059, 6556.147700798866, 6557.5081868860025, 5933.2880054393745, 6052.152698622196, 6145.262568491809, 6185.567010309235, 6243.063540468966, 4382.583654552813, 4425.269830478, 4454.797204754763, 4501.954980450219, 4543.772811359485, 1275.1456524128855, 1293.6377814212035, 1294.3334182895817, 1310.6133690561308, 1312.6915174933883, 777.7744454108246, 785.2853902948403, 805.3571162249635, 818.059231883327, 832.6045128563884, 4837.0, 5512.173174023848, 5514.869451762379, 6173.382661733791, 6369.585976911486, 487.22531175430527, 597.6951754605095, 599.0893841361194, 611.3458599298708, 613.7084884679741, 4029.6171863672903, 4291.763952982554, 4320.719153255029, 4447.355133505624, 4470.173017991682, 14817.481028225227, 14954.0, 15424.997375170802, 15457.922710386376, 15488.303026363841, 14954.102753834588, 14961.102333860003, 15343.616409589626, 15350.692986140215, 15359.462418815288, 9501.287403444907, 10834.970677785597, 10945.83581246282, 11129.165312601588, 11144.665660030212, 5866.5893387464175, 6752.683226770732, 7119.466040046914, 7166.820829479305, 7274.454415918722, 13651.976101792206, 13981.23103229332, 14011.159330440207, 14053.648658783612, 14155.575332740034, 13953.0, 14007.369668364745, 14112.78830817518, 14231.501897433955, 14282.428702852185, 8822.338324625807, 9423.38747981379, 9608.13526782593, 9853.359531630422, 9895.604175832887, 8333.374996875138, 10454.529546170592, 10541.945805419396, 10594.0, 10597.099246564128, 9315.906840931504, 9333.626654933998, 9377.437353758796, 9388.014258502759, 9501.382410143318, 9163.49600771964, 9189.494577798285, 9216.170544651013, 9270.304727145356, 9301.906980930104, 8277.130901255523, 8353.331733461187, 8448.83102337962, 8453.915460845314, 8462.238398544161, 4961.305417241517, 6061.848453788514, 6088.786892458743, 6229.283632382334, 6242.250929888442, 5501.642393244426, 6145.8156255312415, 6232.940400131898, 6269.467095296951, 6502.642354670538], "value": 5368.6544548383945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.6468437144056, 413.5926112778913, 416.02649799469236, 419.82239817312427, 424.26390212980476, 6159.322474527804, 6161.258240083165, 6190.535709821759, 6196.597221180631, 6206.286277078138, 5485.259489968853, 5990.610610310327, 6024.457798798107, 6040.456358927696, 6062.333143354227, 4680.812767489297, 4681.7190968542, 4689.2966055091665, 4690.882727931812, 4699.412573428322, 4076.8165432555606, 4275.46556680415, 4336.522982471925, 4719.315699223611, 4734.431868175807, 4426.712263702865, 4430.889227769299, 4446.533114023029, 4459.595227503342, 4467.0, 4442.62237709795, 4449.710768800018, 4458.509563947963, 4467.821287148527, 4473.507914129443, 3212.855421506038, 3250.7236884864815, 3877.379619260933, 3902.609739026103, 3912.39357899526, 5458.5087342139, 5866.589338746289, 5891.823245302605, 5901.586888917777, 5918.082697181943, 5341.786328546892, 5344.278522399504, 5344.305240318772, 5383.919241211385, 5383.977044361559, 5676.574256930747, 5887.175795388649, 6207.658578778165, 6490.253620833618, 6512.967435162841, 3861.710371722132, 4357.934630980538, 4379.233634114017, 4392.363107349416, 4399.868003959887, 5962.97018514909, 6541.34586541342, 6794.0, 6814.047852245735, 6907.585544867324, 3679.521662183899, 3725.9194833498523, 4283.464566929134, 4440.3339499074755, 4446.666500012512, 4507.0, 4523.0, 4530.954690453119, 4544.454665440102, 4549.6360291176625, 4428.424304840414, 4613.354130421677, 4960.826371077067, 5367.275417818544, 5380.2736630555155, 5159.922601160985, 5390.434004429557, 6482.578632388974, 6525.967370163119, 6535.771248006297, 1202.5911190195375, 1266.1769849597652, 1519.4150252153001, 1539.8229203641501, 1541.745611974034, 882.2412725056446, 959.6737109382843, 1017.3285631483186, 1020.9540570674337, 1037.2842738510556, 5958.910616340759, 6193.194884664965, 6198.163247961557, 6237.781677641261, 6257.0, 5906.40935906406, 6724.327567243236, 6734.3602357775935, 6760.7295708172105, 6764.627945462948, 5951.3751056139345, 6016.548758843104, 6115.296740874767, 6179.3315804733365, 6239.719212635442, 3470.340635279289, 3496.5104885316077, 3514.7522629466685, 3518.894433167009, 3524.4008518551395, 6295.276043254993, 6686.231083425371, 6834.0, 6861.020608047321, 6957.956306553956, 5597.8600534986135, 5968.80623875218, 6397.464608493928, 6719.462443004548, 6928.302565871293, 5312.103565042799, 5683.914741278884, 6170.56806023583, 6460.612363258219, 6537.8692426152165, 6061.696915154313, 6212.782552610637, 6750.189977202767, 6766.594004359754, 6804.795856124324, 5161.612879034163, 6426.4537514311805, 6656.567323123982, 6682.599044057372, 6723.016710070443, 6095.262850087704, 6325.810225693236, 6751.459883209233, 6925.376716095374, 7040.0, 3573.7319701022006, 4018.3323920573803, 4116.485439320085, 4478.484974228006, 4486.730796152241, 5708.4862362387585, 5895.587308888336, 6683.732650694113, 6747.730090796509, 6799.93200067993, 6001.90997135052, 6506.837329066811, 6527.421668441034, 6554.0, 6556.311587283458, 5660.490555849993, 6521.739130434729, 6530.412262896362, 6531.608103513804, 6578.638174900235, 5545.639533430475, 6118.663473509, 6187.514052312038, 6304.275008374096, 6392.808215753535, 5423.566114710735, 6527.5430719849155, 6562.278149403466, 6575.0, 6594.373534514213, 5804.564657650778, 6220.813375598739, 6234.415201344437, 6322.114903913363, 6349.14286571307], "value": 4694.336802770143, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.6488997506134, 830.4560512864068, 835.761807884753, 872.0712441250068, 875.5009644502634, 15645.0, 15989.0, 16026.679466410666, 18161.90919045403, 18844.0, 17873.016984065904, 18004.369847055357, 18031.639367212647, 18221.180046897887, 18675.906620466914, 991.1179050644931, 998.9621172807482, 1017.1405162637597, 1017.3692310767335, 1019.9949000254989, 1012.4380968562444, 1034.8499467577196, 1042.249580302185, 1044.2742294105599, 1044.4307852220559, 1102.5314241447352, 1106.7011906785162, 1107.1143085531583, 1107.241539545414, 1112.3492756737319, 1087.635642059903, 1095.2059756676426, 1098.0, 1101.7741363020561, 1102.0852692265441, 790.7548659915444, 801.0067516279771, 802.2458888644655, 803.2931020701803, 803.5620586780219, 16626.25181866819, 16906.070166140857, 17042.23309951055, 17125.65748685032, 17174.141292935426, 16909.23908424124, 17209.0, 17332.82667173337, 17351.56621084483, 17370.131493425277, 13573.389197486136, 13706.52027179054, 13860.306984650728, 13870.237136957463, 13884.722305553933, 3118.438681037412, 3309.1065412338776, 3330.6003279606603, 3431.1936694876686, 3522.2955408918065, 97775.51112244393, 107721.46139269332, 118251.0, 119311.0, 119751.0, 12140.575079872338, 12402.821731935452, 13412.865871341357, 13659.521916732867, 13662.521811736542, 24325.391865203157, 25550.744492555208, 25672.101476448235, 25993.0, 26054.34864128374, 7861.606919653995, 9066.682666106655, 9179.95410022959, 9189.3108016899, 9192.862107068398, 4372.584604462571, 4651.558101980307, 4829.010052939139, 4832.830850920272, 4923.08922849274, 4286.828526858891, 4367.082912588328, 4390.846320378835, 4393.319035549431, 4410.845620403271, 933.1368484152132, 964.1033838530094, 964.262339310428, 970.6214576315101, 971.6696323250129, 643.9130717353191, 667.9031540426708, 675.5541342713785, 680.2721088435327, 685.3900028974217, 10912.508937097691, 10912.727181820517, 12086.274823510617, 12086.395680215954, 12103.697407564881, 647.4755448087064, 649.1334069017914, 651.212033439534, 665.670493105906, 680.3740558686021, 5238.869028274247, 5360.91958620621, 5430.56555475561, 5533.505953392561, 5702.600817942704, 77789.61105194438, 93828.65428364345, 102768.48615756874, 103733.48133259437, 105804.47097764615, 67190.66404668044, 84021.73967390494, 86823.69764453538, 88682.0, 89642.0, 82861.17138828535, 83296.0, 84992.99999999876, 85396.14603854006, 86099.0, 10638.255322127377, 11316.434178291218, 11580.073594112619, 12303.815442768187, 12681.80977285323, 36857.0, 37260.0, 37306.81346593249, 38515.42226866543, 40647.59352406438, 65657.34342656512, 66481.66759166367, 67870.0, 67903.66048169727, 68031.65984170047, 13986.230757308445, 16496.67006659836, 16796.328146873988, 16885.986840789592, 16920.0, 18439.90780046145, 18465.0, 18467.984260865243, 18503.0, 18714.71927921055, 16218.945768525007, 16846.9891806492, 16987.83012169912, 17102.743458848377, 17261.79167458266, 16307.0, 16966.981981081175, 17168.656626867643, 17247.396341128002, 17276.481705548853, 16261.837381626505, 16601.41895033668, 16697.926900671635, 16855.747163792308, 16998.405055822986, 11578.131640127192, 11706.297622142698, 12071.456784444897, 12232.204906681038, 12269.263844169378, 12122.696932576757, 12127.272363658209, 13301.201927884358, 13939.372728227052, 14184.219867907364], "value": 8512.577489692512, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1602.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 120.0, 116.0, 135.0, 167.0, 94.0, 154.0, 167.0, 136.0, 133.0], "value": 132.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 119.0, 196.0, 115.0, 137.0, 110.0, 146.0, 165.0, 146.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 264.0, 272.0, 239.0, 197.0, 198.0, 197.0, 192.0, 195.0, 203.0], "value": 217.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 78.0, 78.0, 67.0, 53.0, 79.0, 86.0, 100.0, 91.0], "value": 77.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 84.0, 72.0, 71.0, 71.0, 87.0, 88.0, 105.0, 114.0], "value": 84.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 136.0, 94.0, 122.0, 92.0, 136.0, 102.0, 90.0, 87.0], "value": 103.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 97.0, 97.0, 101.0, 97.0, 98.0, 98.0, 95.0, 97.0], "value": 97.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 87.0, 148.0, 85.0, 145.0, 146.0, 97.0, 146.0, 95.0, 146.0], "value": 121.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 50.0, 52.0, 52.0, 52.0, 51.0, 52.0, 52.0, 52.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 59.0, 66.0, 68.0, 64.0, 58.0, 57.0, 59.0, 58.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 88.0, 86.0, 87.0, 86.0, 84.0, 83.0, 86.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 146.0, 153.0, 143.0, 147.0, 150.0, 156.0, 147.0, 202.0, 154.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [227.0, 214.0, 190.0, 189.0, 222.0, 233.0, 183.0, 190.0, 186.0, 185.0], "value": 201.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 62.0, 60.0, 82.0, 62.0, 83.0, 102.0, 75.0, 95.0], "value": 76.0, "unit": "score"}]}]} 20:14:34 INFO - Return code: 0 20:14:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:14:34 ERROR - # TBPL SUCCESS # 20:14:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:14:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:14:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:14:34 INFO - 2017-04-12 20:14:34.489 screenresolution[1663:10829] starting screenresolution argv=screenresolution get 20:14:34 INFO - 2017-04-12 20:14:34.492 screenresolution[1663:10829] Display 0: 1600x1200x32@60 20:14:34 INFO - 2017-04-12 20:14:34.498 screenresolution[1664:10832] starting screenresolution argv=screenresolution list 20:14:34 INFO - Available Modes on Display 0 20:14:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:14:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:14:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:14:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:14:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:14:34 INFO - Intel Iris: 20:14:34 INFO - Chipset Model: Intel Iris 20:14:34 INFO - Type: GPU 20:14:34 INFO - Bus: Built-In 20:14:34 INFO - VRAM (Dynamic, Max): 1536 MB 20:14:34 INFO - Vendor: Intel (0x8086) 20:14:34 INFO - Device ID: 0x0a2e 20:14:34 INFO - Revision ID: 0x0009 20:14:34 INFO - Displays: 20:14:34 INFO - Display: 20:14:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:14:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:14:34 INFO - Display Serial Number: 1600x1200 60 20:14:34 INFO - Main Display: Yes 20:14:34 INFO - Mirror: Off 20:14:34 INFO - Online: Yes 20:14:34 INFO - Rotation: Supported 20:14:34 INFO - Return code: 0 20:14:34 INFO - Running post-action listener: _resource_record_post_action 20:14:34 INFO - [mozharness: 2017-04-13 03:14:34.747733Z] Finished run-tests step (success) 20:14:34 INFO - Running post-run listener: _resource_record_post_run 20:14:34 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 39159296; Write bytes: 518919680; Read time: 385; Write time: 1784 20:14:34 INFO - TinderboxPrint: CPU usage
54.2% 20:14:34 INFO - TinderboxPrint: I/O read bytes / time
39,159,296 / 385 20:14:34 INFO - TinderboxPrint: I/O write bytes / time
518,919,680 / 1,784 20:14:34 INFO - TinderboxPrint: CPU idle
2,193.9 (45.8%) 20:14:34 INFO - TinderboxPrint: CPU system
966.9 (20.2%) 20:14:34 INFO - TinderboxPrint: CPU user
1,632.8 (34.1%) 20:14:34 INFO - TinderboxPrint: Swap in / out
248,160,256 / 0 20:14:34 INFO - install - Wall time: 20s; CPU: 55.0%; Read bytes: 209164800; Write bytes: 210560512; Read time: 15933; Write time: 442 20:14:34 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 34702848; Write bytes: 307019776; Read time: 352; Write time: 1336 20:14:35 INFO - Running post-run listener: _upload_blobber_files 20:14:35 INFO - Blob upload gear active. 20:14:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:14:35 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 20:14:35 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'] 20:14:35 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 20:14:35 INFO - (blobuploader) - INFO - Open directory for files ... 20:14:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:14:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:14:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:14:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:14:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:14:36 INFO - (blobuploader) - INFO - Done attempting. 20:14:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:14:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:14:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:14:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:14:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:14:37 INFO - (blobuploader) - INFO - Done attempting. 20:14:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:14:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:14:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:14:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:14:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:14:38 INFO - (blobuploader) - INFO - Done attempting. 20:14:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:14:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:14:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:14:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:14:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:14:40 INFO - (blobuploader) - INFO - Done attempting. 20:14:40 INFO - (blobuploader) - INFO - Iteration through files over. 20:14:40 INFO - Return code: 0 20:14:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:14:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:14:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9c4a0de77006367eb744b31a98e10f84c8ceeb555b97c56ca93913d525a14eb669cb869e24938bba89869167de5300e1dbf5b855b3ed3cfe4c529d96f686d7c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae5331dcdb1f5ab9c98b56ea6e36b6c8d902a937c7ae4de006df570d6adff2d24719b5d0ca1e3a599786d2e3b67388596120cd865118e145637ed40a551be064", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f26d67593f1873644199b942af8b9ad33bd661c1e46905de64e8953331b7658bc4838a0befb76610da263d44cfc723ced03867df58851b14cf36f708c08fea97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb759a489c3922ac6c1c0c0efcc0c2d42ab9b867b183eb86bcae40cd0b4722cdea79f5e1dc8d79265ec8dedc1a36752015b232de639380a9530d313602f346b9"} 20:14:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:14:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:14:40 INFO - Contents: 20:14:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9c4a0de77006367eb744b31a98e10f84c8ceeb555b97c56ca93913d525a14eb669cb869e24938bba89869167de5300e1dbf5b855b3ed3cfe4c529d96f686d7c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae5331dcdb1f5ab9c98b56ea6e36b6c8d902a937c7ae4de006df570d6adff2d24719b5d0ca1e3a599786d2e3b67388596120cd865118e145637ed40a551be064", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f26d67593f1873644199b942af8b9ad33bd661c1e46905de64e8953331b7658bc4838a0befb76610da263d44cfc723ced03867df58851b14cf36f708c08fea97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb759a489c3922ac6c1c0c0efcc0c2d42ab9b867b183eb86bcae40cd0b4722cdea79f5e1dc8d79265ec8dedc1a36752015b232de639380a9530d313602f346b9"} 20:14:40 INFO - Running post-run listener: copy_logs_to_upload_dir 20:14:40 INFO - Copying logs to upload dir... 20:14:40 INFO - mkdir: /builds/slave/test/build/upload/logs 20:14:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.358163 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-12 20:14:40.472417) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 20:14:40.475968) ========= 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.Si91sh4VS5/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.WB48aHEIRN/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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/e9c4a0de77006367eb744b31a98e10f84c8ceeb555b97c56ca93913d525a14eb669cb869e24938bba89869167de5300e1dbf5b855b3ed3cfe4c529d96f686d7c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae5331dcdb1f5ab9c98b56ea6e36b6c8d902a937c7ae4de006df570d6adff2d24719b5d0ca1e3a599786d2e3b67388596120cd865118e145637ed40a551be064", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f26d67593f1873644199b942af8b9ad33bd661c1e46905de64e8953331b7658bc4838a0befb76610da263d44cfc723ced03867df58851b14cf36f708c08fea97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb759a489c3922ac6c1c0c0efcc0c2d42ab9b867b183eb86bcae40cd0b4722cdea79f5e1dc8d79265ec8dedc1a36752015b232de639380a9530d313602f346b9"} build_url:https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/ZoSByQ2HRiaSrpbGuootLQ/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/e9c4a0de77006367eb744b31a98e10f84c8ceeb555b97c56ca93913d525a14eb669cb869e24938bba89869167de5300e1dbf5b855b3ed3cfe4c529d96f686d7c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae5331dcdb1f5ab9c98b56ea6e36b6c8d902a937c7ae4de006df570d6adff2d24719b5d0ca1e3a599786d2e3b67388596120cd865118e145637ed40a551be064", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f26d67593f1873644199b942af8b9ad33bd661c1e46905de64e8953331b7658bc4838a0befb76610da263d44cfc723ced03867df58851b14cf36f708c08fea97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb759a489c3922ac6c1c0c0efcc0c2d42ab9b867b183eb86bcae40cd0b4722cdea79f5e1dc8d79265ec8dedc1a36752015b232de639380a9530d313602f346b9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 20:14:40.513526) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 20:14:40.514047) ========= 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.Si91sh4VS5/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.WB48aHEIRN/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.005311 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 20:14:40.564176) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 20:14:40.564638) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 20:14:40.565098) ========= ========= Total master_lag: 0.26 =========