builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0257 starttime: 1479951340.54 results: success (0) buildid: 20161123152836 builduid: 23500bd4b7b94cb7a441fd33b1658309 revision: 0b84bed45174c7ef5ead3f0285e8201892b4d20c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 17:35:40.538140) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 17:35:40.538589) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 17:35:40.538862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 17:35:40.564903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:35:40.565253) ========= 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.I9SwIZXfUt/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.czfZ3EFobZ/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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-11-23 17:35:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.0M=0s 2016-11-23 17:35:40 (29.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082587 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:35:40.671629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:35:40.671942) ========= 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.I9SwIZXfUt/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.czfZ3EFobZ/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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.024479 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:35:40.720804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 17:35:40.723561) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0b84bed45174c7ef5ead3f0285e8201892b4d20c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0b84bed45174c7ef5ead3f0285e8201892b4d20c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.I9SwIZXfUt/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.czfZ3EFobZ/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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-11-23 17:35:40,821 truncating revision to first 12 chars 2016-11-23 17:35:40,821 Setting DEBUG logging. 2016-11-23 17:35:40,821 attempt 1/10 2016-11-23 17:35:40,821 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0b84bed45174?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 17:35:41,551 unpacking tar archive at: mozilla-aurora-0b84bed45174/testing/mozharness/ program finished with exit code 0 elapsedTime=1.006867 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 17:35:41.753960) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 17:35:41.754292) ========= script_repo_revision: 0b84bed45174c7ef5ead3f0285e8201892b4d20c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 17:35:41.754669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 17:35:41.754933) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 17:35:41.774526) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-23 17:35:41.774945) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.I9SwIZXfUt/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.czfZ3EFobZ/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 17:35:41 INFO - MultiFileLogger online at 20161123 17:35:41 in /builds/slave/test 17:35:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:35:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:35:41 INFO - {'append_to_log': False, 17:35:41 INFO - 'base_work_dir': '/builds/slave/test', 17:35:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:35:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:35:41 INFO - 'branch': 'Mozilla-Aurora', 17:35:41 INFO - 'buildbot_json_path': 'buildprops.json', 17:35:41 INFO - 'config_files': ('talos/mac_config.py',), 17:35:41 INFO - 'default_actions': ('clobber', 17:35:41 INFO - 'read-buildbot-config', 17:35:41 INFO - 'download-and-extract', 17:35:41 INFO - 'populate-webroot', 17:35:41 INFO - 'create-virtualenv', 17:35:41 INFO - 'install', 17:35:41 INFO - 'run-tests'), 17:35:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:35:41 INFO - 'download_minidump_stackwalk': True, 17:35:41 INFO - 'download_symbols': 'ondemand', 17:35:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:35:41 INFO - 'tooltool.py': '/tools/tooltool.py', 17:35:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:35:41 INFO - '/tools/misc-python/virtualenv.py')}, 17:35:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:35:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:35:41 INFO - 'installer_path': 'installer.exe', 17:35:41 INFO - 'log_level': 'info', 17:35:41 INFO - 'log_name': 'talos', 17:35:41 INFO - 'log_to_console': True, 17:35:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:35:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:35:41 INFO - 'opt_config_files': (), 17:35:41 INFO - 'pip_index': False, 17:35:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:35:41 INFO - 'cmd': ('bash', 17:35:41 INFO - '-c', 17:35:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:35:41 INFO - 'enabled': True, 17:35:41 INFO - 'halt_on_failure': False, 17:35:41 INFO - 'name': 'check_screen_resolution'},), 17:35:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:35:41 INFO - 'cmd': ('bash', 17:35:41 INFO - '-c', 17:35:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:35:41 INFO - 'enabled': True, 17:35:41 INFO - 'halt_on_failure': False, 17:35:41 INFO - 'name': 'check_screen_resolution'},), 17:35:41 INFO - 'run_cmd_checks_enabled': True, 17:35:41 INFO - 'sps_profile': False, 17:35:41 INFO - 'sps_profile_interval': 0, 17:35:41 INFO - 'suite': 'dromaeojs', 17:35:41 INFO - 'system_bits': '32', 17:35:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:35:41 INFO - 'title': 't-yosemite-r7-0257', 17:35:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:35:41 INFO - 'use_talos_json': True, 17:35:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:35:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:35:41 INFO - 'work_dir': 'build'} 17:35:41 INFO - [mozharness: 2016-11-24 01:35:41.976804Z] Running clobber step. 17:35:41 INFO - Running pre-action listener: _resource_record_pre_action 17:35:41 INFO - Running main action method: clobber 17:35:41 INFO - rmtree: /builds/slave/test/build 17:35:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:35:44 INFO - Running post-action listener: _resource_record_post_action 17:35:44 INFO - [mozharness: 2016-11-24 01:35:44.238925Z] Finished clobber step (success) 17:35:44 INFO - [mozharness: 2016-11-24 01:35:44.239059Z] Running read-buildbot-config step. 17:35:44 INFO - Running pre-action listener: _resource_record_pre_action 17:35:44 INFO - Running main action method: read_buildbot_config 17:35:44 INFO - Using buildbot properties: 17:35:44 INFO - { 17:35:44 INFO - "project": "", 17:35:44 INFO - "product": "firefox", 17:35:44 INFO - "script_repo_revision": "production", 17:35:44 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 17:35:44 INFO - "repository": "", 17:35:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 17:35:44 INFO - "buildid": "20161123152836", 17:35:44 INFO - "pgo_build": "False", 17:35:44 INFO - "basedir": "/builds/slave/test", 17:35:44 INFO - "buildnumber": 38, 17:35:44 INFO - "slavename": "t-yosemite-r7-0257", 17:35:44 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 17:35:44 INFO - "platform": "yosemite_r7", 17:35:44 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 17:35:44 INFO - "branch": "mozilla-aurora", 17:35:44 INFO - "repo_path": "releases/mozilla-aurora", 17:35:44 INFO - "revision": "0b84bed45174c7ef5ead3f0285e8201892b4d20c", 17:35:44 INFO - "stage_platform": "macosx64", 17:35:44 INFO - "builduid": "23500bd4b7b94cb7a441fd33b1658309", 17:35:44 INFO - "slavebuilddir": "test" 17:35:44 INFO - } 17:35:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 17:35:44 INFO - Running post-action listener: _resource_record_post_action 17:35:44 INFO - [mozharness: 2016-11-24 01:35:44.242559Z] Finished read-buildbot-config step (success) 17:35:44 INFO - [mozharness: 2016-11-24 01:35:44.242665Z] Running download-and-extract step. 17:35:44 INFO - Running pre-action listener: _resource_record_pre_action 17:35:44 INFO - Running main action method: download_and_extract 17:35:44 INFO - mkdir: /builds/slave/test/build/tests 17:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:44 INFO - trying https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 17:35:44 INFO - Downloading https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 17:35:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 17:35:45 INFO - Downloaded 1199 bytes. 17:35:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 17:35:45 INFO - Using the following test package requirements: 17:35:45 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 17:35:45 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:35:45 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 17:35:45 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:35:45 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 17:35:45 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:35:45 INFO - u'jsshell-mac.zip'], 17:35:45 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:35:45 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 17:35:45 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 17:35:45 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:35:45 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 17:35:45 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:35:45 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 17:35:45 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:35:45 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 17:35:45 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:35:45 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 17:35:45 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 17:35:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 17:35:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:35:45 INFO - Fetch https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 17:35:45 INFO - Http code: 200 17:35:45 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 17:35:45 INFO - x-amz-cf-id: 4zQ_0MIeCF6pn1KDQtlF6cI7Awc89bHFpyoSlHFAoL6QUt7cTS0cww== 17:35:45 INFO - x-amz-version-id: EChwgxu0B_MMBn7mJpskuv3I0qug8Cae 17:35:46 INFO - Expected file size: 16278307 17:35:46 INFO - Obtained file size: 16278307 17:35:52 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 17:35:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 17:35:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:35:52 INFO - Fetch https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 17:35:53 INFO - Http code: 200 17:35:53 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 17:35:53 INFO - x-amz-cf-id: ksEXJOj5qPY-IPRzbFwHVh2EdHzx9wmSCyA1l_FNRaSPKCPiOkMbyw== 17:35:53 INFO - x-amz-version-id: EChwgxu0B_MMBn7mJpskuv3I0qug8Cae 17:35:53 INFO - Expected file size: 16278307 17:35:53 INFO - Obtained file size: 16278307 17:35:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 17:35:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 17:35:59 INFO - Fetch https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 17:36:00 INFO - Http code: 200 17:36:00 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 17:36:00 INFO - x-amz-cf-id: TzUzAPtmtZDlTyTATVAi8iix-re7oWpcS_vf8ZB8nCYWi685cXSuwA== 17:36:00 INFO - x-amz-version-id: vahCBZ3xyCTIlrtDbpefxvHbMPR3De2J 17:36:00 INFO - Expected file size: 14409038 17:36:00 INFO - Obtained file size: 14409038 17:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:01 INFO - trying https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 17:36:01 INFO - Downloading https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 17:36:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 17:36:03 INFO - Downloaded 109692371 bytes. 17:36:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 17:36:03 INFO - mkdir: /builds/slave/test/properties 17:36:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:36:03 INFO - Writing to file /builds/slave/test/properties/build_url 17:36:03 INFO - Contents: 17:36:03 INFO - build_url:https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 17:36:04 INFO - Running post-action listener: _resource_record_post_action 17:36:04 INFO - Running post-action listener: set_extra_try_arguments 17:36:04 INFO - [mozharness: 2016-11-24 01:36:04.525684Z] Finished download-and-extract step (success) 17:36:04 INFO - [mozharness: 2016-11-24 01:36:04.525836Z] Running populate-webroot step. 17:36:04 INFO - Running pre-action listener: _resource_record_pre_action 17:36:04 INFO - Running main action method: populate_webroot 17:36:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:36:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:36:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:36:04 INFO - '--tppagecycles', 17:36:04 INFO - '7'], 17:36:04 INFO - 'tests': ['tsvgm']}}, 17:36:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:36:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:36:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:36:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:36:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:36:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:36:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:04 INFO - 'talos_options': ['--disable-e10s'], 17:36:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:04 INFO - 'talos_options': ['--disable-e10s'], 17:36:04 INFO - 'tests': ['damp', 'tps']}, 17:36:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:04 INFO - 'tests': ['damp', 'tps']}, 17:36:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:36:04 INFO - 'tests': ['dromaeo_dom']}, 17:36:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:36:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:36:04 INFO - 'tests': ['basic_compositor_video']}, 17:36:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:36:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:36:04 INFO - 'tests': ['a11yr', 17:36:04 INFO - 'ts_paint', 17:36:04 INFO - 'tpaint', 17:36:04 INFO - 'sessionrestore', 17:36:04 INFO - 'sessionrestore_no_auto_restore', 17:36:04 INFO - 'tabpaint']}, 17:36:04 INFO - 'other-e10s': {'tests': ['a11yr', 17:36:04 INFO - 'ts_paint', 17:36:04 INFO - 'tpaint', 17:36:04 INFO - 'sessionrestore', 17:36:04 INFO - 'sessionrestore_no_auto_restore', 17:36:04 INFO - 'tabpaint']}, 17:36:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:36:04 INFO - 'ts_paint', 17:36:04 INFO - 'tpaint', 17:36:04 INFO - 'sessionrestore', 17:36:04 INFO - 'sessionrestore_no_auto_restore', 17:36:04 INFO - 'tabpaint']}, 17:36:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:36:04 INFO - 'ts_paint', 17:36:04 INFO - 'tpaint', 17:36:04 INFO - 'sessionrestore', 17:36:04 INFO - 'sessionrestore_no_auto_restore', 17:36:04 INFO - 'tabpaint']}, 17:36:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:36:04 INFO - 'tests': ['a11yr', 17:36:04 INFO - 'ts_paint', 17:36:04 INFO - 'tpaint', 17:36:04 INFO - 'sessionrestore', 17:36:04 INFO - 'sessionrestore_no_auto_restore', 17:36:04 INFO - 'tabpaint']}, 17:36:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:36:04 INFO - 'tests': ['a11yr', 17:36:04 INFO - 'ts_paint', 17:36:04 INFO - 'tpaint', 17:36:04 INFO - 'sessionrestore', 17:36:04 INFO - 'sessionrestore_no_auto_restore', 17:36:04 INFO - 'tabpaint']}, 17:36:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:36:04 INFO - 'tests': ['tsvgx', 17:36:04 INFO - 'tsvgr_opacity', 17:36:04 INFO - 'tart', 17:36:04 INFO - 'tscrollx', 17:36:04 INFO - 'cart']}, 17:36:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:36:04 INFO - 'tsvgr_opacity', 17:36:04 INFO - 'tart', 17:36:04 INFO - 'tscrollx', 17:36:04 INFO - 'cart']}, 17:36:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:04 INFO - 'talos_options': ['--disable-e10s'], 17:36:04 INFO - 'tests': ['tp5o']}, 17:36:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:04 INFO - 'tests': ['tp5o']}, 17:36:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:04 INFO - 'talos_options': ['--disable-e10s', 17:36:04 INFO - '--xperf_path', 17:36:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:04 INFO - 'tests': ['tp5n']}, 17:36:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:04 INFO - 'talos_options': ['--xperf_path', 17:36:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:04 INFO - 'tests': ['tp5n']}}, 17:36:04 INFO - 'talos.zip': {'path': '', 17:36:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:36:04 INFO - Running post-action listener: _resource_record_post_action 17:36:04 INFO - [mozharness: 2016-11-24 01:36:04.544738Z] Finished populate-webroot step (success) 17:36:04 INFO - [mozharness: 2016-11-24 01:36:04.544875Z] Running create-virtualenv step. 17:36:04 INFO - Running pre-action listener: _resource_record_pre_action 17:36:04 INFO - Running main action method: create_virtualenv 17:36:04 INFO - Creating virtualenv /builds/slave/test/build/venv 17:36:04 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 17:36:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:36:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:36:04 INFO - Using real prefix '/tools/python27' 17:36:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:36:05 INFO - Installing distribute.............................................................................................................................................................................................done. 17:36:08 INFO - Installing pip.................done. 17:36:08 INFO - Return code: 0 17:36:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:36:08 INFO - Reading from file tmpfile_stdout 17:36:08 INFO - Output received: 17:36:08 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) 17:36:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:36:08 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')]} 17:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:08 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')]} 17:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:08 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 0x100c71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100be7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa060da8e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a85d30>, '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 0x1008ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7db20>, '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.I9SwIZXfUt/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.czfZ3EFobZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 17:36:08 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 17:36:08 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 17:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9SwIZXfUt/Render', 17:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:08 INFO - 'HOME': '/Users/cltbld', 17:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:08 INFO - 'LOGNAME': 'cltbld', 17:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:08 INFO - 'MOZ_NO_REMOTE': '1', 17:36:08 INFO - 'NO_EM_RESTART': '1', 17:36:08 INFO - 'PAGER': '/bin/cat', 17:36:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:08 INFO - 'PWD': '/builds/slave/test', 17:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:08 INFO - 'SHELL': '/bin/bash', 17:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.czfZ3EFobZ/Listeners', 17:36:08 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 17:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:08 INFO - 'USER': 'cltbld', 17:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:08 INFO - 'XPC_FLAGS': '0x0', 17:36:08 INFO - 'XPC_SERVICE_NAME': '0', 17:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:08 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 17:36:08 INFO - Cleaning up... 17:36:08 INFO - Return code: 0 17:36:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:36:08 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')]} 17:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:08 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')]} 17:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:08 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 0x100c71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100be7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa060da8e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a85d30>, '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 0x1008ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7db20>, '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.I9SwIZXfUt/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.czfZ3EFobZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 17:36:08 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 17:36:08 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 17:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9SwIZXfUt/Render', 17:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:08 INFO - 'HOME': '/Users/cltbld', 17:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:08 INFO - 'LOGNAME': 'cltbld', 17:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:08 INFO - 'MOZ_NO_REMOTE': '1', 17:36:08 INFO - 'NO_EM_RESTART': '1', 17:36:08 INFO - 'PAGER': '/bin/cat', 17:36:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:08 INFO - 'PWD': '/builds/slave/test', 17:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:08 INFO - 'SHELL': '/bin/bash', 17:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.czfZ3EFobZ/Listeners', 17:36:08 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 17:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:08 INFO - 'USER': 'cltbld', 17:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:08 INFO - 'XPC_FLAGS': '0x0', 17:36:08 INFO - 'XPC_SERVICE_NAME': '0', 17:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:09 INFO - Downloading/unpacking psutil>=3.1.1 17:36:09 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 17:36:09 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 17:36:09 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 17:36:09 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 17:36:09 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 17:36:09 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 17:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:36:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:12 INFO - Installing collected packages: psutil 17:36:12 INFO - Running setup.py install for psutil 17:36:12 INFO - building 'psutil._psutil_osx' extension 17:36:12 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 17:36:13 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 17:36:13 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 17:36:13 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 17:36:13 INFO - building 'psutil._psutil_posix' extension 17:36:13 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 17:36:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:36:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:36:13 INFO - ^ 17:36:13 INFO - 1 warning generated. 17:36:13 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 17:36:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:13 INFO - Successfully installed psutil 17:36:13 INFO - Cleaning up... 17:36:13 INFO - Return code: 0 17:36:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:13 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 0x100c71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100be7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa060da8e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a85d30>, '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 0x1008ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7db20>, '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.I9SwIZXfUt/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.czfZ3EFobZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 17:36:13 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 17:36:13 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 17:36:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9SwIZXfUt/Render', 17:36:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:13 INFO - 'HOME': '/Users/cltbld', 17:36:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:13 INFO - 'LOGNAME': 'cltbld', 17:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:13 INFO - 'MOZ_NO_REMOTE': '1', 17:36:13 INFO - 'NO_EM_RESTART': '1', 17:36:13 INFO - 'PAGER': '/bin/cat', 17:36:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:13 INFO - 'PWD': '/builds/slave/test', 17:36:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:13 INFO - 'SHELL': '/bin/bash', 17:36:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.czfZ3EFobZ/Listeners', 17:36:13 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 17:36:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:13 INFO - 'USER': 'cltbld', 17:36:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:13 INFO - 'XPC_FLAGS': '0x0', 17:36:13 INFO - 'XPC_SERVICE_NAME': '0', 17:36:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:36:13 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 17:36:13 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 17:36:13 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 17:36:13 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 17:36:13 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 17:36:13 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 17:36:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:36:16 INFO - Installing collected packages: mozsystemmonitor 17:36:16 INFO - Running setup.py install for mozsystemmonitor 17:36:16 INFO - Successfully installed mozsystemmonitor 17:36:16 INFO - Cleaning up... 17:36:16 INFO - Return code: 0 17:36:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100be7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa060da8e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a85d30>, '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 0x1008ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7db20>, '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.I9SwIZXfUt/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.czfZ3EFobZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 17:36:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:36:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9SwIZXfUt/Render', 17:36:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:16 INFO - 'HOME': '/Users/cltbld', 17:36:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:16 INFO - 'LOGNAME': 'cltbld', 17:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:16 INFO - 'MOZ_NO_REMOTE': '1', 17:36:16 INFO - 'NO_EM_RESTART': '1', 17:36:16 INFO - 'PAGER': '/bin/cat', 17:36:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:16 INFO - 'PWD': '/builds/slave/test', 17:36:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:16 INFO - 'SHELL': '/bin/bash', 17:36:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.czfZ3EFobZ/Listeners', 17:36:16 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 17:36:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:16 INFO - 'USER': 'cltbld', 17:36:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:16 INFO - 'XPC_FLAGS': '0x0', 17:36:16 INFO - 'XPC_SERVICE_NAME': '0', 17:36:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:17 INFO - Downloading/unpacking jsonschema==2.5.1 17:36:17 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 17:36:17 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 17:36:17 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 17:36:17 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 17:36:17 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 17:36:17 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 17:36:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:36:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:19 INFO - Downloading functools32-3.2.3-2.tar.gz 17:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:36:20 INFO - warning: no files found matching '*.txt' 17:36:20 INFO - no previously-included directories found matching 'build' 17:36:20 INFO - no previously-included directories found matching 'dist' 17:36:20 INFO - no previously-included directories found matching '.git*' 17:36:20 INFO - Installing collected packages: jsonschema, functools32 17:36:20 INFO - Running setup.py install for functools32 17:36:20 INFO - warning: no files found matching '*.txt' 17:36:20 INFO - no previously-included directories found matching 'build' 17:36:20 INFO - no previously-included directories found matching 'dist' 17:36:20 INFO - no previously-included directories found matching '.git*' 17:36:20 INFO - Successfully installed jsonschema functools32 17:36:20 INFO - Cleaning up... 17:36:20 INFO - Return code: 0 17:36:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100be7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa060da8e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a85d30>, '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 0x1008ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7db20>, '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.I9SwIZXfUt/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.czfZ3EFobZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 17:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:36:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9SwIZXfUt/Render', 17:36:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:20 INFO - 'HOME': '/Users/cltbld', 17:36:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:20 INFO - 'LOGNAME': 'cltbld', 17:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:20 INFO - 'MOZ_NO_REMOTE': '1', 17:36:20 INFO - 'NO_EM_RESTART': '1', 17:36:20 INFO - 'PAGER': '/bin/cat', 17:36:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:20 INFO - 'PWD': '/builds/slave/test', 17:36:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:20 INFO - 'SHELL': '/bin/bash', 17:36:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.czfZ3EFobZ/Listeners', 17:36:20 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 17:36:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:20 INFO - 'USER': 'cltbld', 17:36:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:20 INFO - 'XPC_FLAGS': '0x0', 17:36:20 INFO - 'XPC_SERVICE_NAME': '0', 17:36:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:36:20 INFO - Cleaning up... 17:36:20 INFO - Return code: 0 17:36:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100be7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa060da8e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a85d30>, '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 0x1008ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7db20>, '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.I9SwIZXfUt/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.czfZ3EFobZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 17:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:36:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9SwIZXfUt/Render', 17:36:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:20 INFO - 'HOME': '/Users/cltbld', 17:36:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:20 INFO - 'LOGNAME': 'cltbld', 17:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:20 INFO - 'MOZ_NO_REMOTE': '1', 17:36:20 INFO - 'NO_EM_RESTART': '1', 17:36:20 INFO - 'PAGER': '/bin/cat', 17:36:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:20 INFO - 'PWD': '/builds/slave/test', 17:36:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:20 INFO - 'SHELL': '/bin/bash', 17:36:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.czfZ3EFobZ/Listeners', 17:36:20 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 17:36:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:20 INFO - 'USER': 'cltbld', 17:36:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:20 INFO - 'XPC_FLAGS': '0x0', 17:36:20 INFO - 'XPC_SERVICE_NAME': '0', 17:36:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:20 INFO - Downloading/unpacking blobuploader==1.2.4 17:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:23 INFO - Downloading blobuploader-1.2.4.tar.gz 17:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:36:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:36:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:24 INFO - Downloading docopt-0.6.1.tar.gz 17:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:36:24 INFO - Installing collected packages: blobuploader, requests, docopt 17:36:24 INFO - Running setup.py install for blobuploader 17:36:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:36:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:36:24 INFO - Running setup.py install for requests 17:36:25 INFO - Running setup.py install for docopt 17:36:25 INFO - Successfully installed blobuploader requests docopt 17:36:25 INFO - Cleaning up... 17:36:25 INFO - Return code: 0 17:36:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100be7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa060da8e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a85d30>, '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 0x1008ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7db20>, '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.I9SwIZXfUt/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.czfZ3EFobZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 17:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9SwIZXfUt/Render', 17:36:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:25 INFO - 'HOME': '/Users/cltbld', 17:36:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:25 INFO - 'LOGNAME': 'cltbld', 17:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:25 INFO - 'MOZ_NO_REMOTE': '1', 17:36:25 INFO - 'NO_EM_RESTART': '1', 17:36:25 INFO - 'PAGER': '/bin/cat', 17:36:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:25 INFO - 'PWD': '/builds/slave/test', 17:36:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:25 INFO - 'SHELL': '/bin/bash', 17:36:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.czfZ3EFobZ/Listeners', 17:36:25 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 17:36:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:25 INFO - 'USER': 'cltbld', 17:36:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:25 INFO - 'XPC_FLAGS': '0x0', 17:36:25 INFO - 'XPC_SERVICE_NAME': '0', 17:36:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:25 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-w81UKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:25 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-DwWTGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:26 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-I6P4po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:26 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-oJLdMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:26 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-_f2nq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:26 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-Jzcb3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:26 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-975dAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:26 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-DmxMN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:26 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-F9Wfz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:26 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-eLC2cM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:26 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-MZJaV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:26 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-1_hvJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:27 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-GcmZaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:27 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-Y0Z_Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:27 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-Z2u5Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:27 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-9aU_i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:27 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-bczOqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:36:27 INFO - Running setup.py install for manifestparser 17:36:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:36:27 INFO - Running setup.py install for mozcrash 17:36:27 INFO - Running setup.py install for mozdebug 17:36:27 INFO - Running setup.py install for mozdevice 17:36:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:36:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:36:28 INFO - Running setup.py install for mozfile 17:36:28 INFO - Running setup.py install for mozhttpd 17:36:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:36:28 INFO - Running setup.py install for mozinfo 17:36:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:36:28 INFO - Running setup.py install for mozInstall 17:36:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:36:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:36:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:36:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:36:28 INFO - Running setup.py install for mozleak 17:36:28 INFO - Running setup.py install for mozlog 17:36:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:36:29 INFO - Running setup.py install for moznetwork 17:36:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:36:29 INFO - Running setup.py install for mozprocess 17:36:29 INFO - Running setup.py install for mozprofile 17:36:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:36:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:36:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:36:29 INFO - Running setup.py install for mozrunner 17:36:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:36:29 INFO - Running setup.py install for mozscreenshot 17:36:29 INFO - Running setup.py install for moztest 17:36:30 INFO - Running setup.py install for mozversion 17:36:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:36:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:36:30 INFO - Cleaning up... 17:36:30 INFO - Return code: 0 17:36:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100be7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa060da8e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a85d30>, '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 0x1008ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7db20>, '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.I9SwIZXfUt/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.czfZ3EFobZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 17:36:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9SwIZXfUt/Render', 17:36:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:30 INFO - 'HOME': '/Users/cltbld', 17:36:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:30 INFO - 'LOGNAME': 'cltbld', 17:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:30 INFO - 'MOZ_NO_REMOTE': '1', 17:36:30 INFO - 'NO_EM_RESTART': '1', 17:36:30 INFO - 'PAGER': '/bin/cat', 17:36:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:30 INFO - 'PWD': '/builds/slave/test', 17:36:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:30 INFO - 'SHELL': '/bin/bash', 17:36:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.czfZ3EFobZ/Listeners', 17:36:30 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 17:36:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:30 INFO - 'USER': 'cltbld', 17:36:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:30 INFO - 'XPC_FLAGS': '0x0', 17:36:30 INFO - 'XPC_SERVICE_NAME': '0', 17:36:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:30 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-_lmcnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:30 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-y_q8Z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:30 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-eAwQqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:30 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-Aw0IoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:30 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)) 17:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:30 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-Ltj5vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:30 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-eAPfLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:31 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-TTVOKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:31 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-FtvE1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:31 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-FjA5vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:31 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-fOJb5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:31 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-WRPRyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:31 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-6muUQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:31 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)) 17:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:31 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-lhNtuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:31 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-yu9OLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:31 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-a8r5te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:32 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-exD08P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:32 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)) 17:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:32 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-ZUcaLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:36:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:34 INFO - Downloading blessings-1.6.tar.gz 17:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:36:34 INFO - Installing collected packages: blessings 17:36:34 INFO - Running setup.py install for blessings 17:36:35 INFO - Successfully installed blessings 17:36:35 INFO - Cleaning up... 17:36:35 INFO - Return code: 0 17:36:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:36:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:36:35 INFO - Reading from file tmpfile_stdout 17:36:35 INFO - Current package versions: 17:36:35 INFO - blessings == 1.6 17:36:35 INFO - blobuploader == 1.2.4 17:36:35 INFO - docopt == 0.6.1 17:36:35 INFO - functools32 == 3.2.3-2 17:36:35 INFO - jsonschema == 2.5.1 17:36:35 INFO - manifestparser == 1.1 17:36:35 INFO - mozInstall == 1.12 17:36:35 INFO - mozcrash == 1.0 17:36:35 INFO - mozdebug == 0.1 17:36:35 INFO - mozdevice == 0.48 17:36:35 INFO - mozfile == 1.2 17:36:35 INFO - mozhttpd == 0.7 17:36:35 INFO - mozinfo == 0.9 17:36:35 INFO - mozleak == 0.1 17:36:35 INFO - mozlog == 3.4 17:36:35 INFO - moznetwork == 0.27 17:36:35 INFO - mozprocess == 0.23 17:36:35 INFO - mozprofile == 0.28 17:36:35 INFO - mozrunner == 6.13 17:36:35 INFO - mozscreenshot == 0.1 17:36:35 INFO - mozsystemmonitor == 0.3 17:36:35 INFO - moztest == 0.7 17:36:35 INFO - mozversion == 1.4 17:36:35 INFO - psutil == 3.1.1 17:36:35 INFO - requests == 1.2.3 17:36:35 INFO - wsgiref == 0.1.2 17:36:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:36 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 0x100c71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100be7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa060da8e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a85d30>, '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 0x1008ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7db20>, '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.I9SwIZXfUt/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.czfZ3EFobZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 17:36:36 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 17:36:36 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 17:36:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9SwIZXfUt/Render', 17:36:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:36 INFO - 'HOME': '/Users/cltbld', 17:36:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:36 INFO - 'LOGNAME': 'cltbld', 17:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:36 INFO - 'MOZ_NO_REMOTE': '1', 17:36:36 INFO - 'NO_EM_RESTART': '1', 17:36:36 INFO - 'PAGER': '/bin/cat', 17:36:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:36 INFO - 'PWD': '/builds/slave/test', 17:36:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:36 INFO - 'SHELL': '/bin/bash', 17:36:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.czfZ3EFobZ/Listeners', 17:36:36 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 17:36:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:36 INFO - 'USER': 'cltbld', 17:36:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:36 INFO - 'XPC_FLAGS': '0x0', 17:36:36 INFO - 'XPC_SERVICE_NAME': '0', 17:36:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:36 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)) 17:36:36 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)) 17:36:36 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)) 17:36:36 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)) 17:36:36 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)) 17:36:36 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)) 17:36:36 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)) 17:36:36 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)) 17:36:36 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)) 17:36:36 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)) 17:36:36 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)) 17:36:36 INFO - Cleaning up... 17:36:36 INFO - Return code: 0 17:36:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:36 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 0x100c71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100be7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa060da8e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a85d30>, '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 0x1008ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7db20>, '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.I9SwIZXfUt/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.czfZ3EFobZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 17:36:36 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 17:36:36 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 17:36:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9SwIZXfUt/Render', 17:36:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:36 INFO - 'HOME': '/Users/cltbld', 17:36:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:36 INFO - 'LOGNAME': 'cltbld', 17:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:36 INFO - 'MOZ_NO_REMOTE': '1', 17:36:36 INFO - 'NO_EM_RESTART': '1', 17:36:36 INFO - 'PAGER': '/bin/cat', 17:36:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:36 INFO - 'PWD': '/builds/slave/test', 17:36:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:36 INFO - 'SHELL': '/bin/bash', 17:36:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.czfZ3EFobZ/Listeners', 17:36:36 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 17:36:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:36 INFO - 'USER': 'cltbld', 17:36:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:36 INFO - 'XPC_FLAGS': '0x0', 17:36:36 INFO - 'XPC_SERVICE_NAME': '0', 17:36:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:36:37 INFO - Cleaning up... 17:36:37 INFO - Return code: 0 17:36:37 INFO - Running post-action listener: _resource_record_post_action 17:36:37 INFO - Running post-action listener: _start_resource_monitoring 17:36:37 INFO - Starting resource monitoring. 17:36:37 INFO - [mozharness: 2016-11-24 01:36:37.185902Z] Finished create-virtualenv step (success) 17:36:37 INFO - [mozharness: 2016-11-24 01:36:37.186961Z] Running install step. 17:36:37 INFO - Running pre-action listener: _resource_record_pre_action 17:36:37 INFO - Running main action method: install 17:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:36:37 INFO - Reading from file tmpfile_stdout 17:36:37 INFO - Detecting whether we're running mozinstall >=1.0... 17:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:36:37 INFO - Reading from file tmpfile_stdout 17:36:37 INFO - Output received: 17:36:37 INFO - Usage: mozinstall [options] installer 17:36:37 INFO - Options: 17:36:37 INFO - -h, --help show this help message and exit 17:36:37 INFO - -d DEST, --destination=DEST 17:36:37 INFO - Directory to install application into. [default: 17:36:37 INFO - "/builds/slave/test"] 17:36:37 INFO - --app=APP Application being installed. [default: firefox] 17:36:37 INFO - mkdir: /builds/slave/test/build/application 17:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 17:37:09 INFO - Reading from file tmpfile_stdout 17:37:09 INFO - Output received: 17:37:09 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 17:37:09 INFO - Running post-action listener: _resource_record_post_action 17:37:09 INFO - [mozharness: 2016-11-24 01:37:09.042636Z] Finished install step (success) 17:37:09 INFO - [mozharness: 2016-11-24 01:37:09.042804Z] Running run-tests step. 17:37:09 INFO - Running pre-action listener: _resource_record_pre_action 17:37:09 INFO - Running main action method: run_tests 17:37:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:37:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:37:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:37:09 INFO - 2016-11-23 17:37:09.057 screenresolution[1638:7710] starting screenresolution argv=screenresolution get 17:37:09 INFO - 2016-11-23 17:37:09.060 screenresolution[1638:7710] Display 0: 1600x1200x32@60 17:37:09 INFO - 2016-11-23 17:37:09.066 screenresolution[1639:7713] starting screenresolution argv=screenresolution list 17:37:09 INFO - Available Modes on Display 0 17:37:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:37:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:37:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:37:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:37:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:37:09 INFO - Intel Iris: 17:37:09 INFO - Chipset Model: Intel Iris 17:37:09 INFO - Type: GPU 17:37:09 INFO - Bus: Built-In 17:37:09 INFO - VRAM (Dynamic, Max): 1536 MB 17:37:09 INFO - Vendor: Intel (0x8086) 17:37:09 INFO - Device ID: 0x0a2e 17:37:09 INFO - Revision ID: 0x0009 17:37:09 INFO - Displays: 17:37:09 INFO - Display: 17:37:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:37:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:37:09 INFO - Display Serial Number: 1600x1200 60 17:37:09 INFO - Main Display: Yes 17:37:09 INFO - Mirror: Off 17:37:09 INFO - Online: Yes 17:37:09 INFO - Rotation: Supported 17:37:09 INFO - Return code: 0 17:37:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:37:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:37:09 INFO - Python 2.7.3 17:37:09 INFO - Return code: 0 17:37:09 INFO - grabbing minidump binary from tooltool 17:37:09 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')]} 17:37:09 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 0x100a85d30>, '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 0x1008ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:37:09 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 17:37:09 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 17:37:09 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 17:37:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:37:09 INFO - Return code: 0 17:37:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:37:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:37:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:37:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:37:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:37:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0257', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:37:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0257 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:37:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9SwIZXfUt/Render', 17:37:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:09 INFO - 'HOME': '/Users/cltbld', 17:37:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:09 INFO - 'LOGNAME': 'cltbld', 17:37:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:37:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:09 INFO - 'MOZ_NO_REMOTE': '1', 17:37:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:37:09 INFO - 'NO_EM_RESTART': '1', 17:37:09 INFO - 'PAGER': '/bin/cat', 17:37:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:09 INFO - 'PWD': '/builds/slave/test', 17:37:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:37:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:09 INFO - 'SHELL': '/bin/bash', 17:37:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.czfZ3EFobZ/Listeners', 17:37:09 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 17:37:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:09 INFO - 'USER': 'cltbld', 17:37:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:09 INFO - 'XPC_FLAGS': '0x0', 17:37:09 INFO - 'XPC_SERVICE_NAME': '0', 17:37:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0257', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:37:09 INFO - mozversion application_buildid: 20161123152836 17:37:09 INFO - mozversion application_changeset: 0b84bed45174c7ef5ead3f0285e8201892b4d20c 17:37:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:37:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:37:09 INFO - mozversion application_name: Firefox 17:37:09 INFO - mozversion application_remotingname: firefox-dev 17:37:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:37:09 INFO - mozversion application_vendor: Mozilla 17:37:09 INFO - mozversion application_version: 52.0a2 17:37:09 INFO - mozversion platform_buildid: 20161123152836 17:37:09 INFO - mozversion platform_changeset: 0b84bed45174c7ef5ead3f0285e8201892b4d20c 17:37:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:37:09 INFO - mozversion platform_version: 52.0a2 17:37:09 INFO - using testdate: 1479951429 17:37:09 INFO - actual date: 1479951429 17:37:09 INFO - starting webserver on 'localhost:49248' 17:37:09 INFO - SUITE-START | Running 2 tests 17:37:09 INFO - TEST-START | dromaeo_css 17:37:09 INFO - operating with platform_type : mac_ 17:37:09 INFO - Initialising browser for dromaeo_css test... 17:37:09 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/tmpwIRqF1/profile http://localhost:49248/getInfo.html) 17:37:11 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 17:37:12 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 17:37:12 INFO - PROCESS | 1649 | colorDepth:24 17:37:12 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 17:37:12 INFO - PROCESS | 1649 | __metrics 17:37:12 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:37:12 INFO - PROCESS | 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:37:13 INFO - TEST-INFO | 1649: exit 0 17:37:13 INFO - Browser initialized. 17:37:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:37:13 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/tmpwIRqF1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:25 INFO - PROCESS | 1651 | RSS: Main: 222826496 17:37:25 INFO - PROCESS | 1651 | 17:38:16 INFO - PROCESS | 1651 | 1479951496794 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] 17:40:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 17:40:31 INFO - PROCESS | 1651 | RSS: Main: 366329856 17:40:31 INFO - PROCESS | 1651 | 17:43:34 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 17:43:35 INFO - PROCESS | 1651 | RSS: Main: 349593600 17:43:35 INFO - PROCESS | 1651 | 17:46:37 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 17:46:38 INFO - PROCESS | 1651 | RSS: Main: 315330560 17:46:38 INFO - PROCESS | 1651 | 17:49:40 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 17:49:41 INFO - PROCESS | 1651 | RSS: Main: 312455168 17:49:41 INFO - PROCESS | 1651 | 17:52:44 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 17:52:45 INFO - PROCESS | 1651 | RSS: Main: 308400128 17:52:45 INFO - PROCESS | 1651 | 17:55:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 17:55:48 INFO - PROCESS | 1651 | RSS: Main: 369360896 17:55:48 INFO - PROCESS | 1651 | 17:55:48 INFO - PROCESS | 1651 | __start_tp_report 17:55:48 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 17:55:48 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 17:55:48 INFO - PROCESS | 1651 | |i|pagename|runs| 17:55:48 INFO - PROCESS | 1651 | |0;dojo.html;3202.8398580071007;3308.586426696663;3332.583427071616;3353.9496907546377;3391.1013581400916;5603.859903502414;5655.462731040555;5668.943310566893;5705.372409035008;5717.942820571793;5605.523530499912;5690.2033715279895;5690.971545142268;5702.885942281162;5710.086386178213;5163.845084647466;5171.276021357013;5185.611079169059;5224.712640804754;5225.973870130644;5163.432022477525;5165.586753059746;5166.612504062192;5284.154535274357;5328.760205790749;5184.637075404723;5187.3775146982225;5218.425973142951;5248.68507889526;5266.710330931816;5197.818076367347;5207.166853303491;5217.2695822584865;5237.423883372826;5263.36839579253;5125.589952803767;5216.295800067019;5223.921641175385;5247.212918062283;5266.841994740125;5506.421825708323;5568.470995255444;5574.9721251393485;5635.3237611486475;5681.744321505542;6089.025755879038;6113.7803774110635;6116.908246376308;6134.355892631299;6134.816205099513;6228.657423841687;6245.56281060326;6319;6323.083152942843;6327.620342779448;5657.038303488417;5783.855403614902;5795.855103622359;5811.3026436827;5854.414558544111;6219.098230756515;6226.941419958618;6256.311805701369;6267.059941008885;6288.9056664150075;6036.63780173191;6043.576949613484;6046.969765151234;6057.57596968208;6094;6151.600145990586;6172.351903050115;6177.84555386119;6178.567500275028;6184.536159787944;5330.307060082165;5806.535477161817;6008.03871380577;6110.694465276719;6118.724657390429;6243.219597550306;6245.281792593819;6249.781257656051;6258.718357673915;6272.247330320391;3909.4135879617716;4896.2410826321975;4938.234573641092;4946.530079642428;4989.451160372356;4367.344898265285;4397.07661391105;4405.185040767404;4407.140607581491;4462.040661257845;5709.115087161496;5773.797917072966;5779.624324418899;5786.218860453869;5830.067189249699;6227.532935029891;6228;6232.0963460298;6248.375162483715;6255.40573645503;5628.352739434936;5682;5745.253117094834;5772.884542309131;5778.27771528559;5307.442718514578;5347;5395.865103372368;5400.891982160335;5426.511613954763;6176.35148309421;6219.533534984985;6228.906566401417;6246.219222597176;6255.46828519581;6230.408111229426;6251.499880009497;6254.249490061222;6292.11910332563;6298.622082675054;6004;6182.505399568114;6195.721192546436;6208.068789681584;6224.657643829632;6195.19462469876;6199.442050215503;6200.937990620217;6212.223472065992;6212.4408803207925;5272.209168624737;6238.313785483684;6251.031090181029;6262.5929314594405;6266.154069200599;5953.345132035386;5994.67029313392;6036;6059.272887253558;6073.48375388097;6074.331823499323;6102.816915492543;6129.724162412613;6136.048912418404;6140.355262697352;5811.94188058114;5951.285845698544;5966.49284810796;6031.035034394651;6038.909416358671;5136.2552429898205;5909.084091965752;6040.546958978006;6064.575479716377;6176.4441200292185;5939.613925094855;6026.246719160105;6034.426729460694;6050.546209034252;6077.997130473423 17:55:48 INFO - PROCESS | 1651 | |1;ext.html;456.33830945129563;480.25080873836816;524.8031988004499;534.268052767708;554.9916751248729;29972.700272997263;39187;40361.798191009075;40382;40520;34777.65222347776;35410.93767186982;41294.7935260324;41667.37498937511;41671.95820104499;9308.674196403144;9466.763330916749;9487.051294870493;9489.240860731124;9504.524773761319;8193.590320483952;9357.719268421959;9367.437953722798;9473.43159410434;9474.905250947506;8200.671973121098;9446.81106377872;9464.526773661324;9495.145436910676;9515.333926625139;9406.764830879249;9468.100530449596;9481.146696797286;9481.810363792754;9489.857652135224;9202.619607058929;9295.48874811885;9315.72052838416;9317.813643727088;9325.393849399836;39510.80244598787;39679.40480892789;39777.40333894994;39831.4025289618;39995.40006899899;3078.6459557150993;3218.4206842768294;3386.153461634591;3515.455104458813;3525.665061819149;29074.216525639466;29723.851380743174;29758.107256782332;30171;30217.546736798966;3152.1646763607664;3157.5579418881375;3224.3228921926425;3257.1042963185077;3261.4944683574086;476987;480747;480822;481542;486772;58814.41185588175;59193.81612367729;59264.40735592589;59412;59471.40528594659;34252.486212706826;35134;35146;35724.74963376321;35737.1065723359;16450.177491125396;16577.751333730004;16602.50192494227;16604.58488537772;16664.333426662797;12620.485541734866;12740.55408060732;12745;12760.10679252462;12762.361881906054;15389.461368852037;18621.06894655262;18637.534061648297;18641.347552835585;18704.906475467807;6436.388543088399;6497.675116244169;7393.852122957511;7512.887306690404;7597.620118994028;809.9149589293157;849.4478588917129;905.8369493491103;943.6225509796136;992.3004281981185;28209.858950705526;28756.856215719206;29258.975935842143;29896.40207195844;29898.252543686584;835.8328334333157;1012.6658202793061;1013.8783345998528;1016.2225897188656;1027.7636143686993;14696;15235.542933712006;15335;15495.612609684622;15554.22228888551;694906.0509394943;699085;700671;702495;703048;56931;57366.85266294734;57609;57709.71145144331;57778.799908008485;1196.6051203102954;1239.095460313994;1300.681333073403;1318.4198952460886;1353.2557093598482;28950.42099158047;29810.658520366203;30183.245418864703;30365;30972;48696;49099;49285.26072108993;49380;49582.50417495779;541136;544113;544275;544741;547065;22770.089196431956;26138.86930565335;27683.58474622842;27788.583171252852;27982.300442488286;43453.34819977766;43557.19403192665;43970;43983.78008110067;44742.3288650677;36451.90644280676;36636.81681591575;37016;37749.62250377461;38315;34768;36718;36786.8160659195;37349;37737.81131094327;36636;36677;37011.6298837019;37736.81131594325;38352;31993.36013279768;33543.49684754682;34001.65998339985;34263.65736342605;34344.65655343414;25287.74712252854;25470.872645636653;25498.362540936625;25527.851246694314;26093.869530652224 17:55:48 INFO - PROCESS | 1651 | |2;jquery.html;347.58984398409865;369.2448941913784;371.81595110420335;378.22086501806274;399.16773527195795;14783.334749936252;15042.473513427032;15671.05973641581;19374;20523.589528209428;18674;19169;19855.5036124097;19960.800391996076;20543.897280513578;5005.624578156635;6112.113743507189;6118.143459915593;6135.233095863017;6145.877082458348;4712.104700106986;6047.546434017444;6087.360827113156;6100.450959413652;6108.725107370179;5694.5729070319685;6044.909326360086;6052.485538729214;6052.697365131748;6055.6063855849225;5892.9705351473185;6016.157737916673;6016.608920420159;6023.789167379165;6035.909461358083;4980.576650984671;5119.539241468248;5221.269022336838;5234.345706786652;5236.3978142513715;20838;25114.623280650805;25266.11568595109;25523.617145742643;25529.361765955815;2276.8520046196945;2288.4050146961745;2452.0559584559896;2956.659984101834;3031.8787248510034;14500.41998320066;15633.140177290245;15749.44876929302;15797.763033554505;16172.11053392063;1510.4864346122372;1832.5418645338666;1846.1138653446287;1893.9905300473547;1896.6396384686866;68346.31653683449;85915;90545.54727226388;115147.42426287815;115693.84306156999;9755.853662195073;10960.890391096147;11050.33697978124;11105.666829995112;11163;13195.538156164488;13272.13731107475;13277.20336779777;13301.66745831362;13323.66690832737;8426.620802063922;8468.703595374132;8513.531755753493;8590.527520986405;8669.91330086691;8434.662613495391;8584.484930904166;8631.093735157843;8726.476411415335;8864.024957254696;5603.579731520153;6481.902771458432;6494.64279464634;6497.18785151856;6499.837504062341;1570.6073481629592;1786.2587026383906;1835.128314050815;1838.2463190092265;1840.68708319586;859.6260626627437;870.5212133326645;889.5507768576828;894.18182363137;1050.7320633238476;16892.662146756997;22103.557928841656;22210.1126853508;22340.441488962904;22394.55210895773;767.2327672327673;802.4142376065505;887.4586502233632;922.1792604581927;924.1867156901883;9660.903390966001;10572.735681607868;11533.538658453735;11730.296182229093;11777.352245626402;570468;608501;609696;622578;625018;105966;115763;117048;119219;121891.39054304671;982.5873133284038;1001.5943542865006;1014.8629934958834;1015.9238057145743;1020.4285600063988;18811.341603043827;19148;19537.706934395712;19559;19585.922774247552;34804.82597586996;48486;50933;51301.74349128231;52659.73670131625;70437.64781176062;73054.63472682603;73943.8908416385;75278;75278;5176.327077479904;5929.318128415288;6966.85046967265;7819.609019549113;7947.205279472007;12622.116451848282;13032.804507932578;13361.26513041792;13636.318184090955;13658.590242292747;9710.320277580502;11134.109271258118;11274.605388811353;11416.94291528537;11655.125865559947;10939.45302734876;11211.495482703134;11382.203245772716;11472.598459053894;11767.411629418324;10262.973702629975;11404.657860264206;11534.59628912984;11597.420128993685;11933.761324773282;6960.79117626472;7422.183559808309;7880.448368614371;8041.356691464785;8067.515949043076;10259.333143345659;10581.62964296246;10868.07621352194;10948.507317170586;11108.666739997812 17:55:48 INFO - PROCESS | 1651 | |3;mootools.html;1310.3644732304836;1466.4427517543331;1485.2722166138592;1634.5831812887711;1808.2495764257842;7630.351420129289;8012.639431225594;8268.751937441872;8524.957375213131;8543.61553730082;8390.790230244247;8482.151784821515;8484.745457636265;8486.872696909551;8504.149585041492;1946.649603071443;2334.0663734506165;2335.3344296875393;2336.824738144646;2337.754535773745;2158.5467051919118;2348.96476552851;2359.95280094398;2367.981767839828;2368.3013511014206;2304.8156147508244;2325.3489023073566;2338.6959695239593;2342.0631747301045;2349.0721165139844;2255.9661605075935;2299.8735069571167;2327.2320134355623;2328.6739856420113;2331.090874558915;2326.150954901466;2351.1770880191966;2353.094058787362;2353.5292941411785;2354.340784580303;7385.150707668633;8442.197991190827;8499.107593702634;8504.617292221865;8504.744857654281;5081.923771143436;5267.315249017642;5275.076861549252;5283.260343551906;5284.313039304904;3414.402479566066;3580.104973756561;3620.2759448110482;3656.652618001312;3660.6705396514176;890.3411475508077;1061.135174832509;1062.8140075486835;1108.418080507732;1108.5067145120424;11028.724281892937;11059.889401105966;11124.276922000045;11143.108551315876;11147.498362573622;3645.7812531247678;4423.093265880487;4486.955130448719;4532.864014079583;4541.205289074464;8757.649694012169;8777.122287771172;8777.51723655205;8784.341174411944;8801.691940782042;5076.847694569169;5096.413912400121;5102.336696229467;5108.233764935215;5109.8722531936255;4151.543330233671;4278.764667943231;4431.512533621299;4472.2620767573635;4714.151452738472;3105.8602362893726;3620.637936206411;3705.6109108543756;3714.814259287025;3720.9069773255887;1142.0406858239119;1142.5546683445448;1143.9027682646902;1162.6976985983706;1163.5578480177478;750.8535835512023;864.8140649760331;867.7873920889297;879.8108406692592;885.6767279942775;5412.702301373462;5438.428964958702;5485.6434331768305;5487.176923461433;5509.449055094458;447.19951287196204;449.1690372810275;457.1611093643136;938.4603852784676;981.6613268422383;3511.367953768295;3519.697711846633;3566.1084728817796;3705.2404257127223;3732.8133593320226;9967;10480.895191047992;10492.003259690317;10494.632687856041;10497.632582859564;10342.224333175041;10346.068853803194;10367.740806479898;10431.634892778868;10432.165426765841;7608.581528016012;7880.684772609146;8019.198080191934;8032.236937491046;8062.274395304451;5175.4565770593545;5191.091558977239;5416.106342453609;5607.420706163941;5770.567207459541;9271.582778775106;9345.859812102688;9660.275479338938;9691.030896910253;9787.021297870157;8185.263326300424;9012;9557.092076252746;9880.654177103766;9955.054269844353;7059.435245180476;7293.744718934812;7306.744263950736;7309.707611695472;7313.195548489768;7685.346745526693;7936.166702496154;8058.516489010678;8127.918720812716;8130.186981302059;7051.259617740064;7155.391791697764;7187.425005999403;7250.202477727551;7307.963460182665;7042.0845290114;7078.1506219254015;7104;7119.786406407816;7149.60677162761;6734.9326506734305;6754.527183097332;6755.831104222237;6813.931860681329;6818.965905170442;4648.233041548242;4729.834455794031;4737.38414006177;4788.066327066328;4810.63920205993;3836.577976422647;4213.599708027732;4695.812167513262;4820.34925285082;4853.39332583427 17:55:48 INFO - PROCESS | 1651 | |4;prototype.html;301.81438415374544;307.8799268285368;311.594926595426;314.6051705110086;317.7521533204099;4403.317485789699;4414.7792610369515;5255.160693757183;5274.367075950887;5281.999999999995;4648.604868586174;4979.253112033197;5152.252923326116;5156.871078223046;5181.5077567631015;3733.383991641376;3779.2252588219417;3814.4278358246347;3854.8265328060306;4067.3288907330257;3961.6038396160443;4003.6396724294955;4055.8986025349454;4059.1678705865374;4077.0215148364477;3293.7767007269995;3488.476728490721;3969.4045893115976;3972.9868883434683;4004.1991601679633;3309.8841540545964;3379.493076038589;3404.7957122572725;3922.333203355422;3988.501437320335;2870.7846911481515;3294.1929227339215;3424.6746559077096;3441.8623255069765;3456.1705190754287;4447.355133505656;4926.359573255454;5102.234664800272;5110.361204849394;5118.2873077269105;3486.3027394520946;4012.979935100335;4516.532127058719;4518.27707566791;4526.95473045272;4394.978025109854;4775.505312774624;5281.683099014072;5483.8080667176455;5493.697846618435;3204.8878289259997;3386.0868609235704;3752.9249415011545;3755;3773.3019391412404;5688.402717714663;5703.914441283384;5718.370979192286;5730.484256416901;5733.760425359742;3492.231709024011;3699.574548926854;3761.7931013793955;3823.2162406706557;3847.249786291702;3454.7063499602814;3495.702865256482;3810.333191691443;3913.2369188008634;3938.3895496198134;4028.3957406389277;4461.821527138943;4507.4365704286965;4515.7290562565695;4531.546845315442;5218.947810521846;5285.788568457296;5481.917771233435;5538.584606154554;5582.967151077064;1224.0415335463188;1240.765438388809;1258.5406326690693;1258.9236203046446;1261.4197469164287;681.5127184063418;816.3061397811813;855.2516548020482;855.2858363266618;855.7475544714324;4833.3958255218095;4998.550130488274;5045.545900868866;5056;5184.403793563713;5180.145276029413;5633.253691355693;5640.717964101778;5668;5692.601517893708;4911.87720306988;5131.974340128276;5148.639595228298;5151.6136289778415;5168.715720635401;2398.4723360860585;2637.5779875220255;2752.1973107614544;2804.7001458803993;2809.7752179825566;4697.78859951303;5073.858381864125;5107.259447380109;5430.619856609999;5473.28847249855;4828.787684918203;5235.853300146921;5421.484958928895;5451.0207548489825;5492.709213334863;4686.789094490756;5369.597280203922;5414.971155480525;5438.416752042748;5443.863903402446;4411.404460397805;5280.1815718563685;5299.602529810202;5311.867203319948;5321.787128514816;4552.565941728345;4560.338750881037;5237.659552129099;5245.501677340647;5710.8001219957105;5375.408705042364;5842.853928651818;5851.502622276984;5857.970710146422;5862.7654893805475;3840.423936409561;3844.7308688391545;3864.30442520349;3881.262560113569;3884.864029758945;5486.204500347507;5678.659280443187;5753.626014309057;5757.827265182052;5768.884622307446;4875.805887350635;4885.633577481632;5508.3114610673665;5532.3637781654015;5582.804601838916;5297.311349524537;5405.189221616789;5521.3926468087675;5528.86177845541;5571.637843540157;4999.725015124058;5070.847874563769;5410.621256512007;5431.424886782789;5444.346678398618;4614.676972611885;5413.377461591967;5421.62048656606;5427.83716488506;5533.695646739468;4741.55809757968;5395.514403703685;5426.64726792773;5431.701256430934;5442.891142177055 17:55:48 INFO - PROCESS | 1651 | |5;yui.html;744.374725230806;764.3770327183348;765.7855800375896;766.934810541104;777.1723114882647;13857.030007899451;15989.60025999349;16718.08050557219;16723.08023058733;16748.58128546787;15343.923280383582;15371.615709607237;15373.38506459743;15411.15238661873;15432.228388580583;660.4386271669067;683.5078743304813;810.7162493127418;838.2748922182329;842.8272204198155;690.6891898645605;810.7365106340434;821.9725343320849;835.5070508400042;844.5228445928062;873.4977388001893;873.9257163141141;874.4971641306242;874.7638137702817;874.7813046738315;701.6596950479013;868.0754995929346;870.5473153959969;872.389327470773;879.1779685993616;531.0944839049412;624.3506752976898;639.4564620072947;640.3212594649686;648.0408994687841;14414.063085899383;14467.276636168255;14473.276336183255;14481.92759036198;14482.1310721356;10669.359838409642;11303.886961130365;12922.160059596095;13089.934550327187;13187.472501099945;9654.662086826998;11313.094952403788;11760.941195294054;12138;12529.937350313281;3695.7597756146033;3704.351738445788;3718.1448266898765;3767.321882061228;3811.123441608446;92686.53656731741;93856.59215111847;94702;95417;98576;9119.452832830051;9194.356395052282;9286.95356523213;9307.53462326881;9316.20812230968;17007.149642517823;20067.899660501895;20111.698324525143;20167.49581260451;20419.28532501385;7219.917012448175;7306.634668266565;7412.18465968743;7443.739469118555;7694.769156925301;4133.780534742258;4182.456280683492;4260.403543503912;4277.550857160016;4301.41930839339;3416.214270717749;3507.7895326280504;3526.365254254259;3526.559180102487;3533.169705119295;637.0698779781478;638.6168299020643;644.8968165093562;646.9805905822833;671.419222372654;521.6426747677853;577.653407955232;644.8323435906605;668.353320849432;696.4010950582496;9063.68277110298;9121.407108537924;9335.299852511089;9355.48544830041;9403;656.6683824668607;662.903878937561;668.391763495217;676.2662511175331;685.8559702462439;4268.423762791983;4531.546845315508;4540.432445944257;4563.977180114078;4608.055348653518;83545;105367.94632053735;108832;127016.72983270048;131915;68586.79838616973;71845;72749;72791;89018;84086.57956710299;87191;88005;89438.65842012505;92644.53677731568;9331.626734930527;9483.857742133736;9634.807303854024;9654.469004204555;9662.951685241529;37627;52059.479405205464;56151;56293;58819.41180588139;58238.708806455696;72929.27070729225;74307;77590;82039;12280.263184208976;12334.629961101182;12357.629271121881;12428.13003089775;12657;14066.42893631387;14084.577462676136;14201.360938757574;14297.571072867831;14450.566483005527;12996.610101696964;13027.413766380725;13078.542251021168;13141.54004609834;13427.932860336026;12426.808710137439;12608.684782880502;13104.475820967054;13353.332333383098;13396.866031339561;12870;12878.098533102968;13261;13461.86538134606;13514.121582097132;10648;10965.890341096487;11187;11396.145289103184;11417.372044537298;10326.896731032593;11139.944300278446;11174.66476005721;11180;11180.105591552494 17:55:48 INFO - PROCESS | 1651 | __end_tp_report 17:55:48 INFO - PROCESS | 1651 | __start_cc_report 17:55:48 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1812 17:55:48 INFO - PROCESS | 1651 | __end_cc_report 17:55:48 INFO - PROCESS | 1651 | __startTimestamp1479952548436__endTimestamp 17:55:48 INFO - PROCESS | 1651 | 17:55:48 INFO - PROCESS | 1651 | ------- Summary: start ------- 17:55:48 INFO - PROCESS | 1651 | Number of tests: 6 17:55:48 INFO - PROCESS | 1651 | 17:55:48 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5705.97 Median:5951.29 stddev:645.35 (10.8%) stddev-sans-first:616.73 17:55:48 INFO - PROCESS | 1651 | Values: 3202.8 3308.6 3332.6 3353.9 3391.1 5603.9 5655.5 5668.9 5705.4 5717.9 5605.5 5690.2 5691.0 5702.9 5710.1 5163.8 5171.3 5185.6 5224.7 5226.0 5163.4 5165.6 5166.6 5284.2 5328.8 5184.6 5187.4 5218.4 5248.7 5266.7 5197.8 5207.2 5217.3 5237.4 5263.4 5125.6 5216.3 5223.9 5247.2 5266.8 5506.4 5568.5 5575.0 5635.3 5681.7 6089.0 6113.8 6116.9 6134.4 6134.8 6228.7 6245.6 6319.0 6323.1 6327.6 5657.0 5783.9 5795.9 5811.3 5854.4 6219.1 6226.9 6256.3 6267.1 6288.9 6036.6 6043.6 6047.0 6057.6 6094.0 6151.6 6172.4 6177.8 6178.6 6184.5 5330.3 5806.5 6008.0 6110.7 6118.7 6243.2 6245.3 6249.8 6258.7 6272.2 3909.4 4896.2 4938.2 4946.5 4989.5 4367.3 4397.1 4405.2 4407.1 4462.0 5709.1 5773.8 5779.6 5786.2 5830.1 6227.5 6228.0 6232.1 6248.4 6255.4 5628.4 5682.0 5745.3 5772.9 5778.3 5307.4 5347.0 5395.9 5400.9 5426.5 6176.4 6219.5 6228.9 6246.2 6255.5 6230.4 6251.5 6254.2 6292.1 6298.6 6004.0 6182.5 6195.7 6208.1 6224.7 6195.2 6199.4 6200.9 6212.2 6212.4 5272.2 6238.3 6251.0 6262.6 6266.2 5953.3 5994.7 6036.0 6059.3 6073.5 6074.3 6102.8 6129.7 6136.0 6140.4 5811.9 5951.3 5966.5 6031.0 6038.9 5136.3 5909.1 6040.5 6064.6 6176.4 5939.6 6026.2 6034.4 6050.5 6078.0 17:55:48 INFO - PROCESS | 1651 | 17:55:48 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:69443.16 Median:38333.50 stddev:156083.90 (407.2%) stddev-sans-first:156435.81 17:55:48 INFO - PROCESS | 1651 | Values: 456.3 480.3 524.8 534.3 555.0 29972.7 39187.0 40361.8 40382.0 40520.0 34777.7 35410.9 41294.8 41667.4 41672.0 9308.7 9466.8 9487.1 9489.2 9504.5 8193.6 9357.7 9367.4 9473.4 9474.9 8200.7 9446.8 9464.5 9495.1 9515.3 9406.8 9468.1 9481.1 9481.8 9489.9 9202.6 9295.5 9315.7 9317.8 9325.4 39510.8 39679.4 39777.4 39831.4 39995.4 3078.6 3218.4 3386.2 3515.5 3525.7 29074.2 29723.9 29758.1 30171.0 30217.5 3152.2 3157.6 3224.3 3257.1 3261.5 476987.0 480747.0 480822.0 481542.0 486772.0 58814.4 59193.8 59264.4 59412.0 59471.4 34252.5 35134.0 35146.0 35724.7 35737.1 16450.2 16577.8 16602.5 16604.6 16664.3 12620.5 12740.6 12745.0 12760.1 12762.4 15389.5 18621.1 18637.5 18641.3 18704.9 6436.4 6497.7 7393.9 7512.9 7597.6 809.9 849.4 905.8 943.6 992.3 28209.9 28756.9 29259.0 29896.4 29898.3 835.8 1012.7 1013.9 1016.2 1027.8 14696.0 15235.5 15335.0 15495.6 15554.2 694906.1 699085.0 700671.0 702495.0 703048.0 56931.0 57366.9 57609.0 57709.7 57778.8 1196.6 1239.1 1300.7 1318.4 1353.3 28950.4 29810.7 30183.2 30365.0 30972.0 48696.0 49099.0 49285.3 49380.0 49582.5 541136.0 544113.0 544275.0 544741.0 547065.0 22770.1 26138.9 27683.6 27788.6 27982.3 43453.3 43557.2 43970.0 43983.8 44742.3 36451.9 36636.8 37016.0 37749.6 38315.0 34768.0 36718.0 36786.8 37349.0 37737.8 36636.0 36677.0 37011.6 37736.8 38352.0 31993.4 33543.5 34001.7 34263.7 34344.7 25287.7 25470.9 25498.4 25527.9 26093.9 17:55:48 INFO - PROCESS | 1651 | 17:55:48 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:34051.73 Median:25526.49 stddev:100544.12 (393.9%) stddev-sans-first:100794.33 17:55:48 INFO - PROCESS | 1651 | Values: 347.6 369.2 371.8 378.2 399.2 14783.3 15042.5 15671.1 19374.0 20523.6 18674.0 19169.0 19855.5 19960.8 20543.9 5005.6 6112.1 6118.1 6135.2 6145.9 4712.1 6047.5 6087.4 6100.5 6108.7 5694.6 6044.9 6052.5 6052.7 6055.6 5893.0 6016.2 6016.6 6023.8 6035.9 4980.6 5119.5 5221.3 5234.3 5236.4 20838.0 25114.6 25266.1 25523.6 25529.4 2276.9 2288.4 2452.1 2956.7 3031.9 14500.4 15633.1 15749.4 15797.8 16172.1 1510.5 1832.5 1846.1 1894.0 1896.6 68346.3 85915.0 90545.5 115147.4 115693.8 9755.9 10960.9 11050.3 11105.7 11163.0 13195.5 13272.1 13277.2 13301.7 13323.7 8426.6 8468.7 8513.5 8590.5 8669.9 8434.7 8584.5 8631.1 8726.5 8864.0 5603.6 6481.9 6494.6 6497.2 6499.8 1570.6 1786.3 1835.1 1838.2 1840.7 859.6 870.5 889.6 894.2 1050.7 16892.7 22103.6 22210.1 22340.4 22394.6 767.2 802.4 887.5 922.2 924.2 9660.9 10572.7 11533.5 11730.3 11777.4 570468.0 608501.0 609696.0 622578.0 625018.0 105966.0 115763.0 117048.0 119219.0 121891.4 982.6 1001.6 1014.9 1015.9 1020.4 18811.3 19148.0 19537.7 19559.0 19585.9 34804.8 48486.0 50933.0 51301.7 52659.7 70437.6 73054.6 73943.9 75278.0 75278.0 5176.3 5929.3 6966.9 7819.6 7947.2 12622.1 13032.8 13361.3 13636.3 13658.6 9710.3 11134.1 11274.6 11416.9 11655.1 10939.5 11211.5 11382.2 11472.6 11767.4 10263.0 11404.7 11534.6 11597.4 11933.8 6960.8 7422.2 7880.4 8041.4 8067.5 10259.3 10581.6 10868.1 10948.5 11108.7 17:55:48 INFO - PROCESS | 1651 | 17:55:48 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5429.38 Median:4965.12 stddev:3053.25 (61.5%) stddev-sans-first:3046.12 17:55:48 INFO - PROCESS | 1651 | Values: 1310.4 1466.4 1485.3 1634.6 1808.2 7630.4 8012.6 8268.8 8525.0 8543.6 8390.8 8482.2 8484.7 8486.9 8504.1 1946.6 2334.1 2335.3 2336.8 2337.8 2158.5 2349.0 2360.0 2368.0 2368.3 2304.8 2325.3 2338.7 2342.1 2349.1 2256.0 2299.9 2327.2 2328.7 2331.1 2326.2 2351.2 2353.1 2353.5 2354.3 7385.2 8442.2 8499.1 8504.6 8504.7 5081.9 5267.3 5275.1 5283.3 5284.3 3414.4 3580.1 3620.3 3656.7 3660.7 890.3 1061.1 1062.8 1108.4 1108.5 11028.7 11059.9 11124.3 11143.1 11147.5 3645.8 4423.1 4487.0 4532.9 4541.2 8757.6 8777.1 8777.5 8784.3 8801.7 5076.8 5096.4 5102.3 5108.2 5109.9 4151.5 4278.8 4431.5 4472.3 4714.2 3105.9 3620.6 3705.6 3714.8 3720.9 1142.0 1142.6 1143.9 1162.7 1163.6 750.9 864.8 867.8 879.8 885.7 5412.7 5438.4 5485.6 5487.2 5509.4 447.2 449.2 457.2 938.5 981.7 3511.4 3519.7 3566.1 3705.2 3732.8 9967.0 10480.9 10492.0 10494.6 10497.6 10342.2 10346.1 10367.7 10431.6 10432.2 7608.6 7880.7 8019.2 8032.2 8062.3 5175.5 5191.1 5416.1 5607.4 5770.6 9271.6 9345.9 9660.3 9691.0 9787.0 8185.3 9012.0 9557.1 9880.7 9955.1 7059.4 7293.7 7306.7 7309.7 7313.2 7685.3 7936.2 8058.5 8127.9 8130.2 7051.3 7155.4 7187.4 7250.2 7308.0 7042.1 7078.2 7104.0 7119.8 7149.6 6734.9 6754.5 6755.8 6813.9 6819.0 4648.2 4729.8 4737.4 4788.1 4810.6 3836.6 4213.6 4695.8 4820.3 4853.4 17:55:48 INFO - PROCESS | 1651 | 17:55:48 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4383.79 Median:4999.14 stddev:1362.28 (27.3%) stddev-sans-first:1331.20 17:55:48 INFO - PROCESS | 1651 | Values: 301.8 307.9 311.6 314.6 317.8 4403.3 4414.8 5255.2 5274.4 5282.0 4648.6 4979.3 5152.3 5156.9 5181.5 3733.4 3779.2 3814.4 3854.8 4067.3 3961.6 4003.6 4055.9 4059.2 4077.0 3293.8 3488.5 3969.4 3973.0 4004.2 3309.9 3379.5 3404.8 3922.3 3988.5 2870.8 3294.2 3424.7 3441.9 3456.2 4447.4 4926.4 5102.2 5110.4 5118.3 3486.3 4013.0 4516.5 4518.3 4527.0 4395.0 4775.5 5281.7 5483.8 5493.7 3204.9 3386.1 3752.9 3755.0 3773.3 5688.4 5703.9 5718.4 5730.5 5733.8 3492.2 3699.6 3761.8 3823.2 3847.2 3454.7 3495.7 3810.3 3913.2 3938.4 4028.4 4461.8 4507.4 4515.7 4531.5 5218.9 5285.8 5481.9 5538.6 5583.0 1224.0 1240.8 1258.5 1258.9 1261.4 681.5 816.3 855.3 855.3 855.7 4833.4 4998.6 5045.5 5056.0 5184.4 5180.1 5633.3 5640.7 5668.0 5692.6 4911.9 5132.0 5148.6 5151.6 5168.7 2398.5 2637.6 2752.2 2804.7 2809.8 4697.8 5073.9 5107.3 5430.6 5473.3 4828.8 5235.9 5421.5 5451.0 5492.7 4686.8 5369.6 5415.0 5438.4 5443.9 4411.4 5280.2 5299.6 5311.9 5321.8 4552.6 4560.3 5237.7 5245.5 5710.8 5375.4 5842.9 5851.5 5858.0 5862.8 3840.4 3844.7 3864.3 3881.3 3884.9 5486.2 5678.7 5753.6 5757.8 5768.9 4875.8 4885.6 5508.3 5532.4 5582.8 5297.3 5405.2 5521.4 5528.9 5571.6 4999.7 5070.8 5410.6 5431.4 5444.3 4614.7 5413.4 5421.6 5427.8 5533.7 4741.6 5395.5 5426.6 5431.7 5442.9 17:55:48 INFO - PROCESS | 1651 | 17:55:48 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:20280.56 Median:526.37 stddev:29640.32 (5631.1%) stddev-sans-first:29687.17 17:55:48 INFO - PROCESS | 1651 | Values: 744.4 764.4 765.8 766.9 777.2 13857.0 15989.6 16718.1 16723.1 16748.6 15343.9 15371.6 15373.4 15411.2 15432.2 660.4 683.5 810.7 838.3 842.8 690.7 810.7 822.0 835.5 844.5 873.5 873.9 874.5 874.8 874.8 701.7 868.1 870.5 872.4 879.2 531.1 624.4 639.5 640.3 648.0 14414.1 14467.3 14473.3 14481.9 14482.1 10669.4 11303.9 12922.2 13089.9 13187.5 9654.7 11313.1 11760.9 12138.0 12529.9 3695.8 3704.4 3718.1 3767.3 3811.1 92686.5 93856.6 94702.0 95417.0 98576.0 9119.5 9194.4 9287.0 9307.5 9316.2 17007.1 20067.9 20111.7 20167.5 20419.3 7219.9 7306.6 7412.2 7443.7 7694.8 4133.8 4182.5 4260.4 4277.6 4301.4 3416.2 3507.8 3526.4 3526.6 3533.2 637.1 638.6 644.9 647.0 671.4 521.6 577.7 644.8 668.4 696.4 9063.7 9121.4 9335.3 9355.5 9403.0 656.7 662.9 668.4 676.3 685.9 4268.4 4531.5 4540.4 4564.0 4608.1 83545.0 105367.9 108832.0 127016.7 131915.0 68586.8 71845.0 72749.0 72791.0 89018.0 84086.6 87191.0 88005.0 89438.7 92644.5 9331.6 9483.9 9634.8 9654.5 9663.0 37627.0 52059.5 56151.0 56293.0 58819.4 58238.7 72929.3 74307.0 77590.0 82039.0 12280.3 12334.6 12357.6 12428.1 12657.0 14066.4 14084.6 14201.4 14297.6 14450.6 12996.6 13027.4 13078.5 13141.5 13427.9 12426.8 12608.7 13104.5 13353.3 13396.9 12870.0 12878.1 13261.0 13461.9 13514.1 10648.0 10965.9 11187.0 11396.1 11417.4 10326.9 11139.9 11174.7 11180.0 11180.1 17:55:48 INFO - PROCESS | 1651 | -------- Summary: end -------- 17:55:48 INFO - PROCESS | 1651 | 17:55:49 INFO - TEST-INFO | 1651: exit 0 17:55:49 INFO - TEST-OK | dromaeo_css | took 1119529ms 17:55:49 INFO - TEST-START | kraken 17:55:49 INFO - operating with platform_type : mac_ 17:55:49 INFO - Initialising browser for kraken test... 17:55:49 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/tmpriViSR/profile http://localhost:49248/getInfo.html) 17:55:51 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 17:55:51 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 17:55:51 INFO - PROCESS | 1660 | colorDepth:24 17:55:51 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 17:55:51 INFO - PROCESS | 1660 | __metrics 17:55:51 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:55:51 INFO - PROCESS | 1660 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:55:52 INFO - TEST-INFO | 1660: exit 0 17:55:52 INFO - Browser initialized. 17:55:52 INFO - Running cycle 1/1 for kraken test... 17:55:52 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/tmpriViSR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:05 INFO - PROCESS | 1661 | RSS: Main: 222633984 17:56:05 INFO - PROCESS | 1661 | 17:56:07 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 17:56:08 INFO - PROCESS | 1661 | RSS: Main: 272551936 17:56:08 INFO - PROCESS | 1661 | 17:56:11 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 17:56:12 INFO - PROCESS | 1661 | RSS: Main: 282042368 17:56:12 INFO - PROCESS | 1661 | 17:56:15 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 17:56:16 INFO - PROCESS | 1661 | RSS: Main: 380760064 17:56:16 INFO - PROCESS | 1661 | 17:56:18 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 17:56:18 INFO - PROCESS | 1661 | RSS: Main: 282578944 17:56:18 INFO - PROCESS | 1661 | 17:56:20 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:56:21 INFO - PROCESS | 1661 | RSS: Main: 284610560 17:56:21 INFO - PROCESS | 1661 | 17:56:24 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 17:56:24 INFO - PROCESS | 1661 | RSS: Main: 325627904 17:56:24 INFO - PROCESS | 1661 | 17:56:27 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 17:56:28 INFO - PROCESS | 1661 | RSS: Main: 326316032 17:56:28 INFO - PROCESS | 1661 | 17:56:31 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 17:56:31 INFO - PROCESS | 1661 | RSS: Main: 322351104 17:56:31 INFO - PROCESS | 1661 | 17:56:33 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:56:33 INFO - PROCESS | 1661 | RSS: Main: 301400064 17:56:33 INFO - PROCESS | 1661 | 17:56:35 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:56:36 INFO - PROCESS | 1661 | RSS: Main: 303800320 17:56:36 INFO - PROCESS | 1661 | 17:56:38 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:56:39 INFO - PROCESS | 1661 | RSS: Main: 305885184 17:56:39 INFO - PROCESS | 1661 | 17:56:42 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:56:42 INFO - PROCESS | 1661 | RSS: Main: 320585728 17:56:42 INFO - PROCESS | 1661 | 17:56:45 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:56:46 INFO - PROCESS | 1661 | RSS: Main: 314171392 17:56:46 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 17:56:48 INFO - PROCESS | 1661 | RSS: Main: 358453248 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | __start_tp_report 17:56:48 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 17:56:48 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 17:56:48 INFO - PROCESS | 1661 | |i|pagename|runs| 17:56:48 INFO - PROCESS | 1661 | |0;ai-astar;116;115;118;158;166;115;116;116;115;114 17:56:48 INFO - PROCESS | 1661 | |1;audio-beat-detection;150;133;121;160;137;140;138;113;142;112 17:56:48 INFO - PROCESS | 1661 | |2;audio-dft;184;188;219;184;184;182;185;186;184;184 17:56:48 INFO - PROCESS | 1661 | |3;audio-fft;79;60;59;89;62;60;60;58;82;76 17:56:48 INFO - PROCESS | 1661 | |4;audio-oscillator;85;69;93;73;96;99;115;68;68;92 17:56:48 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;89;86;89;86;88;85;90;85;89;85 17:56:48 INFO - PROCESS | 1661 | |6;imaging-darkroom;95;95;94;95;130;108;95;93;95;94 17:56:48 INFO - PROCESS | 1661 | |7;imaging-desaturate;81;82;81;79;82;83;82;115;121;108 17:56:48 INFO - PROCESS | 1661 | |8;json-parse-financial;54;53;50;53;57;55;55;55;55;56 17:56:48 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;64;70;68;79;74;70;69;69;70;68 17:56:48 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;85;85;82;95;83;85;84;83;85;85 17:56:48 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;145;149;149;145;146;158;152;160;197;146 17:56:48 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;166;168;167;171;169;165;166;166;163;166 17:56:48 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;68;67;68;67;67;66;65;69;81;81 17:56:48 INFO - PROCESS | 1661 | __end_tp_report 17:56:48 INFO - PROCESS | 1661 | __start_cc_report 17:56:48 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1967 17:56:48 INFO - PROCESS | 1661 | __end_cc_report 17:56:48 INFO - PROCESS | 1661 | __startTimestamp1479952608282__endTimestamp 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | ------- Summary: start ------- 17:56:48 INFO - PROCESS | 1661 | Number of tests: 14 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:124.90 Median:116.00 stddev:19.67 (17.0%) stddev-sans-first:20.60 17:56:48 INFO - PROCESS | 1661 | Values: 116.0 115.0 118.0 158.0 166.0 115.0 116.0 116.0 115.0 114.0 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:139.00 stddev:15.45 (11.1%) stddev-sans-first:15.35 17:56:48 INFO - PROCESS | 1661 | Values: 150.0 133.0 121.0 160.0 137.0 140.0 138.0 113.0 142.0 112.0 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:188.00 Median:184.50 stddev:11.01 (6.0%) stddev-sans-first:11.58 17:56:48 INFO - PROCESS | 1661 | Values: 184.0 188.0 219.0 184.0 184.0 182.0 185.0 186.0 184.0 184.0 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:68.50 Median:69.00 stddev:11.68 (16.9%) stddev-sans-first:11.76 17:56:48 INFO - PROCESS | 1661 | Values: 79.0 60.0 59.0 89.0 62.0 60.0 60.0 58.0 82.0 76.0 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:85.80 Median:88.50 stddev:15.99 (18.1%) stddev-sans-first:16.96 17:56:48 INFO - PROCESS | 1661 | Values: 85.0 69.0 93.0 73.0 96.0 99.0 115.0 68.0 68.0 92.0 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.50 stddev:1.99 (2.2%) stddev-sans-first:2.00 17:56:48 INFO - PROCESS | 1661 | Values: 89.0 86.0 89.0 86.0 88.0 85.0 90.0 85.0 89.0 85.0 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:99.40 Median:95.00 stddev:11.58 (12.2%) stddev-sans-first:12.17 17:56:48 INFO - PROCESS | 1661 | Values: 95.0 95.0 94.0 95.0 130.0 108.0 95.0 93.0 95.0 94.0 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:91.40 Median:81.50 stddev:16.38 (20.1%) stddev-sans-first:16.93 17:56:48 INFO - PROCESS | 1661 | Values: 81.0 82.0 81.0 79.0 82.0 83.0 82.0 115.0 121.0 108.0 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:1.95 (3.5%) stddev-sans-first:2.06 17:56:48 INFO - PROCESS | 1661 | Values: 54.0 53.0 50.0 53.0 57.0 55.0 55.0 55.0 55.0 56.0 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:3.98 (5.7%) stddev-sans-first:3.56 17:56:48 INFO - PROCESS | 1661 | Values: 64.0 70.0 68.0 79.0 74.0 70.0 69.0 69.0 70.0 68.0 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:3.61 (4.3%) stddev-sans-first:3.83 17:56:48 INFO - PROCESS | 1661 | Values: 85.0 85.0 82.0 95.0 83.0 85.0 84.0 83.0 85.0 85.0 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:154.70 Median:150.50 stddev:15.78 (10.5%) stddev-sans-first:16.34 17:56:48 INFO - PROCESS | 1661 | Values: 145.0 149.0 149.0 145.0 146.0 158.0 152.0 160.0 197.0 146.0 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:166.50 stddev:2.21 (1.3%) stddev-sans-first:2.33 17:56:48 INFO - PROCESS | 1661 | Values: 166.0 168.0 167.0 171.0 169.0 165.0 166.0 166.0 163.0 166.0 17:56:48 INFO - PROCESS | 1661 | 17:56:48 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:68.00 stddev:5.95 (8.8%) stddev-sans-first:6.27 17:56:48 INFO - PROCESS | 1661 | Values: 68.0 67.0 68.0 67.0 67.0 66.0 65.0 69.0 81.0 81.0 17:56:48 INFO - PROCESS | 1661 | -------- Summary: end -------- 17:56:48 INFO - PROCESS | 1661 | 17:56:49 INFO - TEST-INFO | 1661: exit 0 17:56:49 INFO - TEST-OK | kraken | took 60208ms 17:56:49 INFO - SUITE-END | took 1179s 17:56:49 INFO - Completed test suite (00:19:39) 17:56:49 INFO - javascript benchmark 17:56:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3202.8398580071007, 3308.586426696663, 3332.583427071616, 3353.9496907546377, 3391.1013581400916, 5603.859903502414, 5655.462731040555, 5668.943310566893, 5705.372409035008, 5717.942820571793, 5605.523530499912, 5690.2033715279895, 5690.971545142268, 5702.885942281162, 5710.086386178213, 5163.845084647466, 5171.276021357013, 5185.611079169059, 5224.712640804754, 5225.973870130644, 5163.432022477525, 5165.586753059746, 5166.612504062192, 5284.154535274357, 5328.760205790749, 5184.637075404723, 5187.3775146982225, 5218.425973142951, 5248.68507889526, 5266.710330931816, 5197.818076367347, 5207.166853303491, 5217.2695822584865, 5237.423883372826, 5263.36839579253, 5125.589952803767, 5216.295800067019, 5223.921641175385, 5247.212918062283, 5266.841994740125, 5506.421825708323, 5568.470995255444, 5574.9721251393485, 5635.3237611486475, 5681.744321505542, 6089.025755879038, 6113.7803774110635, 6116.908246376308, 6134.355892631299, 6134.816205099513, 6228.657423841687, 6245.56281060326, 6319.0, 6323.083152942843, 6327.620342779448, 5657.038303488417, 5783.855403614902, 5795.855103622359, 5811.3026436827, 5854.414558544111, 6219.098230756515, 6226.941419958618, 6256.311805701369, 6267.059941008885, 6288.9056664150075, 6036.63780173191, 6043.576949613484, 6046.969765151234, 6057.57596968208, 6094.0, 6151.600145990586, 6172.351903050115, 6177.84555386119, 6178.567500275028, 6184.536159787944, 5330.307060082165, 5806.535477161817, 6008.03871380577, 6110.694465276719, 6118.724657390429, 6243.219597550306, 6245.281792593819, 6249.781257656051, 6258.718357673915, 6272.247330320391, 3909.4135879617716, 4896.2410826321975, 4938.234573641092, 4946.530079642428, 4989.451160372356, 4367.344898265285, 4397.07661391105, 4405.185040767404, 4407.140607581491, 4462.040661257845, 5709.115087161496, 5773.797917072966, 5779.624324418899, 5786.218860453869, 5830.067189249699, 6227.532935029891, 6228.0, 6232.0963460298, 6248.375162483715, 6255.40573645503, 5628.352739434936, 5682.0, 5745.253117094834, 5772.884542309131, 5778.27771528559, 5307.442718514578, 5347.0, 5395.865103372368, 5400.891982160335, 5426.511613954763, 6176.35148309421, 6219.533534984985, 6228.906566401417, 6246.219222597176, 6255.46828519581, 6230.408111229426, 6251.499880009497, 6254.249490061222, 6292.11910332563, 6298.622082675054, 6004.0, 6182.505399568114, 6195.721192546436, 6208.068789681584, 6224.657643829632, 6195.19462469876, 6199.442050215503, 6200.937990620217, 6212.223472065992, 6212.4408803207925, 5272.209168624737, 6238.313785483684, 6251.031090181029, 6262.5929314594405, 6266.154069200599, 5953.345132035386, 5994.67029313392, 6036.0, 6059.272887253558, 6073.48375388097, 6074.331823499323, 6102.816915492543, 6129.724162412613, 6136.048912418404, 6140.355262697352, 5811.94188058114, 5951.285845698544, 5966.49284810796, 6031.035034394651, 6038.909416358671, 5136.2552429898205, 5909.084091965752, 6040.546958978006, 6064.575479716377, 6176.4441200292185, 5939.613925094855, 6026.246719160105, 6034.426729460694, 6050.546209034252, 6077.997130473423], "value": 5664.3515382698, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.33830945129563, 480.25080873836816, 524.8031988004499, 534.268052767708, 554.9916751248729, 29972.700272997263, 39187.0, 40361.798191009075, 40382.0, 40520.0, 34777.65222347776, 35410.93767186982, 41294.7935260324, 41667.37498937511, 41671.95820104499, 9308.674196403144, 9466.763330916749, 9487.051294870493, 9489.240860731124, 9504.524773761319, 8193.590320483952, 9357.719268421959, 9367.437953722798, 9473.43159410434, 9474.905250947506, 8200.671973121098, 9446.81106377872, 9464.526773661324, 9495.145436910676, 9515.333926625139, 9406.764830879249, 9468.100530449596, 9481.146696797286, 9481.810363792754, 9489.857652135224, 9202.619607058929, 9295.48874811885, 9315.72052838416, 9317.813643727088, 9325.393849399836, 39510.80244598787, 39679.40480892789, 39777.40333894994, 39831.4025289618, 39995.40006899899, 3078.6459557150993, 3218.4206842768294, 3386.153461634591, 3515.455104458813, 3525.665061819149, 29074.216525639466, 29723.851380743174, 29758.107256782332, 30171.0, 30217.546736798966, 3152.1646763607664, 3157.5579418881375, 3224.3228921926425, 3257.1042963185077, 3261.4944683574086, 476987.0, 480747.0, 480822.0, 481542.0, 486772.0, 58814.41185588175, 59193.81612367729, 59264.40735592589, 59412.0, 59471.40528594659, 34252.486212706826, 35134.0, 35146.0, 35724.74963376321, 35737.1065723359, 16450.177491125396, 16577.751333730004, 16602.50192494227, 16604.58488537772, 16664.333426662797, 12620.485541734866, 12740.55408060732, 12745.0, 12760.10679252462, 12762.361881906054, 15389.461368852037, 18621.06894655262, 18637.534061648297, 18641.347552835585, 18704.906475467807, 6436.388543088399, 6497.675116244169, 7393.852122957511, 7512.887306690404, 7597.620118994028, 809.9149589293157, 849.4478588917129, 905.8369493491103, 943.6225509796136, 992.3004281981185, 28209.858950705526, 28756.856215719206, 29258.975935842143, 29896.40207195844, 29898.252543686584, 835.8328334333157, 1012.6658202793061, 1013.8783345998528, 1016.2225897188656, 1027.7636143686993, 14696.0, 15235.542933712006, 15335.0, 15495.612609684622, 15554.22228888551, 694906.0509394943, 699085.0, 700671.0, 702495.0, 703048.0, 56931.0, 57366.85266294734, 57609.0, 57709.71145144331, 57778.799908008485, 1196.6051203102954, 1239.095460313994, 1300.681333073403, 1318.4198952460886, 1353.2557093598482, 28950.42099158047, 29810.658520366203, 30183.245418864703, 30365.0, 30972.0, 48696.0, 49099.0, 49285.26072108993, 49380.0, 49582.50417495779, 541136.0, 544113.0, 544275.0, 544741.0, 547065.0, 22770.089196431956, 26138.86930565335, 27683.58474622842, 27788.583171252852, 27982.300442488286, 43453.34819977766, 43557.19403192665, 43970.0, 43983.78008110067, 44742.3288650677, 36451.90644280676, 36636.81681591575, 37016.0, 37749.62250377461, 38315.0, 34768.0, 36718.0, 36786.8160659195, 37349.0, 37737.81131094327, 36636.0, 36677.0, 37011.6298837019, 37736.81131594325, 38352.0, 31993.36013279768, 33543.49684754682, 34001.65998339985, 34263.65736342605, 34344.65655343414, 25287.74712252854, 25470.872645636653, 25498.362540936625, 25527.851246694314, 26093.869530652224], "value": 19182.875706994517, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.58984398409865, 369.2448941913784, 371.81595110420335, 378.22086501806274, 399.16773527195795, 14783.334749936252, 15042.473513427032, 15671.05973641581, 19374.0, 20523.589528209428, 18674.0, 19169.0, 19855.5036124097, 19960.800391996076, 20543.897280513578, 5005.624578156635, 6112.113743507189, 6118.143459915593, 6135.233095863017, 6145.877082458348, 4712.104700106986, 6047.546434017444, 6087.360827113156, 6100.450959413652, 6108.725107370179, 5694.5729070319685, 6044.909326360086, 6052.485538729214, 6052.697365131748, 6055.6063855849225, 5892.9705351473185, 6016.157737916673, 6016.608920420159, 6023.789167379165, 6035.909461358083, 4980.576650984671, 5119.539241468248, 5221.269022336838, 5234.345706786652, 5236.3978142513715, 20838.0, 25114.623280650805, 25266.11568595109, 25523.617145742643, 25529.361765955815, 2276.8520046196945, 2288.4050146961745, 2452.0559584559896, 2956.659984101834, 3031.8787248510034, 14500.41998320066, 15633.140177290245, 15749.44876929302, 15797.763033554505, 16172.11053392063, 1510.4864346122372, 1832.5418645338666, 1846.1138653446287, 1893.9905300473547, 1896.6396384686866, 68346.31653683449, 85915.0, 90545.54727226388, 115147.42426287815, 115693.84306156999, 9755.853662195073, 10960.890391096147, 11050.33697978124, 11105.666829995112, 11163.0, 13195.538156164488, 13272.13731107475, 13277.20336779777, 13301.66745831362, 13323.66690832737, 8426.620802063922, 8468.703595374132, 8513.531755753493, 8590.527520986405, 8669.91330086691, 8434.662613495391, 8584.484930904166, 8631.093735157843, 8726.476411415335, 8864.024957254696, 5603.579731520153, 6481.902771458432, 6494.64279464634, 6497.18785151856, 6499.837504062341, 1570.6073481629592, 1786.2587026383906, 1835.128314050815, 1838.2463190092265, 1840.68708319586, 859.6260626627437, 870.5212133326645, 889.5507768576828, 894.18182363137, 1050.7320633238476, 16892.662146756997, 22103.557928841656, 22210.1126853508, 22340.441488962904, 22394.55210895773, 767.2327672327673, 802.4142376065505, 887.4586502233632, 922.1792604581927, 924.1867156901883, 9660.903390966001, 10572.735681607868, 11533.538658453735, 11730.296182229093, 11777.352245626402, 570468.0, 608501.0, 609696.0, 622578.0, 625018.0, 105966.0, 115763.0, 117048.0, 119219.0, 121891.39054304671, 982.5873133284038, 1001.5943542865006, 1014.8629934958834, 1015.9238057145743, 1020.4285600063988, 18811.341603043827, 19148.0, 19537.706934395712, 19559.0, 19585.922774247552, 34804.82597586996, 48486.0, 50933.0, 51301.74349128231, 52659.73670131625, 70437.64781176062, 73054.63472682603, 73943.8908416385, 75278.0, 75278.0, 5176.327077479904, 5929.318128415288, 6966.85046967265, 7819.609019549113, 7947.205279472007, 12622.116451848282, 13032.804507932578, 13361.26513041792, 13636.318184090955, 13658.590242292747, 9710.320277580502, 11134.109271258118, 11274.605388811353, 11416.94291528537, 11655.125865559947, 10939.45302734876, 11211.495482703134, 11382.203245772716, 11472.598459053894, 11767.411629418324, 10262.973702629975, 11404.657860264206, 11534.59628912984, 11597.420128993685, 11933.761324773282, 6960.79117626472, 7422.183559808309, 7880.448368614371, 8041.356691464785, 8067.515949043076, 10259.333143345659, 10581.62964296246, 10868.07621352194, 10948.507317170586, 11108.666739997812], "value": 9485.871205190975, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.3644732304836, 1466.4427517543331, 1485.2722166138592, 1634.5831812887711, 1808.2495764257842, 7630.351420129289, 8012.639431225594, 8268.751937441872, 8524.957375213131, 8543.61553730082, 8390.790230244247, 8482.151784821515, 8484.745457636265, 8486.872696909551, 8504.149585041492, 1946.649603071443, 2334.0663734506165, 2335.3344296875393, 2336.824738144646, 2337.754535773745, 2158.5467051919118, 2348.96476552851, 2359.95280094398, 2367.981767839828, 2368.3013511014206, 2304.8156147508244, 2325.3489023073566, 2338.6959695239593, 2342.0631747301045, 2349.0721165139844, 2255.9661605075935, 2299.8735069571167, 2327.2320134355623, 2328.6739856420113, 2331.090874558915, 2326.150954901466, 2351.1770880191966, 2353.094058787362, 2353.5292941411785, 2354.340784580303, 7385.150707668633, 8442.197991190827, 8499.107593702634, 8504.617292221865, 8504.744857654281, 5081.923771143436, 5267.315249017642, 5275.076861549252, 5283.260343551906, 5284.313039304904, 3414.402479566066, 3580.104973756561, 3620.2759448110482, 3656.652618001312, 3660.6705396514176, 890.3411475508077, 1061.135174832509, 1062.8140075486835, 1108.418080507732, 1108.5067145120424, 11028.724281892937, 11059.889401105966, 11124.276922000045, 11143.108551315876, 11147.498362573622, 3645.7812531247678, 4423.093265880487, 4486.955130448719, 4532.864014079583, 4541.205289074464, 8757.649694012169, 8777.122287771172, 8777.51723655205, 8784.341174411944, 8801.691940782042, 5076.847694569169, 5096.413912400121, 5102.336696229467, 5108.233764935215, 5109.8722531936255, 4151.543330233671, 4278.764667943231, 4431.512533621299, 4472.2620767573635, 4714.151452738472, 3105.8602362893726, 3620.637936206411, 3705.6109108543756, 3714.814259287025, 3720.9069773255887, 1142.0406858239119, 1142.5546683445448, 1143.9027682646902, 1162.6976985983706, 1163.5578480177478, 750.8535835512023, 864.8140649760331, 867.7873920889297, 879.8108406692592, 885.6767279942775, 5412.702301373462, 5438.428964958702, 5485.6434331768305, 5487.176923461433, 5509.449055094458, 447.19951287196204, 449.1690372810275, 457.1611093643136, 938.4603852784676, 981.6613268422383, 3511.367953768295, 3519.697711846633, 3566.1084728817796, 3705.2404257127223, 3732.8133593320226, 9967.0, 10480.895191047992, 10492.003259690317, 10494.632687856041, 10497.632582859564, 10342.224333175041, 10346.068853803194, 10367.740806479898, 10431.634892778868, 10432.165426765841, 7608.581528016012, 7880.684772609146, 8019.198080191934, 8032.236937491046, 8062.274395304451, 5175.4565770593545, 5191.091558977239, 5416.106342453609, 5607.420706163941, 5770.567207459541, 9271.582778775106, 9345.859812102688, 9660.275479338938, 9691.030896910253, 9787.021297870157, 8185.263326300424, 9012.0, 9557.092076252746, 9880.654177103766, 9955.054269844353, 7059.435245180476, 7293.744718934812, 7306.744263950736, 7309.707611695472, 7313.195548489768, 7685.346745526693, 7936.166702496154, 8058.516489010678, 8127.918720812716, 8130.186981302059, 7051.259617740064, 7155.391791697764, 7187.425005999403, 7250.202477727551, 7307.963460182665, 7042.0845290114, 7078.1506219254015, 7104.0, 7119.786406407816, 7149.60677162761, 6734.9326506734305, 6754.527183097332, 6755.831104222237, 6813.931860681329, 6818.965905170442, 4648.233041548242, 4729.834455794031, 4737.38414006177, 4788.066327066328, 4810.63920205993, 3836.577976422647, 4213.599708027732, 4695.812167513262, 4820.34925285082, 4853.39332583427], "value": 4337.187371185009, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.81438415374544, 307.8799268285368, 311.594926595426, 314.6051705110086, 317.7521533204099, 4403.317485789699, 4414.7792610369515, 5255.160693757183, 5274.367075950887, 5281.999999999995, 4648.604868586174, 4979.253112033197, 5152.252923326116, 5156.871078223046, 5181.5077567631015, 3733.383991641376, 3779.2252588219417, 3814.4278358246347, 3854.8265328060306, 4067.3288907330257, 3961.6038396160443, 4003.6396724294955, 4055.8986025349454, 4059.1678705865374, 4077.0215148364477, 3293.7767007269995, 3488.476728490721, 3969.4045893115976, 3972.9868883434683, 4004.1991601679633, 3309.8841540545964, 3379.493076038589, 3404.7957122572725, 3922.333203355422, 3988.501437320335, 2870.7846911481515, 3294.1929227339215, 3424.6746559077096, 3441.8623255069765, 3456.1705190754287, 4447.355133505656, 4926.359573255454, 5102.234664800272, 5110.361204849394, 5118.2873077269105, 3486.3027394520946, 4012.979935100335, 4516.532127058719, 4518.27707566791, 4526.95473045272, 4394.978025109854, 4775.505312774624, 5281.683099014072, 5483.8080667176455, 5493.697846618435, 3204.8878289259997, 3386.0868609235704, 3752.9249415011545, 3755.0, 3773.3019391412404, 5688.402717714663, 5703.914441283384, 5718.370979192286, 5730.484256416901, 5733.760425359742, 3492.231709024011, 3699.574548926854, 3761.7931013793955, 3823.2162406706557, 3847.249786291702, 3454.7063499602814, 3495.702865256482, 3810.333191691443, 3913.2369188008634, 3938.3895496198134, 4028.3957406389277, 4461.821527138943, 4507.4365704286965, 4515.7290562565695, 4531.546845315442, 5218.947810521846, 5285.788568457296, 5481.917771233435, 5538.584606154554, 5582.967151077064, 1224.0415335463188, 1240.765438388809, 1258.5406326690693, 1258.9236203046446, 1261.4197469164287, 681.5127184063418, 816.3061397811813, 855.2516548020482, 855.2858363266618, 855.7475544714324, 4833.3958255218095, 4998.550130488274, 5045.545900868866, 5056.0, 5184.403793563713, 5180.145276029413, 5633.253691355693, 5640.717964101778, 5668.0, 5692.601517893708, 4911.87720306988, 5131.974340128276, 5148.639595228298, 5151.6136289778415, 5168.715720635401, 2398.4723360860585, 2637.5779875220255, 2752.1973107614544, 2804.7001458803993, 2809.7752179825566, 4697.78859951303, 5073.858381864125, 5107.259447380109, 5430.619856609999, 5473.28847249855, 4828.787684918203, 5235.853300146921, 5421.484958928895, 5451.0207548489825, 5492.709213334863, 4686.789094490756, 5369.597280203922, 5414.971155480525, 5438.416752042748, 5443.863903402446, 4411.404460397805, 5280.1815718563685, 5299.602529810202, 5311.867203319948, 5321.787128514816, 4552.565941728345, 4560.338750881037, 5237.659552129099, 5245.501677340647, 5710.8001219957105, 5375.408705042364, 5842.853928651818, 5851.502622276984, 5857.970710146422, 5862.7654893805475, 3840.423936409561, 3844.7308688391545, 3864.30442520349, 3881.262560113569, 3884.864029758945, 5486.204500347507, 5678.659280443187, 5753.626014309057, 5757.827265182052, 5768.884622307446, 4875.805887350635, 4885.633577481632, 5508.3114610673665, 5532.3637781654015, 5582.804601838916, 5297.311349524537, 5405.189221616789, 5521.3926468087675, 5528.86177845541, 5571.637843540157, 4999.725015124058, 5070.847874563769, 5410.621256512007, 5431.424886782789, 5444.346678398618, 4614.676972611885, 5413.377461591967, 5421.62048656606, 5427.83716488506, 5533.695646739468, 4741.55809757968, 5395.514403703685, 5426.64726792773, 5431.701256430934, 5442.891142177055], "value": 3948.6324473727195, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.374725230806, 764.3770327183348, 765.7855800375896, 766.934810541104, 777.1723114882647, 13857.030007899451, 15989.60025999349, 16718.08050557219, 16723.08023058733, 16748.58128546787, 15343.923280383582, 15371.615709607237, 15373.38506459743, 15411.15238661873, 15432.228388580583, 660.4386271669067, 683.5078743304813, 810.7162493127418, 838.2748922182329, 842.8272204198155, 690.6891898645605, 810.7365106340434, 821.9725343320849, 835.5070508400042, 844.5228445928062, 873.4977388001893, 873.9257163141141, 874.4971641306242, 874.7638137702817, 874.7813046738315, 701.6596950479013, 868.0754995929346, 870.5473153959969, 872.389327470773, 879.1779685993616, 531.0944839049412, 624.3506752976898, 639.4564620072947, 640.3212594649686, 648.0408994687841, 14414.063085899383, 14467.276636168255, 14473.276336183255, 14481.92759036198, 14482.1310721356, 10669.359838409642, 11303.886961130365, 12922.160059596095, 13089.934550327187, 13187.472501099945, 9654.662086826998, 11313.094952403788, 11760.941195294054, 12138.0, 12529.937350313281, 3695.7597756146033, 3704.351738445788, 3718.1448266898765, 3767.321882061228, 3811.123441608446, 92686.53656731741, 93856.59215111847, 94702.0, 95417.0, 98576.0, 9119.452832830051, 9194.356395052282, 9286.95356523213, 9307.53462326881, 9316.20812230968, 17007.149642517823, 20067.899660501895, 20111.698324525143, 20167.49581260451, 20419.28532501385, 7219.917012448175, 7306.634668266565, 7412.18465968743, 7443.739469118555, 7694.769156925301, 4133.780534742258, 4182.456280683492, 4260.403543503912, 4277.550857160016, 4301.41930839339, 3416.214270717749, 3507.7895326280504, 3526.365254254259, 3526.559180102487, 3533.169705119295, 637.0698779781478, 638.6168299020643, 644.8968165093562, 646.9805905822833, 671.419222372654, 521.6426747677853, 577.653407955232, 644.8323435906605, 668.353320849432, 696.4010950582496, 9063.68277110298, 9121.407108537924, 9335.299852511089, 9355.48544830041, 9403.0, 656.6683824668607, 662.903878937561, 668.391763495217, 676.2662511175331, 685.8559702462439, 4268.423762791983, 4531.546845315508, 4540.432445944257, 4563.977180114078, 4608.055348653518, 83545.0, 105367.94632053735, 108832.0, 127016.72983270048, 131915.0, 68586.79838616973, 71845.0, 72749.0, 72791.0, 89018.0, 84086.57956710299, 87191.0, 88005.0, 89438.65842012505, 92644.53677731568, 9331.626734930527, 9483.857742133736, 9634.807303854024, 9654.469004204555, 9662.951685241529, 37627.0, 52059.479405205464, 56151.0, 56293.0, 58819.41180588139, 58238.708806455696, 72929.27070729225, 74307.0, 77590.0, 82039.0, 12280.263184208976, 12334.629961101182, 12357.629271121881, 12428.13003089775, 12657.0, 14066.42893631387, 14084.577462676136, 14201.360938757574, 14297.571072867831, 14450.566483005527, 12996.610101696964, 13027.413766380725, 13078.542251021168, 13141.54004609834, 13427.932860336026, 12426.808710137439, 12608.684782880502, 13104.475820967054, 13353.332333383098, 13396.866031339561, 12870.0, 12878.098533102968, 13261.0, 13461.86538134606, 13514.121582097132, 10648.0, 10965.890341096487, 11187.0, 11396.145289103184, 11417.372044537298, 10326.896731032593, 11139.944300278446, 11174.66476005721, 11180.0, 11180.105591552494], "value": 7283.850632308457, "unit": "score"}], "name": "dromaeo_css", "value": 7104.510897549365, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 118.0, 158.0, 166.0, 115.0, 116.0, 116.0, 115.0, 114.0], "value": 124.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 133.0, 121.0, 160.0, 137.0, 140.0, 138.0, 113.0, 142.0, 112.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 188.0, 219.0, 184.0, 184.0, 182.0, 185.0, 186.0, 184.0, 184.0], "value": 188.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 59.0, 89.0, 62.0, 60.0, 60.0, 58.0, 82.0, 76.0], "value": 68.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 93.0, 73.0, 96.0, 99.0, 115.0, 68.0, 68.0, 92.0], "value": 85.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 88.0, 85.0, 90.0, 85.0, 89.0, 85.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 130.0, 108.0, 95.0, 93.0, 95.0, 94.0], "value": 99.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 81.0, 79.0, 82.0, 83.0, 82.0, 115.0, 121.0, 108.0], "value": 91.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 50.0, 53.0, 57.0, 55.0, 55.0, 55.0, 55.0, 56.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 68.0, 79.0, 74.0, 70.0, 69.0, 69.0, 70.0, 68.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 82.0, 95.0, 83.0, 85.0, 84.0, 83.0, 85.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 149.0, 149.0, 145.0, 146.0, 158.0, 152.0, 160.0, 197.0, 146.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 167.0, 171.0, 169.0, 165.0, 166.0, 166.0, 163.0, 166.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 67.0, 67.0, 66.0, 65.0, 69.0, 81.0, 81.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1480.7, "alertThreshold": 2.0}]} 17:56:49 INFO - Return code: 0 17:56:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:56:49 ERROR - # TBPL SUCCESS # 17:56:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:56:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:56:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:56:49 INFO - 2016-11-23 17:56:49.578 screenresolution[1665:10121] starting screenresolution argv=screenresolution get 17:56:49 INFO - 2016-11-23 17:56:49.581 screenresolution[1665:10121] Display 0: 1600x1200x32@60 17:56:49 INFO - 2016-11-23 17:56:49.587 screenresolution[1666:10124] starting screenresolution argv=screenresolution list 17:56:49 INFO - Available Modes on Display 0 17:56:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:56:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:56:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:56:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:56:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:56:49 INFO - Intel Iris: 17:56:49 INFO - Chipset Model: Intel Iris 17:56:49 INFO - Type: GPU 17:56:49 INFO - Bus: Built-In 17:56:49 INFO - VRAM (Dynamic, Max): 1536 MB 17:56:49 INFO - Vendor: Intel (0x8086) 17:56:49 INFO - Device ID: 0x0a2e 17:56:49 INFO - Revision ID: 0x0009 17:56:49 INFO - Displays: 17:56:49 INFO - Display: 17:56:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:56:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:56:49 INFO - Display Serial Number: 1600x1200 60 17:56:49 INFO - Main Display: Yes 17:56:49 INFO - Mirror: Off 17:56:49 INFO - Online: Yes 17:56:49 INFO - Rotation: Supported 17:56:49 INFO - Return code: 0 17:56:49 INFO - Running post-action listener: _resource_record_post_action 17:56:49 INFO - [mozharness: 2016-11-24 01:56:49.834722Z] Finished run-tests step (success) 17:56:49 INFO - Running post-run listener: _resource_record_post_run 17:56:49 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 42943488; Write bytes: 658206720; Read time: 314; Write time: 1940 17:56:49 INFO - TinderboxPrint: CPU usage
53.6% 17:56:49 INFO - TinderboxPrint: I/O read bytes / time
42,943,488 / 314 17:56:49 INFO - TinderboxPrint: I/O write bytes / time
658,206,720 / 1,940 17:56:49 INFO - TinderboxPrint: CPU idle
2,248.3 (46.4%) 17:56:49 INFO - TinderboxPrint: CPU system
972.0 (20.0%) 17:56:49 INFO - TinderboxPrint: CPU user
1,629.4 (33.6%) 17:56:49 INFO - TinderboxPrint: Swap in / out
390,291,456 / 0 17:56:49 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 336003584; Write bytes: 332969472; Read time: 27154; Write time: 691 17:56:49 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 41980928; Write bytes: 307444224; Read time: 301; Write time: 1196 17:56:50 INFO - Running post-run listener: _upload_blobber_files 17:56:50 INFO - Blob upload gear active. 17:56:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:56:50 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 17:56:50 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:56:50 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:56:50 INFO - (blobuploader) - INFO - Open directory for files ... 17:56:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:56:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:56:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:51 INFO - (blobuploader) - INFO - Done attempting. 17:56:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:56:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:56:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:52 INFO - (blobuploader) - INFO - Done attempting. 17:56:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:56:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:56:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:55 INFO - (blobuploader) - INFO - Done attempting. 17:56:55 INFO - (blobuploader) - INFO - Iteration through files over. 17:56:55 INFO - Return code: 0 17:56:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:56:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:56:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db91f8085a8c68b7b251eb59eda836f921096e0002495f00fd3fbea469af7dbc620db2a0fb3b0063c5e60e87b9cebdd451dea5a910564dc3e792eab84b4533d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a93d755535daf4db69166c4131c0c4cf3f08edaf66d8e4414aab6e54238e492b41c5abc1d1ea4cd7f1235657f5096a62cabc3ae9a36abf7555ebe99d68a9f65e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c13969d8f81cee572dc791e91281e267dff8cd3695d4b0bdc3640a6a84ca7e4f9c54a9eb24a801e5813814e4401f9221285a98fbb7bcf42d02475e9ad95148e5"} 17:56:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:56:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:56:55 INFO - Contents: 17:56:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db91f8085a8c68b7b251eb59eda836f921096e0002495f00fd3fbea469af7dbc620db2a0fb3b0063c5e60e87b9cebdd451dea5a910564dc3e792eab84b4533d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a93d755535daf4db69166c4131c0c4cf3f08edaf66d8e4414aab6e54238e492b41c5abc1d1ea4cd7f1235657f5096a62cabc3ae9a36abf7555ebe99d68a9f65e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c13969d8f81cee572dc791e91281e267dff8cd3695d4b0bdc3640a6a84ca7e4f9c54a9eb24a801e5813814e4401f9221285a98fbb7bcf42d02475e9ad95148e5"} 17:56:55 INFO - Running post-run listener: copy_logs_to_upload_dir 17:56:55 INFO - Copying logs to upload dir... 17:56:55 INFO - mkdir: /builds/slave/test/build/upload/logs 17:56:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.962804 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-23 17:56:55.778479) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 17:56:55.782461) ========= 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.I9SwIZXfUt/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.czfZ3EFobZ/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db91f8085a8c68b7b251eb59eda836f921096e0002495f00fd3fbea469af7dbc620db2a0fb3b0063c5e60e87b9cebdd451dea5a910564dc3e792eab84b4533d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a93d755535daf4db69166c4131c0c4cf3f08edaf66d8e4414aab6e54238e492b41c5abc1d1ea4cd7f1235657f5096a62cabc3ae9a36abf7555ebe99d68a9f65e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c13969d8f81cee572dc791e91281e267dff8cd3695d4b0bdc3640a6a84ca7e4f9c54a9eb24a801e5813814e4401f9221285a98fbb7bcf42d02475e9ad95148e5"} build_url:https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010967 build_url: 'https://queue.taskcluster.net/v1/task/dq6uGNpoQ1SSqiRAuxhzHg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db91f8085a8c68b7b251eb59eda836f921096e0002495f00fd3fbea469af7dbc620db2a0fb3b0063c5e60e87b9cebdd451dea5a910564dc3e792eab84b4533d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a93d755535daf4db69166c4131c0c4cf3f08edaf66d8e4414aab6e54238e492b41c5abc1d1ea4cd7f1235657f5096a62cabc3ae9a36abf7555ebe99d68a9f65e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c13969d8f81cee572dc791e91281e267dff8cd3695d4b0bdc3640a6a84ca7e4f9c54a9eb24a801e5813814e4401f9221285a98fbb7bcf42d02475e9ad95148e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 17:56:55.816143) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:56:55.816560) ========= 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.I9SwIZXfUt/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.czfZ3EFobZ/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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.005152 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:56:55.867378) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 17:56:55.867890) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 17:56:55.868327) ========= ========= Total master_lag: 0.18 =========