builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0145 starttime: 1491321937.68 results: success (0) buildid: 20170404075227 builduid: dbfa79210e92461094ac3fcd5a70eace revision: 81e37ef1360ba4505726ddf542ebdcc952a57578 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 09:05:37.679101) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 09:05:37.679594) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 09:05:37.679933) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 09:05:37.705465) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:05:37.705833) ========= 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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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-04 09:05:38-- 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% 6.63M=0.002s 2017-04-04 09:05:38 (6.63 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097288 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:05:37.827067) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:05:37.827465) ========= 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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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.020696 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:05:37.876806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-04 09:05:37.877229) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 81e37ef1360ba4505726ddf542ebdcc952a57578 --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 81e37ef1360ba4505726ddf542ebdcc952a57578 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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-04 09:05:38,374 truncating revision to first 12 chars 2017-04-04 09:05:38,374 Setting DEBUG logging. 2017-04-04 09:05:38,374 attempt 1/10 2017-04-04 09:05:38,374 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/81e37ef1360b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 09:05:40,116 unpacking tar archive at: mozilla-central-81e37ef1360b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.007276 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-04 09:05:39.952307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 09:05:39.952673) ========= script_repo_revision: 81e37ef1360ba4505726ddf542ebdcc952a57578 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 09:05:39.953133) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 09:05:39.953437) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 09:05:39.974278) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-04 09:05:39.975034) ========= /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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:05:40 INFO - MultiFileLogger online at 20170404 09:05:40 in /builds/slave/test 09:05:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:05:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:05:40 INFO - {'append_to_log': False, 09:05:40 INFO - 'base_work_dir': '/builds/slave/test', 09:05:40 INFO - 'blob_upload_branch': 'Firefox', 09:05:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:05:40 INFO - 'branch': 'Firefox', 09:05:40 INFO - 'buildbot_json_path': 'buildprops.json', 09:05:40 INFO - 'config_files': ('talos/mac_config.py',), 09:05:40 INFO - 'default_actions': ('clobber', 09:05:40 INFO - 'read-buildbot-config', 09:05:40 INFO - 'download-and-extract', 09:05:40 INFO - 'populate-webroot', 09:05:40 INFO - 'create-virtualenv', 09:05:40 INFO - 'install', 09:05:40 INFO - 'run-tests'), 09:05:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:05:40 INFO - 'download_minidump_stackwalk': True, 09:05:40 INFO - 'download_symbols': 'ondemand', 09:05:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:05:40 INFO - 'tooltool.py': '/tools/tooltool.py', 09:05:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:05:40 INFO - '/tools/misc-python/virtualenv.py')}, 09:05:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:05:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:05:40 INFO - 'gecko_profile': False, 09:05:40 INFO - 'gecko_profile_interval': 0, 09:05:40 INFO - 'installer_path': 'installer.exe', 09:05:40 INFO - 'log_level': 'info', 09:05:40 INFO - 'log_name': 'talos', 09:05:40 INFO - 'log_to_console': True, 09:05:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:05:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:05:40 INFO - 'opt_config_files': (), 09:05:40 INFO - 'pip_index': False, 09:05:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:05:40 INFO - 'cmd': ('bash', 09:05:40 INFO - '-c', 09:05:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:05:40 INFO - 'enabled': True, 09:05:40 INFO - 'halt_on_failure': False, 09:05:40 INFO - 'name': 'check_screen_resolution'},), 09:05:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:05:40 INFO - 'cmd': ('bash', 09:05:40 INFO - '-c', 09:05:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:05:40 INFO - 'enabled': True, 09:05:40 INFO - 'halt_on_failure': False, 09:05:40 INFO - 'name': 'check_screen_resolution'},), 09:05:40 INFO - 'run_cmd_checks_enabled': True, 09:05:40 INFO - 'suite': 'dromaeojs-e10s', 09:05:40 INFO - 'system_bits': '32', 09:05:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:05:40 INFO - 'title': 't-yosemite-r7-0145', 09:05:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:05:40 INFO - 'use_talos_json': True, 09:05:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:05:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:05:40 INFO - 'work_dir': 'build'} 09:05:40 INFO - [mozharness: 2017-04-04 16:05:40.602833Z] Running clobber step. 09:05:40 INFO - Running pre-action listener: _resource_record_pre_action 09:05:40 INFO - Running main action method: clobber 09:05:40 INFO - rmtree: /builds/slave/test/build 09:05:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:05:42 INFO - Running post-action listener: _resource_record_post_action 09:05:42 INFO - [mozharness: 2017-04-04 16:05:42.431042Z] Finished clobber step (success) 09:05:42 INFO - [mozharness: 2017-04-04 16:05:42.431215Z] Running read-buildbot-config step. 09:05:42 INFO - Running pre-action listener: _resource_record_pre_action 09:05:42 INFO - Running main action method: read_buildbot_config 09:05:42 INFO - Using buildbot properties: 09:05:42 INFO - { 09:05:42 INFO - "project": "", 09:05:42 INFO - "product": "firefox", 09:05:42 INFO - "script_repo_revision": "production", 09:05:42 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:05:42 INFO - "repository": "", 09:05:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:05:42 INFO - "buildid": "20170404075227", 09:05:42 INFO - "pgo_build": "False", 09:05:42 INFO - "basedir": "/builds/slave/test", 09:05:42 INFO - "buildnumber": 22, 09:05:42 INFO - "slavename": "t-yosemite-r7-0145", 09:05:42 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:05:42 INFO - "platform": "yosemite_r7", 09:05:42 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:05:42 INFO - "branch": "mozilla-central", 09:05:42 INFO - "repo_path": "mozilla-central", 09:05:42 INFO - "revision": "81e37ef1360ba4505726ddf542ebdcc952a57578", 09:05:42 INFO - "stage_platform": "macosx64", 09:05:42 INFO - "builduid": "dbfa79210e92461094ac3fcd5a70eace", 09:05:42 INFO - "slavebuilddir": "test" 09:05:42 INFO - } 09:05:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:05:42 INFO - Running post-action listener: _resource_record_post_action 09:05:42 INFO - [mozharness: 2017-04-04 16:05:42.434584Z] Finished read-buildbot-config step (success) 09:05:42 INFO - [mozharness: 2017-04-04 16:05:42.434700Z] Running download-and-extract step. 09:05:42 INFO - Running pre-action listener: _resource_record_pre_action 09:05:42 INFO - Running main action method: download_and_extract 09:05:42 INFO - mkdir: /builds/slave/test/build/tests 09:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:42 INFO - trying https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:05:42 INFO - Downloading https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:05:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:05:43 INFO - Downloaded 1325 bytes. 09:05:43 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:05:43 INFO - Using the following test package requirements: 09:05:43 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:05:43 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:05:43 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:05:43 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:05:43 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:05:43 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:05:43 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:05:43 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:05:43 INFO - u'jsshell-mac.zip'], 09:05:43 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:05:43 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:05:43 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:05:43 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:05:43 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:05:43 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:05:43 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:05:43 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:05:43 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:05:43 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:05:43 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:05:43 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:05:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:05:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:05:43 INFO - Fetch https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:05:44 INFO - Expected file size: 52518044 09:05:44 INFO - Obtained file size: 52518044 09:06:01 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:06:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:06:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:06:01 INFO - Fetch https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:06:02 INFO - Expected file size: 52518044 09:06:02 INFO - Obtained file size: 52518044 09:06:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:06:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:06:18 INFO - Fetch https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:06:20 INFO - Expected file size: 14404152 09:06:20 INFO - Obtained file size: 14404152 09:06: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')]} 09:06:20 INFO - trying https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:06:20 INFO - Downloading https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:06:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:06:22 INFO - Downloaded 75588485 bytes. 09:06:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:06:22 INFO - mkdir: /builds/slave/test/properties 09:06:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:06:22 INFO - Writing to file /builds/slave/test/properties/build_url 09:06:22 INFO - Contents: 09:06:22 INFO - build_url:https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:06:23 INFO - Running post-action listener: _resource_record_post_action 09:06:23 INFO - Running post-action listener: set_extra_try_arguments 09:06:23 INFO - [mozharness: 2017-04-04 16:06:23.277550Z] Finished download-and-extract step (success) 09:06:23 INFO - [mozharness: 2017-04-04 16:06:23.277669Z] Running populate-webroot step. 09:06:23 INFO - Running pre-action listener: _resource_record_pre_action 09:06:23 INFO - Running main action method: populate_webroot 09:06:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:06:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:06:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:06:23 INFO - '--tppagecycles', 09:06:23 INFO - '7'], 09:06:23 INFO - 'tests': ['tsvgm']}}, 09:06:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:06:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:06:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:06:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:06:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:06:23 INFO - 'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:06:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:06:23 INFO - 'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['damp', 'tps']}, 09:06:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:06:23 INFO - 'tests': ['damp', 'tps']}, 09:06:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['dromaeo_dom']}, 09:06:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:06:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['basic_compositor_video']}, 09:06:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:06:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['a11yr', 09:06:23 INFO - 'ts_paint', 09:06:23 INFO - 'tpaint', 09:06:23 INFO - 'sessionrestore', 09:06:23 INFO - 'sessionrestore_no_auto_restore', 09:06:23 INFO - 'tabpaint']}, 09:06:23 INFO - 'other-e10s': {'tests': ['a11yr', 09:06:23 INFO - 'ts_paint', 09:06:23 INFO - 'tpaint', 09:06:23 INFO - 'sessionrestore', 09:06:23 INFO - 'sessionrestore_no_auto_restore', 09:06:23 INFO - 'tabpaint']}, 09:06:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:06:23 INFO - 'ts_paint', 09:06:23 INFO - 'tpaint', 09:06:23 INFO - 'sessionrestore', 09:06:23 INFO - 'sessionrestore_no_auto_restore', 09:06:23 INFO - 'tabpaint']}, 09:06:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:06:23 INFO - 'ts_paint', 09:06:23 INFO - 'tpaint', 09:06:23 INFO - 'sessionrestore', 09:06:23 INFO - 'sessionrestore_no_auto_restore', 09:06:23 INFO - 'tabpaint']}, 09:06:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['a11yr', 09:06:23 INFO - 'ts_paint', 09:06:23 INFO - 'tpaint', 09:06:23 INFO - 'sessionrestore', 09:06:23 INFO - 'sessionrestore_no_auto_restore', 09:06:23 INFO - 'tabpaint']}, 09:06:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['a11yr', 09:06:23 INFO - 'ts_paint', 09:06:23 INFO - 'tpaint', 09:06:23 INFO - 'sessionrestore', 09:06:23 INFO - 'sessionrestore_no_auto_restore', 09:06:23 INFO - 'tabpaint']}, 09:06:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['tsvgx', 09:06:23 INFO - 'tsvgr_opacity', 09:06:23 INFO - 'tart', 09:06:23 INFO - 'tscrollx', 09:06:23 INFO - 'cart', 09:06:23 INFO - 'tsvg_static']}, 09:06:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:06:23 INFO - 'tsvgr_opacity', 09:06:23 INFO - 'tart', 09:06:23 INFO - 'tscrollx', 09:06:23 INFO - 'cart', 09:06:23 INFO - 'tsvg_static']}, 09:06:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:06:23 INFO - 'talos_options': ['--disable-e10s'], 09:06:23 INFO - 'tests': ['tp5o']}, 09:06:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:06:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:06:23 INFO - 'talos_options': ['--disable-e10s', 09:06:23 INFO - '--xperf_path', 09:06:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:23 INFO - 'tests': ['tp5n']}, 09:06:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:06:23 INFO - 'talos_options': ['--xperf_path', 09:06:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:23 INFO - 'tests': ['tp5n']}}, 09:06:23 INFO - 'talos.zip': {'path': '', 09:06:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:06:23 INFO - Running post-action listener: _resource_record_post_action 09:06:23 INFO - [mozharness: 2017-04-04 16:06:23.296303Z] Finished populate-webroot step (success) 09:06:23 INFO - [mozharness: 2017-04-04 16:06:23.296438Z] Running create-virtualenv step. 09:06:23 INFO - Running pre-action listener: _resource_record_pre_action 09:06:23 INFO - Running main action method: create_virtualenv 09:06:23 INFO - Creating virtualenv /builds/slave/test/build/venv 09:06:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:06:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:06:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:06:23 INFO - Using real prefix '/tools/python27' 09:06:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:06:24 INFO - Installing distribute.............................................................................................................................................................................................done. 09:06:26 INFO - Installing pip.................done. 09:06:26 INFO - Return code: 0 09:06:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:06:27 INFO - Reading from file tmpfile_stdout 09:06:27 INFO - Output received: 09:06:27 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:06:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:27 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 0x105ebab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ebd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9662cd1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c98d30>, '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 0x105bbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dbe8>, '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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:06:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kz3NnMMcCP/Render', 09:06:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:27 INFO - 'HOME': '/Users/cltbld', 09:06:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:27 INFO - 'LOGNAME': 'cltbld', 09:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:27 INFO - 'MOZ_NO_REMOTE': '1', 09:06:27 INFO - 'NO_EM_RESTART': '1', 09:06:27 INFO - 'PAGER': '/bin/cat', 09:06:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:27 INFO - 'PWD': '/builds/slave/test', 09:06:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:27 INFO - 'SHELL': '/bin/bash', 09:06:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ovuY3RzuCo/Listeners', 09:06:27 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 09:06:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:27 INFO - 'USER': 'cltbld', 09:06:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:27 INFO - 'XPC_FLAGS': '0x0', 09:06:27 INFO - 'XPC_SERVICE_NAME': '0', 09:06:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:06:27 INFO - Cleaning up... 09:06:27 INFO - Return code: 0 09:06:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:27 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 0x105ebab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ebd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9662cd1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c98d30>, '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 0x105bbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dbe8>, '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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:06:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kz3NnMMcCP/Render', 09:06:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:27 INFO - 'HOME': '/Users/cltbld', 09:06:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:27 INFO - 'LOGNAME': 'cltbld', 09:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:27 INFO - 'MOZ_NO_REMOTE': '1', 09:06:27 INFO - 'NO_EM_RESTART': '1', 09:06:27 INFO - 'PAGER': '/bin/cat', 09:06:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:27 INFO - 'PWD': '/builds/slave/test', 09:06:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:27 INFO - 'SHELL': '/bin/bash', 09:06:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ovuY3RzuCo/Listeners', 09:06:27 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 09:06:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:27 INFO - 'USER': 'cltbld', 09:06:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:27 INFO - 'XPC_FLAGS': '0x0', 09:06:27 INFO - 'XPC_SERVICE_NAME': '0', 09:06:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:27 INFO - Downloading/unpacking psutil>=3.1.1 09:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:06:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:31 INFO - Installing collected packages: psutil 09:06:31 INFO - Running setup.py install for psutil 09:06:31 INFO - building 'psutil._psutil_osx' extension 09:06:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:06:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:06:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:06:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:06:31 INFO - building 'psutil._psutil_posix' extension 09:06:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:06:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:06:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:06:31 INFO - ^ 09:06:31 INFO - 1 warning generated. 09:06:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:06:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:31 INFO - Successfully installed psutil 09:06:31 INFO - Cleaning up... 09:06:32 INFO - Return code: 0 09:06:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ebab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ebd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9662cd1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c98d30>, '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 0x105bbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dbe8>, '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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:06:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kz3NnMMcCP/Render', 09:06:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:32 INFO - 'HOME': '/Users/cltbld', 09:06:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:32 INFO - 'LOGNAME': 'cltbld', 09:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:32 INFO - 'MOZ_NO_REMOTE': '1', 09:06:32 INFO - 'NO_EM_RESTART': '1', 09:06:32 INFO - 'PAGER': '/bin/cat', 09:06:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:32 INFO - 'PWD': '/builds/slave/test', 09:06:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:32 INFO - 'SHELL': '/bin/bash', 09:06:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ovuY3RzuCo/Listeners', 09:06:32 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 09:06:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:32 INFO - 'USER': 'cltbld', 09:06:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:32 INFO - 'XPC_FLAGS': '0x0', 09:06:32 INFO - 'XPC_SERVICE_NAME': '0', 09:06:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:06: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 09:06: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 09:06: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 09:06: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 09:06: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 09:06: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 09:06:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:06:35 INFO - Installing collected packages: mozsystemmonitor 09:06:35 INFO - Running setup.py install for mozsystemmonitor 09:06:35 INFO - Successfully installed mozsystemmonitor 09:06:35 INFO - Cleaning up... 09:06:35 INFO - Return code: 0 09:06:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:06: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')]} 09:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06: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')]} 09:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ebab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ebd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9662cd1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c98d30>, '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 0x105bbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dbe8>, '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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06: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==2.5.1'] in /builds/slave/test/build 09:06: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==2.5.1 09:06:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kz3NnMMcCP/Render', 09:06:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:35 INFO - 'HOME': '/Users/cltbld', 09:06:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:35 INFO - 'LOGNAME': 'cltbld', 09:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:35 INFO - 'MOZ_NO_REMOTE': '1', 09:06:35 INFO - 'NO_EM_RESTART': '1', 09:06:35 INFO - 'PAGER': '/bin/cat', 09:06:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:35 INFO - 'PWD': '/builds/slave/test', 09:06:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:35 INFO - 'SHELL': '/bin/bash', 09:06:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ovuY3RzuCo/Listeners', 09:06:35 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 09:06:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:35 INFO - 'USER': 'cltbld', 09:06:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:35 INFO - 'XPC_FLAGS': '0x0', 09:06:35 INFO - 'XPC_SERVICE_NAME': '0', 09:06:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:35 INFO - Downloading/unpacking jsonschema==2.5.1 09:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:06:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:38 INFO - Downloading functools32-3.2.3-2.tar.gz 09:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:06:39 INFO - warning: no files found matching '*.txt' 09:06:39 INFO - no previously-included directories found matching 'build' 09:06:39 INFO - no previously-included directories found matching 'dist' 09:06:39 INFO - no previously-included directories found matching '.git*' 09:06:39 INFO - Installing collected packages: jsonschema, functools32 09:06:39 INFO - Running setup.py install for functools32 09:06:39 INFO - warning: no files found matching '*.txt' 09:06:39 INFO - no previously-included directories found matching 'build' 09:06:39 INFO - no previously-included directories found matching 'dist' 09:06:39 INFO - no previously-included directories found matching '.git*' 09:06:39 INFO - Successfully installed jsonschema functools32 09:06:39 INFO - Cleaning up... 09:06:39 INFO - Return code: 0 09:06:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105ebab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ebd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9662cd1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c98d30>, '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 0x105bbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dbe8>, '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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:06:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kz3NnMMcCP/Render', 09:06:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:39 INFO - 'HOME': '/Users/cltbld', 09:06:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:39 INFO - 'LOGNAME': 'cltbld', 09:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:39 INFO - 'MOZ_NO_REMOTE': '1', 09:06:39 INFO - 'NO_EM_RESTART': '1', 09:06:39 INFO - 'PAGER': '/bin/cat', 09:06:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:39 INFO - 'PWD': '/builds/slave/test', 09:06:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:39 INFO - 'SHELL': '/bin/bash', 09:06:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ovuY3RzuCo/Listeners', 09:06:39 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 09:06:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:39 INFO - 'USER': 'cltbld', 09:06:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:39 INFO - 'XPC_FLAGS': '0x0', 09:06:39 INFO - 'XPC_SERVICE_NAME': '0', 09:06:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:06:39 INFO - Cleaning up... 09:06:39 INFO - Return code: 0 09:06:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105ebab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ebd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9662cd1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c98d30>, '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 0x105bbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dbe8>, '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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:06:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kz3NnMMcCP/Render', 09:06:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:39 INFO - 'HOME': '/Users/cltbld', 09:06:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:39 INFO - 'LOGNAME': 'cltbld', 09:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:39 INFO - 'MOZ_NO_REMOTE': '1', 09:06:39 INFO - 'NO_EM_RESTART': '1', 09:06:39 INFO - 'PAGER': '/bin/cat', 09:06:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:39 INFO - 'PWD': '/builds/slave/test', 09:06:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:39 INFO - 'SHELL': '/bin/bash', 09:06:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ovuY3RzuCo/Listeners', 09:06:39 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 09:06:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:39 INFO - 'USER': 'cltbld', 09:06:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:39 INFO - 'XPC_FLAGS': '0x0', 09:06:39 INFO - 'XPC_SERVICE_NAME': '0', 09:06:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:39 INFO - Downloading/unpacking blobuploader==1.2.4 09:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:42 INFO - Downloading blobuploader-1.2.4.tar.gz 09:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:06:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:06:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:43 INFO - Downloading docopt-0.6.1.tar.gz 09:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:06:43 INFO - Installing collected packages: blobuploader, requests, docopt 09:06:43 INFO - Running setup.py install for blobuploader 09:06:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:06:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:06:43 INFO - Running setup.py install for requests 09:06:44 INFO - Running setup.py install for docopt 09:06:44 INFO - Successfully installed blobuploader requests docopt 09:06:44 INFO - Cleaning up... 09:06:44 INFO - Return code: 0 09:06:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:44 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 0x105ebab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ebd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9662cd1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c98d30>, '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 0x105bbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dbe8>, '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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:06:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kz3NnMMcCP/Render', 09:06:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:44 INFO - 'HOME': '/Users/cltbld', 09:06:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:44 INFO - 'LOGNAME': 'cltbld', 09:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:44 INFO - 'MOZ_NO_REMOTE': '1', 09:06:44 INFO - 'NO_EM_RESTART': '1', 09:06:44 INFO - 'PAGER': '/bin/cat', 09:06:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:44 INFO - 'PWD': '/builds/slave/test', 09:06:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:44 INFO - 'SHELL': '/bin/bash', 09:06:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ovuY3RzuCo/Listeners', 09:06:44 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 09:06:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:44 INFO - 'USER': 'cltbld', 09:06:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:44 INFO - 'XPC_FLAGS': '0x0', 09:06:44 INFO - 'XPC_SERVICE_NAME': '0', 09:06:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:45 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-00aDWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:45 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-WPvpsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:45 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-GIdLcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:45 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-uPYnEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:45 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-ov7mER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:45 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-_VQ_SB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:45 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-9YKxXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:45 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-8iYJa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:45 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-MTnIOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:45 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-V4y6Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-6kb5Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-tZQ2BN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-M5uEzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-IEcbRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-8lex0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-hC5mC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-tE5Lgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:06:46 INFO - Running setup.py install for manifestparser 09:06:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:06:46 INFO - Running setup.py install for mozcrash 09:06:47 INFO - Running setup.py install for mozdebug 09:06:47 INFO - Running setup.py install for mozdevice 09:06:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:06:47 INFO - Running setup.py install for mozfile 09:06:47 INFO - Running setup.py install for mozhttpd 09:06:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:06:47 INFO - Running setup.py install for mozinfo 09:06:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:06:47 INFO - Running setup.py install for mozInstall 09:06:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:06:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:06:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:06:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:06:47 INFO - Running setup.py install for mozleak 09:06:48 INFO - Running setup.py install for mozlog 09:06:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:06:48 INFO - Running setup.py install for moznetwork 09:06:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:06:48 INFO - Running setup.py install for mozprocess 09:06:48 INFO - Running setup.py install for mozprofile 09:06:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:06:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:06:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:06:48 INFO - Running setup.py install for mozrunner 09:06:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:06:48 INFO - Running setup.py install for mozscreenshot 09:06:49 INFO - Running setup.py install for moztest 09:06:49 INFO - Running setup.py install for mozversion 09:06:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:06:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:06:49 INFO - Cleaning up... 09:06:49 INFO - Return code: 0 09:06:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:49 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 0x105ebab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ebd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9662cd1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c98d30>, '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 0x105bbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dbe8>, '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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:06:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kz3NnMMcCP/Render', 09:06:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:49 INFO - 'HOME': '/Users/cltbld', 09:06:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:49 INFO - 'LOGNAME': 'cltbld', 09:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:49 INFO - 'MOZ_NO_REMOTE': '1', 09:06:49 INFO - 'NO_EM_RESTART': '1', 09:06:49 INFO - 'PAGER': '/bin/cat', 09:06:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:49 INFO - 'PWD': '/builds/slave/test', 09:06:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:49 INFO - 'SHELL': '/bin/bash', 09:06:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ovuY3RzuCo/Listeners', 09:06:49 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 09:06:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:49 INFO - 'USER': 'cltbld', 09:06:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:49 INFO - 'XPC_FLAGS': '0x0', 09:06:49 INFO - 'XPC_SERVICE_NAME': '0', 09:06:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:49 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-2DKALb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:49 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-4yi3aF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:49 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-V2nkeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:49 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-mE6bUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:50 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-2DQ55H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:50 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-Hrp6E2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:50 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-WsHH6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:50 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-d_mxQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:50 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-RuAqpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:50 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-mD7HeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:50 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-zIXBY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:50 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-gZCjh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:50 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-Z7wPTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:51 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-aMaNQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:51 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-DGIg6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:51 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-t7RAya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:51 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-ih7KtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:06:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:54 INFO - Downloading blessings-1.6.tar.gz 09:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:06:54 INFO - Installing collected packages: blessings 09:06:54 INFO - Running setup.py install for blessings 09:06:54 INFO - Successfully installed blessings 09:06:54 INFO - Cleaning up... 09:06:54 INFO - Return code: 0 09:06:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:06:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:54 INFO - Reading from file tmpfile_stdout 09:06:54 INFO - Current package versions: 09:06:54 INFO - blessings == 1.6 09:06:54 INFO - blobuploader == 1.2.4 09:06:54 INFO - docopt == 0.6.1 09:06:54 INFO - functools32 == 3.2.3-2 09:06:54 INFO - jsonschema == 2.5.1 09:06:54 INFO - manifestparser == 1.1 09:06:54 INFO - mozInstall == 1.12 09:06:54 INFO - mozcrash == 1.0 09:06:54 INFO - mozdebug == 0.1 09:06:54 INFO - mozdevice == 0.49 09:06:54 INFO - mozfile == 1.2 09:06:54 INFO - mozhttpd == 0.7 09:06:54 INFO - mozinfo == 0.9 09:06:54 INFO - mozleak == 0.1 09:06:54 INFO - mozlog == 3.4 09:06:54 INFO - moznetwork == 0.27 09:06:54 INFO - mozprocess == 0.25 09:06:54 INFO - mozprofile == 0.28 09:06:54 INFO - mozrunner == 6.13 09:06:54 INFO - mozscreenshot == 0.1 09:06:54 INFO - mozsystemmonitor == 0.3 09:06:54 INFO - moztest == 0.8 09:06:54 INFO - mozversion == 1.4 09:06:54 INFO - psutil == 3.1.1 09:06:54 INFO - requests == 1.2.3 09:06:54 INFO - wsgiref == 0.1.2 09:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:54 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 0x105ebab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ebd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9662cd1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c98d30>, '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 0x105bbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dbe8>, '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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:06:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kz3NnMMcCP/Render', 09:06:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:54 INFO - 'HOME': '/Users/cltbld', 09:06:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:54 INFO - 'LOGNAME': 'cltbld', 09:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:54 INFO - 'MOZ_NO_REMOTE': '1', 09:06:54 INFO - 'NO_EM_RESTART': '1', 09:06:54 INFO - 'PAGER': '/bin/cat', 09:06:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:54 INFO - 'PWD': '/builds/slave/test', 09:06:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:54 INFO - 'SHELL': '/bin/bash', 09:06:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ovuY3RzuCo/Listeners', 09:06:54 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 09:06:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:54 INFO - 'USER': 'cltbld', 09:06:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:54 INFO - 'XPC_FLAGS': '0x0', 09:06:54 INFO - 'XPC_SERVICE_NAME': '0', 09:06:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:06:55 INFO - Cleaning up... 09:06:55 INFO - Return code: 0 09:06:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:55 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 0x105ebab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ebd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9662cd1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c98d30>, '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 0x105bbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dbe8>, '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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:06:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kz3NnMMcCP/Render', 09:06:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:55 INFO - 'HOME': '/Users/cltbld', 09:06:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:55 INFO - 'LOGNAME': 'cltbld', 09:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:55 INFO - 'MOZ_NO_REMOTE': '1', 09:06:55 INFO - 'NO_EM_RESTART': '1', 09:06:55 INFO - 'PAGER': '/bin/cat', 09:06:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:55 INFO - 'PWD': '/builds/slave/test', 09:06:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:55 INFO - 'SHELL': '/bin/bash', 09:06:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ovuY3RzuCo/Listeners', 09:06:55 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 09:06:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:55 INFO - 'USER': 'cltbld', 09:06:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:55 INFO - 'XPC_FLAGS': '0x0', 09:06:55 INFO - 'XPC_SERVICE_NAME': '0', 09:06:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:06:55 INFO - Cleaning up... 09:06:55 INFO - Return code: 0 09:06:55 INFO - Running post-action listener: _resource_record_post_action 09:06:55 INFO - Running post-action listener: _start_resource_monitoring 09:06:55 INFO - Starting resource monitoring. 09:06:55 INFO - [mozharness: 2017-04-04 16:06:55.455223Z] Finished create-virtualenv step (success) 09:06:55 INFO - [mozharness: 2017-04-04 16:06:55.456247Z] Running install step. 09:06:55 INFO - Running pre-action listener: _resource_record_pre_action 09:06:55 INFO - Running main action method: install 09:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:55 INFO - Reading from file tmpfile_stdout 09:06:55 INFO - Detecting whether we're running mozinstall >=1.0... 09:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:06:55 INFO - Reading from file tmpfile_stdout 09:06:55 INFO - Output received: 09:06:55 INFO - Usage: mozinstall [options] installer 09:06:55 INFO - Options: 09:06:55 INFO - -h, --help show this help message and exit 09:06:55 INFO - -d DEST, --destination=DEST 09:06:55 INFO - Directory to install application into. [default: 09:06:55 INFO - "/builds/slave/test"] 09:06:55 INFO - --app=APP Application being installed. [default: firefox] 09:06:55 INFO - mkdir: /builds/slave/test/build/application 09:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:07:16 INFO - Reading from file tmpfile_stdout 09:07:16 INFO - Output received: 09:07:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:07:16 INFO - Running post-action listener: _resource_record_post_action 09:07:16 INFO - [mozharness: 2017-04-04 16:07:16.297083Z] Finished install step (success) 09:07:16 INFO - [mozharness: 2017-04-04 16:07:16.297236Z] Running run-tests step. 09:07:16 INFO - Running pre-action listener: _resource_record_pre_action 09:07:16 INFO - Running main action method: run_tests 09:07:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:07:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:07:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:07:16 INFO - 2017-04-04 09:07:16.311 screenresolution[1901:17924] starting screenresolution argv=screenresolution get 09:07:16 INFO - 2017-04-04 09:07:16.314 screenresolution[1901:17924] Display 0: 1600x1200x32@60 09:07:16 INFO - 2017-04-04 09:07:16.320 screenresolution[1902:17926] starting screenresolution argv=screenresolution list 09:07:16 INFO - Available Modes on Display 0 09:07:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:07:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:07:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:07:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:07:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:07:16 INFO - Intel Iris: 09:07:16 INFO - Chipset Model: Intel Iris 09:07:16 INFO - Type: GPU 09:07:16 INFO - Bus: Built-In 09:07:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:07:16 INFO - Vendor: Intel (0x8086) 09:07:16 INFO - Device ID: 0x0a2e 09:07:16 INFO - Revision ID: 0x0009 09:07:16 INFO - Displays: 09:07:16 INFO - Display: 09:07:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:07:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:07:16 INFO - Display Serial Number: 1600x1200 60 09:07:16 INFO - Main Display: Yes 09:07:16 INFO - Mirror: Off 09:07:16 INFO - Online: Yes 09:07:16 INFO - Rotation: Supported 09:07:16 INFO - Return code: 0 09:07:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:07:16 INFO - Python 2.7.3 09:07:16 INFO - Return code: 0 09:07:16 INFO - grabbing minidump binary from tooltool 09:07: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')]} 09:07:16 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 0x105c98d30>, '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 0x105bbfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c8dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:07:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:07:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:07:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:07:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:07:16 INFO - Return code: 0 09:07:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:07:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:07:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:07:16 INFO - ENV: RUST_BACKTRACE is now 1 09:07:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:07:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:07:16 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/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0145', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:07:16 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/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0145 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:07:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kz3NnMMcCP/Render', 09:07:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:16 INFO - 'HOME': '/Users/cltbld', 09:07:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:16 INFO - 'LOGNAME': 'cltbld', 09:07:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:07:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:16 INFO - 'MOZ_NO_REMOTE': '1', 09:07:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:07:16 INFO - 'NO_EM_RESTART': '1', 09:07:16 INFO - 'PAGER': '/bin/cat', 09:07:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:16 INFO - 'PWD': '/builds/slave/test', 09:07:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:07:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:16 INFO - 'RUST_BACKTRACE': '1', 09:07:16 INFO - 'SHELL': '/bin/bash', 09:07:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ovuY3RzuCo/Listeners', 09:07:16 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 09:07:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:16 INFO - 'USER': 'cltbld', 09:07:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:16 INFO - 'XPC_FLAGS': '0x0', 09:07:16 INFO - 'XPC_SERVICE_NAME': '0', 09:07:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:16 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/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0145', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:07:16 INFO - mozversion application_buildid: 20170404075227 09:07:16 INFO - mozversion application_changeset: 81e37ef1360ba4505726ddf542ebdcc952a57578 09:07:16 INFO - mozversion application_display_name: Nightly 09:07:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:07:16 INFO - mozversion application_name: Firefox 09:07:16 INFO - mozversion application_remotingname: firefox 09:07:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:07:16 INFO - mozversion application_vendor: Mozilla 09:07:16 INFO - mozversion application_version: 55.0a1 09:07:16 INFO - mozversion platform_buildid: 20170404075227 09:07:16 INFO - mozversion platform_changeset: 81e37ef1360ba4505726ddf542ebdcc952a57578 09:07:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:07:16 INFO - mozversion platform_version: 55.0a1 09:07:16 INFO - using testdate: 1491322036 09:07:16 INFO - actual date: 1491322036 09:07:16 INFO - starting webserver on 'localhost:54210' 09:07:16 INFO - SUITE-START | Running 2 tests 09:07:16 INFO - TEST-START | dromaeo_css 09:07:16 INFO - operating with platform_type : mac_ 09:07:16 INFO - Initialising browser for dromaeo_css test... 09:07:16 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpCchaLy/profile http://localhost:54210/getInfo.html) 09:07:19 INFO - PID 1912 | 2017-04-04 09:07:19.704 plugin-container[1914:18104] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f37, name = 'com.apple.tsm.portname' 09:07:19 INFO - PID 1912 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:07:19 INFO - PID 1912 | 2017-04-04 09:07:19.706 plugin-container[1914:18104] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 09:07:19 INFO - PID 1912 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:07:19 INFO - PID 1912 | 2017-04-04 09:07:19.706 plugin-container[1914:18104] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:07:19 INFO - PID 1912 | __metrics Screen width/height:1600/1200 09:07:19 INFO - PID 1912 | colorDepth:24 09:07:19 INFO - PID 1912 | Browser inner width/height: 1024/689 09:07:19 INFO - PID 1912 | __metrics 09:07:19 ERROR - PID 1912 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3355: TypeError: this.tabs is undefined 09:07:20 INFO - TEST-INFO | 1912: exit 0 09:07:20 INFO - Browser initialized. 09:07:20 INFO - Running cycle 1/1 for dromaeo_css test... 09:07:20 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpCchaLy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:22 INFO - PID 1915 | 2017-04-04 09:07:22.851 plugin-container[1916:18234] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4b, name = 'com.apple.tsm.portname' 09:07:22 INFO - PID 1915 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:07:22 INFO - PID 1915 | 2017-04-04 09:07:22.852 plugin-container[1916:18234] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9017, name = 'com.apple.CFPasteboardClient' 09:07:22 INFO - PID 1915 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:07:22 INFO - PID 1915 | 2017-04-04 09:07:22.852 plugin-container[1916:18234] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:07:32 INFO - PID 1915 | RSS: Main: 228663296 09:07:32 INFO - PID 1915 | 09:10:36 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:54210/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54210/tests/dromaeo/cssquery-ext.html) 09:10:38 INFO - PID 1915 | RSS: Main: 257409024 09:10:38 INFO - PID 1915 | 09:12:20 INFO - PID 1915 | ************************* 09:12:20 INFO - PID 1915 | A coding exception was thrown and uncaught in a Task. 09:12:20 INFO - PID 1915 | 09:12:20 ERROR - PID 1915 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:12:20 INFO - PID 1915 | Full stack: 09:12:20 INFO - PID 1915 | ************************* 09:12:20 INFO - PID 1915 | ************************* 09:12:20 INFO - PID 1915 | A coding exception was thrown and uncaught in a Task. 09:12:20 INFO - PID 1915 | 09:12:20 ERROR - PID 1915 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:12:20 INFO - PID 1915 | Full stack: 09:12:20 INFO - PID 1915 | ************************* 09:12:20 INFO - PID 1915 | ************************* 09:12:20 INFO - PID 1915 | A coding exception was thrown and uncaught in a Task. 09:12:20 INFO - PID 1915 | 09:12:20 ERROR - PID 1915 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:12:20 INFO - PID 1915 | Full stack: 09:12:20 INFO - PID 1915 | ************************* 09:12:20 INFO - PID 1915 | ************************* 09:12:20 INFO - PID 1915 | A coding exception was thrown and uncaught in a Task. 09:12:20 INFO - PID 1915 | 09:12:20 ERROR - PID 1915 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:12:20 INFO - PID 1915 | Full stack: 09:12:20 INFO - PID 1915 | ************************* 09:13:40 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:54210/tests/dromaeo/cssquery-ext.html (next: http://localhost:54210/tests/dromaeo/cssquery-jquery.html) 09:13:41 INFO - PID 1915 | RSS: Main: 263290880 09:13:41 INFO - PID 1915 | 09:16:42 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:54210/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54210/tests/dromaeo/cssquery-mootools.html) 09:16:43 INFO - PID 1915 | RSS: Main: 275456000 09:16:43 INFO - PID 1915 | 09:19:45 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:54210/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54210/tests/dromaeo/cssquery-prototype.html) 09:19:45 INFO - PID 1915 | RSS: Main: 267788288 09:19:45 INFO - PID 1915 | 09:22:48 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:54210/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54210/tests/dromaeo/cssquery-yui.html) 09:22:49 INFO - PID 1915 | RSS: Main: 278388736 09:22:49 INFO - PID 1915 | 09:25:52 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:54210/tests/dromaeo/cssquery-yui.html (next: http://localhost:54210/tests/dromaeo/cssquery-dojo.html) 09:25:52 INFO - PID 1915 | RSS: Main: 272818176 09:25:52 INFO - PID 1915 | 09:25:52 INFO - PID 1915 | __start_tp_report 09:25:52 INFO - PID 1915 | _x_x_mozilla_page_load 09:25:52 INFO - PID 1915 | _x_x_mozilla_page_load_details 09:25:52 INFO - PID 1915 | |i|pagename|runs| 09:25:52 INFO - PID 1915 | |0;dojo.html;3022.36530328631;3530.3115892400974;3554.6267641897584;3598.0824889653136;3599;5246.317978662773;6068.6055406398555;6244.250689917205;6266.1540692006565;6270.749170033199;6144.893919094561;6181;6236.12694222808;6239.500839932806;6325.5255855810765;5430.212619170218;5464.508194262516;5465.945340546603;5487.780488780444;5555.583331250173;5363.195520671891;5459.69971651561;5527.53015993639;5546.334439867222;5608.971955140219;5357.705326207057;5440.102383106782;5465.398806131322;5468.64453810505;5495.203195536645;5442.6462279951675;5449.64577302478;5477.178423236506;5484.396716361197;5505.476979686923;5417.45825417459;5420.376656684492;5439;5445.50990410861;5451.890962180773;4660.953390466119;5448.564114870801;5795.88408231833;6145.754169833246;6186.721597528122;6671.199456065303;6698.39714425704;6699.732010719566;6701.128853249095;6720;6775.728970841161;6794.184697836291;6799.864002719967;6813.11429514165;6815.625140617264;6203.751849925952;6233.968830155911;6262.749490020439;6360.077788720656;6382.266039405481;5234.842954711365;6740.764073257511;6778.423833974168;6852.074969879102;6905.343992320722;6322.241331040304;6349.555531112777;6378.84052898672;6415.26224484181;6467.2562655294305;6590.835229119214;6670.4997125215805;6691.0967019451755;6739.663016849236;6754.864902701918;6355.459785918156;6418.903716444257;6701.363370479797;6717.193936727624;6736.05695202672;6511.576747511396;6518.217813862272;6617.4706023518;6618.404343609098;6622.801315960529;5295.788168473295;5297.17893726473;5322.3879253885525;5324.893502129936;5359.732013399314;4676.8129274828625;4740.5733483986605;4759.904801903943;4769.117713223065;4796.952030479651;6218.689065546704;6265.310815810257;6268.435840774352;6312.5581209314905;6338.873222535523;6776.69504872282;6784.491163162783;6789.694463749143;6804.55770374924;6819.5908245505425;6252.124702541648;6288.685565721696;6317.305096439388;6345;6380.3619638035825;5724.084146536534;5812.418758124154;5833.504152147115;5889.469947704727;5942.970285148546;5481.561475082063;6929.5842249465195;6936.965315173291;6952.791416257521;6967.268436814062;6662.700178492077;6727.529072964846;6751.189857217166;6753.966230168818;6763.797086087426;6043.153958445733;6546.18172728409;6621.933780662324;6729.528932974645;6865.347791959756;5517.889642207214;6660.800175994728;6664.966675166593;6674.332566743286;6689.331066893272;5667.631603945731;6406.583572067801;6730.192376914802;6766.458683305422;6776.254611992578;6269;6411.775587854403;6493.772717954849;6518.543701941008;6523;5777.3933736957015;6143.771245750779;6425.614463132227;6476.384743449365;6489.935100648933;5605.299337582802;6132.0495871890025;6376.9043464349;6400.423961843457;6434.67826608677;6556.737730490727;6574.671266436755;6583.44040756541;6585.374389432996;6591.209054913441;5141.640085194001;5654.85862853432;6140.600860944024;6221.066839973859;6279.843003924939 09:25:52 INFO - PID 1915 | |1;ext.html;641.7433026789283;740.3743836458194;821.9753407397778;1144.3934714601264;1183.9112066595003;38352.42471362928;40123.99999999996;40163.799181004055;40180.59819401805;40263.59736402639;39579.604203957955;39787.60212397875;39857.800710996475;39873.00317492064;40097.19805603886;8057.677692892292;8231.382646301521;8516.489010659348;8767.78080547985;8779.780505487382;8774.298056155492;8794.252488538483;8816.294696424302;8895.421797583169;8938.955305223464;8812.206901378875;8837.513936733478;8880.777980550505;8886;8894.733158005238;8800.73597792064;8842.911570884306;8860.291176705849;8867.822643547157;8899.644014239422;7465.925340746578;8695.39132260742;8761.386702930797;8765.824683506358;8766.517841518715;38275.425868611994;38393;38406.61593384086;38461;38554.61445385566;2948.7640988721064;3428.2800611871535;3455.23984723363;3466.046837119812;3468.6357932417236;24547;30199.849000755075;30654.540181897068;30768.230794230098;30800;3051.1761824307537;3102.860371283275;3126.3590963852585;3156.779025468218;3160.6365267994015;269206;274324;320542;322577;323550;48080.75959620249;48628.78428039327;48661.513384866405;48750.99999999929;48981;44548.55451445509;50492.990140197726;51609.2258616121;51633;51685.483145168066;14535.927320363331;14618.26908654563;14679.339429725474;14699.485518006819;14704.897132715088;11938.104642151873;12070.637880863587;12078.154529182873;12084.637460876187;12106.81839772404;11152.776944461066;11311.660650180507;13613.455461781417;13873.959453040861;13902.026858120036;5062.443131255559;5907.379725128885;5980.820575382745;5981.850453738604;6004.189434426384;941.5762906692016;971.8542218667257;980.2648013989508;1000.7832650678781;1041.3023274406166;18478.630427391377;19504.609907801765;24090.39774005664;24379.14672986437;24475.632865507032;1091.2633972068822;1103.6633826682778;1133.8469306643497;1134.733337665648;1139.9886001140048;10181.676770899761;10729.819719830812;12076.879231207751;12384.81422778659;12574.99400047994;330082;336029;409868;410170;466940;58429.70785146047;58753.70623146857;59288.703556482804;59421;59680;1315.5855905389772;1318.9274589897457;1474.3144437836459;1514.5532068039954;1514.9621259468381;27021.08194311853;27722.584161237195;28457.715422845507;29105.12684619465;29314;42801;51259.2311115341;51307;51919.22121168261;52036.21945670894;453099;453768;456630;456840;456925;31391;33529.49705754464;37171.725251596414;37200.81399592985;37528;47273.527264726916;47869.76065119652;48224;49102.75448622734;49729;25322.987080516574;29046.7095329044;29736;32499.133105463727;32767.50848737223;31973;32589;32940.50589241115;33024.66975330216;33242.33515329631;38697.16285464317;38753;38839;39280.62517811977;39454;31319.373612527164;31925.20186995344;32057.03828885137;32510.717873733418;33160;21961;24582.89376978076;25819.870900645376;25940.962361505328;26161.869190653924 09:25:52 INFO - PID 1915 | |2;jquery.html;401.11153794345535;401.2416532753099;416.3775156141569;425.05425428421756;439.52531266232467;21258.681119783196;21338.786612133874;22175.44561385966;22185;22453.887730561324;16973.57566060849;21947.0123844427;22931.885340573273;23940.40148996276;24074.638880416765;6168.969155154229;6411.615303081807;6429.517786166033;6438.967805160968;6443.935560644404;4610.5389461053965;6219.067139929001;6259.217597800275;6322.778702745405;6323.462505686999;6160.722767475474;6275.780347687832;6295.244570651528;6299.086632438317;6301.590396624205;6092.482139018189;6217.906731399033;6271.498280137578;6302.936970630327;6315.336889626615;5540.168974653834;5567.3040869891265;5577.944220557823;5600.327960644708;5611.298587676541;26539.867300663373;27331.043413480435;27344.45311093767;27452.62736863169;27484;2156.9460763480884;2221.4224301681515;2226.9554608907893;2229.108356657334;2232.151782322723;14484.855151448455;16728;17453.301867925267;18093.819061809347;18246.270149194017;1811.5108920591367;1888.2824526679774;1892.81071892811;2135.3807395855183;2190.507135894427;147813;148597;150330.7450388245;151322.48677513195;153113.9999999989;11361.772764544663;11384.772304553862;12610.306433146265;12722.554710585086;12887.16233444823;16115.838841611669;16350.34598616042;16474.093924834247;16487.422940197037;16527.50417487477;6939.306069393121;7835.804104897309;8609.913900861036;8856.64573417069;8873.645054197888;8293.295069919004;8338.04112527067;8342.416030877901;8500.53247071417;8507.447015944068;7818.921810781933;7864.2922137007945;7885.487443316166;7974.641141148662;7994.2405471480115;2002.8097330753556;2110.8627939183903;2114.661654135331;2114.8625339352893;2140.3685912655806;866.3935245328296;925.5696101312922;958.0276019839868;1002.5789168549227;1012.8126296635146;20527.4868128298;21190.89404552998;21278.255261066097;21545.56908861814;25446.363840903756;796.4305521552118;988.1304452082122;992.3153024413276;1008.5562352564995;1012.8987101289812;10879.619213327496;12381.876181238073;13089.476420943247;13407.061505694508;13488.325583720774;712885;717801;718908;738759;741733;117510.58097359822;151001.24499377434;153098;156300;157768;1169.9821155594686;1197.8802119787952;1223.473906220316;1227.472186959598;1229.5266322465736;17670.823291767432;19817;20112.296069637494;21716.34850954474;22148.77851221467;63663;64360.35639643544;64542.70914581776;65142.74286285572;65426;89628.5518572429;91206;91262.54368728114;91264.5436772812;91926.54036729774;8464;8690.565471726515;8875.33434992391;8920.86618700733;9018.774530636787;12480.689527599834;13159.934200328937;13232.603021909357;13498;13697.726045479234;10661.413622250851;11368.658940231806;11528.884711152781;11784.41077946082;11813;8650.956745216485;10739.301945373525;10811.297265677706;10855.348679079281;11064.557417703523;11753.88246117562;11941.16411851162;12075.094367922266;12145.453454594388;12169.878301217228;8530.232279094911;8662.653493860174;8774.683141960268;9066.637334506546;9110.908890911007;11390.088792896382;11969.281843089442;12226.20529665569;12245.326507042199;12294.692632684255 09:25:52 INFO - PID 1915 | |3;mootools.html;1192.7256730951885;1351.0610125962453;1351.3513513513512;1365.4947669362336;1380.7376598446292;10027.849582256264;10729.819719830812;11002.174836887236;11167.050800681951;11249.55001799927;9786.559604817783;11135.944320278388;11204.831927521094;11226.214165008452;11276.661700148989;2435.5250726108416;2469.444375015625;2492.0405643827166;2492.6385674077337;2495.513374891897;2395.125779090628;2427.2354208424376;2468.25952214335;2470.72821989581;2471.6045432730766;2430.538197742432;2433.7322894481595;2453.619688948207;2468.160825319391;2471.876406179693;2410.867402292873;2414.3722632115687;2435.2207293665947;2459.213051823417;2461.483088551406;2160.4166874943835;2374.8693821839793;2402.1712509184304;2405.7834794868545;2410.023940304162;9104.590293436744;11200.607978720705;11234.382108984002;11299.870012998634;11324.6036388726;6316.242050953915;6539.9673001635165;6548.836279093013;6563.507736919702;6599.571027883172;3787.2425514896854;4005.2790497710403;4056.614621610972;4096.877093687194;4098.672106231495;1191.2435603391823;1195.5277665322235;1196.8743281955356;1209.866914639389;1257.9182353147016;11834.822477662841;14579.125252484992;15090.54728358151;15207.467738629206;15320.387184512607;5183.403908550565;5239.869003274948;5394.865128371822;5405.378381486179;5406.405295417501;9981.602575639416;11400.885991140149;11683.182177247681;11760.529578816922;11796.52813887452;5942.61373010753;6271.404216599416;6357.904631430532;6361.650109243943;6378.617282963037;5312.62811603184;5772;6008.729607167688;6021.939780602225;6026.367231440723;4158.276329004507;4216.262154123016;4315.6763242756915;4349.521552629209;4415.183191109655;1109.7515295292797;1274.350081458463;1286.2154086007529;1290.6515240884908;1290.9354532273537;620.7516993202755;697.3131465506472;713.7002458967246;716.2837162837163;718.3893690363254;6350.269718982377;6650;6761.898571521431;6776.051352810512;6820.795376138624;904.9366544341965;917;935.3720410056004;942.830290547708;954.5227386306847;4133.751974881517;4177.081042170717;4279.315309550457;4302.526722060571;4342.066455712037;13848.723025539633;14117.435302587986;14305.356258968372;14321.6419589509;14358.641033974025;13929.442822287197;14243.928780356031;14252.358643861051;14257.572272831832;14276.714465710835;10143.289969702199;10422.791544169226;10498.370097794157;10601.575936962436;10629.681109566725;6354.777582784581;6913.412359949461;6936.583804971718;7000.334968178015;7051.6474176292;12031.097667674785;12127.272363658209;12163.574274900337;12244.938775306067;12378.566750163702;12393.62819115428;12420.875791241971;12478.937605311916;12509.311987840392;12582.433790479634;6716.6902454021;8348.66605335804;8370.121137280741;8400.075991640793;8505.74482765518;10035.849462258218;10071;10081.949590252296;10161.644342447978;10187.337823041775;8514.531700756517;8692.391532592657;8728.389012769045;8764.21122099014;8785.736427907173;8569.48583085017;8574.742757717278;8582.957085214533;8676.522791246542;8720.65117395297;7780.533168009937;7920.5247685139075;7925.524468531907;7927.920720792718;7928.207179282256;5869.6771677558145;5918.822435326947;6051.3948605140895;6076.301225358963;6113.969430152821;5611.74747136388;5781.913271300849;5812.389699081536;5833.212516310414;5959.553033522417 09:25:52 INFO - PID 1915 | |4;prototype.html;347.55165836071467;385.22954091816365;391.237087679026;401.53622565936337;402.848931650631;6094.8171554853425;6217.782377616784;6249.437550620443;6261.71634814863;6315.3684631536935;5923.407659234085;6114.938850611493;6122.877542449149;6135.631862088278;6140.907886381708;3764.682361173581;4507.3689683444345;4507.4365704286965;4530.79611417487;4531.6601254905845;4268.274393353122;4493.281075027996;4507.188706032913;4524.23088075028;4536.9546304537025;4476.664250181233;4479.3952816369865;4504.954950450503;4525.728456292633;4526.7283962962165;3743.401055831081;3799.0502374406396;4342.826286948534;4455.910881782363;4478.708883922567;3186;3783.8999355357764;3841.308564458396;3842.4620553122304;3871.728978971473;5991.670458124801;6008.158857759917;6014.098509714612;6034.607750496204;6034.668093254869;4128.60778226068;5020.447750747415;5276.657017293864;5322.973385133088;5331.280277162572;6453.709583068773;6530.542861999662;6532.542722009462;6536;6562.606243625398;4338.110687309094;4372.672049596261;4381.583749543788;4394.934075988863;4397.626201772853;5891.499222566087;6564.901526477059;6738.292479289702;6927.93072069283;6950.131233595801;4456.197884380843;4457.108578284357;4458.5318541553315;4467.821287148543;4478.745951133687;4537.274036154199;4543.159515489645;4546.726357022938;4572.222722137245;4574.9020235143325;4465.24090904547;5124.846254612367;5348.5186333230195;5349.732513374393;5364.597655175878;5451.64564303319;5719.828405147852;6387.201599800025;6584.440322572635;6587.242467116343;1409.0136904166918;1443.6246575890343;1525.9771103433457;1545.6831349573536;1558.0729465967731;989.4063561862824;999.5407248645666;1016.6289304403839;1020.5458570936011;1029.3206483720708;4985.6845197943685;6093.878122437526;6110.755569777248;6112.616079728909;6129.724162412702;6801.047853300542;6817.466070134279;6819.181698196248;6827;6881.621510816853;5875.83037810306;6041.486473649701;6071;6120.265568131853;6130.160951714468;3223.4842425211855;3368.8714280715744;3491.441369380887;3574.945391109629;3579.3736096183065;5987.101934709828;6614.86770264592;6993.566318904613;7026.191987921352;7040.6479676016;5564.610477266552;5896.233489646319;6243.844888695606;6578.934210657832;7061.364477197077;5851.268591426072;6130.78542251028;6762.561182698992;7017.263187365457;7107.614015267077;5025.7989680412375;6735.696893639896;6797.558158719865;6802.54433346159;6834.384905358542;5599.580031497572;6717;6752.864942701217;6760.459163267025;6808.7276508939085;5624.578156638187;6139.355367686508;6976.77906366394;7119.236725111062;7166.749163779243;3364.7308215342223;4405.030893203619;4429.468463784367;4450.666200035075;4463;6817.761378351734;6829.180498340231;6855.4172895304455;6884.345987131214;6887.896681549881;5460.426655201147;6394.633985425422;6542.509311801538;6574.84940135484;6584.736610535717;6264.874702506016;6578.506612004023;6582.539222254396;6588.670566471753;6607.975763756625;6067.666278354733;6279.152314437675;6468.579542329733;6475.150933589206;6502.252240992347;6539.318879259481;6595.043718660863;6613.14029176204;6629.569078009914;6708.758879607289;5896.439838215363;6128.50971922254;6431.196100487439;6449.355064493513;6502.122213501117 09:25:52 INFO - PID 1915 | |5;yui.html;812.6830536090924;819.3731795176694;821.8890449789277;824.1593574553955;826.0129145670921;11909.940450297747;16301.83698163018;16317.347306107771;16326.510204693877;16369;14520.927395363009;14547.854521454808;14638.707225855476;14984.250787460638;15170.089794612304;960.7790208252106;979.9657012004582;1007.0634310091611;1012.2913960227833;1013.1995723378523;1005.36661903001;1013.2096964367768;1018.1752780248023;1018.3024628129717;1018.3482571154467;1059.1262208677833;1059.1579694143174;1059.6503153959213;1059.7191744187796;1061.3525749292965;1046.3094357723903;1053.9987012338308;1055.0504545908666;1056.6407421476697;1057.0750593230923;781.3007358414244;782.1083964280724;784.1766145547152;784.8665726826454;786.6892577431883;16199.595010124724;16759.24583393738;16886.240119194666;16905.985640861465;17011.404600838912;14790.926045369704;14803.185824779634;14826;14974.176420296879;15539.378424862993;12906.741865162645;13236.338183090904;13406.329683515785;13552.390142443614;13611.523596674167;3300.5544251526217;3325.48454989477;3389.86440542378;3397.3545026444895;3405.1316914186973;75252;101889;108944.4552777239;109083.45458272737;109647.45176274067;8052.412981586589;11575.247608905394;11662.00872925794;11837.408129593487;11888.762224755457;20132.496687582927;23619.173328933404;23918.402039949142;24108.758912411;24137.7586224139;7830.647620857075;7863.685452581833;7998.84002319962;8091.797705057421;8105.311048560939;4064.9390259146135;4126.690498212646;4134.359174327984;4179.561146079679;4266.722663026893;4141.151064031867;4190.224808410454;4250.213710463574;4258.084511829909;4261.914761704748;810.4650930385917;913.1507697841072;935.555611084743;951.9666811661558;958.9136977671903;616.479075181471;622.6202016769766;628.9371062893765;637.7990932856136;646.6904518350378;9512.904870951203;9715.514224288758;10440.477976101165;10453.895461045444;11257.605983790529;615.972281247345;621.2638023941644;621.9689015549204;627.7915013598804;642.7011439680477;3854.622258973987;4588.311753236974;4740.19416699162;4768.008458726306;4770.284457331359;79461.60269198618;98682;100622.99377006282;102400;104417.47791260995;63385.41536461533;88530.55734721285;89792.5510372444;90584;90987.09012909919;60121.39878601158;74946.12634684067;75418;79732.20267797363;81343.59328203321;10471.790564188826;10813.51339189754;10922.071623912056;11136.944315278372;11155.880382727255;38542.80728596339;39351.80324098361;39364.60635393609;39473.60526394699;40123.1975360497;49176.77058073577;50702.23946640877;50887.2366914504;50986;51444;11290.830637540279;13346.799798003232;13587.660308492366;13658.658533536742;14039.816781136866;14362.712745745235;14367.928160359132;14586.635334116732;14822.481213157487;14958.476453324081;13405.731885362433;13558;13683.315834208448;13936.024478286423;13978.32418616654;13360.93319533396;13513.662158445724;13574.59276221715;13949.907106593957;14002.509912153026;12711.173773704679;13169.73660526765;13471.393787279792;13765.724685506435;14103.576892693236;9208.907910920805;9540.486203610813;9561.521923903916;9669.27480438984;9810.074483529164;8609.248514748298;10201.489925503844;10262.230332725225;10351.171906247633;10354.1198998083 09:25:52 INFO - PID 1915 | __end_tp_report 09:25:52 INFO - PID 1915 | __start_cc_report 09:25:52 INFO - PID 1915 | _x_x_mozilla_cycle_collect,431 09:25:52 INFO - PID 1915 | __end_cc_report 09:25:52 INFO - PID 1915 | __startTimestamp1491323152668__endTimestamp 09:25:52 INFO - PID 1915 | 09:25:52 INFO - PID 1915 | ------- Summary: start ------- 09:25:52 INFO - PID 1915 | Number of tests: 6 09:25:52 INFO - PID 1915 | 09:25:52 INFO - PID 1915 | [#0] dojo.html Cycles:165 Average:6082.91 Median:6312.56 stddev:740.11 (11.7%) stddev-sans-first:702.36 09:25:52 INFO - PID 1915 | Values: 3022.4 3530.3 3554.6 3598.1 3599.0 5246.3 6068.6 6244.3 6266.2 6270.7 6144.9 6181.0 6236.1 6239.5 6325.5 5430.2 5464.5 5465.9 5487.8 5555.6 5363.2 5459.7 5527.5 5546.3 5609.0 5357.7 5440.1 5465.4 5468.6 5495.2 5442.6 5449.6 5477.2 5484.4 5505.5 5417.5 5420.4 5439.0 5445.5 5451.9 4661.0 5448.6 5795.9 6145.8 6186.7 6671.2 6698.4 6699.7 6701.1 6720.0 6775.7 6794.2 6799.9 6813.1 6815.6 6203.8 6234.0 6262.7 6360.1 6382.3 5234.8 6740.8 6778.4 6852.1 6905.3 6322.2 6349.6 6378.8 6415.3 6467.3 6590.8 6670.5 6691.1 6739.7 6754.9 6355.5 6418.9 6701.4 6717.2 6736.1 6511.6 6518.2 6617.5 6618.4 6622.8 5295.8 5297.2 5322.4 5324.9 5359.7 4676.8 4740.6 4759.9 4769.1 4797.0 6218.7 6265.3 6268.4 6312.6 6338.9 6776.7 6784.5 6789.7 6804.6 6819.6 6252.1 6288.7 6317.3 6345.0 6380.4 5724.1 5812.4 5833.5 5889.5 5943.0 5481.6 6929.6 6937.0 6952.8 6967.3 6662.7 6727.5 6751.2 6754.0 6763.8 6043.2 6546.2 6621.9 6729.5 6865.3 5517.9 6660.8 6665.0 6674.3 6689.3 5667.6 6406.6 6730.2 6766.5 6776.3 6269.0 6411.8 6493.8 6518.5 6523.0 5777.4 6143.8 6425.6 6476.4 6489.9 5605.3 6132.0 6376.9 6400.4 6434.7 6556.7 6574.7 6583.4 6585.4 6591.2 5141.6 5654.9 6140.6 6221.1 6279.8 09:25:52 INFO - PID 1915 | 09:25:52 INFO - PID 1915 | [#1] ext.html Cycles:180 Average:52985.95 Median:37901.71 stddev:103159.68 (272.2%) stddev-sans-first:103374.21 09:25:52 INFO - PID 1915 | Values: 641.7 740.4 822.0 1144.4 1183.9 38352.4 40124.0 40163.8 40180.6 40263.6 39579.6 39787.6 39857.8 39873.0 40097.2 8057.7 8231.4 8516.5 8767.8 8779.8 8774.3 8794.3 8816.3 8895.4 8939.0 8812.2 8837.5 8880.8 8886.0 8894.7 8800.7 8842.9 8860.3 8867.8 8899.6 7465.9 8695.4 8761.4 8765.8 8766.5 38275.4 38393.0 38406.6 38461.0 38554.6 2948.8 3428.3 3455.2 3466.0 3468.6 24547.0 30199.8 30654.5 30768.2 30800.0 3051.2 3102.9 3126.4 3156.8 3160.6 269206.0 274324.0 320542.0 322577.0 323550.0 48080.8 48628.8 48661.5 48751.0 48981.0 44548.6 50493.0 51609.2 51633.0 51685.5 14535.9 14618.3 14679.3 14699.5 14704.9 11938.1 12070.6 12078.2 12084.6 12106.8 11152.8 11311.7 13613.5 13874.0 13902.0 5062.4 5907.4 5980.8 5981.9 6004.2 941.6 971.9 980.3 1000.8 1041.3 18478.6 19504.6 24090.4 24379.1 24475.6 1091.3 1103.7 1133.8 1134.7 1140.0 10181.7 10729.8 12076.9 12384.8 12575.0 330082.0 336029.0 409868.0 410170.0 466940.0 58429.7 58753.7 59288.7 59421.0 59680.0 1315.6 1318.9 1474.3 1514.6 1515.0 27021.1 27722.6 28457.7 29105.1 29314.0 42801.0 51259.2 51307.0 51919.2 52036.2 453099.0 453768.0 456630.0 456840.0 456925.0 31391.0 33529.5 37171.7 37200.8 37528.0 47273.5 47869.8 48224.0 49102.8 49729.0 25323.0 29046.7 29736.0 32499.1 32767.5 31973.0 32589.0 32940.5 33024.7 33242.3 38697.2 38753.0 38839.0 39280.6 39454.0 31319.4 31925.2 32057.0 32510.7 33160.0 21961.0 24582.9 25819.9 25941.0 26161.9 09:25:52 INFO - PID 1915 | 09:25:52 INFO - PID 1915 | [#2] jquery.html Cycles:180 Average:41449.74 Median:2228.03 stddev:121334.77 (5445.8%) stddev-sans-first:121636.00 09:25:52 INFO - PID 1915 | Values: 401.1 401.2 416.4 425.1 439.5 21258.7 21338.8 22175.4 22185.0 22453.9 16973.6 21947.0 22931.9 23940.4 24074.6 6169.0 6411.6 6429.5 6439.0 6443.9 4610.5 6219.1 6259.2 6322.8 6323.5 6160.7 6275.8 6295.2 6299.1 6301.6 6092.5 6217.9 6271.5 6302.9 6315.3 5540.2 5567.3 5577.9 5600.3 5611.3 26539.9 27331.0 27344.5 27452.6 27484.0 2156.9 2221.4 2227.0 2229.1 2232.2 14484.9 16728.0 17453.3 18093.8 18246.3 1811.5 1888.3 1892.8 2135.4 2190.5 147813.0 148597.0 150330.7 151322.5 153114.0 11361.8 11384.8 12610.3 12722.6 12887.2 16115.8 16350.3 16474.1 16487.4 16527.5 6939.3 7835.8 8609.9 8856.6 8873.6 8293.3 8338.0 8342.4 8500.5 8507.4 7818.9 7864.3 7885.5 7974.6 7994.2 2002.8 2110.9 2114.7 2114.9 2140.4 866.4 925.6 958.0 1002.6 1012.8 20527.5 21190.9 21278.3 21545.6 25446.4 796.4 988.1 992.3 1008.6 1012.9 10879.6 12381.9 13089.5 13407.1 13488.3 712885.0 717801.0 718908.0 738759.0 741733.0 117510.6 151001.2 153098.0 156300.0 157768.0 1170.0 1197.9 1223.5 1227.5 1229.5 17670.8 19817.0 20112.3 21716.3 22148.8 63663.0 64360.4 64542.7 65142.7 65426.0 89628.6 91206.0 91262.5 91264.5 91926.5 8464.0 8690.6 8875.3 8920.9 9018.8 12480.7 13159.9 13232.6 13498.0 13697.7 10661.4 11368.7 11528.9 11784.4 11813.0 8651.0 10739.3 10811.3 10855.3 11064.6 11753.9 11941.2 12075.1 12145.5 12169.9 8530.2 8662.7 8774.7 9066.6 9110.9 11390.1 11969.3 12226.2 12245.3 12294.7 09:25:52 INFO - PID 1915 | 09:25:52 INFO - PID 1915 | [#3] mootools.html Cycles:180 Average:6794.68 Median:2494.08 stddev:4167.16 (167.1%) stddev-sans-first:4157.59 09:25:52 INFO - PID 1915 | Values: 1192.7 1351.1 1351.4 1365.5 1380.7 10027.8 10729.8 11002.2 11167.1 11249.6 9786.6 11135.9 11204.8 11226.2 11276.7 2435.5 2469.4 2492.0 2492.6 2495.5 2395.1 2427.2 2468.3 2470.7 2471.6 2430.5 2433.7 2453.6 2468.2 2471.9 2410.9 2414.4 2435.2 2459.2 2461.5 2160.4 2374.9 2402.2 2405.8 2410.0 9104.6 11200.6 11234.4 11299.9 11324.6 6316.2 6540.0 6548.8 6563.5 6599.6 3787.2 4005.3 4056.6 4096.9 4098.7 1191.2 1195.5 1196.9 1209.9 1257.9 11834.8 14579.1 15090.5 15207.5 15320.4 5183.4 5239.9 5394.9 5405.4 5406.4 9981.6 11400.9 11683.2 11760.5 11796.5 5942.6 6271.4 6357.9 6361.7 6378.6 5312.6 5772.0 6008.7 6021.9 6026.4 4158.3 4216.3 4315.7 4349.5 4415.2 1109.8 1274.4 1286.2 1290.7 1290.9 620.8 697.3 713.7 716.3 718.4 6350.3 6650.0 6761.9 6776.1 6820.8 904.9 917.0 935.4 942.8 954.5 4133.8 4177.1 4279.3 4302.5 4342.1 13848.7 14117.4 14305.4 14321.6 14358.6 13929.4 14243.9 14252.4 14257.6 14276.7 10143.3 10422.8 10498.4 10601.6 10629.7 6354.8 6913.4 6936.6 7000.3 7051.6 12031.1 12127.3 12163.6 12244.9 12378.6 12393.6 12420.9 12478.9 12509.3 12582.4 6716.7 8348.7 8370.1 8400.1 8505.7 10035.8 10071.0 10081.9 10161.6 10187.3 8514.5 8692.4 8728.4 8764.2 8785.7 8569.5 8574.7 8583.0 8676.5 8720.7 7780.5 7920.5 7925.5 7927.9 7928.2 5869.7 5918.8 6051.4 6076.3 6114.0 5611.7 5781.9 5812.4 5833.2 5959.6 09:25:52 INFO - PID 1915 | 09:25:52 INFO - PID 1915 | [#4] prototype.html Cycles:180 Average:5271.85 Median:6024.35 stddev:1674.32 (27.8%) stddev-sans-first:1637.71 09:25:52 INFO - PID 1915 | Values: 347.6 385.2 391.2 401.5 402.8 6094.8 6217.8 6249.4 6261.7 6315.4 5923.4 6114.9 6122.9 6135.6 6140.9 3764.7 4507.4 4507.4 4530.8 4531.7 4268.3 4493.3 4507.2 4524.2 4537.0 4476.7 4479.4 4505.0 4525.7 4526.7 3743.4 3799.1 4342.8 4455.9 4478.7 3186.0 3783.9 3841.3 3842.5 3871.7 5991.7 6008.2 6014.1 6034.6 6034.7 4128.6 5020.4 5276.7 5323.0 5331.3 6453.7 6530.5 6532.5 6536.0 6562.6 4338.1 4372.7 4381.6 4394.9 4397.6 5891.5 6564.9 6738.3 6927.9 6950.1 4456.2 4457.1 4458.5 4467.8 4478.7 4537.3 4543.2 4546.7 4572.2 4574.9 4465.2 5124.8 5348.5 5349.7 5364.6 5451.6 5719.8 6387.2 6584.4 6587.2 1409.0 1443.6 1526.0 1545.7 1558.1 989.4 999.5 1016.6 1020.5 1029.3 4985.7 6093.9 6110.8 6112.6 6129.7 6801.0 6817.5 6819.2 6827.0 6881.6 5875.8 6041.5 6071.0 6120.3 6130.2 3223.5 3368.9 3491.4 3574.9 3579.4 5987.1 6614.9 6993.6 7026.2 7040.6 5564.6 5896.2 6243.8 6578.9 7061.4 5851.3 6130.8 6762.6 7017.3 7107.6 5025.8 6735.7 6797.6 6802.5 6834.4 5599.6 6717.0 6752.9 6760.5 6808.7 5624.6 6139.4 6976.8 7119.2 7166.7 3364.7 4405.0 4429.5 4450.7 4463.0 6817.8 6829.2 6855.4 6884.3 6887.9 5460.4 6394.6 6542.5 6574.8 6584.7 6264.9 6578.5 6582.5 6588.7 6608.0 6067.7 6279.2 6468.6 6475.2 6502.3 6539.3 6595.0 6613.1 6629.6 6708.8 5896.4 6128.5 6431.2 6449.4 6502.1 09:25:52 INFO - PID 1915 | 09:25:52 INFO - PID 1915 | [#5] yui.html Cycles:180 Average:19389.84 Median:18571.95 stddev:27271.14 (146.8%) stddev-sans-first:27311.97 09:25:52 INFO - PID 1915 | Values: 812.7 819.4 821.9 824.2 826.0 11909.9 16301.8 16317.3 16326.5 16369.0 14520.9 14547.9 14638.7 14984.3 15170.1 960.8 980.0 1007.1 1012.3 1013.2 1005.4 1013.2 1018.2 1018.3 1018.3 1059.1 1059.2 1059.7 1059.7 1061.4 1046.3 1054.0 1055.1 1056.6 1057.1 781.3 782.1 784.2 784.9 786.7 16199.6 16759.2 16886.2 16906.0 17011.4 14790.9 14803.2 14826.0 14974.2 15539.4 12906.7 13236.3 13406.3 13552.4 13611.5 3300.6 3325.5 3389.9 3397.4 3405.1 75252.0 101889.0 108944.5 109083.5 109647.5 8052.4 11575.2 11662.0 11837.4 11888.8 20132.5 23619.2 23918.4 24108.8 24137.8 7830.6 7863.7 7998.8 8091.8 8105.3 4064.9 4126.7 4134.4 4179.6 4266.7 4141.2 4190.2 4250.2 4258.1 4261.9 810.5 913.2 935.6 952.0 958.9 616.5 622.6 628.9 637.8 646.7 9512.9 9715.5 10440.5 10453.9 11257.6 616.0 621.3 622.0 627.8 642.7 3854.6 4588.3 4740.2 4768.0 4770.3 79461.6 98682.0 100623.0 102400.0 104417.5 63385.4 88530.6 89792.6 90584.0 90987.1 60121.4 74946.1 75418.0 79732.2 81343.6 10471.8 10813.5 10922.1 11136.9 11155.9 38542.8 39351.8 39364.6 39473.6 40123.2 49176.8 50702.2 50887.2 50986.0 51444.0 11290.8 13346.8 13587.7 13658.7 14039.8 14362.7 14367.9 14586.6 14822.5 14958.5 13405.7 13558.0 13683.3 13936.0 13978.3 13360.9 13513.7 13574.6 13949.9 14002.5 12711.2 13169.7 13471.4 13765.7 14103.6 9208.9 9540.5 9561.5 9669.3 9810.1 8609.2 10201.5 10262.2 10351.2 10354.1 09:25:52 INFO - PID 1915 | -------- Summary: end -------- 09:25:52 INFO - PID 1915 | 09:25:53 INFO - TEST-INFO | 1915: exit 0 09:25:53 INFO - TEST-OK | dromaeo_css | took 1116398ms 09:25:53 INFO - TEST-START | kraken 09:25:53 INFO - operating with platform_type : mac_ 09:25:53 INFO - Initialising browser for kraken test... 09:25:53 INFO - TEST-INFO | started process 1921 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpYhX6gI/profile http://localhost:54210/getInfo.html) 09:25:55 INFO - PID 1921 | 2017-04-04 09:25:55.968 plugin-container[1922:20331] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 09:25:55 INFO - PID 1921 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:25:55 INFO - PID 1921 | 2017-04-04 09:25:55.972 plugin-container[1922:20331] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 09:25:55 INFO - PID 1921 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:25:55 INFO - PID 1921 | 2017-04-04 09:25:55.972 plugin-container[1922:20331] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:25:56 INFO - PID 1921 | __metrics Screen width/height:1600/1200 09:25:56 INFO - PID 1921 | colorDepth:24 09:25:56 INFO - PID 1921 | Browser inner width/height: 1024/689 09:25:56 INFO - PID 1921 | __metrics 09:25:56 ERROR - PID 1921 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3355: TypeError: this.tabs is undefined 09:25:56 INFO - TEST-INFO | 1921: exit 0 09:25:56 INFO - Browser initialized. 09:25:56 INFO - Running cycle 1/1 for kraken test... 09:25:56 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpYhX6gI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:59 INFO - PID 1923 | 2017-04-04 09:25:59.340 plugin-container[1924:20462] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 09:25:59 INFO - PID 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:25:59 INFO - PID 1923 | 2017-04-04 09:25:59.341 plugin-container[1924:20462] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9013, name = 'com.apple.CFPasteboardClient' 09:25:59 INFO - PID 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:25:59 INFO - PID 1923 | 2017-04-04 09:25:59.341 plugin-container[1924:20462] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:26:09 INFO - PID 1923 | RSS: Main: 228044800 09:26:09 INFO - PID 1923 | 09:26:11 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:54210/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54210/tests/kraken/driver.html?testName=audio-beat-detection) 09:26:12 INFO - PID 1923 | RSS: Main: 243802112 09:26:12 INFO - PID 1923 | 09:26:15 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:54210/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54210/tests/kraken/driver.html?testName=audio-dft) 09:26:16 INFO - PID 1923 | RSS: Main: 251719680 09:26:16 INFO - PID 1923 | 09:26:20 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:54210/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54210/tests/kraken/driver.html?testName=audio-fft) 09:26:21 INFO - PID 1923 | RSS: Main: 253911040 09:26:21 INFO - PID 1923 | 09:26:23 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:54210/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54210/tests/kraken/driver.html?testName=audio-oscillator) 09:26:23 INFO - PID 1923 | RSS: Main: 255860736 09:26:23 INFO - PID 1923 | 09:26:25 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:54210/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54210/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:26:26 INFO - PID 1923 | RSS: Main: 256184320 09:26:26 INFO - PID 1923 | 09:26:29 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:54210/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54210/tests/kraken/driver.html?testName=imaging-darkroom) 09:26:30 INFO - PID 1923 | RSS: Main: 262160384 09:26:30 INFO - PID 1923 | 09:26:33 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:54210/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54210/tests/kraken/driver.html?testName=imaging-desaturate) 09:26:34 INFO - PID 1923 | RSS: Main: 262934528 09:26:34 INFO - PID 1923 | 09:26:37 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:54210/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54210/tests/kraken/driver.html?testName=json-parse-financial) 09:26:38 INFO - PID 1923 | RSS: Main: 262557696 09:26:38 INFO - PID 1923 | 09:26:39 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:54210/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54210/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:26:40 INFO - PID 1923 | RSS: Main: 262610944 09:26:40 INFO - PID 1923 | 09:26:42 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:54210/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54210/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:26:43 INFO - PID 1923 | RSS: Main: 262475776 09:26:43 INFO - PID 1923 | 09:26:45 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:54210/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54210/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:26:46 INFO - PID 1923 | RSS: Main: 262684672 09:26:46 INFO - PID 1923 | 09:26:49 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:54210/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:26:49 INFO - PID 1923 | RSS: Main: 263036928 09:26:49 INFO - PID 1923 | 09:26:53 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:54210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:26:53 INFO - PID 1923 | RSS: Main: 260300800 09:26:53 INFO - PID 1923 | 09:26:55 INFO - PID 1923 | Cycle 1(1): loaded http://localhost:54210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54210/tests/kraken/driver.html?testName=ai-astar) 09:26:56 INFO - PID 1923 | RSS: Main: 263737344 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | __start_tp_report 09:26:56 INFO - PID 1923 | _x_x_mozilla_page_load 09:26:56 INFO - PID 1923 | _x_x_mozilla_page_load_details 09:26:56 INFO - PID 1923 | |i|pagename|runs| 09:26:56 INFO - PID 1923 | |0;ai-astar;111;124;124;125;120;123;122;125;122;125 09:26:56 INFO - PID 1923 | |1;audio-beat-detection;155;116;119;160;130;159;151;122;143;144 09:26:56 INFO - PID 1923 | |2;audio-dft;208;282;250;319;276;306;245;278;215;289 09:26:56 INFO - PID 1923 | |3;audio-fft;88;68;73;91;62;67;95;82;77;63 09:26:56 INFO - PID 1923 | |4;audio-oscillator;88;71;92;74;73;74;86;72;74;87 09:26:56 INFO - PID 1923 | |5;imaging-gaussian-blur;94;111;131;94;139;93;99;111;92;89 09:26:56 INFO - PID 1923 | |6;imaging-darkroom;101;103;108;160;140;100;155;128;100;101 09:26:56 INFO - PID 1923 | |7;imaging-desaturate;158;134;103;105;103;104;103;100;105;103 09:26:56 INFO - PID 1923 | |8;json-parse-financial;52;51;50;53;52;53;52;53;52;51 09:26:56 INFO - PID 1923 | |9;json-stringify-tinderbox;62;63;69;93;58;66;82;89;92;84 09:26:56 INFO - PID 1923 | |10;stanford-crypto-aes;89;89;88;90;92;85;84;95;85;122 09:26:56 INFO - PID 1923 | |11;stanford-crypto-ccm;145;170;164;166;154;183;174;150;198;153 09:26:56 INFO - PID 1923 | |12;stanford-crypto-pbkdf2;221;246;207;198;203;189;206;249;263;201 09:26:56 INFO - PID 1923 | |13;stanford-crypto-sha256-iterative;90;98;64;61;78;99;101;94;81;74 09:26:56 INFO - PID 1923 | __end_tp_report 09:26:56 INFO - PID 1923 | __start_cc_report 09:26:56 INFO - PID 1923 | _x_x_mozilla_cycle_collect,1033 09:26:56 INFO - PID 1923 | __end_cc_report 09:26:56 INFO - PID 1923 | __startTimestamp1491323216176__endTimestamp 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | ------- Summary: start ------- 09:26:56 INFO - PID 1923 | Number of tests: 14 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | [#0] ai-astar Cycles:10 Average:122.10 Median:124.00 stddev:4.23 (3.4%) stddev-sans-first:1.73 09:26:56 INFO - PID 1923 | Values: 111.0 124.0 124.0 125.0 120.0 123.0 122.0 125.0 122.0 125.0 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:147.50 stddev:16.91 (11.5%) stddev-sans-first:17.03 09:26:56 INFO - PID 1923 | Values: 155.0 116.0 119.0 160.0 130.0 159.0 151.0 122.0 143.0 144.0 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | [#2] audio-dft Cycles:10 Average:266.80 Median:280.00 stddev:36.66 (13.1%) stddev-sans-first:32.12 09:26:56 INFO - PID 1923 | Values: 208.0 282.0 250.0 319.0 276.0 306.0 245.0 278.0 215.0 289.0 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | [#3] audio-fft Cycles:10 Average:76.60 Median:79.50 stddev:11.94 (15.0%) stddev-sans-first:11.93 09:26:56 INFO - PID 1923 | Values: 88.0 68.0 73.0 91.0 62.0 67.0 95.0 82.0 77.0 63.0 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:80.00 stddev:8.08 (10.1%) stddev-sans-first:7.90 09:26:56 INFO - PID 1923 | Values: 88.0 71.0 92.0 74.0 73.0 74.0 86.0 72.0 74.0 87.0 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | [#5] imaging-gaussian-blur Cycles:10 Average:105.30 Median:92.50 stddev:17.48 (18.9%) stddev-sans-first:18.06 09:26:56 INFO - PID 1923 | Values: 94.0 111.0 131.0 94.0 139.0 93.0 99.0 111.0 92.0 89.0 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | [#6] imaging-darkroom Cycles:10 Average:119.60 Median:118.00 stddev:24.13 (20.5%) stddev-sans-first:24.64 09:26:56 INFO - PID 1923 | Values: 101.0 103.0 108.0 160.0 140.0 100.0 155.0 128.0 100.0 101.0 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | [#7] imaging-desaturate Cycles:10 Average:111.80 Median:104.50 stddev:18.94 (18.1%) stddev-sans-first:10.36 09:26:56 INFO - PID 1923 | Values: 158.0 134.0 103.0 105.0 103.0 104.0 103.0 100.0 105.0 103.0 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.99 (1.9%) stddev-sans-first:1.05 09:26:56 INFO - PID 1923 | Values: 52.0 51.0 50.0 53.0 52.0 53.0 52.0 53.0 52.0 51.0 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | [#9] json-stringify-tinderbox Cycles:10 Average:75.80 Median:83.00 stddev:13.55 (16.3%) stddev-sans-first:13.42 09:26:56 INFO - PID 1923 | Values: 62.0 63.0 69.0 93.0 58.0 66.0 82.0 89.0 92.0 84.0 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:89.00 stddev:11.10 (12.5%) stddev-sans-first:11.72 09:26:56 INFO - PID 1923 | Values: 89.0 89.0 88.0 90.0 92.0 85.0 84.0 95.0 85.0 122.0 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | [#11] stanford-crypto-ccm Cycles:10 Average:165.70 Median:168.00 stddev:16.35 (9.7%) stddev-sans-first:15.53 09:26:56 INFO - PID 1923 | Values: 145.0 170.0 164.0 166.0 154.0 183.0 174.0 150.0 198.0 153.0 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:218.30 Median:214.00 stddev:25.38 (11.9%) stddev-sans-first:26.90 09:26:56 INFO - PID 1923 | Values: 221.0 246.0 207.0 198.0 203.0 189.0 206.0 249.0 263.0 201.0 09:26:56 INFO - PID 1923 | 09:26:56 INFO - PID 1923 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.00 Median:85.50 stddev:14.61 (17.1%) stddev-sans-first:15.33 09:26:56 INFO - PID 1923 | Values: 90.0 98.0 64.0 61.0 78.0 99.0 101.0 94.0 81.0 74.0 09:26:56 INFO - PID 1923 | -------- Summary: end -------- 09:26:56 INFO - PID 1923 | 09:26:57 INFO - TEST-INFO | 1923: exit 0 09:26:57 INFO - TEST-OK | kraken | took 63808ms 09:26:57 INFO - SUITE-END | took 1180s 09:26:57 INFO - Completed test suite (00:19:40) 09:26:57 INFO - javascript benchmark 09:26:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7771.075348588475, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3022.36530328631, 3530.3115892400974, 3554.6267641897584, 3598.0824889653136, 3599.0, 5246.317978662773, 6068.6055406398555, 6244.250689917205, 6266.1540692006565, 6270.749170033199, 6144.893919094561, 6181.0, 6236.12694222808, 6239.500839932806, 6325.5255855810765, 5430.212619170218, 5464.508194262516, 5465.945340546603, 5487.780488780444, 5555.583331250173, 5363.195520671891, 5459.69971651561, 5527.53015993639, 5546.334439867222, 5608.971955140219, 5357.705326207057, 5440.102383106782, 5465.398806131322, 5468.64453810505, 5495.203195536645, 5442.6462279951675, 5449.64577302478, 5477.178423236506, 5484.396716361197, 5505.476979686923, 5417.45825417459, 5420.376656684492, 5439.0, 5445.50990410861, 5451.890962180773, 4660.953390466119, 5448.564114870801, 5795.88408231833, 6145.754169833246, 6186.721597528122, 6671.199456065303, 6698.39714425704, 6699.732010719566, 6701.128853249095, 6720.0, 6775.728970841161, 6794.184697836291, 6799.864002719967, 6813.11429514165, 6815.625140617264, 6203.751849925952, 6233.968830155911, 6262.749490020439, 6360.077788720656, 6382.266039405481, 5234.842954711365, 6740.764073257511, 6778.423833974168, 6852.074969879102, 6905.343992320722, 6322.241331040304, 6349.555531112777, 6378.84052898672, 6415.26224484181, 6467.2562655294305, 6590.835229119214, 6670.4997125215805, 6691.0967019451755, 6739.663016849236, 6754.864902701918, 6355.459785918156, 6418.903716444257, 6701.363370479797, 6717.193936727624, 6736.05695202672, 6511.576747511396, 6518.217813862272, 6617.4706023518, 6618.404343609098, 6622.801315960529, 5295.788168473295, 5297.17893726473, 5322.3879253885525, 5324.893502129936, 5359.732013399314, 4676.8129274828625, 4740.5733483986605, 4759.904801903943, 4769.117713223065, 4796.952030479651, 6218.689065546704, 6265.310815810257, 6268.435840774352, 6312.5581209314905, 6338.873222535523, 6776.69504872282, 6784.491163162783, 6789.694463749143, 6804.55770374924, 6819.5908245505425, 6252.124702541648, 6288.685565721696, 6317.305096439388, 6345.0, 6380.3619638035825, 5724.084146536534, 5812.418758124154, 5833.504152147115, 5889.469947704727, 5942.970285148546, 5481.561475082063, 6929.5842249465195, 6936.965315173291, 6952.791416257521, 6967.268436814062, 6662.700178492077, 6727.529072964846, 6751.189857217166, 6753.966230168818, 6763.797086087426, 6043.153958445733, 6546.18172728409, 6621.933780662324, 6729.528932974645, 6865.347791959756, 5517.889642207214, 6660.800175994728, 6664.966675166593, 6674.332566743286, 6689.331066893272, 5667.631603945731, 6406.583572067801, 6730.192376914802, 6766.458683305422, 6776.254611992578, 6269.0, 6411.775587854403, 6493.772717954849, 6518.543701941008, 6523.0, 5777.3933736957015, 6143.771245750779, 6425.614463132227, 6476.384743449365, 6489.935100648933, 5605.299337582802, 6132.0495871890025, 6376.9043464349, 6400.423961843457, 6434.67826608677, 6556.737730490727, 6574.671266436755, 6583.44040756541, 6585.374389432996, 6591.209054913441, 5141.640085194001, 5654.85862853432, 6140.600860944024, 6221.066839973859, 6279.843003924939], "value": 6035.7263091347, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.7433026789283, 740.3743836458194, 821.9753407397778, 1144.3934714601264, 1183.9112066595003, 38352.42471362928, 40123.99999999996, 40163.799181004055, 40180.59819401805, 40263.59736402639, 39579.604203957955, 39787.60212397875, 39857.800710996475, 39873.00317492064, 40097.19805603886, 8057.677692892292, 8231.382646301521, 8516.489010659348, 8767.78080547985, 8779.780505487382, 8774.298056155492, 8794.252488538483, 8816.294696424302, 8895.421797583169, 8938.955305223464, 8812.206901378875, 8837.513936733478, 8880.777980550505, 8886.0, 8894.733158005238, 8800.73597792064, 8842.911570884306, 8860.291176705849, 8867.822643547157, 8899.644014239422, 7465.925340746578, 8695.39132260742, 8761.386702930797, 8765.824683506358, 8766.517841518715, 38275.425868611994, 38393.0, 38406.61593384086, 38461.0, 38554.61445385566, 2948.7640988721064, 3428.2800611871535, 3455.23984723363, 3466.046837119812, 3468.6357932417236, 24547.0, 30199.849000755075, 30654.540181897068, 30768.230794230098, 30800.0, 3051.1761824307537, 3102.860371283275, 3126.3590963852585, 3156.779025468218, 3160.6365267994015, 269206.0, 274324.0, 320542.0, 322577.0, 323550.0, 48080.75959620249, 48628.78428039327, 48661.513384866405, 48750.99999999929, 48981.0, 44548.55451445509, 50492.990140197726, 51609.2258616121, 51633.0, 51685.483145168066, 14535.927320363331, 14618.26908654563, 14679.339429725474, 14699.485518006819, 14704.897132715088, 11938.104642151873, 12070.637880863587, 12078.154529182873, 12084.637460876187, 12106.81839772404, 11152.776944461066, 11311.660650180507, 13613.455461781417, 13873.959453040861, 13902.026858120036, 5062.443131255559, 5907.379725128885, 5980.820575382745, 5981.850453738604, 6004.189434426384, 941.5762906692016, 971.8542218667257, 980.2648013989508, 1000.7832650678781, 1041.3023274406166, 18478.630427391377, 19504.609907801765, 24090.39774005664, 24379.14672986437, 24475.632865507032, 1091.2633972068822, 1103.6633826682778, 1133.8469306643497, 1134.733337665648, 1139.9886001140048, 10181.676770899761, 10729.819719830812, 12076.879231207751, 12384.81422778659, 12574.99400047994, 330082.0, 336029.0, 409868.0, 410170.0, 466940.0, 58429.70785146047, 58753.70623146857, 59288.703556482804, 59421.0, 59680.0, 1315.5855905389772, 1318.9274589897457, 1474.3144437836459, 1514.5532068039954, 1514.9621259468381, 27021.08194311853, 27722.584161237195, 28457.715422845507, 29105.12684619465, 29314.0, 42801.0, 51259.2311115341, 51307.0, 51919.22121168261, 52036.21945670894, 453099.0, 453768.0, 456630.0, 456840.0, 456925.0, 31391.0, 33529.49705754464, 37171.725251596414, 37200.81399592985, 37528.0, 47273.527264726916, 47869.76065119652, 48224.0, 49102.75448622734, 49729.0, 25322.987080516574, 29046.7095329044, 29736.0, 32499.133105463727, 32767.50848737223, 31973.0, 32589.0, 32940.50589241115, 33024.66975330216, 33242.33515329631, 38697.16285464317, 38753.0, 38839.0, 39280.62517811977, 39454.0, 31319.373612527164, 31925.20186995344, 32057.03828885137, 32510.717873733418, 33160.0, 21961.0, 24582.89376978076, 25819.870900645376, 25940.962361505328, 26161.869190653924], "value": 18256.77080426287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.11153794345535, 401.2416532753099, 416.3775156141569, 425.05425428421756, 439.52531266232467, 21258.681119783196, 21338.786612133874, 22175.44561385966, 22185.0, 22453.887730561324, 16973.57566060849, 21947.0123844427, 22931.885340573273, 23940.40148996276, 24074.638880416765, 6168.969155154229, 6411.615303081807, 6429.517786166033, 6438.967805160968, 6443.935560644404, 4610.5389461053965, 6219.067139929001, 6259.217597800275, 6322.778702745405, 6323.462505686999, 6160.722767475474, 6275.780347687832, 6295.244570651528, 6299.086632438317, 6301.590396624205, 6092.482139018189, 6217.906731399033, 6271.498280137578, 6302.936970630327, 6315.336889626615, 5540.168974653834, 5567.3040869891265, 5577.944220557823, 5600.327960644708, 5611.298587676541, 26539.867300663373, 27331.043413480435, 27344.45311093767, 27452.62736863169, 27484.0, 2156.9460763480884, 2221.4224301681515, 2226.9554608907893, 2229.108356657334, 2232.151782322723, 14484.855151448455, 16728.0, 17453.301867925267, 18093.819061809347, 18246.270149194017, 1811.5108920591367, 1888.2824526679774, 1892.81071892811, 2135.3807395855183, 2190.507135894427, 147813.0, 148597.0, 150330.7450388245, 151322.48677513195, 153113.9999999989, 11361.772764544663, 11384.772304553862, 12610.306433146265, 12722.554710585086, 12887.16233444823, 16115.838841611669, 16350.34598616042, 16474.093924834247, 16487.422940197037, 16527.50417487477, 6939.306069393121, 7835.804104897309, 8609.913900861036, 8856.64573417069, 8873.645054197888, 8293.295069919004, 8338.04112527067, 8342.416030877901, 8500.53247071417, 8507.447015944068, 7818.921810781933, 7864.2922137007945, 7885.487443316166, 7974.641141148662, 7994.2405471480115, 2002.8097330753556, 2110.8627939183903, 2114.661654135331, 2114.8625339352893, 2140.3685912655806, 866.3935245328296, 925.5696101312922, 958.0276019839868, 1002.5789168549227, 1012.8126296635146, 20527.4868128298, 21190.89404552998, 21278.255261066097, 21545.56908861814, 25446.363840903756, 796.4305521552118, 988.1304452082122, 992.3153024413276, 1008.5562352564995, 1012.8987101289812, 10879.619213327496, 12381.876181238073, 13089.476420943247, 13407.061505694508, 13488.325583720774, 712885.0, 717801.0, 718908.0, 738759.0, 741733.0, 117510.58097359822, 151001.24499377434, 153098.0, 156300.0, 157768.0, 1169.9821155594686, 1197.8802119787952, 1223.473906220316, 1227.472186959598, 1229.5266322465736, 17670.823291767432, 19817.0, 20112.296069637494, 21716.34850954474, 22148.77851221467, 63663.0, 64360.35639643544, 64542.70914581776, 65142.74286285572, 65426.0, 89628.5518572429, 91206.0, 91262.54368728114, 91264.5436772812, 91926.54036729774, 8464.0, 8690.565471726515, 8875.33434992391, 8920.86618700733, 9018.774530636787, 12480.689527599834, 13159.934200328937, 13232.603021909357, 13498.0, 13697.726045479234, 10661.413622250851, 11368.658940231806, 11528.884711152781, 11784.41077946082, 11813.0, 8650.956745216485, 10739.301945373525, 10811.297265677706, 10855.348679079281, 11064.557417703523, 11753.88246117562, 11941.16411851162, 12075.094367922266, 12145.453454594388, 12169.878301217228, 8530.232279094911, 8662.653493860174, 8774.683141960268, 9066.637334506546, 9110.908890911007, 11390.088792896382, 11969.281843089442, 12226.20529665569, 12245.326507042199, 12294.692632684255], "value": 10597.688456640732, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1192.7256730951885, 1351.0610125962453, 1351.3513513513512, 1365.4947669362336, 1380.7376598446292, 10027.849582256264, 10729.819719830812, 11002.174836887236, 11167.050800681951, 11249.55001799927, 9786.559604817783, 11135.944320278388, 11204.831927521094, 11226.214165008452, 11276.661700148989, 2435.5250726108416, 2469.444375015625, 2492.0405643827166, 2492.6385674077337, 2495.513374891897, 2395.125779090628, 2427.2354208424376, 2468.25952214335, 2470.72821989581, 2471.6045432730766, 2430.538197742432, 2433.7322894481595, 2453.619688948207, 2468.160825319391, 2471.876406179693, 2410.867402292873, 2414.3722632115687, 2435.2207293665947, 2459.213051823417, 2461.483088551406, 2160.4166874943835, 2374.8693821839793, 2402.1712509184304, 2405.7834794868545, 2410.023940304162, 9104.590293436744, 11200.607978720705, 11234.382108984002, 11299.870012998634, 11324.6036388726, 6316.242050953915, 6539.9673001635165, 6548.836279093013, 6563.507736919702, 6599.571027883172, 3787.2425514896854, 4005.2790497710403, 4056.614621610972, 4096.877093687194, 4098.672106231495, 1191.2435603391823, 1195.5277665322235, 1196.8743281955356, 1209.866914639389, 1257.9182353147016, 11834.822477662841, 14579.125252484992, 15090.54728358151, 15207.467738629206, 15320.387184512607, 5183.403908550565, 5239.869003274948, 5394.865128371822, 5405.378381486179, 5406.405295417501, 9981.602575639416, 11400.885991140149, 11683.182177247681, 11760.529578816922, 11796.52813887452, 5942.61373010753, 6271.404216599416, 6357.904631430532, 6361.650109243943, 6378.617282963037, 5312.62811603184, 5772.0, 6008.729607167688, 6021.939780602225, 6026.367231440723, 4158.276329004507, 4216.262154123016, 4315.6763242756915, 4349.521552629209, 4415.183191109655, 1109.7515295292797, 1274.350081458463, 1286.2154086007529, 1290.6515240884908, 1290.9354532273537, 620.7516993202755, 697.3131465506472, 713.7002458967246, 716.2837162837163, 718.3893690363254, 6350.269718982377, 6650.0, 6761.898571521431, 6776.051352810512, 6820.795376138624, 904.9366544341965, 917.0, 935.3720410056004, 942.830290547708, 954.5227386306847, 4133.751974881517, 4177.081042170717, 4279.315309550457, 4302.526722060571, 4342.066455712037, 13848.723025539633, 14117.435302587986, 14305.356258968372, 14321.6419589509, 14358.641033974025, 13929.442822287197, 14243.928780356031, 14252.358643861051, 14257.572272831832, 14276.714465710835, 10143.289969702199, 10422.791544169226, 10498.370097794157, 10601.575936962436, 10629.681109566725, 6354.777582784581, 6913.412359949461, 6936.583804971718, 7000.334968178015, 7051.6474176292, 12031.097667674785, 12127.272363658209, 12163.574274900337, 12244.938775306067, 12378.566750163702, 12393.62819115428, 12420.875791241971, 12478.937605311916, 12509.311987840392, 12582.433790479634, 6716.6902454021, 8348.66605335804, 8370.121137280741, 8400.075991640793, 8505.74482765518, 10035.849462258218, 10071.0, 10081.949590252296, 10161.644342447978, 10187.337823041775, 8514.531700756517, 8692.391532592657, 8728.389012769045, 8764.21122099014, 8785.736427907173, 8569.48583085017, 8574.742757717278, 8582.957085214533, 8676.522791246542, 8720.65117395297, 7780.533168009937, 7920.5247685139075, 7925.524468531907, 7927.920720792718, 7928.207179282256, 5869.6771677558145, 5918.822435326947, 6051.3948605140895, 6076.301225358963, 6113.969430152821, 5611.74747136388, 5781.913271300849, 5812.389699081536, 5833.212516310414, 5959.553033522417], "value": 5182.298884690117, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.55165836071467, 385.22954091816365, 391.237087679026, 401.53622565936337, 402.848931650631, 6094.8171554853425, 6217.782377616784, 6249.437550620443, 6261.71634814863, 6315.3684631536935, 5923.407659234085, 6114.938850611493, 6122.877542449149, 6135.631862088278, 6140.907886381708, 3764.682361173581, 4507.3689683444345, 4507.4365704286965, 4530.79611417487, 4531.6601254905845, 4268.274393353122, 4493.281075027996, 4507.188706032913, 4524.23088075028, 4536.9546304537025, 4476.664250181233, 4479.3952816369865, 4504.954950450503, 4525.728456292633, 4526.7283962962165, 3743.401055831081, 3799.0502374406396, 4342.826286948534, 4455.910881782363, 4478.708883922567, 3186.0, 3783.8999355357764, 3841.308564458396, 3842.4620553122304, 3871.728978971473, 5991.670458124801, 6008.158857759917, 6014.098509714612, 6034.607750496204, 6034.668093254869, 4128.60778226068, 5020.447750747415, 5276.657017293864, 5322.973385133088, 5331.280277162572, 6453.709583068773, 6530.542861999662, 6532.542722009462, 6536.0, 6562.606243625398, 4338.110687309094, 4372.672049596261, 4381.583749543788, 4394.934075988863, 4397.626201772853, 5891.499222566087, 6564.901526477059, 6738.292479289702, 6927.93072069283, 6950.131233595801, 4456.197884380843, 4457.108578284357, 4458.5318541553315, 4467.821287148543, 4478.745951133687, 4537.274036154199, 4543.159515489645, 4546.726357022938, 4572.222722137245, 4574.9020235143325, 4465.24090904547, 5124.846254612367, 5348.5186333230195, 5349.732513374393, 5364.597655175878, 5451.64564303319, 5719.828405147852, 6387.201599800025, 6584.440322572635, 6587.242467116343, 1409.0136904166918, 1443.6246575890343, 1525.9771103433457, 1545.6831349573536, 1558.0729465967731, 989.4063561862824, 999.5407248645666, 1016.6289304403839, 1020.5458570936011, 1029.3206483720708, 4985.6845197943685, 6093.878122437526, 6110.755569777248, 6112.616079728909, 6129.724162412702, 6801.047853300542, 6817.466070134279, 6819.181698196248, 6827.0, 6881.621510816853, 5875.83037810306, 6041.486473649701, 6071.0, 6120.265568131853, 6130.160951714468, 3223.4842425211855, 3368.8714280715744, 3491.441369380887, 3574.945391109629, 3579.3736096183065, 5987.101934709828, 6614.86770264592, 6993.566318904613, 7026.191987921352, 7040.6479676016, 5564.610477266552, 5896.233489646319, 6243.844888695606, 6578.934210657832, 7061.364477197077, 5851.268591426072, 6130.78542251028, 6762.561182698992, 7017.263187365457, 7107.614015267077, 5025.7989680412375, 6735.696893639896, 6797.558158719865, 6802.54433346159, 6834.384905358542, 5599.580031497572, 6717.0, 6752.864942701217, 6760.459163267025, 6808.7276508939085, 5624.578156638187, 6139.355367686508, 6976.77906366394, 7119.236725111062, 7166.749163779243, 3364.7308215342223, 4405.030893203619, 4429.468463784367, 4450.666200035075, 4463.0, 6817.761378351734, 6829.180498340231, 6855.4172895304455, 6884.345987131214, 6887.896681549881, 5460.426655201147, 6394.633985425422, 6542.509311801538, 6574.84940135484, 6584.736610535717, 6264.874702506016, 6578.506612004023, 6582.539222254396, 6588.670566471753, 6607.975763756625, 6067.666278354733, 6279.152314437675, 6468.579542329733, 6475.150933589206, 6502.252240992347, 6539.318879259481, 6595.043718660863, 6613.14029176204, 6629.569078009914, 6708.758879607289, 5896.439838215363, 6128.50971922254, 6431.196100487439, 6449.355064493513, 6502.122213501117], "value": 4746.4320096512165, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.6830536090924, 819.3731795176694, 821.8890449789277, 824.1593574553955, 826.0129145670921, 11909.940450297747, 16301.83698163018, 16317.347306107771, 16326.510204693877, 16369.0, 14520.927395363009, 14547.854521454808, 14638.707225855476, 14984.250787460638, 15170.089794612304, 960.7790208252106, 979.9657012004582, 1007.0634310091611, 1012.2913960227833, 1013.1995723378523, 1005.36661903001, 1013.2096964367768, 1018.1752780248023, 1018.3024628129717, 1018.3482571154467, 1059.1262208677833, 1059.1579694143174, 1059.6503153959213, 1059.7191744187796, 1061.3525749292965, 1046.3094357723903, 1053.9987012338308, 1055.0504545908666, 1056.6407421476697, 1057.0750593230923, 781.3007358414244, 782.1083964280724, 784.1766145547152, 784.8665726826454, 786.6892577431883, 16199.595010124724, 16759.24583393738, 16886.240119194666, 16905.985640861465, 17011.404600838912, 14790.926045369704, 14803.185824779634, 14826.0, 14974.176420296879, 15539.378424862993, 12906.741865162645, 13236.338183090904, 13406.329683515785, 13552.390142443614, 13611.523596674167, 3300.5544251526217, 3325.48454989477, 3389.86440542378, 3397.3545026444895, 3405.1316914186973, 75252.0, 101889.0, 108944.4552777239, 109083.45458272737, 109647.45176274067, 8052.412981586589, 11575.247608905394, 11662.00872925794, 11837.408129593487, 11888.762224755457, 20132.496687582927, 23619.173328933404, 23918.402039949142, 24108.758912411, 24137.7586224139, 7830.647620857075, 7863.685452581833, 7998.84002319962, 8091.797705057421, 8105.311048560939, 4064.9390259146135, 4126.690498212646, 4134.359174327984, 4179.561146079679, 4266.722663026893, 4141.151064031867, 4190.224808410454, 4250.213710463574, 4258.084511829909, 4261.914761704748, 810.4650930385917, 913.1507697841072, 935.555611084743, 951.9666811661558, 958.9136977671903, 616.479075181471, 622.6202016769766, 628.9371062893765, 637.7990932856136, 646.6904518350378, 9512.904870951203, 9715.514224288758, 10440.477976101165, 10453.895461045444, 11257.605983790529, 615.972281247345, 621.2638023941644, 621.9689015549204, 627.7915013598804, 642.7011439680477, 3854.622258973987, 4588.311753236974, 4740.19416699162, 4768.008458726306, 4770.284457331359, 79461.60269198618, 98682.0, 100622.99377006282, 102400.0, 104417.47791260995, 63385.41536461533, 88530.55734721285, 89792.5510372444, 90584.0, 90987.09012909919, 60121.39878601158, 74946.12634684067, 75418.0, 79732.20267797363, 81343.59328203321, 10471.790564188826, 10813.51339189754, 10922.071623912056, 11136.944315278372, 11155.880382727255, 38542.80728596339, 39351.80324098361, 39364.60635393609, 39473.60526394699, 40123.1975360497, 49176.77058073577, 50702.23946640877, 50887.2366914504, 50986.0, 51444.0, 11290.830637540279, 13346.799798003232, 13587.660308492366, 13658.658533536742, 14039.816781136866, 14362.712745745235, 14367.928160359132, 14586.635334116732, 14822.481213157487, 14958.476453324081, 13405.731885362433, 13558.0, 13683.315834208448, 13936.024478286423, 13978.32418616654, 13360.93319533396, 13513.662158445724, 13574.59276221715, 13949.907106593957, 14002.509912153026, 12711.173773704679, 13169.73660526765, 13471.393787279792, 13765.724685506435, 14103.576892693236, 9208.907910920805, 9540.486203610813, 9561.521923903916, 9669.27480438984, 9810.074483529164, 8609.248514748298, 10201.489925503844, 10262.230332725225, 10351.171906247633, 10354.1198998083], "value": 7666.532830786583, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1708.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 124.0, 124.0, 125.0, 120.0, 123.0, 122.0, 125.0, 122.0, 125.0], "value": 122.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 116.0, 119.0, 160.0, 130.0, 159.0, 151.0, 122.0, 143.0, 144.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 282.0, 250.0, 319.0, 276.0, 306.0, 245.0, 278.0, 215.0, 289.0], "value": 266.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 68.0, 73.0, 91.0, 62.0, 67.0, 95.0, 82.0, 77.0, 63.0], "value": 76.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 92.0, 74.0, 73.0, 74.0, 86.0, 72.0, 74.0, 87.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 111.0, 131.0, 94.0, 139.0, 93.0, 99.0, 111.0, 92.0, 89.0], "value": 105.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 103.0, 108.0, 160.0, 140.0, 100.0, 155.0, 128.0, 100.0, 101.0], "value": 119.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 134.0, 103.0, 105.0, 103.0, 104.0, 103.0, 100.0, 105.0, 103.0], "value": 111.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 53.0, 52.0, 53.0, 52.0, 53.0, 52.0, 51.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 69.0, 93.0, 58.0, 66.0, 82.0, 89.0, 92.0, 84.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 90.0, 92.0, 85.0, 84.0, 95.0, 85.0, 122.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 170.0, 164.0, 166.0, 154.0, 183.0, 174.0, 150.0, 198.0, 153.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 246.0, 207.0, 198.0, 203.0, 189.0, 206.0, 249.0, 263.0, 201.0], "value": 218.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 98.0, 64.0, 61.0, 78.0, 99.0, 101.0, 94.0, 81.0, 74.0], "value": 84.0, "unit": "score"}]}]} 09:26:57 INFO - Return code: 0 09:26:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:26:57 ERROR - # TBPL SUCCESS # 09:26:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:26:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:26:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:26:57 INFO - 2017-04-04 09:26:57.545 screenresolution[1928:20854] starting screenresolution argv=screenresolution get 09:26:57 INFO - 2017-04-04 09:26:57.547 screenresolution[1928:20854] Display 0: 1600x1200x32@60 09:26:57 INFO - 2017-04-04 09:26:57.554 screenresolution[1929:20857] starting screenresolution argv=screenresolution list 09:26:57 INFO - Available Modes on Display 0 09:26:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:26:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:26:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:26:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:26:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:26:57 INFO - Intel Iris: 09:26:57 INFO - Chipset Model: Intel Iris 09:26:57 INFO - Type: GPU 09:26:57 INFO - Bus: Built-In 09:26:57 INFO - VRAM (Dynamic, Max): 1536 MB 09:26:57 INFO - Vendor: Intel (0x8086) 09:26:57 INFO - Device ID: 0x0a2e 09:26:57 INFO - Revision ID: 0x0009 09:26:57 INFO - Displays: 09:26:57 INFO - Display: 09:26:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:26:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:26:57 INFO - Display Serial Number: 1600x1200 60 09:26:57 INFO - Main Display: Yes 09:26:57 INFO - Mirror: Off 09:26:57 INFO - Online: Yes 09:26:57 INFO - Rotation: Supported 09:26:57 INFO - Return code: 0 09:26:57 INFO - Running post-action listener: _resource_record_post_action 09:26:57 INFO - [mozharness: 2017-04-04 16:26:57.789565Z] Finished run-tests step (success) 09:26:57 INFO - Running post-run listener: _resource_record_post_run 09:26:57 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 856064; Write bytes: 513508864; Read time: 12; Write time: 1829 09:26:57 INFO - TinderboxPrint: CPU usage
54.3% 09:26:57 INFO - TinderboxPrint: I/O read bytes / time
856,064 / 12 09:26:57 INFO - TinderboxPrint: I/O write bytes / time
513,508,864 / 1,829 09:26:57 INFO - TinderboxPrint: CPU idle
2,195.8 (45.7%) 09:26:57 INFO - TinderboxPrint: CPU system
971.5 (20.2%) 09:26:57 INFO - TinderboxPrint: CPU user
1,638.5 (34.1%) 09:26:57 INFO - TinderboxPrint: Swap in / out
212,860,928 / 0 09:26:57 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203110912; Write bytes: 204727808; Read time: 15935; Write time: 427 09:26:57 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 856064; Write bytes: 298831872; Read time: 12; Write time: 1361 09:26:58 INFO - Running post-run listener: _upload_blobber_files 09:26:58 INFO - Blob upload gear active. 09:26:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:26:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:26:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:26:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:26:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:26:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:59 INFO - (blobuploader) - INFO - Done attempting. 09:26:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:26:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:00 INFO - (blobuploader) - INFO - Done attempting. 09:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:27:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:01 INFO - (blobuploader) - INFO - Done attempting. 09:27:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:27:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:27:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:04 INFO - (blobuploader) - INFO - Done attempting. 09:27:04 INFO - (blobuploader) - INFO - Iteration through files over. 09:27:04 INFO - Return code: 0 09:27:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:27:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:27:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/610d767c83edf845e7d5d67de2a3b87e81356283235ca85affaadc8ec542d968273d1c2f40f359fee3c365e346fd410c5a0eac2bd404808d579e7a1fa9b6ea99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a373e37844ef0a396b2095844393bde8b150f1ef41e3e3aba39c527bc46e6ca0986a9dc97d5275b6806b3feef507c04b96c4b4af14c75ffa3334188535c10a33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e84c05145aa6205c77055a3849ee5509988446501b23f2eb8435b20a144b1e2e0ad913cf6ea31b37e624bd0180d077271448457c917ae1ca2ed5e9547f362c4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17a97a9830c2cf590eb421a9679ca6e6e4a140b772d4212ca4c0de7d8eca2ada50be41d7d2c19792a2b108f71475213af95f51cfa90c150112a4dde0614ff77b"} 09:27:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:27:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:27:04 INFO - Contents: 09:27:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/610d767c83edf845e7d5d67de2a3b87e81356283235ca85affaadc8ec542d968273d1c2f40f359fee3c365e346fd410c5a0eac2bd404808d579e7a1fa9b6ea99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a373e37844ef0a396b2095844393bde8b150f1ef41e3e3aba39c527bc46e6ca0986a9dc97d5275b6806b3feef507c04b96c4b4af14c75ffa3334188535c10a33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e84c05145aa6205c77055a3849ee5509988446501b23f2eb8435b20a144b1e2e0ad913cf6ea31b37e624bd0180d077271448457c917ae1ca2ed5e9547f362c4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17a97a9830c2cf590eb421a9679ca6e6e4a140b772d4212ca4c0de7d8eca2ada50be41d7d2c19792a2b108f71475213af95f51cfa90c150112a4dde0614ff77b"} 09:27:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:27:04 INFO - Copying logs to upload dir... 09:27:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:27:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.302015 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-04 09:27:04.373793) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 09:27:04.378272) ========= 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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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/610d767c83edf845e7d5d67de2a3b87e81356283235ca85affaadc8ec542d968273d1c2f40f359fee3c365e346fd410c5a0eac2bd404808d579e7a1fa9b6ea99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a373e37844ef0a396b2095844393bde8b150f1ef41e3e3aba39c527bc46e6ca0986a9dc97d5275b6806b3feef507c04b96c4b4af14c75ffa3334188535c10a33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e84c05145aa6205c77055a3849ee5509988446501b23f2eb8435b20a144b1e2e0ad913cf6ea31b37e624bd0180d077271448457c917ae1ca2ed5e9547f362c4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17a97a9830c2cf590eb421a9679ca6e6e4a140b772d4212ca4c0de7d8eca2ada50be41d7d2c19792a2b108f71475213af95f51cfa90c150112a4dde0614ff77b"} build_url:https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/K71wQtf-T1iASM-32zPsxA/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/610d767c83edf845e7d5d67de2a3b87e81356283235ca85affaadc8ec542d968273d1c2f40f359fee3c365e346fd410c5a0eac2bd404808d579e7a1fa9b6ea99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a373e37844ef0a396b2095844393bde8b150f1ef41e3e3aba39c527bc46e6ca0986a9dc97d5275b6806b3feef507c04b96c4b4af14c75ffa3334188535c10a33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e84c05145aa6205c77055a3849ee5509988446501b23f2eb8435b20a144b1e2e0ad913cf6ea31b37e624bd0180d077271448457c917ae1ca2ed5e9547f362c4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17a97a9830c2cf590eb421a9679ca6e6e4a140b772d4212ca4c0de7d8eca2ada50be41d7d2c19792a2b108f71475213af95f51cfa90c150112a4dde0614ff77b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 09:27:04.417185) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:27:04.417554) ========= 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.Kz3NnMMcCP/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.ovuY3RzuCo/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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.005266 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:27:04.466094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 09:27:04.466448) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 09:27:04.466854) ========= ========= Total master_lag: 0.29 =========