builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0006 starttime: 1477972391.34 results: success (0) buildid: 20161031183902 builduid: e1aba3addb834af68cb55d7f0f3f494b revision: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:11.343023) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:11.343522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:11.343853) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:11.376394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:11.376801) ========= 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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 --2016-10-31 20:53:11-- 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% 159M=0s 2016-10-31 20:53:11 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.423795 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:11.826573) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:11.826927) ========= 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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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.019250 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:11.875616) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 20:53:11.875998) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda --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 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 2016-10-31 20:53:11,951 truncating revision to first 12 chars 2016-10-31 20:53:11,951 Setting DEBUG logging. 2016-10-31 20:53:11,951 attempt 1/10 2016-10-31 20:53:11,951 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/21153294d3a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 20:53:12,939 unpacking tar archive at: mozilla-central-21153294d3a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.244970 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 20:53:13.147634) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:13.148337) ========= script_repo_revision: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:13.149445) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:13.158801) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:13.177882) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-31 20:53:13.178223) ========= /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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 20:53:13 INFO - MultiFileLogger online at 20161031 20:53:13 in /builds/slave/test 20:53:13 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 20:53:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:53:13 INFO - {'append_to_log': False, 20:53:13 INFO - 'base_work_dir': '/builds/slave/test', 20:53:13 INFO - 'blob_upload_branch': 'Firefox', 20:53:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:53:13 INFO - 'branch': 'Firefox', 20:53:13 INFO - 'buildbot_json_path': 'buildprops.json', 20:53:13 INFO - 'config_files': ('talos/mac_config.py',), 20:53:13 INFO - 'default_actions': ('clobber', 20:53:13 INFO - 'read-buildbot-config', 20:53:13 INFO - 'download-and-extract', 20:53:13 INFO - 'populate-webroot', 20:53:13 INFO - 'create-virtualenv', 20:53:13 INFO - 'install', 20:53:13 INFO - 'run-tests'), 20:53:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:53:13 INFO - 'download_minidump_stackwalk': True, 20:53:13 INFO - 'download_symbols': 'ondemand', 20:53:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:53:13 INFO - 'tooltool.py': '/tools/tooltool.py', 20:53:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:53:13 INFO - '/tools/misc-python/virtualenv.py')}, 20:53:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:53:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:53:13 INFO - 'installer_path': 'installer.exe', 20:53:13 INFO - 'log_level': 'info', 20:53:13 INFO - 'log_name': 'talos', 20:53:13 INFO - 'log_to_console': True, 20:53:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:53:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:53:13 INFO - 'opt_config_files': (), 20:53:13 INFO - 'pip_index': False, 20:53:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:53:13 INFO - 'cmd': ('bash', 20:53:13 INFO - '-c', 20:53:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:53:13 INFO - 'enabled': True, 20:53:13 INFO - 'halt_on_failure': False, 20:53:13 INFO - 'name': 'check_screen_resolution'},), 20:53:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:53:13 INFO - 'cmd': ('bash', 20:53:13 INFO - '-c', 20:53:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:53:13 INFO - 'enabled': True, 20:53:13 INFO - 'halt_on_failure': False, 20:53:13 INFO - 'name': 'check_screen_resolution'},), 20:53:13 INFO - 'run_cmd_checks_enabled': True, 20:53:13 INFO - 'sps_profile': False, 20:53:13 INFO - 'sps_profile_interval': 0, 20:53:13 INFO - 'suite': 'dromaeojs-e10s', 20:53:13 INFO - 'system_bits': '32', 20:53:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:53:13 INFO - 'title': 't-yosemite-r7-0006', 20:53:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:53:13 INFO - 'use_talos_json': True, 20:53:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:53:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:53:13 INFO - 'work_dir': 'build'} 20:53:13 INFO - [mozharness: 2016-11-01 03:53:13.383706Z] Running clobber step. 20:53:13 INFO - Running pre-action listener: _resource_record_pre_action 20:53:13 INFO - Running main action method: clobber 20:53:13 INFO - rmtree: /builds/slave/test/build 20:53:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:53:13 INFO - Running post-action listener: _resource_record_post_action 20:53:13 INFO - [mozharness: 2016-11-01 03:53:13.934349Z] Finished clobber step (success) 20:53:13 INFO - [mozharness: 2016-11-01 03:53:13.934572Z] Running read-buildbot-config step. 20:53:13 INFO - Running pre-action listener: _resource_record_pre_action 20:53:13 INFO - Running main action method: read_buildbot_config 20:53:13 INFO - Using buildbot properties: 20:53:13 INFO - { 20:53:13 INFO - "project": "", 20:53:13 INFO - "product": "firefox", 20:53:13 INFO - "script_repo_revision": "production", 20:53:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 20:53:13 INFO - "repository": "", 20:53:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 20:53:13 INFO - "buildid": "20161031183902", 20:53:13 INFO - "pgo_build": "False", 20:53:13 INFO - "basedir": "/builds/slave/test", 20:53:13 INFO - "buildnumber": 56, 20:53:13 INFO - "slavename": "t-yosemite-r7-0006", 20:53:13 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 20:53:13 INFO - "platform": "yosemite_r7", 20:53:13 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 20:53:13 INFO - "branch": "mozilla-central", 20:53:13 INFO - "repo_path": "mozilla-central", 20:53:13 INFO - "revision": "21153294d3a0bf7ce8e5e6bb1a0e684745b88fda", 20:53:13 INFO - "stage_platform": "macosx64", 20:53:13 INFO - "builduid": "e1aba3addb834af68cb55d7f0f3f494b", 20:53:13 INFO - "slavebuilddir": "test" 20:53:13 INFO - } 20:53:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 20:53:13 INFO - Running post-action listener: _resource_record_post_action 20:53:13 INFO - [mozharness: 2016-11-01 03:53:13.940519Z] Finished read-buildbot-config step (success) 20:53:13 INFO - [mozharness: 2016-11-01 03:53:13.940747Z] Running download-and-extract step. 20:53:13 INFO - Running pre-action listener: _resource_record_pre_action 20:53:13 INFO - Running main action method: download_and_extract 20:53:13 INFO - mkdir: /builds/slave/test/build/tests 20:53:13 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')]} 20:53:13 INFO - trying https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 20:53:13 INFO - Downloading https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 20:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 20:53:15 INFO - Downloaded 1199 bytes. 20:53:15 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 20:53:15 INFO - Using the following test package requirements: 20:53:15 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:53:15 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:15 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 20:53:15 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:15 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 20:53:15 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:15 INFO - u'jsshell-mac.zip'], 20:53:15 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:15 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 20:53:15 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:53:15 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:15 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 20:53:15 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:15 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 20:53:15 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:15 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 20:53:15 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:15 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 20:53:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:53:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:53:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:53:15 INFO - Fetch https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:53:15 INFO - Http code: 200 20:53:15 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 20:53:15 INFO - x-amz-cf-id: sYVYa8WKbUNnyrKyqaUcgFjYoOsENIZFyMG34g4Tazm-q8uRRyTzhA== 20:53:15 INFO - x-amz-version-id: ZakPg9bg3gQxnA6hA_eXEqwtl5YNAiUp 20:53:16 INFO - Expected file size: 16404928 20:53:16 INFO - Obtained file size: 16404928 20:53:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:53:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:53:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:53:23 INFO - Fetch https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:53:23 INFO - Http code: 200 20:53:23 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 20:53:23 INFO - x-amz-cf-id: JIh3YimvjKbOQa0zlWdHdMvUnlxrTpXNGja2VFKFalvDV7DyotUisg== 20:53:23 INFO - x-amz-version-id: ZakPg9bg3gQxnA6hA_eXEqwtl5YNAiUp 20:53:23 INFO - Expected file size: 16404928 20:53:23 INFO - Obtained file size: 16404928 20:53:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 20:53:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:53:30 INFO - Fetch https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 20:53:31 INFO - Http code: 200 20:53:31 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 20:53:31 INFO - x-amz-cf-id: XmV1QKjrA5EQqB6zq2i2NbMGqfuKaLV8MY5jc9r20CxAzJCHrjjJEA== 20:53:31 INFO - x-amz-version-id: 1ojoslQHMT0maCU_DdhXThKK4nVW5Ncc 20:53:32 INFO - Expected file size: 14409038 20:53:32 INFO - Obtained file size: 14409038 20:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:32 INFO - trying https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:53:32 INFO - Downloading https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 20:53:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 20:53:35 INFO - Downloaded 112093123 bytes. 20:53:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:53:35 INFO - mkdir: /builds/slave/test/properties 20:53:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:53:35 INFO - Writing to file /builds/slave/test/properties/build_url 20:53:35 INFO - Contents: 20:53:35 INFO - build_url:https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:53:36 INFO - Running post-action listener: _resource_record_post_action 20:53:36 INFO - Running post-action listener: set_extra_try_arguments 20:53:36 INFO - [mozharness: 2016-11-01 03:53:36.497926Z] Finished download-and-extract step (success) 20:53:36 INFO - [mozharness: 2016-11-01 03:53:36.498076Z] Running populate-webroot step. 20:53:36 INFO - Running pre-action listener: _resource_record_pre_action 20:53:36 INFO - Running main action method: populate_webroot 20:53:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:53:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:53:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:53:36 INFO - '--tppagecycles', 20:53:36 INFO - '7'], 20:53:36 INFO - 'tests': ['tsvgm']}}, 20:53:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:53:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:53:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:53:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:53:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:53:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:53:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:36 INFO - 'talos_options': ['--disable-e10s'], 20:53:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:53:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:53:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:36 INFO - 'talos_options': ['--disable-e10s'], 20:53:36 INFO - 'tests': ['damp', 'tps']}, 20:53:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:36 INFO - 'tests': ['damp', 'tps']}, 20:53:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:53:36 INFO - 'tests': ['dromaeo_dom']}, 20:53:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:53:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:53:36 INFO - 'tests': ['basic_compositor_video']}, 20:53:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:53:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:53:36 INFO - 'tests': ['a11yr', 20:53:36 INFO - 'ts_paint', 20:53:36 INFO - 'tpaint', 20:53:36 INFO - 'sessionrestore', 20:53:36 INFO - 'sessionrestore_no_auto_restore', 20:53:36 INFO - 'tabpaint']}, 20:53:36 INFO - 'other-e10s': {'tests': ['a11yr', 20:53:36 INFO - 'ts_paint', 20:53:36 INFO - 'tpaint', 20:53:36 INFO - 'sessionrestore', 20:53:36 INFO - 'sessionrestore_no_auto_restore', 20:53:36 INFO - 'tabpaint']}, 20:53:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:53:36 INFO - 'ts_paint', 20:53:36 INFO - 'tpaint', 20:53:36 INFO - 'sessionrestore', 20:53:36 INFO - 'sessionrestore_no_auto_restore', 20:53:36 INFO - 'tabpaint']}, 20:53:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:53:36 INFO - 'ts_paint', 20:53:36 INFO - 'tpaint', 20:53:36 INFO - 'sessionrestore', 20:53:36 INFO - 'sessionrestore_no_auto_restore', 20:53:36 INFO - 'tabpaint']}, 20:53:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:53:36 INFO - 'tests': ['a11yr', 20:53:36 INFO - 'ts_paint', 20:53:36 INFO - 'tpaint', 20:53:36 INFO - 'sessionrestore', 20:53:36 INFO - 'sessionrestore_no_auto_restore', 20:53:36 INFO - 'tabpaint']}, 20:53:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:53:36 INFO - 'tests': ['a11yr', 20:53:36 INFO - 'ts_paint', 20:53:36 INFO - 'tpaint', 20:53:36 INFO - 'sessionrestore', 20:53:36 INFO - 'sessionrestore_no_auto_restore', 20:53:36 INFO - 'tabpaint']}, 20:53:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:53:36 INFO - 'tests': ['tsvgx', 20:53:36 INFO - 'tsvgr_opacity', 20:53:36 INFO - 'tart', 20:53:36 INFO - 'tscrollx', 20:53:36 INFO - 'cart']}, 20:53:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:53:36 INFO - 'tsvgr_opacity', 20:53:36 INFO - 'tart', 20:53:36 INFO - 'tscrollx', 20:53:36 INFO - 'cart']}, 20:53:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:36 INFO - 'talos_options': ['--disable-e10s'], 20:53:36 INFO - 'tests': ['tp5o']}, 20:53:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:36 INFO - 'tests': ['tp5o']}, 20:53:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:36 INFO - 'talos_options': ['--disable-e10s', 20:53:36 INFO - '--xperf_path', 20:53:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:53:36 INFO - 'tests': ['tp5n']}, 20:53:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:36 INFO - 'talos_options': ['--xperf_path', 20:53:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:53:36 INFO - 'tests': ['tp5n']}}, 20:53:36 INFO - 'talos.zip': {'path': '', 20:53:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:53:36 INFO - Running post-action listener: _resource_record_post_action 20:53:36 INFO - [mozharness: 2016-11-01 03:53:36.516815Z] Finished populate-webroot step (success) 20:53:36 INFO - [mozharness: 2016-11-01 03:53:36.516958Z] Running create-virtualenv step. 20:53:36 INFO - Running pre-action listener: _resource_record_pre_action 20:53:36 INFO - Running main action method: create_virtualenv 20:53:36 INFO - Creating virtualenv /builds/slave/test/build/venv 20:53:36 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 20:53:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:53:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:53:36 INFO - Using real prefix '/tools/python27' 20:53:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:53:37 INFO - Installing distribute.............................................................................................................................................................................................done. 20:53:40 INFO - Installing pip.................done. 20:53:40 INFO - Return code: 0 20:53:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:53:40 INFO - Reading from file tmpfile_stdout 20:53:40 INFO - Output received: 20:53:40 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) 20:53:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:53: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')]} 20:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53: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')]} 20:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103753490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a1cd3840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103567d30>, '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 0x10338ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10355fb20>, '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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 20:53: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', 'pip>=1.5'] in /builds/slave/test/build 20:53: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 pip>=1.5 20:53:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uy8qKlW4Tw/Render', 20:53:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:40 INFO - 'HOME': '/Users/cltbld', 20:53:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:40 INFO - 'LOGNAME': 'cltbld', 20:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:40 INFO - 'MOZ_NO_REMOTE': '1', 20:53:40 INFO - 'NO_EM_RESTART': '1', 20:53:40 INFO - 'PAGER': '/bin/cat', 20:53:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:40 INFO - 'PWD': '/builds/slave/test', 20:53:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:40 INFO - 'SHELL': '/bin/bash', 20:53:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yb3FgZiKkq/Listeners', 20:53:40 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 20:53:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:40 INFO - 'USER': 'cltbld', 20:53:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:40 INFO - 'XPC_FLAGS': '0x0', 20:53:40 INFO - 'XPC_SERVICE_NAME': '0', 20:53:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:40 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 20:53:40 INFO - Cleaning up... 20:53:40 INFO - Return code: 0 20:53:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:53: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')]} 20:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53: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')]} 20:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53: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', '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 0x103753490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a1cd3840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103567d30>, '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 0x10338ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10355fb20>, '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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 20:53: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:53: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 psutil>=3.1.1 20:53:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uy8qKlW4Tw/Render', 20:53:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:40 INFO - 'HOME': '/Users/cltbld', 20:53:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:40 INFO - 'LOGNAME': 'cltbld', 20:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:40 INFO - 'MOZ_NO_REMOTE': '1', 20:53:40 INFO - 'NO_EM_RESTART': '1', 20:53:40 INFO - 'PAGER': '/bin/cat', 20:53:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:40 INFO - 'PWD': '/builds/slave/test', 20:53:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:40 INFO - 'SHELL': '/bin/bash', 20:53:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yb3FgZiKkq/Listeners', 20:53:40 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 20:53:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:40 INFO - 'USER': 'cltbld', 20:53:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:40 INFO - 'XPC_FLAGS': '0x0', 20:53:40 INFO - 'XPC_SERVICE_NAME': '0', 20:53:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:40 INFO - Downloading/unpacking psutil>=3.1.1 20:53: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 20:53: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 20:53: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 20:53: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 20:53: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 20:53: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 20:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:53:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:53:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:53:44 INFO - Installing collected packages: psutil 20:53:44 INFO - Running setup.py install for psutil 20:53:44 INFO - building 'psutil._psutil_osx' extension 20:53:44 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 20:53:45 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 20:53:45 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 20:53:45 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 20:53:45 INFO - building 'psutil._psutil_posix' extension 20:53:45 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 20:53:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:53:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:53:45 INFO - ^ 20:53:45 INFO - 1 warning generated. 20:53:45 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 20:53:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:53:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:53:45 INFO - Successfully installed psutil 20:53:45 INFO - Cleaning up... 20:53:45 INFO - Return code: 0 20:53:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:53:45 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')]} 20:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:45 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')]} 20:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:45 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 0x103753490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a1cd3840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103567d30>, '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 0x10338ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10355fb20>, '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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 20:53:45 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 20:53:45 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 20:53:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uy8qKlW4Tw/Render', 20:53:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:45 INFO - 'HOME': '/Users/cltbld', 20:53:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:45 INFO - 'LOGNAME': 'cltbld', 20:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:45 INFO - 'MOZ_NO_REMOTE': '1', 20:53:45 INFO - 'NO_EM_RESTART': '1', 20:53:45 INFO - 'PAGER': '/bin/cat', 20:53:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:45 INFO - 'PWD': '/builds/slave/test', 20:53:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:45 INFO - 'SHELL': '/bin/bash', 20:53:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yb3FgZiKkq/Listeners', 20:53:45 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 20:53:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:45 INFO - 'USER': 'cltbld', 20:53:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:45 INFO - 'XPC_FLAGS': '0x0', 20:53:45 INFO - 'XPC_SERVICE_NAME': '0', 20:53:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:53:48 INFO - Installing collected packages: mozsystemmonitor 20:53:48 INFO - Running setup.py install for mozsystemmonitor 20:53:48 INFO - Successfully installed mozsystemmonitor 20:53:48 INFO - Cleaning up... 20:53:48 INFO - Return code: 0 20:53:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103753490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a1cd3840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103567d30>, '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 0x10338ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10355fb20>, '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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 20:53:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:53:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uy8qKlW4Tw/Render', 20:53:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:48 INFO - 'HOME': '/Users/cltbld', 20:53:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:48 INFO - 'LOGNAME': 'cltbld', 20:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:48 INFO - 'MOZ_NO_REMOTE': '1', 20:53:48 INFO - 'NO_EM_RESTART': '1', 20:53:48 INFO - 'PAGER': '/bin/cat', 20:53:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:48 INFO - 'PWD': '/builds/slave/test', 20:53:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:48 INFO - 'SHELL': '/bin/bash', 20:53:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yb3FgZiKkq/Listeners', 20:53:48 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 20:53:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:48 INFO - 'USER': 'cltbld', 20:53:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:48 INFO - 'XPC_FLAGS': '0x0', 20:53:48 INFO - 'XPC_SERVICE_NAME': '0', 20:53:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:49 INFO - Downloading/unpacking jsonschema==2.5.1 20:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:53:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:51 INFO - Downloading functools32-3.2.3-2.tar.gz 20:53:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:53:52 INFO - warning: no files found matching '*.txt' 20:53:52 INFO - no previously-included directories found matching 'build' 20:53:52 INFO - no previously-included directories found matching 'dist' 20:53:52 INFO - no previously-included directories found matching '.git*' 20:53:52 INFO - Installing collected packages: jsonschema, functools32 20:53:52 INFO - Running setup.py install for functools32 20:53:52 INFO - warning: no files found matching '*.txt' 20:53:52 INFO - no previously-included directories found matching 'build' 20:53:52 INFO - no previously-included directories found matching 'dist' 20:53:52 INFO - no previously-included directories found matching '.git*' 20:53:52 INFO - Successfully installed jsonschema functools32 20:53:52 INFO - Cleaning up... 20:53:52 INFO - Return code: 0 20:53:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:53:52 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')]} 20:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:52 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')]} 20:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:52 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 0x103753490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a1cd3840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103567d30>, '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 0x10338ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10355fb20>, '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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 20:53:52 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 20:53:52 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 20:53:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uy8qKlW4Tw/Render', 20:53:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:52 INFO - 'HOME': '/Users/cltbld', 20:53:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:52 INFO - 'LOGNAME': 'cltbld', 20:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:52 INFO - 'MOZ_NO_REMOTE': '1', 20:53:52 INFO - 'NO_EM_RESTART': '1', 20:53:52 INFO - 'PAGER': '/bin/cat', 20:53:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:52 INFO - 'PWD': '/builds/slave/test', 20:53:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:52 INFO - 'SHELL': '/bin/bash', 20:53:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yb3FgZiKkq/Listeners', 20:53:52 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 20:53:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:52 INFO - 'USER': 'cltbld', 20:53:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:52 INFO - 'XPC_FLAGS': '0x0', 20:53:52 INFO - 'XPC_SERVICE_NAME': '0', 20:53:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:53:52 INFO - Cleaning up... 20:53:52 INFO - Return code: 0 20:53:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:53:52 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')]} 20:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:52 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')]} 20:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:52 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 0x103753490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a1cd3840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103567d30>, '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 0x10338ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10355fb20>, '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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 20:53:52 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 20:53:52 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 20:53:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uy8qKlW4Tw/Render', 20:53:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:52 INFO - 'HOME': '/Users/cltbld', 20:53:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:52 INFO - 'LOGNAME': 'cltbld', 20:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:52 INFO - 'MOZ_NO_REMOTE': '1', 20:53:52 INFO - 'NO_EM_RESTART': '1', 20:53:52 INFO - 'PAGER': '/bin/cat', 20:53:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:52 INFO - 'PWD': '/builds/slave/test', 20:53:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:52 INFO - 'SHELL': '/bin/bash', 20:53:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yb3FgZiKkq/Listeners', 20:53:52 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 20:53:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:52 INFO - 'USER': 'cltbld', 20:53:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:52 INFO - 'XPC_FLAGS': '0x0', 20:53:52 INFO - 'XPC_SERVICE_NAME': '0', 20:53:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:52 INFO - Downloading/unpacking blobuploader==1.2.4 20:53: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 20:53: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 20:53: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 20:53: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 20:53: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 20:53: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 20:53:55 INFO - Downloading blobuploader-1.2.4.tar.gz 20:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:53:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:53:55 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 20:53:55 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 20:53:55 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 20:53:55 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 20:53:55 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 20:53:55 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 20:53:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:53:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:53:56 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 20:53:56 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 20:53:56 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 20:53:56 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 20:53:56 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 20:53:56 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 20:53:56 INFO - Downloading docopt-0.6.1.tar.gz 20:53:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:53:56 INFO - Installing collected packages: blobuploader, requests, docopt 20:53:56 INFO - Running setup.py install for blobuploader 20:53:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:53:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:53:57 INFO - Running setup.py install for requests 20:53:57 INFO - Running setup.py install for docopt 20:53:57 INFO - Successfully installed blobuploader requests docopt 20:53:57 INFO - Cleaning up... 20:53:57 INFO - Return code: 0 20:53:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:53:57 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')]} 20:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:57 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')]} 20:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:57 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 0x103753490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a1cd3840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103567d30>, '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 0x10338ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10355fb20>, '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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 20:53:57 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 20:53:57 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 20:53:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uy8qKlW4Tw/Render', 20:53:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:57 INFO - 'HOME': '/Users/cltbld', 20:53:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:57 INFO - 'LOGNAME': 'cltbld', 20:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:57 INFO - 'MOZ_NO_REMOTE': '1', 20:53:57 INFO - 'NO_EM_RESTART': '1', 20:53:57 INFO - 'PAGER': '/bin/cat', 20:53:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:57 INFO - 'PWD': '/builds/slave/test', 20:53:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:57 INFO - 'SHELL': '/bin/bash', 20:53:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yb3FgZiKkq/Listeners', 20:53:57 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 20:53:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:57 INFO - 'USER': 'cltbld', 20:53:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:57 INFO - 'XPC_FLAGS': '0x0', 20:53:57 INFO - 'XPC_SERVICE_NAME': '0', 20:53:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:53:57 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-IcggmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:53:58 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-sSUxSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:53:58 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-4I6ywc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:53:58 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-EYuw2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:53:58 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-jGfr70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:53:58 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-3KH0nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:53:58 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-Kxwxq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:53:58 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-rtk342-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:53:58 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-mJXyZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:53:58 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-KwYRnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:53:59 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-GXZ_FW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:53:59 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-qsWqFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:53:59 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-nzpip1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:53:59 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-DbNcZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:53:59 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-NAvVCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:53:59 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-Yhl6wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:53:59 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-VqkS9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:53:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:53:59 INFO - Running setup.py install for manifestparser 20:53:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:53:59 INFO - Running setup.py install for mozcrash 20:54:00 INFO - Running setup.py install for mozdebug 20:54:00 INFO - Running setup.py install for mozdevice 20:54:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:54:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:54:00 INFO - Running setup.py install for mozfile 20:54:00 INFO - Running setup.py install for mozhttpd 20:54:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:54:00 INFO - Running setup.py install for mozinfo 20:54:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:54:00 INFO - Running setup.py install for mozInstall 20:54:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:54:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:54:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:54:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:54:00 INFO - Running setup.py install for mozleak 20:54:01 INFO - Running setup.py install for mozlog 20:54:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:54:01 INFO - Running setup.py install for moznetwork 20:54:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:54:01 INFO - Running setup.py install for mozprocess 20:54:01 INFO - Running setup.py install for mozprofile 20:54:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:54:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:54:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:54:01 INFO - Running setup.py install for mozrunner 20:54:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:54:01 INFO - Running setup.py install for mozscreenshot 20:54:02 INFO - Running setup.py install for moztest 20:54:02 INFO - Running setup.py install for mozversion 20:54:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:54:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:54:02 INFO - Cleaning up... 20:54:02 INFO - Return code: 0 20:54:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:54:02 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')]} 20:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:02 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')]} 20:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:02 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 0x103753490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a1cd3840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103567d30>, '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 0x10338ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10355fb20>, '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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 20:54:02 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 20:54:02 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 20:54:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uy8qKlW4Tw/Render', 20:54:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:54:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:54:02 INFO - 'HOME': '/Users/cltbld', 20:54:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:54:02 INFO - 'LOGNAME': 'cltbld', 20:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:02 INFO - 'MOZ_NO_REMOTE': '1', 20:54:02 INFO - 'NO_EM_RESTART': '1', 20:54:02 INFO - 'PAGER': '/bin/cat', 20:54:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:02 INFO - 'PWD': '/builds/slave/test', 20:54:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:54:02 INFO - 'SHELL': '/bin/bash', 20:54:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yb3FgZiKkq/Listeners', 20:54:02 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 20:54:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:54:02 INFO - 'USER': 'cltbld', 20:54:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:54:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:02 INFO - 'XPC_FLAGS': '0x0', 20:54:02 INFO - 'XPC_SERVICE_NAME': '0', 20:54:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:54:02 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-whle36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:54:02 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)) 20:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:54:02 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-vnOxqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 20:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:54:02 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-2BCiu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:54:02 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)) 20:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:54:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-uZD6hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 20:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:54:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-8LZvlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:54:03 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)) 20:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:54:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-13kSp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:54:03 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)) 20:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:54:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-KbwOEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:54:03 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)) 20:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:54:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-OU4EwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:54:03 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)) 20:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:54:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-3BXKzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:54:03 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)) 20:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:54:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-ZLlvyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:54:03 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)) 20:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:54:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-bPRiHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:54:03 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)) 20:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:54:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-hpzEeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 20:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:54:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-OY8DB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:54:04 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)) 20:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:54:04 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-fCm2Ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 20:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:54:04 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-nSKsnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:54:04 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)) 20:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:54:04 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-B6lYc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 20:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:54:04 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-Dh4OBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:54:04 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)) 20:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:54:04 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)) 20:54:04 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:54:04 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:54:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:54:04 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 20:54:04 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 20:54:04 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 20:54:04 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 20:54:04 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 20:54:04 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 20:54:06 INFO - Downloading blessings-1.6.tar.gz 20:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:54:07 INFO - Installing collected packages: blessings 20:54:07 INFO - Running setup.py install for blessings 20:54:07 INFO - Successfully installed blessings 20:54:07 INFO - Cleaning up... 20:54:07 INFO - Return code: 0 20:54:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:54:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:54:07 INFO - Reading from file tmpfile_stdout 20:54:07 INFO - Current package versions: 20:54:07 INFO - blessings == 1.6 20:54:07 INFO - blobuploader == 1.2.4 20:54:07 INFO - docopt == 0.6.1 20:54:07 INFO - functools32 == 3.2.3-2 20:54:07 INFO - jsonschema == 2.5.1 20:54:07 INFO - manifestparser == 1.1 20:54:07 INFO - mozInstall == 1.12 20:54:07 INFO - mozcrash == 0.17 20:54:07 INFO - mozdebug == 0.1 20:54:07 INFO - mozdevice == 0.48 20:54:07 INFO - mozfile == 1.2 20:54:07 INFO - mozhttpd == 0.7 20:54:07 INFO - mozinfo == 0.9 20:54:07 INFO - mozleak == 0.1 20:54:07 INFO - mozlog == 3.4 20:54:07 INFO - moznetwork == 0.27 20:54:07 INFO - mozprocess == 0.23 20:54:07 INFO - mozprofile == 0.28 20:54:07 INFO - mozrunner == 6.12 20:54:07 INFO - mozscreenshot == 0.1 20:54:07 INFO - mozsystemmonitor == 0.3 20:54:07 INFO - moztest == 0.7 20:54:07 INFO - mozversion == 1.4 20:54:07 INFO - psutil == 3.1.1 20:54:07 INFO - requests == 1.2.3 20:54:07 INFO - wsgiref == 0.1.2 20:54:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103753490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a1cd3840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103567d30>, '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 0x10338ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10355fb20>, '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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 20:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:54:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uy8qKlW4Tw/Render', 20:54:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:54:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:54:07 INFO - 'HOME': '/Users/cltbld', 20:54:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:54:07 INFO - 'LOGNAME': 'cltbld', 20:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:07 INFO - 'MOZ_NO_REMOTE': '1', 20:54:07 INFO - 'NO_EM_RESTART': '1', 20:54:07 INFO - 'PAGER': '/bin/cat', 20:54:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:07 INFO - 'PWD': '/builds/slave/test', 20:54:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:54:07 INFO - 'SHELL': '/bin/bash', 20:54:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yb3FgZiKkq/Listeners', 20:54:07 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 20:54:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:54:07 INFO - 'USER': 'cltbld', 20:54:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:54:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:07 INFO - 'XPC_FLAGS': '0x0', 20:54:07 INFO - 'XPC_SERVICE_NAME': '0', 20:54:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:54:07 INFO - Cleaning up... 20:54:07 INFO - Return code: 0 20:54:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103753490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a1cd3840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103567d30>, '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 0x10338ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10355fb20>, '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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 20:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:54:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uy8qKlW4Tw/Render', 20:54:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:54:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:54:07 INFO - 'HOME': '/Users/cltbld', 20:54:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:54:07 INFO - 'LOGNAME': 'cltbld', 20:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:07 INFO - 'MOZ_NO_REMOTE': '1', 20:54:07 INFO - 'NO_EM_RESTART': '1', 20:54:07 INFO - 'PAGER': '/bin/cat', 20:54:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:07 INFO - 'PWD': '/builds/slave/test', 20:54:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:54:07 INFO - 'SHELL': '/bin/bash', 20:54:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yb3FgZiKkq/Listeners', 20:54:07 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 20:54:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:54:07 INFO - 'USER': 'cltbld', 20:54:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:54:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:07 INFO - 'XPC_FLAGS': '0x0', 20:54:07 INFO - 'XPC_SERVICE_NAME': '0', 20:54:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:54:08 INFO - Cleaning up... 20:54:08 INFO - Return code: 0 20:54:08 INFO - Running post-action listener: _resource_record_post_action 20:54:08 INFO - Running post-action listener: _start_resource_monitoring 20:54:08 INFO - Starting resource monitoring. 20:54:08 INFO - [mozharness: 2016-11-01 03:54:08.152311Z] Finished create-virtualenv step (success) 20:54:08 INFO - [mozharness: 2016-11-01 03:54:08.153410Z] Running install step. 20:54:08 INFO - Running pre-action listener: _resource_record_pre_action 20:54:08 INFO - Running main action method: install 20:54:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:54:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:54:08 INFO - Reading from file tmpfile_stdout 20:54:08 INFO - Detecting whether we're running mozinstall >=1.0... 20:54:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:54:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:54:08 INFO - Reading from file tmpfile_stdout 20:54:08 INFO - Output received: 20:54:08 INFO - Usage: mozinstall [options] installer 20:54:08 INFO - Options: 20:54:08 INFO - -h, --help show this help message and exit 20:54:08 INFO - -d DEST, --destination=DEST 20:54:08 INFO - Directory to install application into. [default: 20:54:08 INFO - "/builds/slave/test"] 20:54:08 INFO - --app=APP Application being installed. [default: firefox] 20:54:08 INFO - mkdir: /builds/slave/test/build/application 20:54:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:54:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:54:43 INFO - Reading from file tmpfile_stdout 20:54:43 INFO - Output received: 20:54:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:54:43 INFO - Running post-action listener: _resource_record_post_action 20:54:43 INFO - [mozharness: 2016-11-01 03:54:43.031748Z] Finished install step (success) 20:54:43 INFO - [mozharness: 2016-11-01 03:54:43.031883Z] Running run-tests step. 20:54:43 INFO - Running pre-action listener: _resource_record_pre_action 20:54:43 INFO - Running main action method: run_tests 20:54:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:54:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:54:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:54:43 INFO - 2016-10-31 20:54:43.046 screenresolution[6424:117622] starting screenresolution argv=screenresolution get 20:54:43 INFO - 2016-10-31 20:54:43.049 screenresolution[6424:117622] Display 0: 1600x1200x32@60 20:54:43 INFO - 2016-10-31 20:54:43.055 screenresolution[6425:117624] starting screenresolution argv=screenresolution list 20:54:43 INFO - Available Modes on Display 0 20:54:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:54:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:54:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:54:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:54:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:54:43 INFO - Intel Iris: 20:54:43 INFO - Chipset Model: Intel Iris 20:54:43 INFO - Type: GPU 20:54:43 INFO - Bus: Built-In 20:54:43 INFO - VRAM (Dynamic, Max): 1536 MB 20:54:43 INFO - Vendor: Intel (0x8086) 20:54:43 INFO - Device ID: 0x0a2e 20:54:43 INFO - Revision ID: 0x0009 20:54:43 INFO - Displays: 20:54:43 INFO - Display: 20:54:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:54:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:54:43 INFO - Display Serial Number: 1600x1200 60 20:54:43 INFO - Main Display: Yes 20:54:43 INFO - Mirror: Off 20:54:43 INFO - Online: Yes 20:54:43 INFO - Rotation: Supported 20:54:43 INFO - Return code: 0 20:54:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:54:43 INFO - Python 2.7.3 20:54:43 INFO - Return code: 0 20:54:43 INFO - grabbing minidump binary from tooltool 20:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:54:43 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 0x103567d30>, '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 0x10338ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10355fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:54:43 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 20:54:43 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 20:54:43 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 20:54:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:54:43 INFO - Return code: 0 20:54:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:54:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:54:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:54:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:54:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:54:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0006', '--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 20:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0006 --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 20:54:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uy8qKlW4Tw/Render', 20:54:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:54:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:54:43 INFO - 'HOME': '/Users/cltbld', 20:54:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:54:43 INFO - 'LOGNAME': 'cltbld', 20:54:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:54:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:43 INFO - 'MOZ_NO_REMOTE': '1', 20:54:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:54:43 INFO - 'NO_EM_RESTART': '1', 20:54:43 INFO - 'PAGER': '/bin/cat', 20:54:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:43 INFO - 'PWD': '/builds/slave/test', 20:54:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:54:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:54:43 INFO - 'SHELL': '/bin/bash', 20:54:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yb3FgZiKkq/Listeners', 20:54:43 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 20:54:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:54:43 INFO - 'USER': 'cltbld', 20:54:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:54:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:43 INFO - 'XPC_FLAGS': '0x0', 20:54:43 INFO - 'XPC_SERVICE_NAME': '0', 20:54:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:54:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0006', '--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 20:54:43 INFO - mozversion application_buildid: 20161031183902 20:54:43 INFO - mozversion application_changeset: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda 20:54:43 INFO - mozversion application_display_name: Nightly 20:54:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:54:43 INFO - mozversion application_name: Firefox 20:54:43 INFO - mozversion application_remotingname: firefox 20:54:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:54:43 INFO - mozversion application_vendor: Mozilla 20:54:43 INFO - mozversion application_version: 52.0a1 20:54:43 INFO - mozversion platform_buildid: 20161031183902 20:54:43 INFO - mozversion platform_changeset: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda 20:54:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:54:43 INFO - mozversion platform_version: 52.0a1 20:54:43 INFO - using testdate: 1477972483 20:54:43 INFO - actual date: 1477972483 20:54:43 INFO - starting webserver on 'localhost:57465' 20:54:43 INFO - SUITE-START | Running 2 tests 20:54:43 INFO - TEST-START | dromaeo_css 20:54:43 INFO - operating with platform_type : mac_ 20:54:43 INFO - Initialising browser for dromaeo_css test... 20:54:43 INFO - TEST-INFO | started process 6435 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmp7Fd475/profile http://localhost:57465/getInfo.html) 20:54:46 INFO - PROCESS | 6435 | 2016-10-31 20:54:46.534 plugin-container[6437:117778] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a43, name = 'com.apple.tsm.portname' 20:54:46 INFO - PROCESS | 6435 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:54:46 INFO - PROCESS | 6435 | 2016-10-31 20:54:46.538 plugin-container[6437:117778] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9223, name = 'com.apple.CFPasteboardClient' 20:54:46 INFO - PROCESS | 6435 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:54:46 INFO - PROCESS | 6435 | 2016-10-31 20:54:46.538 plugin-container[6437:117778] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:54:46 INFO - PROCESS | 6435 | __metrics Screen width/height:1600/1200 20:54:46 INFO - PROCESS | 6435 | colorDepth:24 20:54:46 INFO - PROCESS | 6435 | Browser inner width/height: 1024/689 20:54:46 INFO - PROCESS | 6435 | __metrics 20:54:46 ERROR - PROCESS | 6435 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 20:54:47 INFO - TEST-INFO | 6435: exit 0 20:54:47 INFO - Browser initialized. 20:54:47 INFO - Running cycle 1/1 for dromaeo_css test... 20:54:47 INFO - TEST-INFO | started process 6439 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmp7Fd475/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:54:49 INFO - PROCESS | 6439 | 2016-10-31 20:54:49.731 plugin-container[6440:117900] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 20:54:49 INFO - PROCESS | 6439 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:54:49 INFO - PROCESS | 6439 | 2016-10-31 20:54:49.732 plugin-container[6440:117900] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4413, name = 'com.apple.CFPasteboardClient' 20:54:49 INFO - PROCESS | 6439 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:54:49 INFO - PROCESS | 6439 | 2016-10-31 20:54:49.732 plugin-container[6440:117900] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:54:59 INFO - PROCESS | 6439 | RSS: Main: 238145536 20:54:59 INFO - PROCESS | 6439 | 20:55:48 INFO - PROCESS | 6439 | 1477972548973 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:58:02 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:57465/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57465/tests/dromaeo/cssquery-ext.html) 20:58:04 INFO - PROCESS | 6439 | RSS: Main: 250544128 20:58:04 INFO - PROCESS | 6439 | 21:01:06 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:57465/tests/dromaeo/cssquery-ext.html (next: http://localhost:57465/tests/dromaeo/cssquery-jquery.html) 21:01:06 INFO - PROCESS | 6439 | RSS: Main: 262733824 21:01:06 INFO - PROCESS | 6439 | 21:04:08 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:57465/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57465/tests/dromaeo/cssquery-mootools.html) 21:04:09 INFO - PROCESS | 6439 | RSS: Main: 267010048 21:04:09 INFO - PROCESS | 6439 | 21:07:11 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:57465/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57465/tests/dromaeo/cssquery-prototype.html) 21:07:12 INFO - PROCESS | 6439 | RSS: Main: 265854976 21:07:12 INFO - PROCESS | 6439 | 21:10:14 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:57465/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57465/tests/dromaeo/cssquery-yui.html) 21:10:15 INFO - PROCESS | 6439 | RSS: Main: 270344192 21:10:15 INFO - PROCESS | 6439 | 21:13:18 INFO - PROCESS | 6439 | Cycle 1(1): loaded http://localhost:57465/tests/dromaeo/cssquery-yui.html (next: http://localhost:57465/tests/dromaeo/cssquery-dojo.html) 21:13:18 INFO - PROCESS | 6439 | RSS: Main: 272416768 21:13:18 INFO - PROCESS | 6439 | 21:13:18 INFO - PROCESS | 6439 | __start_tp_report 21:13:18 INFO - PROCESS | 6439 | _x_x_mozilla_page_load 21:13:18 INFO - PROCESS | 6439 | _x_x_mozilla_page_load_details 21:13:18 INFO - PROCESS | 6439 | |i|pagename|runs| 21:13:18 INFO - PROCESS | 6439 | |0;dojo.html;3206.4448742359964;3221.98389008055;3228.660990595987;3264.1186879542515;3274;3846.5576458707255;4361.760103194327;4492.687773677983;4935.692041608976;5066.873328166797;4487.528809475015;5352.277442545255;5436.238926550276;5497.39528651848;5540.307461567304;4931.65478416511;4979.1784355581285;4991.40103187618;5018.121828679985;5083.745812709368;4111.259973204837;5040.319556859832;5097;5135.409427915782;5203.713795741232;4945.554900059012;5103.56619687327;5105.821296254632;5111.642185047048;5143.15138002231;4961.578265847407;5059.747012649353;5081.923771143436;5107.208382700687;5131.589472842164;5033.270175824485;5033.823816166453;5051.090803655341;5066.898662026776;5081.79672813087;5344.1716533936915;5378;5433.755481003325;5557.888842223173;5559.916601250984;5741.942580574183;5888.175655408247;5977.641341519479;6036.849078773066;6095.939040609582;6105;6110.144579758838;6122.265328160604;6138.785142520035;6141.232345956755;5456.91814622781;5629.4652008059575;5643.915341269884;5661.122526008434;5663.801766938137;6134.570580059442;6143.327652471189;6184.381561843779;6201.069839524017;6242;6000.21997140369;6028.057869355549;6033.909491357633;6069.119977603223;6075.99746041907;5197.8045049638795;5957.344692083867;6120.234970628671;6152.138700581922;6154.969225153935;4819.638527110481;5878.353381128072;5885.146653735184;5935.554833387513;6020.729067191987;5984.611000284967;5992.31088424828;6025.246844144482;6033.607815491979;6035.577509574376;4756.857294281177;4760.190767569521;4763.356946812205;4774.236122220428;4798.1123492154065;4262.914741705211;4272.380504826845;4312.892177695583;4338.436003319612;4374.58441448062;4122.907429531177;4886.291487734258;5550.611457198038;5610.719464026783;5622.971885140548;5526.171074338801;6146.784862529879;6178.227721534809;6180.134781130645;6184.226971628546;5389.649672771257;5533.253010843485;5554.361248456398;5604;5625.184348269478;4641.373414589055;5228.660137091153;5283.181106928432;5293;5314.707691077027;5844.181814545882;6139.109829074849;6144.938550614436;6161;6190.7523699051535;4644.883877902945;5168.8449346519665;6080.604760690541;6083.878322433438;6088.756449741961;4932.7286999215385;6212.192414986023;6231.813045608639;6235.3452887446165;6272.8431789203805;5089.592832573311;5599.496045355938;5988.101784732325;6094.421030002142;6098.237720284965;5980.461758441761;5999.340072592098;6079.939200607937;6091.42131497507;6151.446369826737;5807.390224026416;5855.560832937632;5922.111683247375;5976.521878249817;6021.638701677914;5790.565707571865;5935.881282374415;5949.732262048132;5953.1070339449425;5965.940340596539;4458.866234012985;4690.226112691368;5674.858128546819;5678.545716342765;5757.309122905278;5968.045112781934;5983.252093488314;5993.280806303272;5999.280086389661;6011.368806275278;5684.147377893349;5711.114777209539;5730.541556675373;5751.798687045934;5761.107028410603 21:13:18 INFO - PROCESS | 6439 | |1;ext.html;459.5565279505279;465.3368949247322;467.4857656577764;490.8625584836247;520.9270702101707;36663.81668091662;40660.59339406609;42185.94535136623;42416.36375454371;42490.78754606227;40873.7956310218;40918.59081409185;41195.970100747494;41250;41308.96727581812;9353.906460935388;9469.905300947006;9509.429434233969;9590;9591.616335346613;9407.81184376312;9510.857337139949;9523.142917137457;9542.570584323686;9552.092551207625;9407.435553866755;9462.337636365457;9507.95246023769;9515;9570.28222883283;9486.525673716322;9566.234701223886;9572.521373931311;9575.042495750438;9581.95209023954;9366.110219529133;9414.482203478807;9429.90570094297;9511.381760185566;9560.235181185488;38768.80615596932;39068.41397379042;39313.60686393128;39338.80330598329;39397.60602393968;3260.6739326067204;3682.4660424238336;3703.7222208334215;3986.4618276532588;3999.5200575930785;29483;30139.246518837204;30430.087097387113;30737.538936915964;30763.769449222003;3194.1056504178637;3259.7555183361105;3281.819499927503;3298.4062868683627;3329;448313;451292;451378.7431062824;452288.9999999967;452654;48101;57144.142837857464;57591.712041439525;57602.135967960516;57757;51014.234786478235;51954.74022629863;61372.693136534035;61410;61666.691666542276;13248.337583120998;15240;15436.845631543541;15452.613684657974;15595.142267175188;10224.386536807815;11541.942290288494;11757.412129393497;11814.350210738492;12042.277463352051;12893.577090001243;12905.483780648668;13697.657558561115;16200.027998320138;16415.83584164167;4944.728039957837;5176.301199338041;5908.586398952118;6022.939770602326;6091.8477038073515;818.5129847740585;909.4952301472746;958.1185309515263;1002.0981116994617;1010.5957616953131;24197;24376.634350484757;28797.712022879503;29663.85168074189;30582.541261881088;870.9113607990013;927.0405130689704;974.7124598243536;1037.2117190934944;1041.1150522056191;15014.774778378332;15424.922875385551;15671.608209794846;15856.752051728427;15938.840611593736;572857;575592;575868;576377;578826.105869468;55683.72158139183;56259;56275.71862140663;56394.43605563974;56403.71798140983;1156.0866915137115;1307.5488956310057;1310.2662508994993;1332.060897067565;1336.2984433172662;27741.30646733848;28849.711502884704;29606.963756268426;30325.84837075889;30374;47574.28638570494;48466.5153348462;48846.51153488562;48950;49018;548285;548761;550102;552022;552284;32829.70192086531;39650.80174599224;39810;39991.80004099961;40294.79852600718;45283.773581131885;46102.769486152356;46507.767461162475;47120;47566.76216618895;38264.85205443841;38482.230355392174;38799;39448.01379965524;39942.600573993885;38346.80826595961;38472.422913655755;39198.6080139195;39610.40584391179;39835.00412489711;31380;32447.35105297928;37256.25487490181;37518;38029.61970380371;32124.518132227568;33535.79736365978;33567.496487553195;34208.486872696434;34311.31377372389;23566;24900.630465323855;25171.87414062918;25630.743692562835;26065.348366290993 21:13:18 INFO - PROCESS | 6439 | |2;jquery.html;329.897731703172;372.157064249475;375.97368184227116;383.15705448014376;401.9356902895535;17606.647867042666;19575.21699132033;19746.605067898632;20199.293024744118;20408.59182816343;15769.526914192593;19751.60496790067;19902.601947961033;20227.59544809103;20236.39290821274;5609.57928155388;5693.402192769761;5850.824475265749;5874.735636896328;5891.175235467038;4982.950170498285;5803.274590676166;5917.319508256563;6004.5796794224425;6031.638101713889;5616.185653080301;5786.392428794979;5955.225820643311;5956.910646340309;5966.67183304918;5719.885602287952;5788.392218817048;5816.331121920991;5822.09757487588;5826.766929322822;4773.474917759078;4987.251912213161;5055.090083784918;5073.898522029575;5135.4094279158;24837.379065523324;24888.253352399457;24923.127690530746;25082;25115;1931.8454523638216;2194.3746032380695;2205.9448513787124;2257.4469255032623;2468.9524035890477;14458.349374278183;15061.048205914969;15490.070595764177;15562.610934726608;15618.609534761608;1853.7775466944054;1859.525820915658;1952.287415093495;1991.611635731033;2012.6880333548324;79928.60035699785;96017.51991239999;125650.71746412643;126893;127234.36382818119;10942.23404361687;11167.944160279147;11281.661550153509;11419.48612312448;11614.535418583331;14116.153030818185;14251.85748142526;14261.073030253001;14264.500742473963;14293.64265893361;7980.880286795703;8248.793780155544;8266.710665126811;8291.668333266602;8317.542535160503;7930.960345198352;8072.596370181467;8074.515529068275;8232.382571307176;8260.876086858701;4422.800973956179;4467.352233926063;4485.192665320208;4487.618552423015;4585.472670642919;1622.959426014359;1886.2455017992638;1930.8262256396993;1939.5151212196952;1947.2308438167129;824.9133840946735;864.8659457784054;904.6878826804742;920.7375897869209;938.5213541093955;17732.734008989875;20056.69914951277;20641.864697441484;20820.37538873836;20845.89577052105;901.2339511415375;915.1169121797365;921.2537844346101;944.4852555357347;963.2871674960479;10606.522706478227;10925.836112458319;10927.781444371069;10984.780304394028;11008.174386921013;572198;577039;581951;582469;587657;79476;124021.37989310177;128880.42239155165;129184;131428.17160449372;764.2853931573997;955.861400096982;990.4156547636785;992.7518120469882;998.6454808543008;15730.370785168465;17402.303907844052;19042.428727137652;19047.904760476107;19137.138828753017;36637.53449861976;37080.443793343664;45396.773016134706;51292.974140516235;54167.72916135394;64980;78498;79498.80751788612;79880.80178797206;80393;7869;7910.881336780068;7993.800154996172;8039.43723939342;8151.225633564802;10170.338927969658;10277.84583231267;10767.407792571485;12697.682557936125;12837.67905802325;10778.083862871743;10863.511141998788;10899;11069.667909962714;11168.66494005181;9225.400348977295;9518.333716639769;10721.463926803473;10727.671451355538;10913.072388847037;10660.200484963814;10761.89238107609;11147.275427097537;11207.327560346404;11290.379029153475;6779.322067793181;7404.703811847466;7745.419093567893;7848.097468791162;8041;9643.758906027124;10490.05589496949;10726.624568140078;10788.784224315626;10970.725731856768 21:13:18 INFO - PROCESS | 6439 | |3;mootools.html;1464.480109561106;1507.3141720517165;1668.2909763350574;1766.7703198584181;1805.5666640006393;7203.4237261019125;7576.810579735509;7831.960840195791;8081.5555144467035;8575.271101956334;7312.597807120606;7906.2884340409355;8183.468074575148;8194.549299788509;8202.876956845652;2281.2927992322393;2323.6398358254414;2328.52265285616;2330.650402439631;2332.3819187915215;2313.849599776009;2341.2976107167865;2349.9530009399887;2356.363781778927;2363.775441333071;2295.5638428698576;2303.216906251874;2309.2610364683223;2329.3477826208687;2330.6853574767442;2285.908563657452;2291;2291.1522736587403;2305.2853615379286;2308.1575225042907;2313.8264630152808;2314.051238992005;2327.7090363704538;2332.0671731307443;2332.871692056953;8409.915900840975;8422.831543369099;8483.15168483153;8499.74500764978;8501.319894408432;5140.485951404867;5260.210968354739;5266.236395722637;5281.260623512711;5283.920741188886;3340.916477088068;3438.1060924159897;3611.927761444783;3668.633136686337;3677.2829298286847;1037.8153985859733;1055.166418529361;1076.9192310576739;1079.271491743078;1080.173667144635;10841.512131954081;10888.564457421693;10983.176261780318;10991.955764202468;11030.22788404812;3632;4593.127305811885;4670.136024835417;4685.484596694361;4703;9299;9417.529123543796;9441.575129119206;9458.33791634579;9489.810203795885;5219.817306394258;5239.240310155006;5245.895082098336;5247.1866860636665;5257.7896884124975;4294.184105020098;4323.827046918151;4720.858374248778;4772.188727916263;4827.8551643450755;3264.24922267875;3690.040589446763;3746.9625303747157;3804.885853424402;3825.713071519647;1244.6079484962208;1251.7809383357876;1254.9749005019848;1262.3498898067503;1265.316728966348;854.7820305821975;862.3403096631082;872.4329186029132;917.2295271971576;921.5254144115786;5575.804846830422;5682.54539636828;5766.4233576642;5790.276215473066;5983.820485385445;733.7065173930471;869.4609342207746;876.1763941894599;907.5479233226916;913.2374467319862;3395.828439188476;3504.4392897136336;3683.3922402803773;3815.904602384907;3927.19492504036;9879.456629885282;9900.762404699413;9969;10058.698239052841;10344.689659310232;9004.874390701163;9280.396774209656;9966.700998970042;10132.088112069949;10225.335353202017;6276.681896801722;7743.070831500143;7775.494592851446;7968.800779980431;8028.598570071473;5513.283273174462;5539.584531160099;5584.888302234014;5623.297087864017;5872.207252020922;9278.814423711354;9395.530223488662;9429.952850235979;9430.622775089194;9441.811163776823;8900.465972041438;9419.246460283299;9471.621135154517;9512.38169518979;9594.66418675343;6637.900431493435;6842.486813488908;6944.895826562504;7120.60836653989;7260.89108663381;7677.692892284246;8026.1171271158955;8028.237317454832;8041.87937180931;8045;7091.60996145217;7138.214796372498;7190.89213661785;7251.419886408969;7330.853382932418;7011.964940175267;7048.647567621496;7079.858402831812;7210.134783825974;7228.89156662661;6678.766243181465;6697.698603562754;6761.560498567577;6769.830754231184;6780.423663988419;4750.311204875343;4814;4825.396825396825;4875.7074575525585;4895.975520122377;4729.290606409066;4798.616110711205;4826.372571565815;4915.754212289443;4925.1381008324115 21:13:18 INFO - PROCESS | 6439 | |4;prototype.html;290.1918157930165;294.04875228635365;303.1708277860053;303.26155810601176;306.2985762603638;4631.480075142895;5346.973265133669;5525.281713377265;5580.972095139524;5697.8005769798065;5260.631755777097;5329.25390445337;5418.647787893784;5510.3744395403355;5551.694656793875;3628.219932714466;4216.620504154625;4236.331111399813;4264.8507302244425;4275.358696195564;4113.806995971165;4175.206710724968;4178.349551926987;4196.880575309465;4289.892752681192;3836.6547010769027;4165.8755933050215;4177.394277829713;4180.6237438630515;4187.267228235062;3461.705755010827;3736.383496723051;3794.5256842894637;4218.7468751874985;4222.809973551198;3006.2192471963344;3638.326909521747;3644.908877278089;3656.5612126544984;3656.8902932912056;3877.728559000871;4480.5967462928165;4650.023495066041;5121.129408000649;5415.350157981028;3945.487086678742;4529.456465224162;4582.587567118942;4724.83463078794;4753.217543421217;5034.370703662043;5199.610029247784;5715.057015592422;5762.366139724627;5779.393163717833;3207.631122420905;3803.2393521295853;3919.9612102792785;3982.263281292941;3984.621460961233;5022.673526220784;5761.337446193699;6055.819115272524;6084.9351363511205;6122.540809439265;4035.8385664573675;4064.4716186896108;4066.674666026711;4077.554466475823;4077.612626800449;3612.8438899551893;3786.981065094657;3926.8429262829736;4016.4376987221813;4047.219223541691;4696.319033740088;4719.4100737407825;4726.929096063562;4729.196036673774;4802.799300174956;4785.660015195751;5787.652740835563;5829.018133834432;5829.650220986754;5878.588498805043;1137.4312843578211;1164.615676826645;1169.7601991591703;1292.0567985370733;1388.4168649167375;788.7476007677603;803.1366281247682;958.9328746987644;966.1690945786618;967.4050458967685;5449.267251932439;5459.754311055933;5470.288862447856;5473.425290344536;5484.945150548443;5653;5911.7635294587735;5925.970370148121;5953.541382361263;5968.791547127504;4313.784310784448;5213.393303348325;5228.712420816892;5465.808696695596;5481.068218402881;2164.3615133535645;2176.770124879438;2331.405491599631;2553.6807899012624;2608.373990242328;4357.143927624075;5086.643934924594;5094.694318340911;5114.667546609458;5169.043726910533;4692.554207350297;4760.001199244454;4926.482719314492;5081.274414794203;5153.4073581538605;4593.770311484413;4632.374629424984;5132.589392848563;5195.298444808678;5228.738563071831;4106.809025382725;4178.862925703471;4623.676342655982;4625.982283897537;4887.047025829929;4482.394876691736;4515.68390212682;4649.256119020941;4732.881677958078;4750.45610176687;4555.9544404556855;4954.410633857034;5148.845534633967;5200.387879757287;5214.687118772886;3085.071830106184;3403.502458918167;3541.3448512025357;3549.568545546309;3559.394902866467;4674.976625116853;4717.3159891816185;4824.517548245148;4824.587706146926;4950.623700623649;4190.769507677107;4701.694389864648;4734.19518681818;4815.951840481691;4818.807247710052;4523.683342166017;4635.351050852816;4744.576627011952;4756.334113224082;4766.856994290177;4240.469941257343;4355.1725172217175;4360.563943605614;4725.503822098768;4756.669232076189;4735.674011276848;4739.431268247832;4756.738379389167;4761.357216775691;4769.379980602499;4162.458880345535;4193.538710741755;4204.4324016257415;4649.093426781745;4756.381670382828 21:13:18 INFO - PROCESS | 6439 | |5;yui.html;686.7424715731601;751.8984937033499;777.7511196417147;784.1061190243121;807.5760225881412;12432.316222607753;13693.972952028587;14896.478623248175;15007.249637518107;15511.844881551182;11843.940780296087;14078.78881816771;14220.288985550707;14248.21634810085;14269.714605707879;699.2064007351642;817.9304759095484;818.4843548564396;818.4843548564426;820.2781552234055;810.2950433123161;814.4624547798454;815.2092470303796;816.603947085663;819.573821612761;831.3224721851702;846.2045677063571;849.3163003781953;861.8147098373848;861.9827603447927;828.8093738440132;850.2730165708323;854.7051267312767;855.285836326668;855.4857901514316;630.9337519560472;631.5137344244952;637.8469167399791;638.7381173718753;639.0605809460086;12836;12848.293343866084;12863.099583029192;12891.226526408353;13747.175169489763;13436.395362208725;13515.66210844727;13557.170416720806;13687.863121368859;13875.37560809766;11477.713057173554;11608.24546404481;11686.532538698442;11846.348450835201;12052.214936830283;3725.2549490102087;3731.197792474631;3926.018495376156;3957.3866050762176;3957.663598594123;84710;84751.57624211902;86709.56645216733;87409;87537;10416.947915260374;10699.358038517714;11057.447127643585;11097.44512774358;11210.27133236337;20898;21448.24931127403;21625.026873790717;21645.458863528536;21901.561968760536;7677.961610192025;7754.224577542201;7757.844843103219;7854;7949.761507154794;4187.5184353799095;4213.094184750294;4232.4286221360335;4319.805608747614;4321.643641516145;3450.189205536697;3548.30807992439;3555.982220088883;3678.31951089044;3857.3828187489867;680.8604236131581;692.3630260160664;703.7712743358327;709.5671640299413;715.4312321704258;552.9162840832014;586.9823905282848;602.5270162922085;614.9902634821032;643.3649878188273;9045.547722613843;9815.165710914509;9817.361871478332;10034;10157.847632285522;525.4062908912904;613.965468186099;617.8723829012071;621.65498148528;625.5527297981873;4149.688773342012;4153.460050193456;4162.41726158338;4278.229918614679;4453.0648563801315;107412;109850.45074774735;113314.86685133043;113691.4315428434;114574.28138577928;95590.52204738931;96636.51681741686;100265.99734002713;101099;101897;74068;87101;88314.55842720874;89916.75208119849;90273;8052.5571093590415;8199.139090395423;8860.3797734158;8930.776730581787;9031.593578288861;52415.73792131015;52442.68893277698;52809.73595132;54479.45520544903;55535.72232138814;52635.15776947788;58269;59495.81008379895;62501.06248406187;68010.65994669995;11398.430078495876;11489.368084755419;11512.481938312629;11522.13583981188;11546.538138474367;10931.96146366094;11964.282143071443;12087.637370878536;12464.563740269046;12551.560695375983;11743.471543780379;12112.091593130726;12127.029837613147;13069.215847048827;13077.084604078003;12732.363381830686;12901.419436125585;13026.60369699298;13280.867191327963;13502.982345712127;12394.504219831106;12422.813657794959;12588.433520491417;12720.300383478627;13128.474861005452;8188.385871059575;10625.521851516545;10771.19216058783;10782.730431738955;10879;9150;9446.763830904283;9961.900380996387;10870.92091018398;11075.042200625448 21:13:18 INFO - PROCESS | 6439 | __end_tp_report 21:13:18 INFO - PROCESS | 6439 | __start_cc_report 21:13:18 INFO - PROCESS | 6439 | _x_x_mozilla_cycle_collect,368 21:13:18 INFO - PROCESS | 6439 | __end_cc_report 21:13:18 INFO - PROCESS | 6439 | __startTimestamp1477973598598__endTimestamp 21:13:18 INFO - PROCESS | 6439 | 21:13:18 INFO - PROCESS | 6439 | ------- Summary: start ------- 21:13:18 INFO - PROCESS | 6439 | Number of tests: 6 21:13:18 INFO - PROCESS | 6439 | 21:13:18 INFO - PROCESS | 6439 | [#0] dojo.html Cycles:165 Average:5468.74 Median:5643.92 stddev:692.16 (12.3%) stddev-sans-first:671.14 21:13:18 INFO - PROCESS | 6439 | Values: 3206.4 3222.0 3228.7 3264.1 3274.0 3846.6 4361.8 4492.7 4935.7 5066.9 4487.5 5352.3 5436.2 5497.4 5540.3 4931.7 4979.2 4991.4 5018.1 5083.7 4111.3 5040.3 5097.0 5135.4 5203.7 4945.6 5103.6 5105.8 5111.6 5143.2 4961.6 5059.7 5081.9 5107.2 5131.6 5033.3 5033.8 5051.1 5066.9 5081.8 5344.2 5378.0 5433.8 5557.9 5559.9 5741.9 5888.2 5977.6 6036.8 6095.9 6105.0 6110.1 6122.3 6138.8 6141.2 5456.9 5629.5 5643.9 5661.1 5663.8 6134.6 6143.3 6184.4 6201.1 6242.0 6000.2 6028.1 6033.9 6069.1 6076.0 5197.8 5957.3 6120.2 6152.1 6155.0 4819.6 5878.4 5885.1 5935.6 6020.7 5984.6 5992.3 6025.2 6033.6 6035.6 4756.9 4760.2 4763.4 4774.2 4798.1 4262.9 4272.4 4312.9 4338.4 4374.6 4122.9 4886.3 5550.6 5610.7 5623.0 5526.2 6146.8 6178.2 6180.1 6184.2 5389.6 5533.3 5554.4 5604.0 5625.2 4641.4 5228.7 5283.2 5293.0 5314.7 5844.2 6139.1 6144.9 6161.0 6190.8 4644.9 5168.8 6080.6 6083.9 6088.8 4932.7 6212.2 6231.8 6235.3 6272.8 5089.6 5599.5 5988.1 6094.4 6098.2 5980.5 5999.3 6079.9 6091.4 6151.4 5807.4 5855.6 5922.1 5976.5 6021.6 5790.6 5935.9 5949.7 5953.1 5965.9 4458.9 4690.2 5674.9 5678.5 5757.3 5968.0 5983.3 5993.3 5999.3 6011.4 5684.1 5711.1 5730.5 5751.8 5761.1 21:13:18 INFO - PROCESS | 6439 | 21:13:18 INFO - PROCESS | 6439 | [#1] ext.html Cycles:180 Average:66139.27 Median:40767.19 stddev:140929.56 (345.7%) stddev-sans-first:141238.63 21:13:18 INFO - PROCESS | 6439 | Values: 459.6 465.3 467.5 490.9 520.9 36663.8 40660.6 42185.9 42416.4 42490.8 40873.8 40918.6 41196.0 41250.0 41309.0 9353.9 9469.9 9509.4 9590.0 9591.6 9407.8 9510.9 9523.1 9542.6 9552.1 9407.4 9462.3 9508.0 9515.0 9570.3 9486.5 9566.2 9572.5 9575.0 9582.0 9366.1 9414.5 9429.9 9511.4 9560.2 38768.8 39068.4 39313.6 39338.8 39397.6 3260.7 3682.5 3703.7 3986.5 3999.5 29483.0 30139.2 30430.1 30737.5 30763.8 3194.1 3259.8 3281.8 3298.4 3329.0 448313.0 451292.0 451378.7 452289.0 452654.0 48101.0 57144.1 57591.7 57602.1 57757.0 51014.2 51954.7 61372.7 61410.0 61666.7 13248.3 15240.0 15436.8 15452.6 15595.1 10224.4 11541.9 11757.4 11814.4 12042.3 12893.6 12905.5 13697.7 16200.0 16415.8 4944.7 5176.3 5908.6 6022.9 6091.8 818.5 909.5 958.1 1002.1 1010.6 24197.0 24376.6 28797.7 29663.9 30582.5 870.9 927.0 974.7 1037.2 1041.1 15014.8 15424.9 15671.6 15856.8 15938.8 572857.0 575592.0 575868.0 576377.0 578826.1 55683.7 56259.0 56275.7 56394.4 56403.7 1156.1 1307.5 1310.3 1332.1 1336.3 27741.3 28849.7 29607.0 30325.8 30374.0 47574.3 48466.5 48846.5 48950.0 49018.0 548285.0 548761.0 550102.0 552022.0 552284.0 32829.7 39650.8 39810.0 39991.8 40294.8 45283.8 46102.8 46507.8 47120.0 47566.8 38264.9 38482.2 38799.0 39448.0 39942.6 38346.8 38472.4 39198.6 39610.4 39835.0 31380.0 32447.4 37256.3 37518.0 38029.6 32124.5 33535.8 33567.5 34208.5 34311.3 23566.0 24900.6 25171.9 25630.7 26065.3 21:13:18 INFO - PROCESS | 6439 | 21:13:18 INFO - PROCESS | 6439 | [#2] jquery.html Cycles:180 Average:33687.38 Median:36858.99 stddev:96715.93 (262.4%) stddev-sans-first:96954.81 21:13:18 INFO - PROCESS | 6439 | Values: 329.9 372.2 376.0 383.2 401.9 17606.6 19575.2 19746.6 20199.3 20408.6 15769.5 19751.6 19902.6 20227.6 20236.4 5609.6 5693.4 5850.8 5874.7 5891.2 4983.0 5803.3 5917.3 6004.6 6031.6 5616.2 5786.4 5955.2 5956.9 5966.7 5719.9 5788.4 5816.3 5822.1 5826.8 4773.5 4987.3 5055.1 5073.9 5135.4 24837.4 24888.3 24923.1 25082.0 25115.0 1931.8 2194.4 2205.9 2257.4 2469.0 14458.3 15061.0 15490.1 15562.6 15618.6 1853.8 1859.5 1952.3 1991.6 2012.7 79928.6 96017.5 125650.7 126893.0 127234.4 10942.2 11167.9 11281.7 11419.5 11614.5 14116.2 14251.9 14261.1 14264.5 14293.6 7980.9 8248.8 8266.7 8291.7 8317.5 7931.0 8072.6 8074.5 8232.4 8260.9 4422.8 4467.4 4485.2 4487.6 4585.5 1623.0 1886.2 1930.8 1939.5 1947.2 824.9 864.9 904.7 920.7 938.5 17732.7 20056.7 20641.9 20820.4 20845.9 901.2 915.1 921.3 944.5 963.3 10606.5 10925.8 10927.8 10984.8 11008.2 572198.0 577039.0 581951.0 582469.0 587657.0 79476.0 124021.4 128880.4 129184.0 131428.2 764.3 955.9 990.4 992.8 998.6 15730.4 17402.3 19042.4 19047.9 19137.1 36637.5 37080.4 45396.8 51293.0 54167.7 64980.0 78498.0 79498.8 79880.8 80393.0 7869.0 7910.9 7993.8 8039.4 8151.2 10170.3 10277.8 10767.4 12697.7 12837.7 10778.1 10863.5 10899.0 11069.7 11168.7 9225.4 9518.3 10721.5 10727.7 10913.1 10660.2 10761.9 11147.3 11207.3 11290.4 6779.3 7404.7 7745.4 7848.1 8041.0 9643.8 10490.1 10726.6 10788.8 10970.7 21:13:18 INFO - PROCESS | 6439 | 21:13:18 INFO - PROCESS | 6439 | [#3] mootools.html Cycles:180 Average:5430.24 Median:5263.22 stddev:2963.38 (56.3%) stddev-sans-first:2956.70 21:13:18 INFO - PROCESS | 6439 | Values: 1464.5 1507.3 1668.3 1766.8 1805.6 7203.4 7576.8 7832.0 8081.6 8575.3 7312.6 7906.3 8183.5 8194.5 8202.9 2281.3 2323.6 2328.5 2330.7 2332.4 2313.8 2341.3 2350.0 2356.4 2363.8 2295.6 2303.2 2309.3 2329.3 2330.7 2285.9 2291.0 2291.2 2305.3 2308.2 2313.8 2314.1 2327.7 2332.1 2332.9 8409.9 8422.8 8483.2 8499.7 8501.3 5140.5 5260.2 5266.2 5281.3 5283.9 3340.9 3438.1 3611.9 3668.6 3677.3 1037.8 1055.2 1076.9 1079.3 1080.2 10841.5 10888.6 10983.2 10992.0 11030.2 3632.0 4593.1 4670.1 4685.5 4703.0 9299.0 9417.5 9441.6 9458.3 9489.8 5219.8 5239.2 5245.9 5247.2 5257.8 4294.2 4323.8 4720.9 4772.2 4827.9 3264.2 3690.0 3747.0 3804.9 3825.7 1244.6 1251.8 1255.0 1262.3 1265.3 854.8 862.3 872.4 917.2 921.5 5575.8 5682.5 5766.4 5790.3 5983.8 733.7 869.5 876.2 907.5 913.2 3395.8 3504.4 3683.4 3815.9 3927.2 9879.5 9900.8 9969.0 10058.7 10344.7 9004.9 9280.4 9966.7 10132.1 10225.3 6276.7 7743.1 7775.5 7968.8 8028.6 5513.3 5539.6 5584.9 5623.3 5872.2 9278.8 9395.5 9430.0 9430.6 9441.8 8900.5 9419.2 9471.6 9512.4 9594.7 6637.9 6842.5 6944.9 7120.6 7260.9 7677.7 8026.1 8028.2 8041.9 8045.0 7091.6 7138.2 7190.9 7251.4 7330.9 7012.0 7048.6 7079.9 7210.1 7228.9 6678.8 6697.7 6761.6 6769.8 6780.4 4750.3 4814.0 4825.4 4875.7 4896.0 4729.3 4798.6 4826.4 4915.8 4925.1 21:13:18 INFO - PROCESS | 6439 | 21:13:18 INFO - PROCESS | 6439 | [#4] prototype.html Cycles:180 Average:4296.01 Median:4694.44 stddev:1299.90 (27.7%) stddev-sans-first:1268.30 21:13:18 INFO - PROCESS | 6439 | Values: 290.2 294.0 303.2 303.3 306.3 4631.5 5347.0 5525.3 5581.0 5697.8 5260.6 5329.3 5418.6 5510.4 5551.7 3628.2 4216.6 4236.3 4264.9 4275.4 4113.8 4175.2 4178.3 4196.9 4289.9 3836.7 4165.9 4177.4 4180.6 4187.3 3461.7 3736.4 3794.5 4218.7 4222.8 3006.2 3638.3 3644.9 3656.6 3656.9 3877.7 4480.6 4650.0 5121.1 5415.4 3945.5 4529.5 4582.6 4724.8 4753.2 5034.4 5199.6 5715.1 5762.4 5779.4 3207.6 3803.2 3920.0 3982.3 3984.6 5022.7 5761.3 6055.8 6084.9 6122.5 4035.8 4064.5 4066.7 4077.6 4077.6 3612.8 3787.0 3926.8 4016.4 4047.2 4696.3 4719.4 4726.9 4729.2 4802.8 4785.7 5787.7 5829.0 5829.7 5878.6 1137.4 1164.6 1169.8 1292.1 1388.4 788.7 803.1 958.9 966.2 967.4 5449.3 5459.8 5470.3 5473.4 5484.9 5653.0 5911.8 5926.0 5953.5 5968.8 4313.8 5213.4 5228.7 5465.8 5481.1 2164.4 2176.8 2331.4 2553.7 2608.4 4357.1 5086.6 5094.7 5114.7 5169.0 4692.6 4760.0 4926.5 5081.3 5153.4 4593.8 4632.4 5132.6 5195.3 5228.7 4106.8 4178.9 4623.7 4626.0 4887.0 4482.4 4515.7 4649.3 4732.9 4750.5 4556.0 4954.4 5148.8 5200.4 5214.7 3085.1 3403.5 3541.3 3549.6 3559.4 4675.0 4717.3 4824.5 4824.6 4950.6 4190.8 4701.7 4734.2 4816.0 4818.8 4523.7 4635.4 4744.6 4756.3 4766.9 4240.5 4355.2 4360.6 4725.5 4756.7 4735.7 4739.4 4756.7 4761.4 4769.4 4162.5 4193.5 4204.4 4649.1 4756.4 21:13:18 INFO - PROCESS | 6439 | 21:13:18 INFO - PROCESS | 6439 | [#5] yui.html Cycles:180 Average:20176.30 Median:4222.76 stddev:29796.83 (705.6%) stddev-sans-first:29844.48 21:13:18 INFO - PROCESS | 6439 | Values: 686.7 751.9 777.8 784.1 807.6 12432.3 13694.0 14896.5 15007.2 15511.8 11843.9 14078.8 14220.3 14248.2 14269.7 699.2 817.9 818.5 818.5 820.3 810.3 814.5 815.2 816.6 819.6 831.3 846.2 849.3 861.8 862.0 828.8 850.3 854.7 855.3 855.5 630.9 631.5 637.8 638.7 639.1 12836.0 12848.3 12863.1 12891.2 13747.2 13436.4 13515.7 13557.2 13687.9 13875.4 11477.7 11608.2 11686.5 11846.3 12052.2 3725.3 3731.2 3926.0 3957.4 3957.7 84710.0 84751.6 86709.6 87409.0 87537.0 10416.9 10699.4 11057.4 11097.4 11210.3 20898.0 21448.2 21625.0 21645.5 21901.6 7678.0 7754.2 7757.8 7854.0 7949.8 4187.5 4213.1 4232.4 4319.8 4321.6 3450.2 3548.3 3556.0 3678.3 3857.4 680.9 692.4 703.8 709.6 715.4 552.9 587.0 602.5 615.0 643.4 9045.5 9815.2 9817.4 10034.0 10157.8 525.4 614.0 617.9 621.7 625.6 4149.7 4153.5 4162.4 4278.2 4453.1 107412.0 109850.5 113314.9 113691.4 114574.3 95590.5 96636.5 100266.0 101099.0 101897.0 74068.0 87101.0 88314.6 89916.8 90273.0 8052.6 8199.1 8860.4 8930.8 9031.6 52415.7 52442.7 52809.7 54479.5 55535.7 52635.2 58269.0 59495.8 62501.1 68010.7 11398.4 11489.4 11512.5 11522.1 11546.5 10932.0 11964.3 12087.6 12464.6 12551.6 11743.5 12112.1 12127.0 13069.2 13077.1 12732.4 12901.4 13026.6 13280.9 13503.0 12394.5 12422.8 12588.4 12720.3 13128.5 8188.4 10625.5 10771.2 10782.7 10879.0 9150.0 9446.8 9961.9 10870.9 11075.0 21:13:18 INFO - PROCESS | 6439 | -------- Summary: end -------- 21:13:18 INFO - PROCESS | 6439 | 21:13:19 INFO - TEST-INFO | 6439: exit 0 21:13:19 INFO - TEST-OK | dromaeo_css | took 1115585ms 21:13:19 INFO - TEST-START | kraken 21:13:19 INFO - operating with platform_type : mac_ 21:13:19 INFO - Initialising browser for kraken test... 21:13:19 INFO - TEST-INFO | started process 6446 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmpCJwvgA/profile http://localhost:57465/getInfo.html) 21:13:22 INFO - PROCESS | 6446 | 2016-10-31 21:13:21.997 plugin-container[6447:120012] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.tsm.portname' 21:13:22 INFO - PROCESS | 6446 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:13:22 INFO - PROCESS | 6446 | 2016-10-31 21:13:22.000 plugin-container[6447:120012] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 21:13:22 INFO - PROCESS | 6446 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:13:22 INFO - PROCESS | 6446 | 2016-10-31 21:13:22.000 plugin-container[6447:120012] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:13:22 INFO - PROCESS | 6446 | __metrics Screen width/height:1600/1200 21:13:22 INFO - PROCESS | 6446 | colorDepth:24 21:13:22 INFO - PROCESS | 6446 | Browser inner width/height: 1024/689 21:13:22 INFO - PROCESS | 6446 | __metrics 21:13:22 ERROR - PROCESS | 6446 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 21:13:22 INFO - TEST-INFO | 6446: exit 0 21:13:22 INFO - Browser initialized. 21:13:22 INFO - Running cycle 1/1 for kraken test... 21:13:22 INFO - TEST-INFO | started process 6448 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmpCJwvgA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:13:25 INFO - PROCESS | 6448 | 2016-10-31 21:13:25.011 plugin-container[6449:120127] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a47, name = 'com.apple.tsm.portname' 21:13:25 INFO - PROCESS | 6448 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:13:25 INFO - PROCESS | 6448 | 2016-10-31 21:13:25.011 plugin-container[6449:120127] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 21:13:25 INFO - PROCESS | 6448 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:13:25 INFO - PROCESS | 6448 | 2016-10-31 21:13:25.011 plugin-container[6449:120127] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:13:34 INFO - PROCESS | 6448 | RSS: Main: 238137344 21:13:34 INFO - PROCESS | 6448 | 21:13:37 INFO - PROCESS | 6448 | Cycle 1(1): loaded http://localhost:57465/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57465/tests/kraken/driver.html?testName=audio-beat-detection) 21:13:38 INFO - PROCESS | 6448 | RSS: Main: 250601472 21:13:38 INFO - PROCESS | 6448 | 21:13:41 INFO - PROCESS | 6448 | Cycle 1(1): loaded http://localhost:57465/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57465/tests/kraken/driver.html?testName=audio-dft) 21:13:41 INFO - PROCESS | 6448 | RSS: Main: 258265088 21:13:41 INFO - PROCESS | 6448 | 21:13:45 INFO - PROCESS | 6448 | Cycle 1(1): loaded http://localhost:57465/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57465/tests/kraken/driver.html?testName=audio-fft) 21:13:46 INFO - PROCESS | 6448 | RSS: Main: 261193728 21:13:46 INFO - PROCESS | 6448 | 21:13:48 INFO - PROCESS | 6448 | Cycle 1(1): loaded http://localhost:57465/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57465/tests/kraken/driver.html?testName=audio-oscillator) 21:13:48 INFO - PROCESS | 6448 | RSS: Main: 262189056 21:13:48 INFO - PROCESS | 6448 | 21:13:50 INFO - PROCESS | 6448 | Cycle 1(1): loaded http://localhost:57465/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57465/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:13:51 INFO - PROCESS | 6448 | RSS: Main: 263856128 21:13:51 INFO - PROCESS | 6448 | 21:13:54 INFO - PROCESS | 6448 | Cycle 1(1): loaded http://localhost:57465/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57465/tests/kraken/driver.html?testName=imaging-darkroom) 21:13:54 INFO - PROCESS | 6448 | RSS: Main: 263950336 21:13:54 INFO - PROCESS | 6448 | 21:13:57 INFO - PROCESS | 6448 | Cycle 1(1): loaded http://localhost:57465/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57465/tests/kraken/driver.html?testName=imaging-desaturate) 21:13:58 INFO - PROCESS | 6448 | RSS: Main: 264138752 21:13:58 INFO - PROCESS | 6448 | 21:14:01 INFO - PROCESS | 6448 | Cycle 1(1): loaded http://localhost:57465/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57465/tests/kraken/driver.html?testName=json-parse-financial) 21:14:02 INFO - PROCESS | 6448 | RSS: Main: 264212480 21:14:02 INFO - PROCESS | 6448 | 21:14:03 INFO - PROCESS | 6448 | Cycle 1(1): loaded http://localhost:57465/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57465/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:14:04 INFO - PROCESS | 6448 | RSS: Main: 264114176 21:14:04 INFO - PROCESS | 6448 | 21:14:06 INFO - PROCESS | 6448 | Cycle 1(1): loaded http://localhost:57465/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57465/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:14:07 INFO - PROCESS | 6448 | RSS: Main: 264122368 21:14:07 INFO - PROCESS | 6448 | 21:14:09 INFO - PROCESS | 6448 | Cycle 1(1): loaded http://localhost:57465/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57465/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:14:10 INFO - PROCESS | 6448 | RSS: Main: 264183808 21:14:10 INFO - PROCESS | 6448 | 21:14:13 INFO - PROCESS | 6448 | Cycle 1(1): loaded http://localhost:57465/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:14:13 INFO - PROCESS | 6448 | RSS: Main: 264515584 21:14:13 INFO - PROCESS | 6448 | 21:14:16 INFO - PROCESS | 6448 | Cycle 1(1): loaded http://localhost:57465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:14:17 INFO - PROCESS | 6448 | RSS: Main: 264273920 21:14:17 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | Cycle 1(1): loaded http://localhost:57465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57465/tests/kraken/driver.html?testName=ai-astar) 21:14:19 INFO - PROCESS | 6448 | RSS: Main: 266022912 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | __start_tp_report 21:14:19 INFO - PROCESS | 6448 | _x_x_mozilla_page_load 21:14:19 INFO - PROCESS | 6448 | _x_x_mozilla_page_load_details 21:14:19 INFO - PROCESS | 6448 | |i|pagename|runs| 21:14:19 INFO - PROCESS | 6448 | |0;ai-astar;106;113;116;115;114;115;117;117;96;173 21:14:19 INFO - PROCESS | 6448 | |1;audio-beat-detection;154;128;118;174;113;115;114;113;144;117 21:14:19 INFO - PROCESS | 6448 | |2;audio-dft;200;210;193;244;177;267;281;207;193;199 21:14:19 INFO - PROCESS | 6448 | |3;audio-fft;80;57;60;85;60;69;83;83;71;70 21:14:19 INFO - PROCESS | 6448 | |4;audio-oscillator;88;71;91;96;71;71;72;58;58;85 21:14:19 INFO - PROCESS | 6448 | |5;imaging-gaussian-blur;136;132;92;90;92;126;93;88;112;132 21:14:19 INFO - PROCESS | 6448 | |6;imaging-darkroom;99;98;96;97;97;97;149;153;96;109 21:14:19 INFO - PROCESS | 6448 | |7;imaging-desaturate;104;90;134;134;111;138;106;76;119;117 21:14:19 INFO - PROCESS | 6448 | |8;json-parse-financial;58;57;55;57;58;59;57;60;67;62 21:14:19 INFO - PROCESS | 6448 | |9;json-stringify-tinderbox;70;90;69;93;128;114;105;72;74;73 21:14:19 INFO - PROCESS | 6448 | |10;stanford-crypto-aes;90;89;89;89;89;90;89;93;90;89 21:14:19 INFO - PROCESS | 6448 | |11;stanford-crypto-ccm;150;147;157;155;173;155;161;162;201;166 21:14:19 INFO - PROCESS | 6448 | |12;stanford-crypto-pbkdf2;176;212;243;192;176;177;175;176;171;194 21:14:19 INFO - PROCESS | 6448 | |13;stanford-crypto-sha256-iterative;68;70;71;68;69;68;67;69;72;77 21:14:19 INFO - PROCESS | 6448 | __end_tp_report 21:14:19 INFO - PROCESS | 6448 | __start_cc_report 21:14:19 INFO - PROCESS | 6448 | _x_x_mozilla_cycle_collect,966 21:14:19 INFO - PROCESS | 6448 | __end_cc_report 21:14:19 INFO - PROCESS | 6448 | __startTimestamp1477973659534__endTimestamp 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | ------- Summary: start ------- 21:14:19 INFO - PROCESS | 6448 | Number of tests: 14 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | [#0] ai-astar Cycles:10 Average:118.20 Median:116.50 stddev:20.32 (17.4%) stddev-sans-first:21.07 21:14:19 INFO - PROCESS | 6448 | Values: 106.0 113.0 116.0 115.0 114.0 115.0 117.0 117.0 96.0 173.0 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:123.00 stddev:21.28 (17.3%) stddev-sans-first:20.55 21:14:19 INFO - PROCESS | 6448 | Values: 154.0 128.0 118.0 174.0 113.0 115.0 114.0 113.0 144.0 117.0 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | [#2] audio-dft Cycles:10 Average:217.10 Median:208.50 stddev:34.70 (16.6%) stddev-sans-first:36.25 21:14:19 INFO - PROCESS | 6448 | Values: 200.0 210.0 193.0 244.0 177.0 267.0 281.0 207.0 193.0 199.0 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | [#3] audio-fft Cycles:10 Average:71.80 Median:75.50 stddev:10.55 (14.0%) stddev-sans-first:10.76 21:14:19 INFO - PROCESS | 6448 | Values: 80.0 57.0 60.0 85.0 60.0 69.0 83.0 83.0 71.0 70.0 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:78.50 stddev:13.29 (16.9%) stddev-sans-first:13.38 21:14:19 INFO - PROCESS | 6448 | Values: 88.0 71.0 91.0 96.0 71.0 71.0 72.0 58.0 58.0 85.0 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:89.00 stddev:20.33 (22.8%) stddev-sans-first:19.13 21:14:19 INFO - PROCESS | 6448 | Values: 136.0 132.0 92.0 90.0 92.0 126.0 93.0 88.0 112.0 132.0 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | [#6] imaging-darkroom Cycles:10 Average:109.10 Median:97.00 stddev:22.43 (23.1%) stddev-sans-first:23.49 21:14:19 INFO - PROCESS | 6448 | Values: 99.0 98.0 96.0 97.0 97.0 97.0 149.0 153.0 96.0 109.0 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | [#7] imaging-desaturate Cycles:10 Average:112.90 Median:134.00 stddev:19.97 (14.9%) stddev-sans-first:20.93 21:14:19 INFO - PROCESS | 6448 | Values: 104.0 90.0 134.0 134.0 111.0 138.0 106.0 76.0 119.0 117.0 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:58.50 stddev:3.40 (5.8%) stddev-sans-first:3.59 21:14:19 INFO - PROCESS | 6448 | Values: 58.0 57.0 55.0 57.0 58.0 59.0 57.0 60.0 67.0 62.0 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | [#9] json-stringify-tinderbox Cycles:10 Average:88.80 Median:72.50 stddev:20.95 (28.9%) stddev-sans-first:21.09 21:14:19 INFO - PROCESS | 6448 | Values: 70.0 90.0 69.0 93.0 128.0 114.0 105.0 72.0 74.0 73.0 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:89.50 stddev:1.25 (1.4%) stddev-sans-first:1.32 21:14:19 INFO - PROCESS | 6448 | Values: 90.0 89.0 89.0 89.0 89.0 90.0 89.0 93.0 90.0 89.0 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | [#11] stanford-crypto-ccm Cycles:10 Average:162.70 Median:161.50 stddev:15.44 (9.6%) stddev-sans-first:15.68 21:14:19 INFO - PROCESS | 6448 | Values: 150.0 147.0 157.0 155.0 173.0 155.0 161.0 162.0 201.0 166.0 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.20 Median:184.50 stddev:22.73 (12.3%) stddev-sans-first:23.60 21:14:19 INFO - PROCESS | 6448 | Values: 176.0 212.0 243.0 192.0 176.0 177.0 175.0 176.0 171.0 194.0 21:14:19 INFO - PROCESS | 6448 | 21:14:19 INFO - PROCESS | 6448 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:69.50 stddev:2.92 (4.2%) stddev-sans-first:3.02 21:14:19 INFO - PROCESS | 6448 | Values: 68.0 70.0 71.0 68.0 69.0 68.0 67.0 69.0 72.0 77.0 21:14:19 INFO - PROCESS | 6448 | -------- Summary: end -------- 21:14:19 INFO - PROCESS | 6448 | 21:14:20 INFO - TEST-INFO | 6448: exit 0 21:14:20 INFO - TEST-OK | kraken | took 61194ms 21:14:20 INFO - SUITE-END | took 1176s 21:14:20 INFO - Completed test suite (00:19:37) 21:14:20 INFO - javascript benchmark 21:14:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7027.584491102027, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3206.4448742359964, 3221.98389008055, 3228.660990595987, 3264.1186879542515, 3274.0, 3846.5576458707255, 4361.760103194327, 4492.687773677983, 4935.692041608976, 5066.873328166797, 4487.528809475015, 5352.277442545255, 5436.238926550276, 5497.39528651848, 5540.307461567304, 4931.65478416511, 4979.1784355581285, 4991.40103187618, 5018.121828679985, 5083.745812709368, 4111.259973204837, 5040.319556859832, 5097.0, 5135.409427915782, 5203.713795741232, 4945.554900059012, 5103.56619687327, 5105.821296254632, 5111.642185047048, 5143.15138002231, 4961.578265847407, 5059.747012649353, 5081.923771143436, 5107.208382700687, 5131.589472842164, 5033.270175824485, 5033.823816166453, 5051.090803655341, 5066.898662026776, 5081.79672813087, 5344.1716533936915, 5378.0, 5433.755481003325, 5557.888842223173, 5559.916601250984, 5741.942580574183, 5888.175655408247, 5977.641341519479, 6036.849078773066, 6095.939040609582, 6105.0, 6110.144579758838, 6122.265328160604, 6138.785142520035, 6141.232345956755, 5456.91814622781, 5629.4652008059575, 5643.915341269884, 5661.122526008434, 5663.801766938137, 6134.570580059442, 6143.327652471189, 6184.381561843779, 6201.069839524017, 6242.0, 6000.21997140369, 6028.057869355549, 6033.909491357633, 6069.119977603223, 6075.99746041907, 5197.8045049638795, 5957.344692083867, 6120.234970628671, 6152.138700581922, 6154.969225153935, 4819.638527110481, 5878.353381128072, 5885.146653735184, 5935.554833387513, 6020.729067191987, 5984.611000284967, 5992.31088424828, 6025.246844144482, 6033.607815491979, 6035.577509574376, 4756.857294281177, 4760.190767569521, 4763.356946812205, 4774.236122220428, 4798.1123492154065, 4262.914741705211, 4272.380504826845, 4312.892177695583, 4338.436003319612, 4374.58441448062, 4122.907429531177, 4886.291487734258, 5550.611457198038, 5610.719464026783, 5622.971885140548, 5526.171074338801, 6146.784862529879, 6178.227721534809, 6180.134781130645, 6184.226971628546, 5389.649672771257, 5533.253010843485, 5554.361248456398, 5604.0, 5625.184348269478, 4641.373414589055, 5228.660137091153, 5283.181106928432, 5293.0, 5314.707691077027, 5844.181814545882, 6139.109829074849, 6144.938550614436, 6161.0, 6190.7523699051535, 4644.883877902945, 5168.8449346519665, 6080.604760690541, 6083.878322433438, 6088.756449741961, 4932.7286999215385, 6212.192414986023, 6231.813045608639, 6235.3452887446165, 6272.8431789203805, 5089.592832573311, 5599.496045355938, 5988.101784732325, 6094.421030002142, 6098.237720284965, 5980.461758441761, 5999.340072592098, 6079.939200607937, 6091.42131497507, 6151.446369826737, 5807.390224026416, 5855.560832937632, 5922.111683247375, 5976.521878249817, 6021.638701677914, 5790.565707571865, 5935.881282374415, 5949.732262048132, 5953.1070339449425, 5965.940340596539, 4458.866234012985, 4690.226112691368, 5674.858128546819, 5678.545716342765, 5757.309122905278, 5968.045112781934, 5983.252093488314, 5993.280806303272, 5999.280086389661, 6011.368806275278, 5684.147377893349, 5711.114777209539, 5730.541556675373, 5751.798687045934, 5761.107028410603], "value": 5426.336282271515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.5565279505279, 465.3368949247322, 467.4857656577764, 490.8625584836247, 520.9270702101707, 36663.81668091662, 40660.59339406609, 42185.94535136623, 42416.36375454371, 42490.78754606227, 40873.7956310218, 40918.59081409185, 41195.970100747494, 41250.0, 41308.96727581812, 9353.906460935388, 9469.905300947006, 9509.429434233969, 9590.0, 9591.616335346613, 9407.81184376312, 9510.857337139949, 9523.142917137457, 9542.570584323686, 9552.092551207625, 9407.435553866755, 9462.337636365457, 9507.95246023769, 9515.0, 9570.28222883283, 9486.525673716322, 9566.234701223886, 9572.521373931311, 9575.042495750438, 9581.95209023954, 9366.110219529133, 9414.482203478807, 9429.90570094297, 9511.381760185566, 9560.235181185488, 38768.80615596932, 39068.41397379042, 39313.60686393128, 39338.80330598329, 39397.60602393968, 3260.6739326067204, 3682.4660424238336, 3703.7222208334215, 3986.4618276532588, 3999.5200575930785, 29483.0, 30139.246518837204, 30430.087097387113, 30737.538936915964, 30763.769449222003, 3194.1056504178637, 3259.7555183361105, 3281.819499927503, 3298.4062868683627, 3329.0, 448313.0, 451292.0, 451378.7431062824, 452288.9999999967, 452654.0, 48101.0, 57144.142837857464, 57591.712041439525, 57602.135967960516, 57757.0, 51014.234786478235, 51954.74022629863, 61372.693136534035, 61410.0, 61666.691666542276, 13248.337583120998, 15240.0, 15436.845631543541, 15452.613684657974, 15595.142267175188, 10224.386536807815, 11541.942290288494, 11757.412129393497, 11814.350210738492, 12042.277463352051, 12893.577090001243, 12905.483780648668, 13697.657558561115, 16200.027998320138, 16415.83584164167, 4944.728039957837, 5176.301199338041, 5908.586398952118, 6022.939770602326, 6091.8477038073515, 818.5129847740585, 909.4952301472746, 958.1185309515263, 1002.0981116994617, 1010.5957616953131, 24197.0, 24376.634350484757, 28797.712022879503, 29663.85168074189, 30582.541261881088, 870.9113607990013, 927.0405130689704, 974.7124598243536, 1037.2117190934944, 1041.1150522056191, 15014.774778378332, 15424.922875385551, 15671.608209794846, 15856.752051728427, 15938.840611593736, 572857.0, 575592.0, 575868.0, 576377.0, 578826.105869468, 55683.72158139183, 56259.0, 56275.71862140663, 56394.43605563974, 56403.71798140983, 1156.0866915137115, 1307.5488956310057, 1310.2662508994993, 1332.060897067565, 1336.2984433172662, 27741.30646733848, 28849.711502884704, 29606.963756268426, 30325.84837075889, 30374.0, 47574.28638570494, 48466.5153348462, 48846.51153488562, 48950.0, 49018.0, 548285.0, 548761.0, 550102.0, 552022.0, 552284.0, 32829.70192086531, 39650.80174599224, 39810.0, 39991.80004099961, 40294.79852600718, 45283.773581131885, 46102.769486152356, 46507.767461162475, 47120.0, 47566.76216618895, 38264.85205443841, 38482.230355392174, 38799.0, 39448.01379965524, 39942.600573993885, 38346.80826595961, 38472.422913655755, 39198.6080139195, 39610.40584391179, 39835.00412489711, 31380.0, 32447.35105297928, 37256.25487490181, 37518.0, 38029.61970380371, 32124.518132227568, 33535.79736365978, 33567.496487553195, 34208.486872696434, 34311.31377372389, 23566.0, 24900.630465323855, 25171.87414062918, 25630.743692562835, 26065.348366290993], "value": 19300.985505199445, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.897731703172, 372.157064249475, 375.97368184227116, 383.15705448014376, 401.9356902895535, 17606.647867042666, 19575.21699132033, 19746.605067898632, 20199.293024744118, 20408.59182816343, 15769.526914192593, 19751.60496790067, 19902.601947961033, 20227.59544809103, 20236.39290821274, 5609.57928155388, 5693.402192769761, 5850.824475265749, 5874.735636896328, 5891.175235467038, 4982.950170498285, 5803.274590676166, 5917.319508256563, 6004.5796794224425, 6031.638101713889, 5616.185653080301, 5786.392428794979, 5955.225820643311, 5956.910646340309, 5966.67183304918, 5719.885602287952, 5788.392218817048, 5816.331121920991, 5822.09757487588, 5826.766929322822, 4773.474917759078, 4987.251912213161, 5055.090083784918, 5073.898522029575, 5135.4094279158, 24837.379065523324, 24888.253352399457, 24923.127690530746, 25082.0, 25115.0, 1931.8454523638216, 2194.3746032380695, 2205.9448513787124, 2257.4469255032623, 2468.9524035890477, 14458.349374278183, 15061.048205914969, 15490.070595764177, 15562.610934726608, 15618.609534761608, 1853.7775466944054, 1859.525820915658, 1952.287415093495, 1991.611635731033, 2012.6880333548324, 79928.60035699785, 96017.51991239999, 125650.71746412643, 126893.0, 127234.36382818119, 10942.23404361687, 11167.944160279147, 11281.661550153509, 11419.48612312448, 11614.535418583331, 14116.153030818185, 14251.85748142526, 14261.073030253001, 14264.500742473963, 14293.64265893361, 7980.880286795703, 8248.793780155544, 8266.710665126811, 8291.668333266602, 8317.542535160503, 7930.960345198352, 8072.596370181467, 8074.515529068275, 8232.382571307176, 8260.876086858701, 4422.800973956179, 4467.352233926063, 4485.192665320208, 4487.618552423015, 4585.472670642919, 1622.959426014359, 1886.2455017992638, 1930.8262256396993, 1939.5151212196952, 1947.2308438167129, 824.9133840946735, 864.8659457784054, 904.6878826804742, 920.7375897869209, 938.5213541093955, 17732.734008989875, 20056.69914951277, 20641.864697441484, 20820.37538873836, 20845.89577052105, 901.2339511415375, 915.1169121797365, 921.2537844346101, 944.4852555357347, 963.2871674960479, 10606.522706478227, 10925.836112458319, 10927.781444371069, 10984.780304394028, 11008.174386921013, 572198.0, 577039.0, 581951.0, 582469.0, 587657.0, 79476.0, 124021.37989310177, 128880.42239155165, 129184.0, 131428.17160449372, 764.2853931573997, 955.861400096982, 990.4156547636785, 992.7518120469882, 998.6454808543008, 15730.370785168465, 17402.303907844052, 19042.428727137652, 19047.904760476107, 19137.138828753017, 36637.53449861976, 37080.443793343664, 45396.773016134706, 51292.974140516235, 54167.72916135394, 64980.0, 78498.0, 79498.80751788612, 79880.80178797206, 80393.0, 7869.0, 7910.881336780068, 7993.800154996172, 8039.43723939342, 8151.225633564802, 10170.338927969658, 10277.84583231267, 10767.407792571485, 12697.682557936125, 12837.67905802325, 10778.083862871743, 10863.511141998788, 10899.0, 11069.667909962714, 11168.66494005181, 9225.400348977295, 9518.333716639769, 10721.463926803473, 10727.671451355538, 10913.072388847037, 10660.200484963814, 10761.89238107609, 11147.275427097537, 11207.327560346404, 11290.379029153475, 6779.322067793181, 7404.703811847466, 7745.419093567893, 7848.097468791162, 8041.0, 9643.758906027124, 10490.05589496949, 10726.624568140078, 10788.784224315626, 10970.725731856768], "value": 9332.669020118483, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.480109561106, 1507.3141720517165, 1668.2909763350574, 1766.7703198584181, 1805.5666640006393, 7203.4237261019125, 7576.810579735509, 7831.960840195791, 8081.5555144467035, 8575.271101956334, 7312.597807120606, 7906.2884340409355, 8183.468074575148, 8194.549299788509, 8202.876956845652, 2281.2927992322393, 2323.6398358254414, 2328.52265285616, 2330.650402439631, 2332.3819187915215, 2313.849599776009, 2341.2976107167865, 2349.9530009399887, 2356.363781778927, 2363.775441333071, 2295.5638428698576, 2303.216906251874, 2309.2610364683223, 2329.3477826208687, 2330.6853574767442, 2285.908563657452, 2291.0, 2291.1522736587403, 2305.2853615379286, 2308.1575225042907, 2313.8264630152808, 2314.051238992005, 2327.7090363704538, 2332.0671731307443, 2332.871692056953, 8409.915900840975, 8422.831543369099, 8483.15168483153, 8499.74500764978, 8501.319894408432, 5140.485951404867, 5260.210968354739, 5266.236395722637, 5281.260623512711, 5283.920741188886, 3340.916477088068, 3438.1060924159897, 3611.927761444783, 3668.633136686337, 3677.2829298286847, 1037.8153985859733, 1055.166418529361, 1076.9192310576739, 1079.271491743078, 1080.173667144635, 10841.512131954081, 10888.564457421693, 10983.176261780318, 10991.955764202468, 11030.22788404812, 3632.0, 4593.127305811885, 4670.136024835417, 4685.484596694361, 4703.0, 9299.0, 9417.529123543796, 9441.575129119206, 9458.33791634579, 9489.810203795885, 5219.817306394258, 5239.240310155006, 5245.895082098336, 5247.1866860636665, 5257.7896884124975, 4294.184105020098, 4323.827046918151, 4720.858374248778, 4772.188727916263, 4827.8551643450755, 3264.24922267875, 3690.040589446763, 3746.9625303747157, 3804.885853424402, 3825.713071519647, 1244.6079484962208, 1251.7809383357876, 1254.9749005019848, 1262.3498898067503, 1265.316728966348, 854.7820305821975, 862.3403096631082, 872.4329186029132, 917.2295271971576, 921.5254144115786, 5575.804846830422, 5682.54539636828, 5766.4233576642, 5790.276215473066, 5983.820485385445, 733.7065173930471, 869.4609342207746, 876.1763941894599, 907.5479233226916, 913.2374467319862, 3395.828439188476, 3504.4392897136336, 3683.3922402803773, 3815.904602384907, 3927.19492504036, 9879.456629885282, 9900.762404699413, 9969.0, 10058.698239052841, 10344.689659310232, 9004.874390701163, 9280.396774209656, 9966.700998970042, 10132.088112069949, 10225.335353202017, 6276.681896801722, 7743.070831500143, 7775.494592851446, 7968.800779980431, 8028.598570071473, 5513.283273174462, 5539.584531160099, 5584.888302234014, 5623.297087864017, 5872.207252020922, 9278.814423711354, 9395.530223488662, 9429.952850235979, 9430.622775089194, 9441.811163776823, 8900.465972041438, 9419.246460283299, 9471.621135154517, 9512.38169518979, 9594.66418675343, 6637.900431493435, 6842.486813488908, 6944.895826562504, 7120.60836653989, 7260.89108663381, 7677.692892284246, 8026.1171271158955, 8028.237317454832, 8041.87937180931, 8045.0, 7091.60996145217, 7138.214796372498, 7190.89213661785, 7251.419886408969, 7330.853382932418, 7011.964940175267, 7048.647567621496, 7079.858402831812, 7210.134783825974, 7228.89156662661, 6678.766243181465, 6697.698603562754, 6761.560498567577, 6769.830754231184, 6780.423663988419, 4750.311204875343, 4814.0, 4825.396825396825, 4875.7074575525585, 4895.975520122377, 4729.290606409066, 4798.616110711205, 4826.372571565815, 4915.754212289443, 4925.1381008324115], "value": 4407.665056593601, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.1918157930165, 294.04875228635365, 303.1708277860053, 303.26155810601176, 306.2985762603638, 4631.480075142895, 5346.973265133669, 5525.281713377265, 5580.972095139524, 5697.8005769798065, 5260.631755777097, 5329.25390445337, 5418.647787893784, 5510.3744395403355, 5551.694656793875, 3628.219932714466, 4216.620504154625, 4236.331111399813, 4264.8507302244425, 4275.358696195564, 4113.806995971165, 4175.206710724968, 4178.349551926987, 4196.880575309465, 4289.892752681192, 3836.6547010769027, 4165.8755933050215, 4177.394277829713, 4180.6237438630515, 4187.267228235062, 3461.705755010827, 3736.383496723051, 3794.5256842894637, 4218.7468751874985, 4222.809973551198, 3006.2192471963344, 3638.326909521747, 3644.908877278089, 3656.5612126544984, 3656.8902932912056, 3877.728559000871, 4480.5967462928165, 4650.023495066041, 5121.129408000649, 5415.350157981028, 3945.487086678742, 4529.456465224162, 4582.587567118942, 4724.83463078794, 4753.217543421217, 5034.370703662043, 5199.610029247784, 5715.057015592422, 5762.366139724627, 5779.393163717833, 3207.631122420905, 3803.2393521295853, 3919.9612102792785, 3982.263281292941, 3984.621460961233, 5022.673526220784, 5761.337446193699, 6055.819115272524, 6084.9351363511205, 6122.540809439265, 4035.8385664573675, 4064.4716186896108, 4066.674666026711, 4077.554466475823, 4077.612626800449, 3612.8438899551893, 3786.981065094657, 3926.8429262829736, 4016.4376987221813, 4047.219223541691, 4696.319033740088, 4719.4100737407825, 4726.929096063562, 4729.196036673774, 4802.799300174956, 4785.660015195751, 5787.652740835563, 5829.018133834432, 5829.650220986754, 5878.588498805043, 1137.4312843578211, 1164.615676826645, 1169.7601991591703, 1292.0567985370733, 1388.4168649167375, 788.7476007677603, 803.1366281247682, 958.9328746987644, 966.1690945786618, 967.4050458967685, 5449.267251932439, 5459.754311055933, 5470.288862447856, 5473.425290344536, 5484.945150548443, 5653.0, 5911.7635294587735, 5925.970370148121, 5953.541382361263, 5968.791547127504, 4313.784310784448, 5213.393303348325, 5228.712420816892, 5465.808696695596, 5481.068218402881, 2164.3615133535645, 2176.770124879438, 2331.405491599631, 2553.6807899012624, 2608.373990242328, 4357.143927624075, 5086.643934924594, 5094.694318340911, 5114.667546609458, 5169.043726910533, 4692.554207350297, 4760.001199244454, 4926.482719314492, 5081.274414794203, 5153.4073581538605, 4593.770311484413, 4632.374629424984, 5132.589392848563, 5195.298444808678, 5228.738563071831, 4106.809025382725, 4178.862925703471, 4623.676342655982, 4625.982283897537, 4887.047025829929, 4482.394876691736, 4515.68390212682, 4649.256119020941, 4732.881677958078, 4750.45610176687, 4555.9544404556855, 4954.410633857034, 5148.845534633967, 5200.387879757287, 5214.687118772886, 3085.071830106184, 3403.502458918167, 3541.3448512025357, 3549.568545546309, 3559.394902866467, 4674.976625116853, 4717.3159891816185, 4824.517548245148, 4824.587706146926, 4950.623700623649, 4190.769507677107, 4701.694389864648, 4734.19518681818, 4815.951840481691, 4818.807247710052, 4523.683342166017, 4635.351050852816, 4744.576627011952, 4756.334113224082, 4766.856994290177, 4240.469941257343, 4355.1725172217175, 4360.563943605614, 4725.503822098768, 4756.669232076189, 4735.674011276848, 4739.431268247832, 4756.738379389167, 4761.357216775691, 4769.379980602499, 4162.458880345535, 4193.538710741755, 4204.4324016257415, 4649.093426781745, 4756.381670382828], "value": 3885.792071429866, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.7424715731601, 751.8984937033499, 777.7511196417147, 784.1061190243121, 807.5760225881412, 12432.316222607753, 13693.972952028587, 14896.478623248175, 15007.249637518107, 15511.844881551182, 11843.940780296087, 14078.78881816771, 14220.288985550707, 14248.21634810085, 14269.714605707879, 699.2064007351642, 817.9304759095484, 818.4843548564396, 818.4843548564426, 820.2781552234055, 810.2950433123161, 814.4624547798454, 815.2092470303796, 816.603947085663, 819.573821612761, 831.3224721851702, 846.2045677063571, 849.3163003781953, 861.8147098373848, 861.9827603447927, 828.8093738440132, 850.2730165708323, 854.7051267312767, 855.285836326668, 855.4857901514316, 630.9337519560472, 631.5137344244952, 637.8469167399791, 638.7381173718753, 639.0605809460086, 12836.0, 12848.293343866084, 12863.099583029192, 12891.226526408353, 13747.175169489763, 13436.395362208725, 13515.66210844727, 13557.170416720806, 13687.863121368859, 13875.37560809766, 11477.713057173554, 11608.24546404481, 11686.532538698442, 11846.348450835201, 12052.214936830283, 3725.2549490102087, 3731.197792474631, 3926.018495376156, 3957.3866050762176, 3957.663598594123, 84710.0, 84751.57624211902, 86709.56645216733, 87409.0, 87537.0, 10416.947915260374, 10699.358038517714, 11057.447127643585, 11097.44512774358, 11210.27133236337, 20898.0, 21448.24931127403, 21625.026873790717, 21645.458863528536, 21901.561968760536, 7677.961610192025, 7754.224577542201, 7757.844843103219, 7854.0, 7949.761507154794, 4187.5184353799095, 4213.094184750294, 4232.4286221360335, 4319.805608747614, 4321.643641516145, 3450.189205536697, 3548.30807992439, 3555.982220088883, 3678.31951089044, 3857.3828187489867, 680.8604236131581, 692.3630260160664, 703.7712743358327, 709.5671640299413, 715.4312321704258, 552.9162840832014, 586.9823905282848, 602.5270162922085, 614.9902634821032, 643.3649878188273, 9045.547722613843, 9815.165710914509, 9817.361871478332, 10034.0, 10157.847632285522, 525.4062908912904, 613.965468186099, 617.8723829012071, 621.65498148528, 625.5527297981873, 4149.688773342012, 4153.460050193456, 4162.41726158338, 4278.229918614679, 4453.0648563801315, 107412.0, 109850.45074774735, 113314.86685133043, 113691.4315428434, 114574.28138577928, 95590.52204738931, 96636.51681741686, 100265.99734002713, 101099.0, 101897.0, 74068.0, 87101.0, 88314.55842720874, 89916.75208119849, 90273.0, 8052.5571093590415, 8199.139090395423, 8860.3797734158, 8930.776730581787, 9031.593578288861, 52415.73792131015, 52442.68893277698, 52809.73595132, 54479.45520544903, 55535.72232138814, 52635.15776947788, 58269.0, 59495.81008379895, 62501.06248406187, 68010.65994669995, 11398.430078495876, 11489.368084755419, 11512.481938312629, 11522.13583981188, 11546.538138474367, 10931.96146366094, 11964.282143071443, 12087.637370878536, 12464.563740269046, 12551.560695375983, 11743.471543780379, 12112.091593130726, 12127.029837613147, 13069.215847048827, 13077.084604078003, 12732.363381830686, 12901.419436125585, 13026.60369699298, 13280.867191327963, 13502.982345712127, 12394.504219831106, 12422.813657794959, 12588.433520491417, 12720.300383478627, 13128.474861005452, 8188.385871059575, 10625.521851516545, 10771.19216058783, 10782.730431738955, 10879.0, 9150.0, 9446.763830904283, 9961.900380996387, 10870.92091018398, 11075.042200625448], "value": 7194.611263443609, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1602.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 116.0, 115.0, 114.0, 115.0, 117.0, 117.0, 96.0, 173.0], "value": 118.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 128.0, 118.0, 174.0, 113.0, 115.0, 114.0, 113.0, 144.0, 117.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 210.0, 193.0, 244.0, 177.0, 267.0, 281.0, 207.0, 193.0, 199.0], "value": 217.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 60.0, 85.0, 60.0, 69.0, 83.0, 83.0, 71.0, 70.0], "value": 71.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 91.0, 96.0, 71.0, 71.0, 72.0, 58.0, 58.0, 85.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 92.0, 90.0, 92.0, 126.0, 93.0, 88.0, 112.0, 132.0], "value": 109.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 98.0, 96.0, 97.0, 97.0, 97.0, 149.0, 153.0, 96.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 90.0, 134.0, 134.0, 111.0, 138.0, 106.0, 76.0, 119.0, 117.0], "value": 112.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 55.0, 57.0, 58.0, 59.0, 57.0, 60.0, 67.0, 62.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 90.0, 69.0, 93.0, 128.0, 114.0, 105.0, 72.0, 74.0, 73.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 89.0, 89.0, 89.0, 90.0, 89.0, 93.0, 90.0, 89.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 157.0, 155.0, 173.0, 155.0, 161.0, 162.0, 201.0, 166.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 212.0, 243.0, 192.0, 176.0, 177.0, 175.0, 176.0, 171.0, 194.0], "value": 189.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 71.0, 68.0, 69.0, 68.0, 67.0, 69.0, 72.0, 77.0], "value": 69.9, "unit": "score"}]}]} 21:14:20 INFO - Return code: 0 21:14:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:14:20 ERROR - # TBPL SUCCESS # 21:14:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:14:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:14:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:14:20 INFO - 2016-10-31 21:14:20.848 screenresolution[6453:120509] starting screenresolution argv=screenresolution get 21:14:20 INFO - 2016-10-31 21:14:20.851 screenresolution[6453:120509] Display 0: 1600x1200x32@60 21:14:20 INFO - 2016-10-31 21:14:20.857 screenresolution[6454:120512] starting screenresolution argv=screenresolution list 21:14:20 INFO - Available Modes on Display 0 21:14:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:14:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:14:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:14:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:14:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:14:21 INFO - Intel Iris: 21:14:21 INFO - Chipset Model: Intel Iris 21:14:21 INFO - Type: GPU 21:14:21 INFO - Bus: Built-In 21:14:21 INFO - VRAM (Dynamic, Max): 1536 MB 21:14:21 INFO - Vendor: Intel (0x8086) 21:14:21 INFO - Device ID: 0x0a2e 21:14:21 INFO - Revision ID: 0x0009 21:14:21 INFO - Displays: 21:14:21 INFO - Display: 21:14:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:14:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:14:21 INFO - Display Serial Number: 1600x1200 60 21:14:21 INFO - Main Display: Yes 21:14:21 INFO - Mirror: Off 21:14:21 INFO - Online: Yes 21:14:21 INFO - Rotation: Supported 21:14:21 INFO - Return code: 0 21:14:21 INFO - Running post-action listener: _resource_record_post_action 21:14:21 INFO - [mozharness: 2016-11-01 04:14:21.086886Z] Finished run-tests step (success) 21:14:21 INFO - Running post-run listener: _resource_record_post_run 21:14:21 INFO - Total resource usage - Wall time: 1212s; CPU: 55.0%; Read bytes: 2120704; Write bytes: 715141632; Read time: 29; Write time: 1945 21:14:21 INFO - TinderboxPrint: CPU usage
54.6% 21:14:21 INFO - TinderboxPrint: I/O read bytes / time
2,120,704 / 29 21:14:21 INFO - TinderboxPrint: I/O write bytes / time
715,141,632 / 1,945 21:14:21 INFO - TinderboxPrint: CPU idle
2,202.4 (45.4%) 21:14:21 INFO - TinderboxPrint: CPU system
983.2 (20.3%) 21:14:21 INFO - TinderboxPrint: CPU user
1,664.2 (34.3%) 21:14:21 INFO - TinderboxPrint: Swap in / out
409,493,504 / 0 21:14:21 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 389319168; Write bytes: 384415744; Read time: 28876; Write time: 789 21:14:21 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 2120704; Write bytes: 304806400; Read time: 29; Write time: 1093 21:14:21 INFO - Running post-run listener: _upload_blobber_files 21:14:21 INFO - Blob upload gear active. 21:14:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:14:21 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 21:14:21 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'] 21:14:21 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 21:14:22 INFO - (blobuploader) - INFO - Open directory for files ... 21:14:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:14:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:14:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:14:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:14:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:14:23 INFO - (blobuploader) - INFO - Done attempting. 21:14:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:14:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:14:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:14:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:14:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:14:24 INFO - (blobuploader) - INFO - Done attempting. 21:14:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:14:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:14:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:14:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:14:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:14:27 INFO - (blobuploader) - INFO - Done attempting. 21:14:27 INFO - (blobuploader) - INFO - Iteration through files over. 21:14:27 INFO - Return code: 0 21:14:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:14:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:14:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76d77d6d2dc27f9403421ec228383b41ac2e777eb0ca0acaba483fcd172c0b3c7d257bbbbccd911c4125aef236eb4abe0da60656f026980aa8f24353e427806f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/538fdf8fdbf4b5a3022b677270700cf47aa604f8c1848c421b60d8da1e98453b027195061c0d4526640559251f71420a5970d52c179530f919c3830f6971f272", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/083566a2f80905e7ab09755984d8536eb3c505dfef3abe85945842d9ae1d9ac1c1cfa0819401d45d0177cd640f47af783719e0faed1b01bb4fcc1ad8beba9046"} 21:14:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:14:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:14:27 INFO - Contents: 21:14:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76d77d6d2dc27f9403421ec228383b41ac2e777eb0ca0acaba483fcd172c0b3c7d257bbbbccd911c4125aef236eb4abe0da60656f026980aa8f24353e427806f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/538fdf8fdbf4b5a3022b677270700cf47aa604f8c1848c421b60d8da1e98453b027195061c0d4526640559251f71420a5970d52c179530f919c3830f6971f272", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/083566a2f80905e7ab09755984d8536eb3c505dfef3abe85945842d9ae1d9ac1c1cfa0819401d45d0177cd640f47af783719e0faed1b01bb4fcc1ad8beba9046"} 21:14:27 INFO - Running post-run listener: copy_logs_to_upload_dir 21:14:27 INFO - Copying logs to upload dir... 21:14:27 INFO - mkdir: /builds/slave/test/build/upload/logs 21:14:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.103960 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-31 21:14:27.335093) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 21:14:27.339532) ========= 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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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/76d77d6d2dc27f9403421ec228383b41ac2e777eb0ca0acaba483fcd172c0b3c7d257bbbbccd911c4125aef236eb4abe0da60656f026980aa8f24353e427806f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/538fdf8fdbf4b5a3022b677270700cf47aa604f8c1848c421b60d8da1e98453b027195061c0d4526640559251f71420a5970d52c179530f919c3830f6971f272", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/083566a2f80905e7ab09755984d8536eb3c505dfef3abe85945842d9ae1d9ac1c1cfa0819401d45d0177cd640f47af783719e0faed1b01bb4fcc1ad8beba9046"} build_url:https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76d77d6d2dc27f9403421ec228383b41ac2e777eb0ca0acaba483fcd172c0b3c7d257bbbbccd911c4125aef236eb4abe0da60656f026980aa8f24353e427806f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/538fdf8fdbf4b5a3022b677270700cf47aa604f8c1848c421b60d8da1e98453b027195061c0d4526640559251f71420a5970d52c179530f919c3830f6971f272", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/083566a2f80905e7ab09755984d8536eb3c505dfef3abe85945842d9ae1d9ac1c1cfa0819401d45d0177cd640f47af783719e0faed1b01bb4fcc1ad8beba9046"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 21:14:27.383097) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:14:27.383450) ========= 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.uy8qKlW4Tw/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.Yb3FgZiKkq/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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.005362 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:14:27.435789) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 21:14:27.436451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 21:14:27.437077) ========= ========= Total master_lag: 0.21 =========