builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0020 starttime: 1489180652.34 results: success (0) buildid: 20170310090116 builduid: e806cd0a0d33405c9643520a0c679400 revision: a8d497b09753c91783b68c5805c64f34a2f39629 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 13:17:32.345137) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 13:17:32.345533) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 13:17:32.345805) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 13:17:32.492860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 13:17:32.493117) ========= 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.BEx0w1mQnm/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.BgMp3PX652/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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-03-10 13:17:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.4M=0.001s 2017-03-10 13:17:33 (14.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.516093 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 13:17:33.041124) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 13:17:33.041404) ========= 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.BEx0w1mQnm/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.BgMp3PX652/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.030517 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 13:17:33.093269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 13:17:33.093714) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a8d497b09753c91783b68c5805c64f34a2f39629 --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 a8d497b09753c91783b68c5805c64f34a2f39629 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BEx0w1mQnm/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.BgMp3PX652/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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-03-10 13:17:33,197 truncating revision to first 12 chars 2017-03-10 13:17:33,197 Setting DEBUG logging. 2017-03-10 13:17:33,197 attempt 1/10 2017-03-10 13:17:33,197 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a8d497b09753?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 13:17:33,497 unpacking tar archive at: mozilla-central-a8d497b09753/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575042 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 13:17:33.693347) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 13:17:33.693649) ========= script_repo_revision: a8d497b09753c91783b68c5805c64f34a2f39629 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 13:17:33.694371) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 13:17:33.694657) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 13:17:33.714249) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-03-10 13:17:33.714641) ========= /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.BEx0w1mQnm/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.BgMp3PX652/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:17:33 INFO - MultiFileLogger online at 20170310 13:17:33 in /builds/slave/test 13:17:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:17:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:17:33 INFO - {'append_to_log': False, 13:17:33 INFO - 'base_work_dir': '/builds/slave/test', 13:17:33 INFO - 'blob_upload_branch': 'Firefox', 13:17:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:17:33 INFO - 'branch': 'Firefox', 13:17:33 INFO - 'buildbot_json_path': 'buildprops.json', 13:17:33 INFO - 'config_files': ('talos/mac_config.py',), 13:17:33 INFO - 'default_actions': ('clobber', 13:17:33 INFO - 'read-buildbot-config', 13:17:33 INFO - 'download-and-extract', 13:17:33 INFO - 'populate-webroot', 13:17:33 INFO - 'create-virtualenv', 13:17:33 INFO - 'install', 13:17:33 INFO - 'run-tests'), 13:17:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:17:33 INFO - 'download_minidump_stackwalk': True, 13:17:33 INFO - 'download_symbols': 'ondemand', 13:17:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:17:33 INFO - 'tooltool.py': '/tools/tooltool.py', 13:17:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:17:33 INFO - '/tools/misc-python/virtualenv.py')}, 13:17:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:17:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:17:33 INFO - 'gecko_profile': False, 13:17:33 INFO - 'gecko_profile_interval': 0, 13:17:33 INFO - 'installer_path': 'installer.exe', 13:17:33 INFO - 'log_level': 'info', 13:17:33 INFO - 'log_name': 'talos', 13:17:33 INFO - 'log_to_console': True, 13:17:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:17:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:17:33 INFO - 'opt_config_files': (), 13:17:33 INFO - 'pip_index': False, 13:17:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:17:33 INFO - 'cmd': ('bash', 13:17:33 INFO - '-c', 13:17:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:17:33 INFO - 'enabled': True, 13:17:33 INFO - 'halt_on_failure': False, 13:17:33 INFO - 'name': 'check_screen_resolution'},), 13:17:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:17:33 INFO - 'cmd': ('bash', 13:17:33 INFO - '-c', 13:17:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:17:33 INFO - 'enabled': True, 13:17:33 INFO - 'halt_on_failure': False, 13:17:33 INFO - 'name': 'check_screen_resolution'},), 13:17:33 INFO - 'run_cmd_checks_enabled': True, 13:17:33 INFO - 'suite': 'dromaeojs-e10s', 13:17:33 INFO - 'system_bits': '32', 13:17:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:17:33 INFO - 'title': 't-yosemite-r7-0020', 13:17:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:17:33 INFO - 'use_talos_json': True, 13:17:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:17:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:17:33 INFO - 'work_dir': 'build'} 13:17:33 INFO - [mozharness: 2017-03-10 21:17:33.932206Z] Running clobber step. 13:17:33 INFO - Running pre-action listener: _resource_record_pre_action 13:17:33 INFO - Running main action method: clobber 13:17:33 INFO - rmtree: /builds/slave/test/build 13:17:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:17:36 INFO - Running post-action listener: _resource_record_post_action 13:17:36 INFO - [mozharness: 2017-03-10 21:17:36.604756Z] Finished clobber step (success) 13:17:36 INFO - [mozharness: 2017-03-10 21:17:36.604899Z] Running read-buildbot-config step. 13:17:36 INFO - Running pre-action listener: _resource_record_pre_action 13:17:36 INFO - Running main action method: read_buildbot_config 13:17:36 INFO - Using buildbot properties: 13:17:36 INFO - { 13:17:36 INFO - "project": "", 13:17:36 INFO - "product": "firefox", 13:17:36 INFO - "script_repo_revision": "production", 13:17:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:17:36 INFO - "repository": "", 13:17:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:17:36 INFO - "buildid": "20170310090116", 13:17:36 INFO - "stage_platform": "macosx64", 13:17:36 INFO - "basedir": "/builds/slave/test", 13:17:36 INFO - "nightly_build": "True", 13:17:36 INFO - "buildnumber": 6, 13:17:36 INFO - "slavename": "t-yosemite-r7-0020", 13:17:36 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 13:17:36 INFO - "platform": "yosemite_r7", 13:17:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:17:36 INFO - "branch": "mozilla-central", 13:17:36 INFO - "repo_path": "mozilla-central", 13:17:36 INFO - "revision": "a8d497b09753c91783b68c5805c64f34a2f39629", 13:17:36 INFO - "pgo_build": "False", 13:17:36 INFO - "builduid": "e806cd0a0d33405c9643520a0c679400", 13:17:36 INFO - "slavebuilddir": "test" 13:17:36 INFO - } 13:17:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 13:17:36 INFO - Running post-action listener: _resource_record_post_action 13:17:36 INFO - [mozharness: 2017-03-10 21:17:36.609103Z] Finished read-buildbot-config step (success) 13:17:36 INFO - [mozharness: 2017-03-10 21:17:36.609276Z] Running download-and-extract step. 13:17:36 INFO - Running pre-action listener: _resource_record_pre_action 13:17:36 INFO - Running main action method: download_and_extract 13:17:36 INFO - mkdir: /builds/slave/test/build/tests 13:17:36 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')]} 13:17:36 INFO - trying https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 13:17:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/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 13:17:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/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 13:17:37 INFO - Downloaded 1199 bytes. 13:17:37 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 13:17:37 INFO - Using the following test package requirements: 13:17:37 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 13:17:37 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:17:37 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 13:17:37 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:17:37 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 13:17:37 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:17:37 INFO - u'jsshell-mac.zip'], 13:17:37 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:17:37 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 13:17:37 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 13:17:37 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:17:37 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 13:17:37 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:17:37 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 13:17:37 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:17:37 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 13:17:37 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:17:37 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 13:17:37 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:17:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 13:17:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:17:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 13:17:46 INFO - Expected file size: 51788709 13:17:46 INFO - Obtained file size: 51788709 13:18:02 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 13:18:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 13:18:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:18:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 13:18:05 INFO - Expected file size: 51788709 13:18:05 INFO - Obtained file size: 51788709 13:18:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 13:18:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:18:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 13:18:21 INFO - Expected file size: 14404424 13:18:21 INFO - Obtained file size: 14404424 13:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:21 INFO - trying https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:18:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 13:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/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 13:18:23 INFO - Downloaded 75036059 bytes. 13:18:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:18:23 INFO - mkdir: /builds/slave/test/properties 13:18:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:18:23 INFO - Writing to file /builds/slave/test/properties/build_url 13:18:23 INFO - Contents: 13:18:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:18:24 INFO - Running post-action listener: _resource_record_post_action 13:18:24 INFO - Running post-action listener: set_extra_try_arguments 13:18:24 INFO - [mozharness: 2017-03-10 21:18:24.360425Z] Finished download-and-extract step (success) 13:18:24 INFO - [mozharness: 2017-03-10 21:18:24.360552Z] Running populate-webroot step. 13:18:24 INFO - Running pre-action listener: _resource_record_pre_action 13:18:24 INFO - Running main action method: populate_webroot 13:18:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:18:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:18:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:18:24 INFO - '--tppagecycles', 13:18:24 INFO - '7'], 13:18:24 INFO - 'tests': ['tsvgm']}}, 13:18:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:18:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:18:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:18:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:18:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:18:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:18:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:18:24 INFO - 'talos_options': ['--disable-e10s'], 13:18:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:18:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:18:24 INFO - 'talos_options': ['--disable-e10s'], 13:18:24 INFO - 'tests': ['damp', 'tps']}, 13:18:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:18:24 INFO - 'tests': ['damp', 'tps']}, 13:18:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:18:24 INFO - 'tests': ['dromaeo_dom']}, 13:18:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:18:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:18:24 INFO - 'tests': ['basic_compositor_video']}, 13:18:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:18:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:18:24 INFO - 'tests': ['a11yr', 13:18:24 INFO - 'ts_paint', 13:18:24 INFO - 'tpaint', 13:18:24 INFO - 'sessionrestore', 13:18:24 INFO - 'sessionrestore_no_auto_restore', 13:18:24 INFO - 'tabpaint']}, 13:18:24 INFO - 'other-e10s': {'tests': ['a11yr', 13:18:24 INFO - 'ts_paint', 13:18:24 INFO - 'tpaint', 13:18:24 INFO - 'sessionrestore', 13:18:24 INFO - 'sessionrestore_no_auto_restore', 13:18:24 INFO - 'tabpaint']}, 13:18:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:18:24 INFO - 'ts_paint', 13:18:24 INFO - 'tpaint', 13:18:24 INFO - 'sessionrestore', 13:18:24 INFO - 'sessionrestore_no_auto_restore', 13:18:24 INFO - 'tabpaint']}, 13:18:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:18:24 INFO - 'ts_paint', 13:18:24 INFO - 'tpaint', 13:18:24 INFO - 'sessionrestore', 13:18:24 INFO - 'sessionrestore_no_auto_restore', 13:18:24 INFO - 'tabpaint']}, 13:18:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:18:24 INFO - 'tests': ['a11yr', 13:18:24 INFO - 'ts_paint', 13:18:24 INFO - 'tpaint', 13:18:24 INFO - 'sessionrestore', 13:18:24 INFO - 'sessionrestore_no_auto_restore', 13:18:24 INFO - 'tabpaint']}, 13:18:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:18:24 INFO - 'tests': ['a11yr', 13:18:24 INFO - 'ts_paint', 13:18:24 INFO - 'tpaint', 13:18:24 INFO - 'sessionrestore', 13:18:24 INFO - 'sessionrestore_no_auto_restore', 13:18:24 INFO - 'tabpaint']}, 13:18:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:18:24 INFO - 'tests': ['tsvgx', 13:18:24 INFO - 'tsvgr_opacity', 13:18:24 INFO - 'tart', 13:18:24 INFO - 'tscrollx', 13:18:24 INFO - 'cart', 13:18:24 INFO - 'tsvg_static']}, 13:18:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:18:24 INFO - 'tsvgr_opacity', 13:18:24 INFO - 'tart', 13:18:24 INFO - 'tscrollx', 13:18:24 INFO - 'cart', 13:18:24 INFO - 'tsvg_static']}, 13:18:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:18:24 INFO - 'talos_options': ['--disable-e10s'], 13:18:24 INFO - 'tests': ['tp5o']}, 13:18:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:18:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:18:24 INFO - 'talos_options': ['--disable-e10s', 13:18:24 INFO - '--xperf_path', 13:18:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:24 INFO - 'tests': ['tp5n']}, 13:18:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:18:24 INFO - 'talos_options': ['--xperf_path', 13:18:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:24 INFO - 'tests': ['tp5n']}}, 13:18:24 INFO - 'talos.zip': {'path': '', 13:18:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:18:24 INFO - Running post-action listener: _resource_record_post_action 13:18:24 INFO - [mozharness: 2017-03-10 21:18:24.378862Z] Finished populate-webroot step (success) 13:18:24 INFO - [mozharness: 2017-03-10 21:18:24.378979Z] Running create-virtualenv step. 13:18:24 INFO - Running pre-action listener: _resource_record_pre_action 13:18:24 INFO - Running main action method: create_virtualenv 13:18:24 INFO - Creating virtualenv /builds/slave/test/build/venv 13:18:24 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 13:18:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:18:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:18:24 INFO - Using real prefix '/tools/python27' 13:18:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:18:25 INFO - Installing distribute.............................................................................................................................................................................................done. 13:18:28 INFO - Installing pip.................done. 13:18:28 INFO - Return code: 0 13:18:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:18:28 INFO - Reading from file tmpfile_stdout 13:18:28 INFO - Output received: 13:18:28 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) 13:18:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:28 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 0x10e2abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8640d82ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e089d30>, '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 0x10dfb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e07ebe8>, '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.BEx0w1mQnm/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.BgMp3PX652/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:18:28 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 13:18:28 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 13:18:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BEx0w1mQnm/Render', 13:18:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:28 INFO - 'HOME': '/Users/cltbld', 13:18:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:28 INFO - 'LOGNAME': 'cltbld', 13:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:28 INFO - 'MOZ_NO_REMOTE': '1', 13:18:28 INFO - 'NO_EM_RESTART': '1', 13:18:28 INFO - 'PAGER': '/bin/cat', 13:18:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:28 INFO - 'PWD': '/builds/slave/test', 13:18:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:28 INFO - 'SHELL': '/bin/bash', 13:18:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgMp3PX652/Listeners', 13:18:28 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:18:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:28 INFO - 'USER': 'cltbld', 13:18:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:28 INFO - 'XPC_FLAGS': '0x0', 13:18:28 INFO - 'XPC_SERVICE_NAME': '0', 13:18:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:28 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 13:18:28 INFO - Cleaning up... 13:18:28 INFO - Return code: 0 13:18:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:28 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 0x10e2abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8640d82ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e089d30>, '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 0x10dfb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e07ebe8>, '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.BEx0w1mQnm/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.BgMp3PX652/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:18:28 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 13:18:28 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 13:18:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BEx0w1mQnm/Render', 13:18:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:28 INFO - 'HOME': '/Users/cltbld', 13:18:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:28 INFO - 'LOGNAME': 'cltbld', 13:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:28 INFO - 'MOZ_NO_REMOTE': '1', 13:18:28 INFO - 'NO_EM_RESTART': '1', 13:18:28 INFO - 'PAGER': '/bin/cat', 13:18:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:28 INFO - 'PWD': '/builds/slave/test', 13:18:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:28 INFO - 'SHELL': '/bin/bash', 13:18:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgMp3PX652/Listeners', 13:18:28 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:18:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:28 INFO - 'USER': 'cltbld', 13:18:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:28 INFO - 'XPC_FLAGS': '0x0', 13:18:28 INFO - 'XPC_SERVICE_NAME': '0', 13:18:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:28 INFO - Downloading/unpacking psutil>=3.1.1 13:18:28 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 13:18:28 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 13:18:28 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 13:18:28 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 13:18:28 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 13:18:28 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 13:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:18:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:18:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:18:32 INFO - Installing collected packages: psutil 13:18:32 INFO - Running setup.py install for psutil 13:18:32 INFO - building 'psutil._psutil_osx' extension 13:18:32 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 13:18:33 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 13:18:33 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 13:18:33 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 13:18:33 INFO - building 'psutil._psutil_posix' extension 13:18:33 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 13:18:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:18:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:18:33 INFO - ^ 13:18:33 INFO - 1 warning generated. 13:18:33 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 13:18:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:18:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:18:33 INFO - Successfully installed psutil 13:18:33 INFO - Cleaning up... 13:18:33 INFO - Return code: 0 13:18:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:18:33 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')]} 13:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:33 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')]} 13:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:33 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 0x10e2abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8640d82ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e089d30>, '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 0x10dfb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e07ebe8>, '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.BEx0w1mQnm/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.BgMp3PX652/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:18:33 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 13:18:33 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 13:18:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BEx0w1mQnm/Render', 13:18:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:33 INFO - 'HOME': '/Users/cltbld', 13:18:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:33 INFO - 'LOGNAME': 'cltbld', 13:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:33 INFO - 'MOZ_NO_REMOTE': '1', 13:18:33 INFO - 'NO_EM_RESTART': '1', 13:18:33 INFO - 'PAGER': '/bin/cat', 13:18:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:33 INFO - 'PWD': '/builds/slave/test', 13:18:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:33 INFO - 'SHELL': '/bin/bash', 13:18:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgMp3PX652/Listeners', 13:18:33 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:18:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:33 INFO - 'USER': 'cltbld', 13:18:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:33 INFO - 'XPC_FLAGS': '0x0', 13:18:33 INFO - 'XPC_SERVICE_NAME': '0', 13:18:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:18:34 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 13:18:34 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 13:18:34 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 13:18:34 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 13:18:34 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 13:18:34 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 13:18:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:18:36 INFO - Installing collected packages: mozsystemmonitor 13:18:36 INFO - Running setup.py install for mozsystemmonitor 13:18:37 INFO - Successfully installed mozsystemmonitor 13:18:37 INFO - Cleaning up... 13:18:37 INFO - Return code: 0 13:18:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:18:37 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')]} 13:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:37 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')]} 13:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:37 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 0x10e2abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8640d82ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e089d30>, '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 0x10dfb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e07ebe8>, '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.BEx0w1mQnm/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.BgMp3PX652/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:18:37 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 13:18:37 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 13:18:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BEx0w1mQnm/Render', 13:18:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:37 INFO - 'HOME': '/Users/cltbld', 13:18:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:37 INFO - 'LOGNAME': 'cltbld', 13:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:37 INFO - 'MOZ_NO_REMOTE': '1', 13:18:37 INFO - 'NO_EM_RESTART': '1', 13:18:37 INFO - 'PAGER': '/bin/cat', 13:18:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:37 INFO - 'PWD': '/builds/slave/test', 13:18:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:37 INFO - 'SHELL': '/bin/bash', 13:18:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgMp3PX652/Listeners', 13:18:37 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:18:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:37 INFO - 'USER': 'cltbld', 13:18:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:37 INFO - 'XPC_FLAGS': '0x0', 13:18:37 INFO - 'XPC_SERVICE_NAME': '0', 13:18:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:37 INFO - Downloading/unpacking jsonschema==2.5.1 13:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:18:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:18:40 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 13:18:40 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 13:18:40 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 13:18:40 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 13:18:40 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 13:18:40 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 13:18:40 INFO - Downloading functools32-3.2.3-2.tar.gz 13:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:18:40 INFO - warning: no files found matching '*.txt' 13:18:40 INFO - no previously-included directories found matching 'build' 13:18:40 INFO - no previously-included directories found matching 'dist' 13:18:40 INFO - no previously-included directories found matching '.git*' 13:18:40 INFO - Installing collected packages: jsonschema, functools32 13:18:40 INFO - Running setup.py install for functools32 13:18:40 INFO - warning: no files found matching '*.txt' 13:18:40 INFO - no previously-included directories found matching 'build' 13:18:40 INFO - no previously-included directories found matching 'dist' 13:18:40 INFO - no previously-included directories found matching '.git*' 13:18:40 INFO - Successfully installed jsonschema functools32 13:18:40 INFO - Cleaning up... 13:18:40 INFO - Return code: 0 13:18:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:18:40 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')]} 13:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:40 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')]} 13:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:40 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 0x10e2abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8640d82ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e089d30>, '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 0x10dfb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e07ebe8>, '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.BEx0w1mQnm/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.BgMp3PX652/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:18:40 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 13:18:40 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 13:18:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BEx0w1mQnm/Render', 13:18:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:40 INFO - 'HOME': '/Users/cltbld', 13:18:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:40 INFO - 'LOGNAME': 'cltbld', 13:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:40 INFO - 'MOZ_NO_REMOTE': '1', 13:18:40 INFO - 'NO_EM_RESTART': '1', 13:18:40 INFO - 'PAGER': '/bin/cat', 13:18:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:40 INFO - 'PWD': '/builds/slave/test', 13:18:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:40 INFO - 'SHELL': '/bin/bash', 13:18:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgMp3PX652/Listeners', 13:18:40 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:18:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:40 INFO - 'USER': 'cltbld', 13:18:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:40 INFO - 'XPC_FLAGS': '0x0', 13:18:40 INFO - 'XPC_SERVICE_NAME': '0', 13:18:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:18:41 INFO - Cleaning up... 13:18:41 INFO - Return code: 0 13:18:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:18:41 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')]} 13:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:41 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')]} 13:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:41 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 0x10e2abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8640d82ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e089d30>, '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 0x10dfb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e07ebe8>, '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.BEx0w1mQnm/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.BgMp3PX652/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:18:41 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 13:18:41 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 13:18:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BEx0w1mQnm/Render', 13:18:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:41 INFO - 'HOME': '/Users/cltbld', 13:18:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:41 INFO - 'LOGNAME': 'cltbld', 13:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:41 INFO - 'MOZ_NO_REMOTE': '1', 13:18:41 INFO - 'NO_EM_RESTART': '1', 13:18:41 INFO - 'PAGER': '/bin/cat', 13:18:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:41 INFO - 'PWD': '/builds/slave/test', 13:18:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:41 INFO - 'SHELL': '/bin/bash', 13:18:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgMp3PX652/Listeners', 13:18:41 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:18:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:41 INFO - 'USER': 'cltbld', 13:18:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:41 INFO - 'XPC_FLAGS': '0x0', 13:18:41 INFO - 'XPC_SERVICE_NAME': '0', 13:18:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:41 INFO - Downloading/unpacking blobuploader==1.2.4 13:18:41 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 13:18:41 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 13:18:41 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 13:18:41 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 13:18:41 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 13:18:41 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 13:18:44 INFO - Downloading blobuploader-1.2.4.tar.gz 13:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:18:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:18:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:45 INFO - Downloading docopt-0.6.1.tar.gz 13:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:18:45 INFO - Installing collected packages: blobuploader, requests, docopt 13:18:45 INFO - Running setup.py install for blobuploader 13:18:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:18:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:18:45 INFO - Running setup.py install for requests 13:18:46 INFO - Running setup.py install for docopt 13:18:46 INFO - Successfully installed blobuploader requests docopt 13:18:46 INFO - Cleaning up... 13:18:46 INFO - Return code: 0 13:18:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18:46 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')]} 13:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:46 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')]} 13:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:46 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 0x10e2abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8640d82ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e089d30>, '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 0x10dfb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e07ebe8>, '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.BEx0w1mQnm/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.BgMp3PX652/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:18:46 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 13:18:46 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 13:18:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BEx0w1mQnm/Render', 13:18:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:46 INFO - 'HOME': '/Users/cltbld', 13:18:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:46 INFO - 'LOGNAME': 'cltbld', 13:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:46 INFO - 'MOZ_NO_REMOTE': '1', 13:18:46 INFO - 'NO_EM_RESTART': '1', 13:18:46 INFO - 'PAGER': '/bin/cat', 13:18:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:46 INFO - 'PWD': '/builds/slave/test', 13:18:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:46 INFO - 'SHELL': '/bin/bash', 13:18:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgMp3PX652/Listeners', 13:18:46 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:18:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:46 INFO - 'USER': 'cltbld', 13:18:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:46 INFO - 'XPC_FLAGS': '0x0', 13:18:46 INFO - 'XPC_SERVICE_NAME': '0', 13:18:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:18:46 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-HvIz4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:18:46 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-oZrlK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:18:46 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-OWDyen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:18:46 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-yrXpDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:18:46 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-7ZTgZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:18:47 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-KQ5VPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:18:47 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-clSyqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:18:47 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-fMFWqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:18:47 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-_X68az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:18:47 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-jM2j32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:18:47 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-y77WuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:18:47 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-PnQhjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:18:47 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-ioYIsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:18:47 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-whIEgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:48 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-q50RHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:18:48 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-oQS2zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:18:48 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-ZyU3qN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:18:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:18:48 INFO - Running setup.py install for manifestparser 13:18:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:18:48 INFO - Running setup.py install for mozcrash 13:18:48 INFO - Running setup.py install for mozdebug 13:18:48 INFO - Running setup.py install for mozdevice 13:18:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:18:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:18:48 INFO - Running setup.py install for mozfile 13:18:49 INFO - Running setup.py install for mozhttpd 13:18:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:18:49 INFO - Running setup.py install for mozinfo 13:18:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:18:49 INFO - Running setup.py install for mozInstall 13:18:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:18:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:18:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:18:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:18:49 INFO - Running setup.py install for mozleak 13:18:49 INFO - Running setup.py install for mozlog 13:18:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:18:49 INFO - Running setup.py install for moznetwork 13:18:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:18:49 INFO - Running setup.py install for mozprocess 13:18:50 INFO - Running setup.py install for mozprofile 13:18:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:18:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:18:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:18:50 INFO - Running setup.py install for mozrunner 13:18:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:18:50 INFO - Running setup.py install for mozscreenshot 13:18:50 INFO - Running setup.py install for moztest 13:18:50 INFO - Running setup.py install for mozversion 13:18:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:18:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:18:50 INFO - Cleaning up... 13:18:50 INFO - Return code: 0 13:18:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:50 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 0x10e2abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8640d82ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e089d30>, '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 0x10dfb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e07ebe8>, '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.BEx0w1mQnm/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.BgMp3PX652/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:18:50 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 13:18:50 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 13:18:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BEx0w1mQnm/Render', 13:18:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:50 INFO - 'HOME': '/Users/cltbld', 13:18:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:50 INFO - 'LOGNAME': 'cltbld', 13:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:50 INFO - 'MOZ_NO_REMOTE': '1', 13:18:50 INFO - 'NO_EM_RESTART': '1', 13:18:50 INFO - 'PAGER': '/bin/cat', 13:18:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:50 INFO - 'PWD': '/builds/slave/test', 13:18:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:50 INFO - 'SHELL': '/bin/bash', 13:18:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgMp3PX652/Listeners', 13:18:50 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:18:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:50 INFO - 'USER': 'cltbld', 13:18:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:50 INFO - 'XPC_FLAGS': '0x0', 13:18:50 INFO - 'XPC_SERVICE_NAME': '0', 13:18:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:18:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Rcfh8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:18:51 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)) 13:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:18:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-JvyRmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:18:51 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)) 13:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:18:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-4KajUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:18:51 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)) 13:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:18:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-aQI_D4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:18:51 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)) 13:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:18:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-GjfKQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:18:51 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)) 13:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:18:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-utIkNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:18:51 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)) 13:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:18:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-6Wxub0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:18:51 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)) 13:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:18:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-7brKuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:18:52 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)) 13:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:18:52 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-0E7CYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:18:52 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)) 13:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:18:52 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-rlgCOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:18:52 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)) 13:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:18:52 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-euEri1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:18:52 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)) 13:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:18:52 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-tY3p8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:18:52 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)) 13:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:18:52 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-lR4Lfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:18:52 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)) 13:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:18:52 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-lhZ8DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:18:52 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)) 13:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:52 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-9ABh7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:52 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)) 13:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:18:52 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-MzhJzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:18:52 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)) 13:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:18:52 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-jjq5Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:18:52 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)) 13:18:52 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)) 13:18:52 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)) 13:18:52 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)) 13:18:52 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)) 13:18:52 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)) 13:18:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:18:52 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 13:18:52 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 13:18:52 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 13:18:52 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 13:18:52 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 13:18:52 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 13:18:55 INFO - Downloading blessings-1.6.tar.gz 13:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:18:55 INFO - Installing collected packages: blessings 13:18:55 INFO - Running setup.py install for blessings 13:18:55 INFO - Successfully installed blessings 13:18:55 INFO - Cleaning up... 13:18:55 INFO - Return code: 0 13:18:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:18:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:18:56 INFO - Reading from file tmpfile_stdout 13:18:56 INFO - Current package versions: 13:18:56 INFO - blessings == 1.6 13:18:56 INFO - blobuploader == 1.2.4 13:18:56 INFO - docopt == 0.6.1 13:18:56 INFO - functools32 == 3.2.3-2 13:18:56 INFO - jsonschema == 2.5.1 13:18:56 INFO - manifestparser == 1.1 13:18:56 INFO - mozInstall == 1.12 13:18:56 INFO - mozcrash == 1.0 13:18:56 INFO - mozdebug == 0.1 13:18:56 INFO - mozdevice == 0.49 13:18:56 INFO - mozfile == 1.2 13:18:56 INFO - mozhttpd == 0.7 13:18:56 INFO - mozinfo == 0.9 13:18:56 INFO - mozleak == 0.1 13:18:56 INFO - mozlog == 3.4 13:18:56 INFO - moznetwork == 0.27 13:18:56 INFO - mozprocess == 0.25 13:18:56 INFO - mozprofile == 0.28 13:18:56 INFO - mozrunner == 6.13 13:18:56 INFO - mozscreenshot == 0.1 13:18:56 INFO - mozsystemmonitor == 0.3 13:18:56 INFO - moztest == 0.8 13:18:56 INFO - mozversion == 1.4 13:18:56 INFO - psutil == 3.1.1 13:18:56 INFO - requests == 1.2.3 13:18:56 INFO - wsgiref == 0.1.2 13:18:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:56 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 0x10e2abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8640d82ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e089d30>, '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 0x10dfb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e07ebe8>, '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.BEx0w1mQnm/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.BgMp3PX652/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:18:56 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 13:18:56 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 13:18:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BEx0w1mQnm/Render', 13:18:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:56 INFO - 'HOME': '/Users/cltbld', 13:18:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:56 INFO - 'LOGNAME': 'cltbld', 13:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:56 INFO - 'MOZ_NO_REMOTE': '1', 13:18:56 INFO - 'NO_EM_RESTART': '1', 13:18:56 INFO - 'PAGER': '/bin/cat', 13:18:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:56 INFO - 'PWD': '/builds/slave/test', 13:18:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:56 INFO - 'SHELL': '/bin/bash', 13:18:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgMp3PX652/Listeners', 13:18:56 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:18:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:56 INFO - 'USER': 'cltbld', 13:18:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:56 INFO - 'XPC_FLAGS': '0x0', 13:18:56 INFO - 'XPC_SERVICE_NAME': '0', 13:18:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:56 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)) 13:18:56 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)) 13:18:56 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)) 13:18:56 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)) 13:18:56 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)) 13:18:56 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)) 13:18:56 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)) 13:18:56 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)) 13:18:56 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)) 13:18:56 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)) 13:18:56 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)) 13:18:56 INFO - Cleaning up... 13:18:56 INFO - Return code: 0 13:18:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:56 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 0x10e2abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8640d82ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e089d30>, '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 0x10dfb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e07ebe8>, '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.BEx0w1mQnm/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.BgMp3PX652/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 13:18:56 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 13:18:56 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 13:18:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BEx0w1mQnm/Render', 13:18:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:56 INFO - 'HOME': '/Users/cltbld', 13:18:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:56 INFO - 'LOGNAME': 'cltbld', 13:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:56 INFO - 'MOZ_NO_REMOTE': '1', 13:18:56 INFO - 'NO_EM_RESTART': '1', 13:18:56 INFO - 'PAGER': '/bin/cat', 13:18:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:56 INFO - 'PWD': '/builds/slave/test', 13:18:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:56 INFO - 'SHELL': '/bin/bash', 13:18:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgMp3PX652/Listeners', 13:18:56 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:18:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:56 INFO - 'USER': 'cltbld', 13:18:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:56 INFO - 'XPC_FLAGS': '0x0', 13:18:56 INFO - 'XPC_SERVICE_NAME': '0', 13:18:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:18:56 INFO - Cleaning up... 13:18:56 INFO - Return code: 0 13:18:56 INFO - Running post-action listener: _resource_record_post_action 13:18:56 INFO - Running post-action listener: _start_resource_monitoring 13:18:56 INFO - Starting resource monitoring. 13:18:56 INFO - [mozharness: 2017-03-10 21:18:56.828731Z] Finished create-virtualenv step (success) 13:18:56 INFO - [mozharness: 2017-03-10 21:18:56.829698Z] Running install step. 13:18:56 INFO - Running pre-action listener: _resource_record_pre_action 13:18:56 INFO - Running main action method: install 13:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:18:57 INFO - Reading from file tmpfile_stdout 13:18:57 INFO - Detecting whether we're running mozinstall >=1.0... 13:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:18:57 INFO - Reading from file tmpfile_stdout 13:18:57 INFO - Output received: 13:18:57 INFO - Usage: mozinstall [options] installer 13:18:57 INFO - Options: 13:18:57 INFO - -h, --help show this help message and exit 13:18:57 INFO - -d DEST, --destination=DEST 13:18:57 INFO - Directory to install application into. [default: 13:18:57 INFO - "/builds/slave/test"] 13:18:57 INFO - --app=APP Application being installed. [default: firefox] 13:18:57 INFO - mkdir: /builds/slave/test/build/application 13:18:57 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'] 13:18:57 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 13:19:17 INFO - Reading from file tmpfile_stdout 13:19:17 INFO - Output received: 13:19:17 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 13:19:17 INFO - Running post-action listener: _resource_record_post_action 13:19:17 INFO - [mozharness: 2017-03-10 21:19:17.266232Z] Finished install step (success) 13:19:17 INFO - [mozharness: 2017-03-10 21:19:17.266387Z] Running run-tests step. 13:19:17 INFO - Running pre-action listener: _resource_record_pre_action 13:19:17 INFO - Running main action method: run_tests 13:19:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:19:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:19:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:19:17 INFO - 2017-03-10 13:19:17.281 screenresolution[1632:9685] starting screenresolution argv=screenresolution get 13:19:17 INFO - 2017-03-10 13:19:17.284 screenresolution[1632:9685] Display 0: 1600x1200x32@60 13:19:17 INFO - 2017-03-10 13:19:17.290 screenresolution[1633:9688] starting screenresolution argv=screenresolution list 13:19:17 INFO - Available Modes on Display 0 13:19:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:19:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:19:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:19:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:19:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:19:17 INFO - Intel Iris: 13:19:17 INFO - Chipset Model: Intel Iris 13:19:17 INFO - Type: GPU 13:19:17 INFO - Bus: Built-In 13:19:17 INFO - VRAM (Dynamic, Max): 1536 MB 13:19:17 INFO - Vendor: Intel (0x8086) 13:19:17 INFO - Device ID: 0x0a2e 13:19:17 INFO - Revision ID: 0x0009 13:19:17 INFO - Displays: 13:19:17 INFO - Display: 13:19:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:19:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:19:17 INFO - Display Serial Number: 1600x1200 60 13:19:17 INFO - Main Display: Yes 13:19:17 INFO - Mirror: Off 13:19:17 INFO - Online: Yes 13:19:17 INFO - Rotation: Supported 13:19:17 INFO - Return code: 0 13:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:19:17 INFO - Python 2.7.3 13:19:17 INFO - Return code: 0 13:19:17 INFO - grabbing minidump binary from tooltool 13:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:19:17 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 0x10e089d30>, '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 0x10dfb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e07ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:19:17 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 13:19:17 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 13:19:17 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 13:19:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:19:17 INFO - Return code: 0 13:19:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:19:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:19:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:19:17 INFO - ENV: RUST_BACKTRACE is now 1 13:19:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:19:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 13:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0020 --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 13:19:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BEx0w1mQnm/Render', 13:19:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:17 INFO - 'HOME': '/Users/cltbld', 13:19:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:17 INFO - 'LOGNAME': 'cltbld', 13:19:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:19:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:17 INFO - 'MOZ_NO_REMOTE': '1', 13:19:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:19:17 INFO - 'NO_EM_RESTART': '1', 13:19:17 INFO - 'PAGER': '/bin/cat', 13:19:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:17 INFO - 'PWD': '/builds/slave/test', 13:19:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:19:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:17 INFO - 'RUST_BACKTRACE': '1', 13:19:17 INFO - 'SHELL': '/bin/bash', 13:19:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgMp3PX652/Listeners', 13:19:17 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 13:19:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:17 INFO - 'USER': 'cltbld', 13:19:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:17 INFO - 'XPC_FLAGS': '0x0', 13:19:17 INFO - 'XPC_SERVICE_NAME': '0', 13:19:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 13:19:17 INFO - mozversion application_buildid: 20170310090116 13:19:17 INFO - mozversion application_changeset: a8d497b09753c91783b68c5805c64f34a2f39629 13:19:17 INFO - mozversion application_display_name: Nightly 13:19:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:19:17 INFO - mozversion application_name: Firefox 13:19:17 INFO - mozversion application_remotingname: firefox 13:19:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:19:17 INFO - mozversion application_vendor: Mozilla 13:19:17 INFO - mozversion application_version: 55.0a1 13:19:17 INFO - mozversion platform_buildid: 20170310090116 13:19:17 INFO - mozversion platform_changeset: a8d497b09753c91783b68c5805c64f34a2f39629 13:19:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:19:17 INFO - mozversion platform_version: 55.0a1 13:19:17 INFO - using testdate: 1489180757 13:19:17 INFO - actual date: 1489180757 13:19:17 INFO - starting webserver on 'localhost:49240' 13:19:17 INFO - SUITE-START | Running 2 tests 13:19:17 INFO - TEST-START | dromaeo_css 13:19:17 INFO - operating with platform_type : mac_ 13:19:17 INFO - Initialising browser for dromaeo_css test... 13:19:18 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpk0iCRM/profile http://localhost:49240/getInfo.html) 13:19:21 INFO - PROCESS | 1643 | 2017-03-10 13:19:21.562 plugin-container[1648:9910] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3b, name = 'com.apple.tsm.portname' 13:19:21 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:19:21 INFO - PROCESS | 1643 | 2017-03-10 13:19:21.563 plugin-container[1648:9910] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 13:19:21 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:19:21 INFO - PROCESS | 1643 | 2017-03-10 13:19:21.563 plugin-container[1648:9910] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:19:21 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 13:19:21 INFO - PROCESS | 1643 | colorDepth:24 13:19:21 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 13:19:21 INFO - PROCESS | 1643 | __metrics 13:19:21 ERROR - PROCESS | 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 13:19:22 INFO - TEST-INFO | 1643: exit 0 13:19:22 INFO - Browser initialized. 13:19:22 INFO - Running cycle 1/1 for dromaeo_css test... 13:19:22 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpk0iCRM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:19:24 INFO - PROCESS | 1650 | 2017-03-10 13:19:24.918 plugin-container[1651:10040] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 13:19:24 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:19:24 INFO - PROCESS | 1650 | 2017-03-10 13:19:24.918 plugin-container[1651:10040] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 13:19:24 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:19:24 INFO - PROCESS | 1650 | 2017-03-10 13:19:24.918 plugin-container[1651:10040] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:19:34 INFO - PROCESS | 1650 | RSS: Main: 227475456 13:19:34 INFO - PROCESS | 1650 | 13:22:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 13:22:40 INFO - PROCESS | 1650 | RSS: Main: 250585088 13:22:40 INFO - PROCESS | 1650 | 13:24:22 INFO - PROCESS | 1650 | ************************* 13:24:22 INFO - PROCESS | 1650 | A coding exception was thrown and uncaught in a Task. 13:24:22 INFO - PROCESS | 1650 | 13:24:22 ERROR - PROCESS | 1650 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:24:22 INFO - PROCESS | 1650 | Full stack: 13:24:22 INFO - PROCESS | 1650 | ************************* 13:25:42 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 13:25:43 INFO - PROCESS | 1650 | RSS: Main: 259125248 13:25:43 INFO - PROCESS | 1650 | 13:28:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 13:28:45 INFO - PROCESS | 1650 | RSS: Main: 270548992 13:28:45 INFO - PROCESS | 1650 | 13:31:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 13:31:48 INFO - PROCESS | 1650 | RSS: Main: 262742016 13:31:48 INFO - PROCESS | 1650 | 13:34:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 13:34:52 INFO - PROCESS | 1650 | RSS: Main: 273321984 13:34:52 INFO - PROCESS | 1650 | 13:37:54 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 13:37:54 INFO - PROCESS | 1650 | RSS: Main: 267235328 13:37:54 INFO - PROCESS | 1650 | 13:37:54 INFO - PROCESS | 1650 | __start_tp_report 13:37:54 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 13:37:54 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 13:37:54 INFO - PROCESS | 1650 | |i|pagename|runs| 13:37:54 INFO - PROCESS | 1650 | |0;dojo.html;3291.934161316772;3394.473856552234;3407.08008837614;3437.0719905625488;3462.3421549905515;5306.4958828911285;5685.232493613361;5796.362400135981;5860.179574859518;5890.263717035371;5739.971300143504;5744.454276843703;5796.942030579693;5820.447057529528;5836.737346819393;5198.662086964335;5203.4016088149965;5337.492938170887;5357.196420536911;5401.621886467949;4424.269995450747;5253.106971814782;5322.9620224056325;5382.730863456812;5385.192221166837;4346.282863327548;5201.843944681666;5250.159974404077;5341.973290133544;5346.893062138735;5277.02375060615;5280.551153151987;5285.180796976475;5327.387350454708;5346.304980352568;4267.957320426818;5209.19257515082;5211.843644690665;5282.735863206824;5293.523582877521;5572.247746554244;5577.470140336662;5607.186957891083;5723.227364305807;5725.770969161229;6199.87600247997;6215.192025036761;6234.937650623481;6248.531360147962;6248.656323902183;6349.9682501587195;6365.936340636581;6367.395097465734;6372.776952806676;6451.322611125858;6028.09578563219;6037.607555508878;6044.516438684895;6059.091136329498;6078.969605152034;6149.385061493815;6290.308066112815;6382.521310901608;6409.102725618417;6422.710978006001;6107.674343494518;6166.876662466726;6221.222347206599;6224.564280500412;6275.780347687901;6198.72105755233;6217.347178546278;6259.499240060784;6269.153664255267;6269.310375858652;6221.3778622138325;6252.5935814171935;6272.2159730033745;6275.96862015687;6302.779402720883;6148.893199224182;6167.753289868355;6184.628922264678;6199.783007594712;6265.592736472115;5118.897622047538;5124.538791508782;5126.102931986962;5164.767585458589;5165.870853228699;3750.1187221003042;4520.81916723334;4523.819047238139;4529.68292219548;4554.681172317973;5460.754266058037;5819.88360232793;5926.199963005025;5971.462568368867;6111.991521399008;4811.9518804812205;5160.40655324635;6211.223597050369;6241.157443745127;6292.622442653455;6104.572679912363;6116.396640261158;6117.857853872152;6118.877622447526;6134.601250918765;5133.537981581676;5506.587005974568;5590.385057643656;5614.747336369873;5644.3508996465935;6288.213973253435;6353.174087368612;6419.069234960998;6442.710078046593;6562.278149403657;6330.082138089859;6332.145160403286;6339;6344.333844946399;6359.014352775327;5432.402435732145;6507.121538592419;6547.050677651809;6548.8035358939305;6569.211694596679;5651;5901.3213480450295;5910.911336329872;6118.071005858243;6131.835460087213;6270.028145637433;6302.086197501245;6314.179156709598;6317.5893566918;6327.525435592257;6108.297545782292;6138.32709113608;6159.753609855556;6203.472704820141;6226.59527130735;6154.753809847556;6161.537884658758;6176.857281402955;6207.96896015517;6230.408111229426;5941.821745347646;6001.159837622824;6028.276606807036;6039.275286965592;6057.303410107717;6023.698815059317;6130.856783744145;6132.783850801352;6135.110179431545;6195.752169913153;6103.05402662588;6168.321484636596;6168.845778855564;6169.598976066542;6195.070739389128 13:37:54 INFO - PROCESS | 1650 | |1;ext.html;726.9091363579553;777.6111944027986;801.755464583302;919.6643225222796;930.5161316115616;37274.627253727485;38137.809310953475;39266.214675706506;39721.40417893734;39734.60265397345;37966.81016594913;38161.664341748045;38214.8089259554;38265.80867095668;38269.234615307745;7638.319569694672;7791.805204869867;10851.348919064842;11144.442777861115;11269;9319.627214911396;10812.513436895359;10887.618933337335;11012.834807477895;11071.446427678624;10918.454077296103;10945.398003109825;11026.503807328649;11031.503582338813;11040.447977601129;9078.409903356262;10914.290571112851;10952.288101273432;10978.066864316543;10985.285956412847;9072.7278181654;9086.363954523185;10719.517621707042;10767.084797792197;10774.353538787698;30451.695483045107;37877.81061094705;38307.80846095779;38309.61690383089;38406;3817.179306449099;3843.80841938997;3844.3272427325387;3863;3868.6324799144036;27632;27777.583336249972;27817.860910695315;28044.579331310048;28165.29586760327;3108.4715598348334;3114.065780265911;3146.9055928322186;3155.5484477140544;3256.0882952773263;339127;345834.9999999975;346327;346544.53455465374;348627.2568637166;49209.753951230734;49403.258951115764;49414.50585494171;49455.0108997818;49554.75222623864;51886;52465.2130218047;52485.47514524882;52489;52821;11847.940760296144;14528;14580;14616.707665846623;14622.415103395957;11869.525218991317;11908.225965312227;11933.522659093713;11940.940295298642;11947.880521194676;13329;13467.922566194877;13515.648435156603;13566;13587.388567514485;5918.644881307049;5947.226860508106;5978.850528736816;5986.191864098378;6002.909956350658;954.4273435938381;1082.4479515447179;1107.1198397274186;1115.8047341715167;1125.3922881643985;21489.355319340444;21536.461588460414;24677.259682209562;26505.86747066291;26930.057447989228;1210.6791700199453;1229.4508918762424;1240.1071228715311;1283.6020833541631;1284.088297308921;11400.486978086006;12710.237385756884;13031.739365212832;13061.869381306065;13867.237301948287;468824;471989;472203.1949201297;472329;472903;54472.72763636236;54702.72648636811;54732.452675473534;54837;54876;1353.6006877971022;1429.6711756295902;1430.5708287513705;1434.8780353669847;1437.3747419872388;24701.25896223116;25631.97472101095;25719.485610287316;25761.355966100997;25782.61326080073;31001.37997240088;40414.79792601018;40636.79681601573;40722.59277407306;40870;359336.20331898174;432071;432281;432728;432922;32255.677443225268;32315;32582.51126233061;32614;32704.34591308208;44082;44340.778296108314;44464;44468.11063778771;45062;30005.69994300029;32745.672543275214;34481.96554103381;34756.47865281972;36581.45127823138;34335.14162145966;35966.640333597374;36046.459303111;36815.63184368122;36930.815345923096;35652;36092;36397.0900727484;36434;37581.81209093937;24368.87815560911;31136.688633114285;32942.67057329396;33142.17144571405;33229.16927076843;24341.878290608434;24410.389740256636;24731.50536989286;24758.009679612613;25259.368515787253 13:37:54 INFO - PROCESS | 1650 | |2;jquery.html;397.8170041780781;399.4128630912561;403.18757703228;409.5004095004095;440.82080434836826;20599.794002059974;20673;21945.231916882913;21998;22116.22593209238;21660.8916955415;21845.67231491529;22185.223517176903;22709.864506774677;22920.77079229207;5985.820425387245;6805.863882722342;6851.486138539604;6871.828204294882;6889.552179108342;5713.800016999406;6095.373252914509;6096.329403765582;6578.111954886077;6692.866142677143;6633.336666333376;6706.765263215789;6707.396334329909;6709.630970296632;6739;6392.680365981706;6638.40254377106;6707.631080290582;6716.731330746813;6740.494462915276;6113.724882380304;6385.818623554611;6473.77341793035;6495.707693153772;6509.739610415578;25934.610980835114;25985.480290394276;26095.478090438275;26138.34654133643;26428.73571264301;3300.9174770630925;3364.49532570114;3372.578427696538;3471.2536804586885;3535.7878527288444;15943.883928125037;16694.33056694333;16866.915665421595;17178.65642687152;17217.82782172175;1961.9705704414446;2032.674772036482;2043.5912817436572;2051.579426217637;2070.12019891547;147853;150710.95734255872;164236;169700;170492.2130840192;18598.977056261763;21591;21901.671474927887;22115.668264976037;22651.773482265296;26570.734292657213;34677.13307167341;34902.476462853076;34921.47617785735;35014.82492587521;10097.747556311004;10299.53652085658;10371.481425928825;10499.950004999439;10590.099841513558;8377.287930525974;8496.362772792065;8532.445391049687;8664.393492455467;8723.869141962876;10161.288709790244;10309.587616495257;10351.63769268087;10465.68602941913;10728.088112510368;4029.49631296088;4214.265047739731;4433.445819272591;4521.796519156645;4522.615577675869;1066.2163309967168;1082.3830416662427;1090.3784842639777;1097.3964319624174;1170.5902933973211;22767.34571898179;23128.76871231266;23489.530209395718;23531.7646823533;23563.764362356498;1096.2435919215716;1105.2318638546133;1145.1411441418936;1157.4097210422744;1165.0795871261778;8849.557522123869;11984.28094314344;12224.1443098984;12327.137100402886;12400.255984640951;701151;705283;711230;712381;728431;147303.52696473114;150714.71069091305;151389.243053784;154198;154524;1039.428314427062;1263.860975292717;1283.666246775845;1286.9742605147844;1301.2387753164317;19241.13414896361;19466.61066778628;19987.93324391293;20501.58996820085;22162.33512994613;63457.730845383754;64771.67614161899;64896.35103648903;65382.346176539526;66323;78132.60933695296;82052;91534;92138.6179207299;93481.5325923366;7463.328300452985;10620.787584248117;10673.306235094695;11900.345480998629;12445.813312800134;12149.878501214875;12303.384830758247;13554.525591604246;13770.724585508435;14403.495877644233;11567.826482602935;11611.593594224161;11993.220440671328;11997.220180688228;12086.75826483483;10359.32664376813;10876.966688164612;11356.807535208683;11977.341246231541;11990.220635658654;9595.664151754934;11702.35637039937;11995.64013079609;12048.819267710816;12173.69565760863;11552.191346605992;12224.694382640506;12270.75458490843;12357.443915024025;12528.812067819172;11397.886021139682;11501.849815018431;11613.941930290295;11692.883071169179;12039.217450865666 13:37:54 INFO - PROCESS | 1650 | |3;mootools.html;1535.2707463954616;1538.2231972853708;1556.004157339303;1583.129278896607;1587.7142114419403;9511.334206605523;9672.951635241832;10469.162467002641;11185.937335953082;11233.932776386251;10517.526711297991;10821.13430925526;10831.891681083187;10839.349639021644;10861.619843305485;2288.21056735426;2330.88345582721;2350.459394339303;2351.4826738117586;2357.776011278934;2288.4278930267433;2299.9195028174017;2325.4070212095894;2325.6046472099783;2325.94185145371;2284.246198754407;2295.701558797354;2305.2738387407912;2308.884555772213;2309.642005489152;2254.5941730488507;2265.784750448705;2273.283915566591;2275.613145765224;2277.5672622201896;2221.1004543160047;2266.1955005972973;2291.6104262275453;2292.6904867842795;2298.092253559851;11100.722481937935;11192.272502287326;11204.383758893258;11214.607488737936;11236.775264494665;5560.666360018412;5646.350669672999;5727.140928860705;5736.971315143398;5745.798897038583;3377.881774137918;3487.232808782064;3576.7853928764357;3676.761010534307;3693.575238847513;1135.9432028398546;1178.5874943769697;1215.2890559022983;1237.962861114168;1244.160191870484;15258.771118433233;15329.923350383177;15403;15437.922810385988;15446.768298475532;4689.247444266535;4695.624350052056;4801.207800712843;4801.663883528189;4907.9263811042865;12419.379031048411;12447.875521244852;12452.75094498105;12495.875041249472;12505.624831255076;4593.770311484413;5565.554755619541;5571.832845014656;5573.386927437979;5587.776488940478;4220.303649897733;4410.25025745624;4686.390769199982;5038.899222015539;5232.319798426256;3073.431415188197;3597.61491825649;3890.630390112935;3958;4030.6372426481757;1110.9111271098293;1114.1031469666834;1116.9329840209614;1122.3165252121817;1130.4573804573852;884.7788052986754;908.318760929303;912.926965842731;935.0186756375663;941.5715849288557;6425.97184450495;6545.934540654628;6598.86802263952;6676.031975363545;6720.764773232913;958.4249450329746;991.0881988570533;998.825205589019;1000.0249756487513;1024.934068568695;3423.4693622488553;3977.5028121484816;4159.396887451303;4232.724872883253;4359.128174365076;13224.47102115924;13522.93238533801;13665.453381864812;13667.111637743516;13691.452341906212;13199;13236.13965092266;13587.1847689137;13588.864111358958;13592.184468931895;9180.8883956689;9309.906900930904;9317.90682093184;9343.95328023369;9610.375325603953;6425.485961123192;6629.602223866584;6711.832204194739;6870.20992585859;6875.48433867452;10879.673609791718;11700.590479333183;12045.09661775388;12088.15382923222;12183.086268530073;11941.283522988648;12226.938865305616;12417.19288246261;12484;12563.18339307942;8042.195780421911;8257.21556452136;9084.682036128705;9263.212626926786;10084;10053.396796192252;10155.238357123393;10376.16990640762;10413.739656508647;10485.580576776843;8993.595288211915;9042;9245.768855778659;9387.061293870558;9526.095020972996;8832.072632373509;9035.186833184782;9047.909520904706;9057.36598438103;9114.77213069652;7766.417518686008;7820.491668041559;7824.100228473799;7918.129005809472;7920.801979950547;5885.205497257815;5886.499647529837;5948.315943666534;6033.42682445167;6056.66688332146;5808.796692115756;5903.793367232126;5954.166416701752;6118.755249789959;6130.754769809336 13:37:54 INFO - PROCESS | 1650 | |4;prototype.html;341.1437292396085;360.58172519876933;381.3783532841468;382.5657878308119;388.5356998386928;5116.718580478072;5245.606579506533;5258.684478931267;5371.489708477693;5376.758045887935;4905.669806841748;5065.86018145917;5083.745812709368;5212.76542555585;5234.476552344764;3989.601039896016;4014.735358362121;4494.4831344395325;4571.634269258451;4599.458417018894;3823.350030494809;4010.4786377770993;4378.277584198603;4574.405327307445;4577.702449340799;3826.330392181357;3879.612038796126;4158.9186811428945;4220.915581688364;4272.038791271954;4063.451434056394;4319.69762116652;4324.675649326282;4341.956580434203;4370.847020354272;3450.8447119879415;3772.943575798781;3874.302625527404;4048.332025215836;4064.5732198119363;4195.370694395834;4393.472783265996;5104.846854594368;5157.690538567698;5185.662931909414;4505.932411013838;4965.453800081988;4982.725950072744;5005.248163142907;5027.673201241908;5206.76569554371;5459.054595535925;5646.164996376153;5649.802256921029;5657.2928383952;4053.5541090480024;4137.420761093449;4214.789260536992;4367.890802729926;4453.977730111361;4433.379326894237;5259.921101183485;5285.973570132163;5836.153757705109;5970.34326224115;4074.735142215806;4209.2633789086785;4426.358178064227;4534.410526631516;4539.84110556129;3826.885193444201;4129.2773764591075;4514.803577052084;4616.630669546428;4661.228733081407;3893.435451859521;4209.5790420957655;4592.287312334389;4739.36964984437;5004.774785134678;5148.975698432842;5412.323459567554;5630.606992028372;5645.576581756302;5658.773649053992;1368.9178649280875;1486.754685476906;1572.1667516216423;1590.872730181606;1600.7514138971621;904.5929331800716;1080.708208783624;1176.7764124816258;1204.6566728482517;1220.273937007497;4651.186042442627;4773.0669079023055;5212.765425555859;5275.393329767126;5318.654287471302;5370.2213179089595;5470.085470085438;5852.297724273029;5857.272104729115;5868.801503180776;4958.933829226734;5274;5340.679559226459;5345.652532585447;5353.804939974591;2878.424315136981;2882.8702708378173;2883.870225839842;2933.9706602934125;3024.3819556537146;5313;5433.510984011458;5767.88464230713;5898.76404943806;6060.818175454743;4868.805247790048;5655.773769049192;5942.376050514634;5983.1623572699855;6068.027890935464;5355.678659280377;5675.545956323402;6016.578839481282;6085.695715214221;6095.420935011167;4809.687370320918;4973.651844371004;5599.556272892223;5776.101131736145;5947.345791962967;5373.140297552372;5383.515483606494;5626;5794.580327819711;5805.622634528742;5432.967736130123;5450.345958484849;5465.672059676433;5818.912716309174;5988.431099045583;3818.19817838246;3889.7326245953536;4536.682432229844;4559.931601025921;4653.906921861611;5304.575633949197;5605.70166231843;5833;5848.883022339444;5876.647401155944;5581.413951535193;5590.422129836827;5601.719914004365;5661.915071274017;5722.599418040863;4699.624030077517;4905.435874874435;5642.520385767256;5655.406182350958;5658.236138121301;4954.108260513142;5099.974500127476;5198.361147196902;5392;5448.918266226089;4854.5873600744335;4944.73909153178;5230.259216359733;5339.893202136013;5538.86152846166;4562.680612357103;4829.782659780389;5475.370332411823;5519.254900588369;5525.11598144311 13:37:54 INFO - PROCESS | 1650 | |5;yui.html;634.6065439427556;718.367836304053;742.6557930146436;809.6720828064632;822.2928281677758;15160.317785699643;15682.686346273067;16299.918500407512;16312.429064982727;16339;12538.749225015517;15146.318415671294;15358.232088395564;15383.38466461343;15531.456399026009;926.434874726418;943.3160958305208;943.7687766497218;945.007741871036;947.4552132523792;921.2031592672357;934.2152591822868;936.9109934556207;937.3813283233068;963.8265112279787;1003.9548220330066;1012.25093430861;1016.5527168046073;1016.6238491758023;1016.761061150629;1006.3810756384844;1009.4347165587258;1009.5457044330044;1011.6964910526887;1014.1683819268203;752.834376437183;752.9947520060725;752.998511979072;754.2871985973258;755.9357454616364;15847.52457426279;16241.756373654405;16246.18769061554;16773.077480738553;17086.40197593091;14523.273836308248;14671.193084380355;14693.523111781038;14752.63118422048;14778.630534236623;11593.304401735923;11669.474873630706;11712.472938717778;11942;11978.880211197864;3625.401808701561;3655.3785856404475;3727.5154229949935;3728.81355932205;3735.570409402926;103342;106849.46575267075;106897.46551267272;107839.46080269627;107985;10783.245172837984;11221.768978211057;11296.71758206035;11326.490307936163;11551.711207219887;23407.648885266735;24059.879700601385;24318.905649245826;24603.3849153769;24611.892464839126;7645.235476452311;7699.576523291273;7749.3413059890545;7805.765827025199;7836.333911617462;3317.3862835375535;4228.9154216915485;4261.631827376963;4316.019395836552;4351.8476853309985;3331.700146986783;3349.866005359807;3351.614564325134;3415.0608582639975;3422.691957723817;548.0325630984784;552.0449622153697;560.0674876330863;562.8424041268452;564.2918137737114;616.3928530397554;648.7349668147132;649.4155260265704;653.7973228299243;668.4125202643721;7737.767866964;8121.431499794958;9366.953165234267;9546.140847323773;9889.456079915673;605.2283338743138;619.87492700748;624.9250089989231;651.3519048546726;653.2683394597985;4519.389882365905;4618.67669263155;4639.744814035261;4682.765861706901;4728.976355118202;89887;96776.51611741896;105342;106438;108689.45655271673;74165;90916.54541727381;91947.5402622996;92148.07851921528;92585.14829703368;74772.62613686897;75246.11884702927;75408;76089.61955190188;76157.85763213556;9008.684696035607;10185.9490702546;10560.260781745204;10784.676459706221;11133;41545;44413.77793111014;45082.098358032;46544.53455465537;47057.05885882195;48298;68094.63810723659;68666.31333686599;68670.65664671645;69498.65250673714;13499.32503374847;13557.525486607921;13680;13898.652533686334;14257.215853128178;14105.858941410455;14180.50368237148;14406.063605865585;14422.783658244925;14785.852141478877;13287.402066907205;13338.698220148954;13484.662883427993;13551.322433878464;13743;13510.662233444242;13559.322033898068;13596.86403135956;13754.243516606282;13835.654108647364;11111.777764444827;13036.283004434847;13053.412596433373;13377.933110334387;13647.385867635781;10147.036031576989;10742.892571074502;10790.244682872124;11257.71855703614;11294.322340659586;6763.154605674291;8381.832363352822;9192.58633361487;10554.525046373084;11379.317240965569 13:37:54 INFO - PROCESS | 1650 | __end_tp_report 13:37:54 INFO - PROCESS | 1650 | __start_cc_report 13:37:54 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,434 13:37:54 INFO - PROCESS | 1650 | __end_cc_report 13:37:54 INFO - PROCESS | 1650 | __startTimestamp1489181874978__endTimestamp 13:37:54 INFO - PROCESS | 1650 | 13:37:54 INFO - PROCESS | 1650 | ------- Summary: start ------- 13:37:54 INFO - PROCESS | 1650 | Number of tests: 6 13:37:54 INFO - PROCESS | 1650 | 13:37:54 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5789.19 Median:6104.57 stddev:679.40 (11.1%) stddev-sans-first:652.63 13:37:54 INFO - PROCESS | 1650 | Values: 3291.9 3394.5 3407.1 3437.1 3462.3 5306.5 5685.2 5796.4 5860.2 5890.3 5740.0 5744.5 5796.9 5820.4 5836.7 5198.7 5203.4 5337.5 5357.2 5401.6 4424.3 5253.1 5323.0 5382.7 5385.2 4346.3 5201.8 5250.2 5342.0 5346.9 5277.0 5280.6 5285.2 5327.4 5346.3 4268.0 5209.2 5211.8 5282.7 5293.5 5572.2 5577.5 5607.2 5723.2 5725.8 6199.9 6215.2 6234.9 6248.5 6248.7 6350.0 6365.9 6367.4 6372.8 6451.3 6028.1 6037.6 6044.5 6059.1 6079.0 6149.4 6290.3 6382.5 6409.1 6422.7 6107.7 6166.9 6221.2 6224.6 6275.8 6198.7 6217.3 6259.5 6269.2 6269.3 6221.4 6252.6 6272.2 6276.0 6302.8 6148.9 6167.8 6184.6 6199.8 6265.6 5118.9 5124.5 5126.1 5164.8 5165.9 3750.1 4520.8 4523.8 4529.7 4554.7 5460.8 5819.9 5926.2 5971.5 6112.0 4812.0 5160.4 6211.2 6241.2 6292.6 6104.6 6116.4 6117.9 6118.9 6134.6 5133.5 5506.6 5590.4 5614.7 5644.4 6288.2 6353.2 6419.1 6442.7 6562.3 6330.1 6332.1 6339.0 6344.3 6359.0 5432.4 6507.1 6547.1 6548.8 6569.2 5651.0 5901.3 5910.9 6118.1 6131.8 6270.0 6302.1 6314.2 6317.6 6327.5 6108.3 6138.3 6159.8 6203.5 6226.6 6154.8 6161.5 6176.9 6208.0 6230.4 5941.8 6001.2 6028.3 6039.3 6057.3 6023.7 6130.9 6132.8 6135.1 6195.8 6103.1 6168.3 6168.8 6169.6 6195.1 13:37:54 INFO - PROCESS | 1650 | 13:37:54 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:55056.77 Median:33185.67 stddev:110073.81 (331.7%) stddev-sans-first:110307.01 13:37:54 INFO - PROCESS | 1650 | Values: 726.9 777.6 801.8 919.7 930.5 37274.6 38137.8 39266.2 39721.4 39734.6 37966.8 38161.7 38214.8 38265.8 38269.2 7638.3 7791.8 10851.3 11144.4 11269.0 9319.6 10812.5 10887.6 11012.8 11071.4 10918.5 10945.4 11026.5 11031.5 11040.4 9078.4 10914.3 10952.3 10978.1 10985.3 9072.7 9086.4 10719.5 10767.1 10774.4 30451.7 37877.8 38307.8 38309.6 38406.0 3817.2 3843.8 3844.3 3863.0 3868.6 27632.0 27777.6 27817.9 28044.6 28165.3 3108.5 3114.1 3146.9 3155.5 3256.1 339127.0 345835.0 346327.0 346544.5 348627.3 49209.8 49403.3 49414.5 49455.0 49554.8 51886.0 52465.2 52485.5 52489.0 52821.0 11847.9 14528.0 14580.0 14616.7 14622.4 11869.5 11908.2 11933.5 11940.9 11947.9 13329.0 13467.9 13515.6 13566.0 13587.4 5918.6 5947.2 5978.9 5986.2 6002.9 954.4 1082.4 1107.1 1115.8 1125.4 21489.4 21536.5 24677.3 26505.9 26930.1 1210.7 1229.5 1240.1 1283.6 1284.1 11400.5 12710.2 13031.7 13061.9 13867.2 468824.0 471989.0 472203.2 472329.0 472903.0 54472.7 54702.7 54732.5 54837.0 54876.0 1353.6 1429.7 1430.6 1434.9 1437.4 24701.3 25632.0 25719.5 25761.4 25782.6 31001.4 40414.8 40636.8 40722.6 40870.0 359336.2 432071.0 432281.0 432728.0 432922.0 32255.7 32315.0 32582.5 32614.0 32704.3 44082.0 44340.8 44464.0 44468.1 45062.0 30005.7 32745.7 34482.0 34756.5 36581.5 34335.1 35966.6 36046.5 36815.6 36930.8 35652.0 36092.0 36397.1 36434.0 37581.8 24368.9 31136.7 32942.7 33142.2 33229.2 24341.9 24410.4 24731.5 24758.0 25259.4 13:37:54 INFO - PROCESS | 1650 | 13:37:54 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:42519.59 Median:21753.28 stddev:119169.21 (547.8%) stddev-sans-first:119461.54 13:37:54 INFO - PROCESS | 1650 | Values: 397.8 399.4 403.2 409.5 440.8 20599.8 20673.0 21945.2 21998.0 22116.2 21660.9 21845.7 22185.2 22709.9 22920.8 5985.8 6805.9 6851.5 6871.8 6889.6 5713.8 6095.4 6096.3 6578.1 6692.9 6633.3 6706.8 6707.4 6709.6 6739.0 6392.7 6638.4 6707.6 6716.7 6740.5 6113.7 6385.8 6473.8 6495.7 6509.7 25934.6 25985.5 26095.5 26138.3 26428.7 3300.9 3364.5 3372.6 3471.3 3535.8 15943.9 16694.3 16866.9 17178.7 17217.8 1962.0 2032.7 2043.6 2051.6 2070.1 147853.0 150711.0 164236.0 169700.0 170492.2 18599.0 21591.0 21901.7 22115.7 22651.8 26570.7 34677.1 34902.5 34921.5 35014.8 10097.7 10299.5 10371.5 10500.0 10590.1 8377.3 8496.4 8532.4 8664.4 8723.9 10161.3 10309.6 10351.6 10465.7 10728.1 4029.5 4214.3 4433.4 4521.8 4522.6 1066.2 1082.4 1090.4 1097.4 1170.6 22767.3 23128.8 23489.5 23531.8 23563.8 1096.2 1105.2 1145.1 1157.4 1165.1 8849.6 11984.3 12224.1 12327.1 12400.3 701151.0 705283.0 711230.0 712381.0 728431.0 147303.5 150714.7 151389.2 154198.0 154524.0 1039.4 1263.9 1283.7 1287.0 1301.2 19241.1 19466.6 19987.9 20501.6 22162.3 63457.7 64771.7 64896.4 65382.3 66323.0 78132.6 82052.0 91534.0 92138.6 93481.5 7463.3 10620.8 10673.3 11900.3 12445.8 12149.9 12303.4 13554.5 13770.7 14403.5 11567.8 11611.6 11993.2 11997.2 12086.8 10359.3 10877.0 11356.8 11977.3 11990.2 9595.7 11702.4 11995.6 12048.8 12173.7 11552.2 12224.7 12270.8 12357.4 12528.8 11397.9 11501.8 11613.9 11692.9 12039.2 13:37:54 INFO - PROCESS | 1650 | 13:37:54 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:6678.04 Median:2715.60 stddev:4219.03 (155.4%) stddev-sans-first:4213.17 13:37:54 INFO - PROCESS | 1650 | Values: 1535.3 1538.2 1556.0 1583.1 1587.7 9511.3 9673.0 10469.2 11185.9 11233.9 10517.5 10821.1 10831.9 10839.3 10861.6 2288.2 2330.9 2350.5 2351.5 2357.8 2288.4 2299.9 2325.4 2325.6 2325.9 2284.2 2295.7 2305.3 2308.9 2309.6 2254.6 2265.8 2273.3 2275.6 2277.6 2221.1 2266.2 2291.6 2292.7 2298.1 11100.7 11192.3 11204.4 11214.6 11236.8 5560.7 5646.4 5727.1 5737.0 5745.8 3377.9 3487.2 3576.8 3676.8 3693.6 1135.9 1178.6 1215.3 1238.0 1244.2 15258.8 15329.9 15403.0 15437.9 15446.8 4689.2 4695.6 4801.2 4801.7 4907.9 12419.4 12447.9 12452.8 12495.9 12505.6 4593.8 5565.6 5571.8 5573.4 5587.8 4220.3 4410.3 4686.4 5038.9 5232.3 3073.4 3597.6 3890.6 3958.0 4030.6 1110.9 1114.1 1116.9 1122.3 1130.5 884.8 908.3 912.9 935.0 941.6 6426.0 6545.9 6598.9 6676.0 6720.8 958.4 991.1 998.8 1000.0 1024.9 3423.5 3977.5 4159.4 4232.7 4359.1 13224.5 13522.9 13665.5 13667.1 13691.5 13199.0 13236.1 13587.2 13588.9 13592.2 9180.9 9309.9 9317.9 9344.0 9610.4 6425.5 6629.6 6711.8 6870.2 6875.5 10879.7 11700.6 12045.1 12088.2 12183.1 11941.3 12226.9 12417.2 12484.0 12563.2 8042.2 8257.2 9084.7 9263.2 10084.0 10053.4 10155.2 10376.2 10413.7 10485.6 8993.6 9042.0 9245.8 9387.1 9526.1 8832.1 9035.2 9047.9 9057.4 9114.8 7766.4 7820.5 7824.1 7918.1 7920.8 5885.2 5886.5 5948.3 6033.4 6056.7 5808.8 5903.8 5954.2 6118.8 6130.8 13:37:54 INFO - PROCESS | 1650 | 13:37:55 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4639.64 Median:5046.77 stddev:1313.33 (26.0%) stddev-sans-first:1276.77 13:37:55 INFO - PROCESS | 1650 | Values: 341.1 360.6 381.4 382.6 388.5 5116.7 5245.6 5258.7 5371.5 5376.8 4905.7 5065.9 5083.7 5212.8 5234.5 3989.6 4014.7 4494.5 4571.6 4599.5 3823.4 4010.5 4378.3 4574.4 4577.7 3826.3 3879.6 4158.9 4220.9 4272.0 4063.5 4319.7 4324.7 4342.0 4370.8 3450.8 3772.9 3874.3 4048.3 4064.6 4195.4 4393.5 5104.8 5157.7 5185.7 4505.9 4965.5 4982.7 5005.2 5027.7 5206.8 5459.1 5646.2 5649.8 5657.3 4053.6 4137.4 4214.8 4367.9 4454.0 4433.4 5259.9 5286.0 5836.2 5970.3 4074.7 4209.3 4426.4 4534.4 4539.8 3826.9 4129.3 4514.8 4616.6 4661.2 3893.4 4209.6 4592.3 4739.4 5004.8 5149.0 5412.3 5630.6 5645.6 5658.8 1368.9 1486.8 1572.2 1590.9 1600.8 904.6 1080.7 1176.8 1204.7 1220.3 4651.2 4773.1 5212.8 5275.4 5318.7 5370.2 5470.1 5852.3 5857.3 5868.8 4958.9 5274.0 5340.7 5345.7 5353.8 2878.4 2882.9 2883.9 2934.0 3024.4 5313.0 5433.5 5767.9 5898.8 6060.8 4868.8 5655.8 5942.4 5983.2 6068.0 5355.7 5675.5 6016.6 6085.7 6095.4 4809.7 4973.7 5599.6 5776.1 5947.3 5373.1 5383.5 5626.0 5794.6 5805.6 5433.0 5450.3 5465.7 5818.9 5988.4 3818.2 3889.7 4536.7 4559.9 4653.9 5304.6 5605.7 5833.0 5848.9 5876.6 5581.4 5590.4 5601.7 5661.9 5722.6 4699.6 4905.4 5642.5 5655.4 5658.2 4954.1 5100.0 5198.4 5392.0 5448.9 4854.6 4944.7 5230.3 5339.9 5538.9 4562.7 4829.8 5475.4 5519.3 5525.1 13:37:55 INFO - PROCESS | 1650 | 13:37:55 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:20245.87 Median:3340.78 stddev:28967.63 (867.1%) stddev-sans-first:29011.46 13:37:55 INFO - PROCESS | 1650 | Values: 634.6 718.4 742.7 809.7 822.3 15160.3 15682.7 16299.9 16312.4 16339.0 12538.7 15146.3 15358.2 15383.4 15531.5 926.4 943.3 943.8 945.0 947.5 921.2 934.2 936.9 937.4 963.8 1004.0 1012.3 1016.6 1016.6 1016.8 1006.4 1009.4 1009.5 1011.7 1014.2 752.8 753.0 753.0 754.3 755.9 15847.5 16241.8 16246.2 16773.1 17086.4 14523.3 14671.2 14693.5 14752.6 14778.6 11593.3 11669.5 11712.5 11942.0 11978.9 3625.4 3655.4 3727.5 3728.8 3735.6 103342.0 106849.5 106897.5 107839.5 107985.0 10783.2 11221.8 11296.7 11326.5 11551.7 23407.6 24059.9 24318.9 24603.4 24611.9 7645.2 7699.6 7749.3 7805.8 7836.3 3317.4 4228.9 4261.6 4316.0 4351.8 3331.7 3349.9 3351.6 3415.1 3422.7 548.0 552.0 560.1 562.8 564.3 616.4 648.7 649.4 653.8 668.4 7737.8 8121.4 9367.0 9546.1 9889.5 605.2 619.9 624.9 651.4 653.3 4519.4 4618.7 4639.7 4682.8 4729.0 89887.0 96776.5 105342.0 106438.0 108689.5 74165.0 90916.5 91947.5 92148.1 92585.1 74772.6 75246.1 75408.0 76089.6 76157.9 9008.7 10185.9 10560.3 10784.7 11133.0 41545.0 44413.8 45082.1 46544.5 47057.1 48298.0 68094.6 68666.3 68670.7 69498.7 13499.3 13557.5 13680.0 13898.7 14257.2 14105.9 14180.5 14406.1 14422.8 14785.9 13287.4 13338.7 13484.7 13551.3 13743.0 13510.7 13559.3 13596.9 13754.2 13835.7 11111.8 13036.3 13053.4 13377.9 13647.4 10147.0 10742.9 10790.2 11257.7 11294.3 6763.2 8381.8 9192.6 10554.5 11379.3 13:37:55 INFO - PROCESS | 1650 | -------- Summary: end -------- 13:37:55 INFO - PROCESS | 1650 | 13:37:55 INFO - TEST-INFO | 1650: exit 0 13:37:55 INFO - TEST-OK | dromaeo_css | took 1117754ms 13:37:55 INFO - TEST-START | kraken 13:37:55 INFO - operating with platform_type : mac_ 13:37:55 INFO - Initialising browser for kraken test... 13:37:55 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpXVFcD9/profile http://localhost:49240/getInfo.html) 13:37:58 INFO - PROCESS | 1660 | 2017-03-10 13:37:58.293 plugin-container[1662:12504] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3b, name = 'com.apple.tsm.portname' 13:37:58 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:37:58 INFO - PROCESS | 1660 | 2017-03-10 13:37:58.294 plugin-container[1662:12504] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 13:37:58 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:37:58 INFO - PROCESS | 1660 | 2017-03-10 13:37:58.294 plugin-container[1662:12504] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:37:58 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 13:37:58 INFO - PROCESS | 1660 | colorDepth:24 13:37:58 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 13:37:58 INFO - PROCESS | 1660 | __metrics 13:37:58 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 13:37:59 INFO - TEST-INFO | 1660: exit 0 13:37:59 INFO - Browser initialized. 13:37:59 INFO - Running cycle 1/1 for kraken test... 13:37:59 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpXVFcD9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:38:01 INFO - PROCESS | 1663 | 2017-03-10 13:38:01.606 plugin-container[1664:12639] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4b, name = 'com.apple.tsm.portname' 13:38:01 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:38:01 INFO - PROCESS | 1663 | 2017-03-10 13:38:01.607 plugin-container[1664:12639] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 13:38:01 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:38:01 INFO - PROCESS | 1663 | 2017-03-10 13:38:01.607 plugin-container[1664:12639] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:38:11 INFO - PROCESS | 1663 | RSS: Main: 227622912 13:38:11 INFO - PROCESS | 1663 | 13:38:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 13:38:15 INFO - PROCESS | 1663 | RSS: Main: 241754112 13:38:15 INFO - PROCESS | 1663 | 13:38:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 13:38:18 INFO - PROCESS | 1663 | RSS: Main: 250236928 13:38:18 INFO - PROCESS | 1663 | 13:38:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 13:38:22 INFO - PROCESS | 1663 | RSS: Main: 252678144 13:38:22 INFO - PROCESS | 1663 | 13:38:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 13:38:24 INFO - PROCESS | 1663 | RSS: Main: 255275008 13:38:24 INFO - PROCESS | 1663 | 13:38:26 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:38:27 INFO - PROCESS | 1663 | RSS: Main: 255893504 13:38:27 INFO - PROCESS | 1663 | 13:38:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 13:38:30 INFO - PROCESS | 1663 | RSS: Main: 261701632 13:38:30 INFO - PROCESS | 1663 | 13:38:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 13:38:34 INFO - PROCESS | 1663 | RSS: Main: 262840320 13:38:34 INFO - PROCESS | 1663 | 13:38:37 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 13:38:38 INFO - PROCESS | 1663 | RSS: Main: 262438912 13:38:38 INFO - PROCESS | 1663 | 13:38:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:38:40 INFO - PROCESS | 1663 | RSS: Main: 261537792 13:38:40 INFO - PROCESS | 1663 | 13:38:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:38:43 INFO - PROCESS | 1663 | RSS: Main: 261582848 13:38:43 INFO - PROCESS | 1663 | 13:38:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:38:46 INFO - PROCESS | 1663 | RSS: Main: 261672960 13:38:46 INFO - PROCESS | 1663 | 13:38:49 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:38:49 INFO - PROCESS | 1663 | RSS: Main: 261931008 13:38:49 INFO - PROCESS | 1663 | 13:38:52 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:38:53 INFO - PROCESS | 1663 | RSS: Main: 262012928 13:38:53 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 13:38:55 INFO - PROCESS | 1663 | RSS: Main: 264065024 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | __start_tp_report 13:38:55 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 13:38:55 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 13:38:55 INFO - PROCESS | 1663 | |i|pagename|runs| 13:38:55 INFO - PROCESS | 1663 | |0;ai-astar;118;180;121;121;121;117;117;122;122;120 13:38:55 INFO - PROCESS | 1663 | |1;audio-beat-detection;143;113;112;149;113;114;118;115;135;117 13:38:55 INFO - PROCESS | 1663 | |2;audio-dft;228;276;209;212;220;201;196;203;200;195 13:38:55 INFO - PROCESS | 1663 | |3;audio-fft;83;60;69;89;63;60;63;61;75;58 13:38:55 INFO - PROCESS | 1663 | |4;audio-oscillator;80;71;85;74;70;72;83;77;87;83 13:38:55 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;89;95;89;88;91;89;91;99;136;89 13:38:55 INFO - PROCESS | 1663 | |6;imaging-darkroom;97;97;106;151;97;102;98;96;97;96 13:38:55 INFO - PROCESS | 1663 | |7;imaging-desaturate;91;95;93;91;92;99;148;93;136;129 13:38:55 INFO - PROCESS | 1663 | |8;json-parse-financial;66;67;68;68;69;67;67;66;66;68 13:38:55 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;64;57;63;74;88;85;59;61;58;58 13:38:55 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;107;110;108;86;87;88;88;90;86;90 13:38:55 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;139;151;139;141;151;144;154;162;194;157 13:38:55 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;176;177;177;216;178;174;179;175;175;172 13:38:55 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;71;68;67;66;69;67;65;66;67;67 13:38:55 INFO - PROCESS | 1663 | __end_tp_report 13:38:55 INFO - PROCESS | 1663 | __start_cc_report 13:38:55 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1002 13:38:55 INFO - PROCESS | 1663 | __end_cc_report 13:38:55 INFO - PROCESS | 1663 | __startTimestamp1489181935437__endTimestamp 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | ------- Summary: start ------- 13:38:55 INFO - PROCESS | 1663 | Number of tests: 14 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:125.90 Median:121.00 stddev:19.10 (15.8%) stddev-sans-first:20.05 13:38:55 INFO - PROCESS | 1663 | Values: 118.0 180.0 121.0 121.0 121.0 117.0 117.0 122.0 122.0 120.0 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:117.50 stddev:13.93 (11.9%) stddev-sans-first:12.74 13:38:55 INFO - PROCESS | 1663 | Values: 143.0 113.0 112.0 149.0 113.0 114.0 118.0 115.0 135.0 117.0 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:214.00 Median:210.50 stddev:24.21 (11.5%) stddev-sans-first:25.15 13:38:55 INFO - PROCESS | 1663 | Values: 228.0 276.0 209.0 212.0 220.0 201.0 196.0 203.0 200.0 195.0 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:68.10 Median:66.00 stddev:10.76 (16.3%) stddev-sans-first:9.98 13:38:55 INFO - PROCESS | 1663 | Values: 83.0 60.0 69.0 89.0 63.0 60.0 63.0 61.0 75.0 58.0 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:81.50 stddev:6.23 (7.6%) stddev-sans-first:6.58 13:38:55 INFO - PROCESS | 1663 | Values: 80.0 71.0 85.0 74.0 70.0 72.0 83.0 77.0 87.0 83.0 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:90.00 stddev:14.60 (16.2%) stddev-sans-first:15.29 13:38:55 INFO - PROCESS | 1663 | Values: 89.0 95.0 89.0 88.0 91.0 89.0 91.0 99.0 136.0 89.0 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:103.70 Median:97.00 stddev:16.92 (17.4%) stddev-sans-first:17.77 13:38:55 INFO - PROCESS | 1663 | Values: 97.0 97.0 106.0 151.0 97.0 102.0 98.0 96.0 97.0 96.0 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:106.70 Median:92.50 stddev:21.96 (23.7%) stddev-sans-first:22.55 13:38:55 INFO - PROCESS | 1663 | Values: 91.0 95.0 93.0 91.0 92.0 99.0 148.0 93.0 136.0 129.0 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:67.50 stddev:1.03 (1.5%) stddev-sans-first:1.00 13:38:55 INFO - PROCESS | 1663 | Values: 66.0 67.0 68.0 68.0 69.0 67.0 67.0 66.0 66.0 68.0 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:63.50 stddev:11.55 (18.2%) stddev-sans-first:12.21 13:38:55 INFO - PROCESS | 1663 | Values: 64.0 57.0 63.0 74.0 88.0 85.0 59.0 61.0 58.0 58.0 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:94.00 Median:87.50 stddev:10.01 (11.4%) stddev-sans-first:9.45 13:38:55 INFO - PROCESS | 1663 | Values: 107.0 110.0 108.0 86.0 87.0 88.0 88.0 90.0 86.0 90.0 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:153.20 Median:152.50 stddev:16.34 (10.7%) stddev-sans-first:16.51 13:38:55 INFO - PROCESS | 1663 | Values: 139.0 151.0 139.0 141.0 151.0 144.0 154.0 162.0 194.0 157.0 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.90 Median:177.00 stddev:12.84 (7.3%) stddev-sans-first:13.55 13:38:55 INFO - PROCESS | 1663 | Values: 176.0 177.0 177.0 216.0 178.0 174.0 179.0 175.0 175.0 172.0 13:38:55 INFO - PROCESS | 1663 | 13:38:55 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.70 (2.5%) stddev-sans-first:1.17 13:38:55 INFO - PROCESS | 1663 | Values: 71.0 68.0 67.0 66.0 69.0 67.0 65.0 66.0 67.0 67.0 13:38:55 INFO - PROCESS | 1663 | -------- Summary: end -------- 13:38:55 INFO - PROCESS | 1663 | 13:38:56 INFO - TEST-INFO | 1663: exit 0 13:38:56 INFO - TEST-OK | kraken | took 60691ms 13:38:56 INFO - SUITE-END | took 1178s 13:38:56 INFO - Completed test suite (00:19:38) 13:38:56 INFO - javascript benchmark 13:38:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7699.971025087623, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3291.934161316772, 3394.473856552234, 3407.08008837614, 3437.0719905625488, 3462.3421549905515, 5306.4958828911285, 5685.232493613361, 5796.362400135981, 5860.179574859518, 5890.263717035371, 5739.971300143504, 5744.454276843703, 5796.942030579693, 5820.447057529528, 5836.737346819393, 5198.662086964335, 5203.4016088149965, 5337.492938170887, 5357.196420536911, 5401.621886467949, 4424.269995450747, 5253.106971814782, 5322.9620224056325, 5382.730863456812, 5385.192221166837, 4346.282863327548, 5201.843944681666, 5250.159974404077, 5341.973290133544, 5346.893062138735, 5277.02375060615, 5280.551153151987, 5285.180796976475, 5327.387350454708, 5346.304980352568, 4267.957320426818, 5209.19257515082, 5211.843644690665, 5282.735863206824, 5293.523582877521, 5572.247746554244, 5577.470140336662, 5607.186957891083, 5723.227364305807, 5725.770969161229, 6199.87600247997, 6215.192025036761, 6234.937650623481, 6248.531360147962, 6248.656323902183, 6349.9682501587195, 6365.936340636581, 6367.395097465734, 6372.776952806676, 6451.322611125858, 6028.09578563219, 6037.607555508878, 6044.516438684895, 6059.091136329498, 6078.969605152034, 6149.385061493815, 6290.308066112815, 6382.521310901608, 6409.102725618417, 6422.710978006001, 6107.674343494518, 6166.876662466726, 6221.222347206599, 6224.564280500412, 6275.780347687901, 6198.72105755233, 6217.347178546278, 6259.499240060784, 6269.153664255267, 6269.310375858652, 6221.3778622138325, 6252.5935814171935, 6272.2159730033745, 6275.96862015687, 6302.779402720883, 6148.893199224182, 6167.753289868355, 6184.628922264678, 6199.783007594712, 6265.592736472115, 5118.897622047538, 5124.538791508782, 5126.102931986962, 5164.767585458589, 5165.870853228699, 3750.1187221003042, 4520.81916723334, 4523.819047238139, 4529.68292219548, 4554.681172317973, 5460.754266058037, 5819.88360232793, 5926.199963005025, 5971.462568368867, 6111.991521399008, 4811.9518804812205, 5160.40655324635, 6211.223597050369, 6241.157443745127, 6292.622442653455, 6104.572679912363, 6116.396640261158, 6117.857853872152, 6118.877622447526, 6134.601250918765, 5133.537981581676, 5506.587005974568, 5590.385057643656, 5614.747336369873, 5644.3508996465935, 6288.213973253435, 6353.174087368612, 6419.069234960998, 6442.710078046593, 6562.278149403657, 6330.082138089859, 6332.145160403286, 6339.0, 6344.333844946399, 6359.014352775327, 5432.402435732145, 6507.121538592419, 6547.050677651809, 6548.8035358939305, 6569.211694596679, 5651.0, 5901.3213480450295, 5910.911336329872, 6118.071005858243, 6131.835460087213, 6270.028145637433, 6302.086197501245, 6314.179156709598, 6317.5893566918, 6327.525435592257, 6108.297545782292, 6138.32709113608, 6159.753609855556, 6203.472704820141, 6226.59527130735, 6154.753809847556, 6161.537884658758, 6176.857281402955, 6207.96896015517, 6230.408111229426, 5941.821745347646, 6001.159837622824, 6028.276606807036, 6039.275286965592, 6057.303410107717, 6023.698815059317, 6130.856783744145, 6132.783850801352, 6135.110179431545, 6195.752169913153, 6103.05402662588, 6168.321484636596, 6168.845778855564, 6169.598976066542, 6195.070739389128], "value": 5746.157562302913, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.9091363579553, 777.6111944027986, 801.755464583302, 919.6643225222796, 930.5161316115616, 37274.627253727485, 38137.809310953475, 39266.214675706506, 39721.40417893734, 39734.60265397345, 37966.81016594913, 38161.664341748045, 38214.8089259554, 38265.80867095668, 38269.234615307745, 7638.319569694672, 7791.805204869867, 10851.348919064842, 11144.442777861115, 11269.0, 9319.627214911396, 10812.513436895359, 10887.618933337335, 11012.834807477895, 11071.446427678624, 10918.454077296103, 10945.398003109825, 11026.503807328649, 11031.503582338813, 11040.447977601129, 9078.409903356262, 10914.290571112851, 10952.288101273432, 10978.066864316543, 10985.285956412847, 9072.7278181654, 9086.363954523185, 10719.517621707042, 10767.084797792197, 10774.353538787698, 30451.695483045107, 37877.81061094705, 38307.80846095779, 38309.61690383089, 38406.0, 3817.179306449099, 3843.80841938997, 3844.3272427325387, 3863.0, 3868.6324799144036, 27632.0, 27777.583336249972, 27817.860910695315, 28044.579331310048, 28165.29586760327, 3108.4715598348334, 3114.065780265911, 3146.9055928322186, 3155.5484477140544, 3256.0882952773263, 339127.0, 345834.9999999975, 346327.0, 346544.53455465374, 348627.2568637166, 49209.753951230734, 49403.258951115764, 49414.50585494171, 49455.0108997818, 49554.75222623864, 51886.0, 52465.2130218047, 52485.47514524882, 52489.0, 52821.0, 11847.940760296144, 14528.0, 14580.0, 14616.707665846623, 14622.415103395957, 11869.525218991317, 11908.225965312227, 11933.522659093713, 11940.940295298642, 11947.880521194676, 13329.0, 13467.922566194877, 13515.648435156603, 13566.0, 13587.388567514485, 5918.644881307049, 5947.226860508106, 5978.850528736816, 5986.191864098378, 6002.909956350658, 954.4273435938381, 1082.4479515447179, 1107.1198397274186, 1115.8047341715167, 1125.3922881643985, 21489.355319340444, 21536.461588460414, 24677.259682209562, 26505.86747066291, 26930.057447989228, 1210.6791700199453, 1229.4508918762424, 1240.1071228715311, 1283.6020833541631, 1284.088297308921, 11400.486978086006, 12710.237385756884, 13031.739365212832, 13061.869381306065, 13867.237301948287, 468824.0, 471989.0, 472203.1949201297, 472329.0, 472903.0, 54472.72763636236, 54702.72648636811, 54732.452675473534, 54837.0, 54876.0, 1353.6006877971022, 1429.6711756295902, 1430.5708287513705, 1434.8780353669847, 1437.3747419872388, 24701.25896223116, 25631.97472101095, 25719.485610287316, 25761.355966100997, 25782.61326080073, 31001.37997240088, 40414.79792601018, 40636.79681601573, 40722.59277407306, 40870.0, 359336.20331898174, 432071.0, 432281.0, 432728.0, 432922.0, 32255.677443225268, 32315.0, 32582.51126233061, 32614.0, 32704.34591308208, 44082.0, 44340.778296108314, 44464.0, 44468.11063778771, 45062.0, 30005.69994300029, 32745.672543275214, 34481.96554103381, 34756.47865281972, 36581.45127823138, 34335.14162145966, 35966.640333597374, 36046.459303111, 36815.63184368122, 36930.815345923096, 35652.0, 36092.0, 36397.0900727484, 36434.0, 37581.81209093937, 24368.87815560911, 31136.688633114285, 32942.67057329396, 33142.17144571405, 33229.16927076843, 24341.878290608434, 24410.389740256636, 24731.50536989286, 24758.009679612613, 25259.368515787253], "value": 18765.4271336009, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.8170041780781, 399.4128630912561, 403.18757703228, 409.5004095004095, 440.82080434836826, 20599.794002059974, 20673.0, 21945.231916882913, 21998.0, 22116.22593209238, 21660.8916955415, 21845.67231491529, 22185.223517176903, 22709.864506774677, 22920.77079229207, 5985.820425387245, 6805.863882722342, 6851.486138539604, 6871.828204294882, 6889.552179108342, 5713.800016999406, 6095.373252914509, 6096.329403765582, 6578.111954886077, 6692.866142677143, 6633.336666333376, 6706.765263215789, 6707.396334329909, 6709.630970296632, 6739.0, 6392.680365981706, 6638.40254377106, 6707.631080290582, 6716.731330746813, 6740.494462915276, 6113.724882380304, 6385.818623554611, 6473.77341793035, 6495.707693153772, 6509.739610415578, 25934.610980835114, 25985.480290394276, 26095.478090438275, 26138.34654133643, 26428.73571264301, 3300.9174770630925, 3364.49532570114, 3372.578427696538, 3471.2536804586885, 3535.7878527288444, 15943.883928125037, 16694.33056694333, 16866.915665421595, 17178.65642687152, 17217.82782172175, 1961.9705704414446, 2032.674772036482, 2043.5912817436572, 2051.579426217637, 2070.12019891547, 147853.0, 150710.95734255872, 164236.0, 169700.0, 170492.2130840192, 18598.977056261763, 21591.0, 21901.671474927887, 22115.668264976037, 22651.773482265296, 26570.734292657213, 34677.13307167341, 34902.476462853076, 34921.47617785735, 35014.82492587521, 10097.747556311004, 10299.53652085658, 10371.481425928825, 10499.950004999439, 10590.099841513558, 8377.287930525974, 8496.362772792065, 8532.445391049687, 8664.393492455467, 8723.869141962876, 10161.288709790244, 10309.587616495257, 10351.63769268087, 10465.68602941913, 10728.088112510368, 4029.49631296088, 4214.265047739731, 4433.445819272591, 4521.796519156645, 4522.615577675869, 1066.2163309967168, 1082.3830416662427, 1090.3784842639777, 1097.3964319624174, 1170.5902933973211, 22767.34571898179, 23128.76871231266, 23489.530209395718, 23531.7646823533, 23563.764362356498, 1096.2435919215716, 1105.2318638546133, 1145.1411441418936, 1157.4097210422744, 1165.0795871261778, 8849.557522123869, 11984.28094314344, 12224.1443098984, 12327.137100402886, 12400.255984640951, 701151.0, 705283.0, 711230.0, 712381.0, 728431.0, 147303.52696473114, 150714.71069091305, 151389.243053784, 154198.0, 154524.0, 1039.428314427062, 1263.860975292717, 1283.666246775845, 1286.9742605147844, 1301.2387753164317, 19241.13414896361, 19466.61066778628, 19987.93324391293, 20501.58996820085, 22162.33512994613, 63457.730845383754, 64771.67614161899, 64896.35103648903, 65382.346176539526, 66323.0, 78132.60933695296, 82052.0, 91534.0, 92138.6179207299, 93481.5325923366, 7463.328300452985, 10620.787584248117, 10673.306235094695, 11900.345480998629, 12445.813312800134, 12149.878501214875, 12303.384830758247, 13554.525591604246, 13770.724585508435, 14403.495877644233, 11567.826482602935, 11611.593594224161, 11993.220440671328, 11997.220180688228, 12086.75826483483, 10359.32664376813, 10876.966688164612, 11356.807535208683, 11977.341246231541, 11990.220635658654, 9595.664151754934, 11702.35637039937, 11995.64013079609, 12048.819267710816, 12173.69565760863, 11552.191346605992, 12224.694382640506, 12270.75458490843, 12357.443915024025, 12528.812067819172, 11397.886021139682, 11501.849815018431, 11613.941930290295, 11692.883071169179, 12039.217450865666], "value": 11894.068688382018, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1535.2707463954616, 1538.2231972853708, 1556.004157339303, 1583.129278896607, 1587.7142114419403, 9511.334206605523, 9672.951635241832, 10469.162467002641, 11185.937335953082, 11233.932776386251, 10517.526711297991, 10821.13430925526, 10831.891681083187, 10839.349639021644, 10861.619843305485, 2288.21056735426, 2330.88345582721, 2350.459394339303, 2351.4826738117586, 2357.776011278934, 2288.4278930267433, 2299.9195028174017, 2325.4070212095894, 2325.6046472099783, 2325.94185145371, 2284.246198754407, 2295.701558797354, 2305.2738387407912, 2308.884555772213, 2309.642005489152, 2254.5941730488507, 2265.784750448705, 2273.283915566591, 2275.613145765224, 2277.5672622201896, 2221.1004543160047, 2266.1955005972973, 2291.6104262275453, 2292.6904867842795, 2298.092253559851, 11100.722481937935, 11192.272502287326, 11204.383758893258, 11214.607488737936, 11236.775264494665, 5560.666360018412, 5646.350669672999, 5727.140928860705, 5736.971315143398, 5745.798897038583, 3377.881774137918, 3487.232808782064, 3576.7853928764357, 3676.761010534307, 3693.575238847513, 1135.9432028398546, 1178.5874943769697, 1215.2890559022983, 1237.962861114168, 1244.160191870484, 15258.771118433233, 15329.923350383177, 15403.0, 15437.922810385988, 15446.768298475532, 4689.247444266535, 4695.624350052056, 4801.207800712843, 4801.663883528189, 4907.9263811042865, 12419.379031048411, 12447.875521244852, 12452.75094498105, 12495.875041249472, 12505.624831255076, 4593.770311484413, 5565.554755619541, 5571.832845014656, 5573.386927437979, 5587.776488940478, 4220.303649897733, 4410.25025745624, 4686.390769199982, 5038.899222015539, 5232.319798426256, 3073.431415188197, 3597.61491825649, 3890.630390112935, 3958.0, 4030.6372426481757, 1110.9111271098293, 1114.1031469666834, 1116.9329840209614, 1122.3165252121817, 1130.4573804573852, 884.7788052986754, 908.318760929303, 912.926965842731, 935.0186756375663, 941.5715849288557, 6425.97184450495, 6545.934540654628, 6598.86802263952, 6676.031975363545, 6720.764773232913, 958.4249450329746, 991.0881988570533, 998.825205589019, 1000.0249756487513, 1024.934068568695, 3423.4693622488553, 3977.5028121484816, 4159.396887451303, 4232.724872883253, 4359.128174365076, 13224.47102115924, 13522.93238533801, 13665.453381864812, 13667.111637743516, 13691.452341906212, 13199.0, 13236.13965092266, 13587.1847689137, 13588.864111358958, 13592.184468931895, 9180.8883956689, 9309.906900930904, 9317.90682093184, 9343.95328023369, 9610.375325603953, 6425.485961123192, 6629.602223866584, 6711.832204194739, 6870.20992585859, 6875.48433867452, 10879.673609791718, 11700.590479333183, 12045.09661775388, 12088.15382923222, 12183.086268530073, 11941.283522988648, 12226.938865305616, 12417.19288246261, 12484.0, 12563.18339307942, 8042.195780421911, 8257.21556452136, 9084.682036128705, 9263.212626926786, 10084.0, 10053.396796192252, 10155.238357123393, 10376.16990640762, 10413.739656508647, 10485.580576776843, 8993.595288211915, 9042.0, 9245.768855778659, 9387.061293870558, 9526.095020972996, 8832.072632373509, 9035.186833184782, 9047.909520904706, 9057.36598438103, 9114.77213069652, 7766.417518686008, 7820.491668041559, 7824.100228473799, 7918.129005809472, 7920.801979950547, 5885.205497257815, 5886.499647529837, 5948.315943666534, 6033.42682445167, 6056.66688332146, 5808.796692115756, 5903.793367232126, 5954.166416701752, 6118.755249789959, 6130.754769809336], "value": 5078.839326498349, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.1437292396085, 360.58172519876933, 381.3783532841468, 382.5657878308119, 388.5356998386928, 5116.718580478072, 5245.606579506533, 5258.684478931267, 5371.489708477693, 5376.758045887935, 4905.669806841748, 5065.86018145917, 5083.745812709368, 5212.76542555585, 5234.476552344764, 3989.601039896016, 4014.735358362121, 4494.4831344395325, 4571.634269258451, 4599.458417018894, 3823.350030494809, 4010.4786377770993, 4378.277584198603, 4574.405327307445, 4577.702449340799, 3826.330392181357, 3879.612038796126, 4158.9186811428945, 4220.915581688364, 4272.038791271954, 4063.451434056394, 4319.69762116652, 4324.675649326282, 4341.956580434203, 4370.847020354272, 3450.8447119879415, 3772.943575798781, 3874.302625527404, 4048.332025215836, 4064.5732198119363, 4195.370694395834, 4393.472783265996, 5104.846854594368, 5157.690538567698, 5185.662931909414, 4505.932411013838, 4965.453800081988, 4982.725950072744, 5005.248163142907, 5027.673201241908, 5206.76569554371, 5459.054595535925, 5646.164996376153, 5649.802256921029, 5657.2928383952, 4053.5541090480024, 4137.420761093449, 4214.789260536992, 4367.890802729926, 4453.977730111361, 4433.379326894237, 5259.921101183485, 5285.973570132163, 5836.153757705109, 5970.34326224115, 4074.735142215806, 4209.2633789086785, 4426.358178064227, 4534.410526631516, 4539.84110556129, 3826.885193444201, 4129.2773764591075, 4514.803577052084, 4616.630669546428, 4661.228733081407, 3893.435451859521, 4209.5790420957655, 4592.287312334389, 4739.36964984437, 5004.774785134678, 5148.975698432842, 5412.323459567554, 5630.606992028372, 5645.576581756302, 5658.773649053992, 1368.9178649280875, 1486.754685476906, 1572.1667516216423, 1590.872730181606, 1600.7514138971621, 904.5929331800716, 1080.708208783624, 1176.7764124816258, 1204.6566728482517, 1220.273937007497, 4651.186042442627, 4773.0669079023055, 5212.765425555859, 5275.393329767126, 5318.654287471302, 5370.2213179089595, 5470.085470085438, 5852.297724273029, 5857.272104729115, 5868.801503180776, 4958.933829226734, 5274.0, 5340.679559226459, 5345.652532585447, 5353.804939974591, 2878.424315136981, 2882.8702708378173, 2883.870225839842, 2933.9706602934125, 3024.3819556537146, 5313.0, 5433.510984011458, 5767.88464230713, 5898.76404943806, 6060.818175454743, 4868.805247790048, 5655.773769049192, 5942.376050514634, 5983.1623572699855, 6068.027890935464, 5355.678659280377, 5675.545956323402, 6016.578839481282, 6085.695715214221, 6095.420935011167, 4809.687370320918, 4973.651844371004, 5599.556272892223, 5776.101131736145, 5947.345791962967, 5373.140297552372, 5383.515483606494, 5626.0, 5794.580327819711, 5805.622634528742, 5432.967736130123, 5450.345958484849, 5465.672059676433, 5818.912716309174, 5988.431099045583, 3818.19817838246, 3889.7326245953536, 4536.682432229844, 4559.931601025921, 4653.906921861611, 5304.575633949197, 5605.70166231843, 5833.0, 5848.883022339444, 5876.647401155944, 5581.413951535193, 5590.422129836827, 5601.719914004365, 5661.915071274017, 5722.599418040863, 4699.624030077517, 4905.435874874435, 5642.520385767256, 5655.406182350958, 5658.236138121301, 4954.108260513142, 5099.974500127476, 5198.361147196902, 5392.0, 5448.918266226089, 4854.5873600744335, 4944.73909153178, 5230.259216359733, 5339.893202136013, 5538.86152846166, 4562.680612357103, 4829.782659780389, 5475.370332411823, 5519.254900588369, 5525.11598144311], "value": 4252.506742965362, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.6065439427556, 718.367836304053, 742.6557930146436, 809.6720828064632, 822.2928281677758, 15160.317785699643, 15682.686346273067, 16299.918500407512, 16312.429064982727, 16339.0, 12538.749225015517, 15146.318415671294, 15358.232088395564, 15383.38466461343, 15531.456399026009, 926.434874726418, 943.3160958305208, 943.7687766497218, 945.007741871036, 947.4552132523792, 921.2031592672357, 934.2152591822868, 936.9109934556207, 937.3813283233068, 963.8265112279787, 1003.9548220330066, 1012.25093430861, 1016.5527168046073, 1016.6238491758023, 1016.761061150629, 1006.3810756384844, 1009.4347165587258, 1009.5457044330044, 1011.6964910526887, 1014.1683819268203, 752.834376437183, 752.9947520060725, 752.998511979072, 754.2871985973258, 755.9357454616364, 15847.52457426279, 16241.756373654405, 16246.18769061554, 16773.077480738553, 17086.40197593091, 14523.273836308248, 14671.193084380355, 14693.523111781038, 14752.63118422048, 14778.630534236623, 11593.304401735923, 11669.474873630706, 11712.472938717778, 11942.0, 11978.880211197864, 3625.401808701561, 3655.3785856404475, 3727.5154229949935, 3728.81355932205, 3735.570409402926, 103342.0, 106849.46575267075, 106897.46551267272, 107839.46080269627, 107985.0, 10783.245172837984, 11221.768978211057, 11296.71758206035, 11326.490307936163, 11551.711207219887, 23407.648885266735, 24059.879700601385, 24318.905649245826, 24603.3849153769, 24611.892464839126, 7645.235476452311, 7699.576523291273, 7749.3413059890545, 7805.765827025199, 7836.333911617462, 3317.3862835375535, 4228.9154216915485, 4261.631827376963, 4316.019395836552, 4351.8476853309985, 3331.700146986783, 3349.866005359807, 3351.614564325134, 3415.0608582639975, 3422.691957723817, 548.0325630984784, 552.0449622153697, 560.0674876330863, 562.8424041268452, 564.2918137737114, 616.3928530397554, 648.7349668147132, 649.4155260265704, 653.7973228299243, 668.4125202643721, 7737.767866964, 8121.431499794958, 9366.953165234267, 9546.140847323773, 9889.456079915673, 605.2283338743138, 619.87492700748, 624.9250089989231, 651.3519048546726, 653.2683394597985, 4519.389882365905, 4618.67669263155, 4639.744814035261, 4682.765861706901, 4728.976355118202, 89887.0, 96776.51611741896, 105342.0, 106438.0, 108689.45655271673, 74165.0, 90916.54541727381, 91947.5402622996, 92148.07851921528, 92585.14829703368, 74772.62613686897, 75246.11884702927, 75408.0, 76089.61955190188, 76157.85763213556, 9008.684696035607, 10185.9490702546, 10560.260781745204, 10784.676459706221, 11133.0, 41545.0, 44413.77793111014, 45082.098358032, 46544.53455465537, 47057.05885882195, 48298.0, 68094.63810723659, 68666.31333686599, 68670.65664671645, 69498.65250673714, 13499.32503374847, 13557.525486607921, 13680.0, 13898.652533686334, 14257.215853128178, 14105.858941410455, 14180.50368237148, 14406.063605865585, 14422.783658244925, 14785.852141478877, 13287.402066907205, 13338.698220148954, 13484.662883427993, 13551.322433878464, 13743.0, 13510.662233444242, 13559.322033898068, 13596.86403135956, 13754.243516606282, 13835.654108647364, 11111.777764444827, 13036.283004434847, 13053.412596433373, 13377.933110334387, 13647.385867635781, 10147.036031576989, 10742.892571074502, 10790.244682872124, 11257.71855703614, 11294.322340659586, 6763.154605674291, 8381.832363352822, 9192.58633361487, 10554.525046373084, 11379.317240965569], "value": 7523.439935485169, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 180.0, 121.0, 121.0, 121.0, 117.0, 117.0, 122.0, 122.0, 120.0], "value": 125.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 113.0, 112.0, 149.0, 113.0, 114.0, 118.0, 115.0, 135.0, 117.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [228.0, 276.0, 209.0, 212.0, 220.0, 201.0, 196.0, 203.0, 200.0, 195.0], "value": 214.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 69.0, 89.0, 63.0, 60.0, 63.0, 61.0, 75.0, 58.0], "value": 68.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 71.0, 85.0, 74.0, 70.0, 72.0, 83.0, 77.0, 87.0, 83.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 95.0, 89.0, 88.0, 91.0, 89.0, 91.0, 99.0, 136.0, 89.0], "value": 95.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 106.0, 151.0, 97.0, 102.0, 98.0, 96.0, 97.0, 96.0], "value": 103.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 93.0, 91.0, 92.0, 99.0, 148.0, 93.0, 136.0, 129.0], "value": 106.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 68.0, 69.0, 67.0, 67.0, 66.0, 66.0, 68.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 57.0, 63.0, 74.0, 88.0, 85.0, 59.0, 61.0, 58.0, 58.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 108.0, 86.0, 87.0, 88.0, 88.0, 90.0, 86.0, 90.0], "value": 94.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 151.0, 139.0, 141.0, 151.0, 144.0, 154.0, 162.0, 194.0, 157.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 177.0, 216.0, 178.0, 174.0, 179.0, 175.0, 175.0, 172.0], "value": 179.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 67.0, 66.0, 69.0, 67.0, 65.0, 66.0, 67.0, 67.0], "value": 67.3, "unit": "score"}]}]} 13:38:56 INFO - Return code: 0 13:38:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:38:56 ERROR - # TBPL SUCCESS # 13:38:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:38:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:38:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:38:56 INFO - 2017-03-10 13:38:56.767 screenresolution[1668:13031] starting screenresolution argv=screenresolution get 13:38:56 INFO - 2017-03-10 13:38:56.769 screenresolution[1668:13031] Display 0: 1600x1200x32@60 13:38:56 INFO - 2017-03-10 13:38:56.775 screenresolution[1669:13034] starting screenresolution argv=screenresolution list 13:38:56 INFO - Available Modes on Display 0 13:38:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:38:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:38:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:38:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:38:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:38:57 INFO - Intel Iris: 13:38:57 INFO - Chipset Model: Intel Iris 13:38:57 INFO - Type: GPU 13:38:57 INFO - Bus: Built-In 13:38:57 INFO - VRAM (Dynamic, Max): 1536 MB 13:38:57 INFO - Vendor: Intel (0x8086) 13:38:57 INFO - Device ID: 0x0a2e 13:38:57 INFO - Revision ID: 0x0009 13:38:57 INFO - Displays: 13:38:57 INFO - Display: 13:38:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:38:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:38:57 INFO - Display Serial Number: 1600x1200 60 13:38:57 INFO - Main Display: Yes 13:38:57 INFO - Mirror: Off 13:38:57 INFO - Online: Yes 13:38:57 INFO - Rotation: Supported 13:38:57 INFO - Return code: 0 13:38:57 INFO - Running post-action listener: _resource_record_post_action 13:38:57 INFO - [mozharness: 2017-03-10 21:38:57.017510Z] Finished run-tests step (success) 13:38:57 INFO - Running post-run listener: _resource_record_post_run 13:38:57 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 41542144; Write bytes: 519002112; Read time: 382; Write time: 1769 13:38:57 INFO - TinderboxPrint: CPU usage
54.8% 13:38:57 INFO - TinderboxPrint: I/O read bytes / time
41,542,144 / 382 13:38:57 INFO - TinderboxPrint: I/O write bytes / time
519,002,112 / 1,769 13:38:57 INFO - TinderboxPrint: CPU idle
2,168.7 (45.2%) 13:38:57 INFO - TinderboxPrint: CPU system
965.8 (20.1%) 13:38:57 INFO - TinderboxPrint: CPU user
1,663.3 (34.7%) 13:38:57 INFO - TinderboxPrint: Swap in / out
255,266,816 / 0 13:38:57 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205400576; Write bytes: 200880128; Read time: 15633; Write time: 359 13:38:57 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 39567872; Write bytes: 307275776; Read time: 360; Write time: 1375 13:38:57 INFO - Running post-run listener: _upload_blobber_files 13:38:57 INFO - Blob upload gear active. 13:38:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:38:57 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 13:38:57 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'] 13:38:57 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 13:38:57 INFO - (blobuploader) - INFO - Open directory for files ... 13:38:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:38:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:38:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:59 INFO - (blobuploader) - INFO - Done attempting. 13:38:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:38:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:39:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:00 INFO - (blobuploader) - INFO - Done attempting. 13:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:39:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:01 INFO - (blobuploader) - INFO - Done attempting. 13:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:39:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:05 INFO - (blobuploader) - INFO - Done attempting. 13:39:05 INFO - (blobuploader) - INFO - Iteration through files over. 13:39:05 INFO - Return code: 0 13:39:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:39:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:39:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cdcd41ee7e28afe07fc52768d4364da8fce34f0c238c70e9af46e7313f7aa30c04ab36b74afa4a89ce328217d5074a4ed891e89af6b85940583e63d076aaa01", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2187d9fd31cc4e21ff62a60c8e1ba76f6cab2e154fbef5f03997fea761cc56e8f5408759ee424550a948cef9db12cfd7e98b4e1cfbaec7362ab452323861bb24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/692d7adec9a5f7fa04d4ebf366ca7eccd5cd84a549f5f0625309c5ad9422417ad79c37b2eb0c7cc85bccd708507bbffbb5dde0e1b1094613403deb03c5b6de7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/602165e6eda8ce6a220f973aef7710c0f3eb41c5bf853c7714c9a21cb4737e325ca85d4c0bf1277afa077d304c96457b055480282f31e77f1d89038d4c95de33"} 13:39:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:39:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:39:05 INFO - Contents: 13:39:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cdcd41ee7e28afe07fc52768d4364da8fce34f0c238c70e9af46e7313f7aa30c04ab36b74afa4a89ce328217d5074a4ed891e89af6b85940583e63d076aaa01", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2187d9fd31cc4e21ff62a60c8e1ba76f6cab2e154fbef5f03997fea761cc56e8f5408759ee424550a948cef9db12cfd7e98b4e1cfbaec7362ab452323861bb24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/692d7adec9a5f7fa04d4ebf366ca7eccd5cd84a549f5f0625309c5ad9422417ad79c37b2eb0c7cc85bccd708507bbffbb5dde0e1b1094613403deb03c5b6de7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/602165e6eda8ce6a220f973aef7710c0f3eb41c5bf853c7714c9a21cb4737e325ca85d4c0bf1277afa077d304c96457b055480282f31e77f1d89038d4c95de33"} 13:39:05 INFO - Running post-run listener: copy_logs_to_upload_dir 13:39:05 INFO - Copying logs to upload dir... 13:39:05 INFO - mkdir: /builds/slave/test/build/upload/logs 13:39:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.936950 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-03-10 13:39:05.693604) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 13:39:05.696963) ========= 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.BEx0w1mQnm/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.BgMp3PX652/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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/7cdcd41ee7e28afe07fc52768d4364da8fce34f0c238c70e9af46e7313f7aa30c04ab36b74afa4a89ce328217d5074a4ed891e89af6b85940583e63d076aaa01", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2187d9fd31cc4e21ff62a60c8e1ba76f6cab2e154fbef5f03997fea761cc56e8f5408759ee424550a948cef9db12cfd7e98b4e1cfbaec7362ab452323861bb24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/692d7adec9a5f7fa04d4ebf366ca7eccd5cd84a549f5f0625309c5ad9422417ad79c37b2eb0c7cc85bccd708507bbffbb5dde0e1b1094613403deb03c5b6de7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/602165e6eda8ce6a220f973aef7710c0f3eb41c5bf853c7714c9a21cb4737e325ca85d4c0bf1277afa077d304c96457b055480282f31e77f1d89038d4c95de33"} build_url:https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011121 build_url: 'https://queue.taskcluster.net/v1/task/Zac8qNJJSuShl4pgURUcTA/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/7cdcd41ee7e28afe07fc52768d4364da8fce34f0c238c70e9af46e7313f7aa30c04ab36b74afa4a89ce328217d5074a4ed891e89af6b85940583e63d076aaa01", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2187d9fd31cc4e21ff62a60c8e1ba76f6cab2e154fbef5f03997fea761cc56e8f5408759ee424550a948cef9db12cfd7e98b4e1cfbaec7362ab452323861bb24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/692d7adec9a5f7fa04d4ebf366ca7eccd5cd84a549f5f0625309c5ad9422417ad79c37b2eb0c7cc85bccd708507bbffbb5dde0e1b1094613403deb03c5b6de7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/602165e6eda8ce6a220f973aef7710c0f3eb41c5bf853c7714c9a21cb4737e325ca85d4c0bf1277afa077d304c96457b055480282f31e77f1d89038d4c95de33"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 13:39:05.732101) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 13:39:05.732469) ========= 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.BEx0w1mQnm/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.BgMp3PX652/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.005214 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 13:39:05.781483) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 13:39:05.781834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 13:39:05.782185) ========= ========= Total master_lag: 0.19 =========