builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0273 starttime: 1477588056.56 results: success (0) buildid: 20161027074334 builduid: 5d8b2f22e8d0404a807b1f47d2c1cf26 revision: 23cbe1a93a98bb0a9822fd2d079fc259ff262899 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 10:07:36.557062) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 10:07:36.557485) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 10:07:36.557763) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 10:07:36.582010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 10:07:36.582350) ========= 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.lPzzSPWE2H/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.WzhoWbqwLk/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-27 10:07:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2016-10-27 10:07:36 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125490 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 10:07:36.730120) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 10:07:36.730453) ========= 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.lPzzSPWE2H/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.WzhoWbqwLk/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.029738 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 10:07:36.780967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-27 10:07:36.781334) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 23cbe1a93a98bb0a9822fd2d079fc259ff262899 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 23cbe1a93a98bb0a9822fd2d079fc259ff262899 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lPzzSPWE2H/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.WzhoWbqwLk/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-27 10:07:36,863 truncating revision to first 12 chars 2016-10-27 10:07:36,863 Setting DEBUG logging. 2016-10-27 10:07:36,863 attempt 1/10 2016-10-27 10:07:36,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/23cbe1a93a98?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 10:07:38,904 unpacking tar archive at: mozilla-central-23cbe1a93a98/testing/mozharness/ program finished with exit code 0 elapsedTime=2.294903 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-27 10:07:39.097740) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 10:07:39.098075) ========= script_repo_revision: 23cbe1a93a98bb0a9822fd2d079fc259ff262899 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 10:07:39.098501) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 10:07:39.098772) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 10:07:39.117570) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-27 10:07:39.117963) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lPzzSPWE2H/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.WzhoWbqwLk/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 10:07:39 INFO - MultiFileLogger online at 20161027 10:07:39 in /builds/slave/test 10:07:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:07:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:07:39 INFO - {'append_to_log': False, 10:07:39 INFO - 'base_work_dir': '/builds/slave/test', 10:07:39 INFO - 'blob_upload_branch': 'Firefox', 10:07:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:07:39 INFO - 'branch': 'Firefox', 10:07:39 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:39 INFO - 'config_files': ('talos/mac_config.py',), 10:07:39 INFO - 'default_actions': ('clobber', 10:07:39 INFO - 'read-buildbot-config', 10:07:39 INFO - 'download-and-extract', 10:07:39 INFO - 'populate-webroot', 10:07:39 INFO - 'create-virtualenv', 10:07:39 INFO - 'install', 10:07:39 INFO - 'run-tests'), 10:07:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:39 INFO - 'download_minidump_stackwalk': True, 10:07:39 INFO - 'download_symbols': 'ondemand', 10:07:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:39 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:39 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:39 INFO - 'installer_path': 'installer.exe', 10:07:39 INFO - 'log_level': 'info', 10:07:39 INFO - 'log_name': 'talos', 10:07:39 INFO - 'log_to_console': True, 10:07:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:07:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:07:39 INFO - 'opt_config_files': (), 10:07:39 INFO - 'pip_index': False, 10:07:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:07:39 INFO - 'cmd': ('bash', 10:07:39 INFO - '-c', 10:07:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:07:39 INFO - 'enabled': True, 10:07:39 INFO - 'halt_on_failure': False, 10:07:39 INFO - 'name': 'check_screen_resolution'},), 10:07:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:07:39 INFO - 'cmd': ('bash', 10:07:39 INFO - '-c', 10:07:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:07:39 INFO - 'enabled': True, 10:07:39 INFO - 'halt_on_failure': False, 10:07:39 INFO - 'name': 'check_screen_resolution'},), 10:07:39 INFO - 'run_cmd_checks_enabled': True, 10:07:39 INFO - 'sps_profile': False, 10:07:39 INFO - 'sps_profile_interval': 0, 10:07:39 INFO - 'suite': 'dromaeojs-e10s', 10:07:39 INFO - 'system_bits': '32', 10:07:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:39 INFO - 'title': 't-yosemite-r7-0273', 10:07:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:39 INFO - 'use_talos_json': True, 10:07:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:07:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:39 INFO - 'work_dir': 'build'} 10:07:39 INFO - [mozharness: 2016-10-27 17:07:39.319102Z] Running clobber step. 10:07:39 INFO - Running pre-action listener: _resource_record_pre_action 10:07:39 INFO - Running main action method: clobber 10:07:39 INFO - rmtree: /builds/slave/test/build 10:07:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:07:41 INFO - Running post-action listener: _resource_record_post_action 10:07:41 INFO - [mozharness: 2016-10-27 17:07:41.439518Z] Finished clobber step (success) 10:07:41 INFO - [mozharness: 2016-10-27 17:07:41.439688Z] Running read-buildbot-config step. 10:07:41 INFO - Running pre-action listener: _resource_record_pre_action 10:07:41 INFO - Running main action method: read_buildbot_config 10:07:41 INFO - Using buildbot properties: 10:07:41 INFO - { 10:07:41 INFO - "project": "", 10:07:41 INFO - "product": "firefox", 10:07:41 INFO - "script_repo_revision": "production", 10:07:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:07:41 INFO - "repository": "", 10:07:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:07:41 INFO - "buildid": "20161027074334", 10:07:41 INFO - "pgo_build": "False", 10:07:41 INFO - "basedir": "/builds/slave/test", 10:07:41 INFO - "buildnumber": 16, 10:07:41 INFO - "slavename": "t-yosemite-r7-0273", 10:07:41 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:07:41 INFO - "platform": "yosemite_r7", 10:07:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:07:41 INFO - "branch": "mozilla-central", 10:07:41 INFO - "repo_path": "mozilla-central", 10:07:41 INFO - "revision": "23cbe1a93a98bb0a9822fd2d079fc259ff262899", 10:07:41 INFO - "stage_platform": "macosx64", 10:07:41 INFO - "builduid": "5d8b2f22e8d0404a807b1f47d2c1cf26", 10:07:41 INFO - "slavebuilddir": "test" 10:07:41 INFO - } 10:07:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 10:07:41 INFO - Running post-action listener: _resource_record_post_action 10:07:41 INFO - [mozharness: 2016-10-27 17:07:41.443058Z] Finished read-buildbot-config step (success) 10:07:41 INFO - [mozharness: 2016-10-27 17:07:41.443162Z] Running download-and-extract step. 10:07:41 INFO - Running pre-action listener: _resource_record_pre_action 10:07:41 INFO - Running main action method: download_and_extract 10:07:41 INFO - mkdir: /builds/slave/test/build/tests 10:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:41 INFO - trying https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 10:07:41 INFO - Downloading https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 10:07:42 INFO - Downloaded 1199 bytes. 10:07:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:07:42 INFO - Using the following test package requirements: 10:07:42 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:07:42 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:42 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 10:07:42 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:42 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 10:07:42 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:42 INFO - u'jsshell-mac.zip'], 10:07:42 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:42 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 10:07:42 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:07:42 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:42 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 10:07:42 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:42 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 10:07:42 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:42 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 10:07:42 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:42 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 10:07:42 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:07:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:07:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:07:42 INFO - Fetch https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:07:43 INFO - Http code: 200 10:07:43 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 10:07:43 INFO - x-amz-cf-id: zYRc8GwqL-p6-375cb5IGAVxHs5lsyru-R1Bml6wNjTQYCSeVod2Fw== 10:07:43 INFO - x-amz-version-id: rvUN9N4hBfOATglCFXLloVQGUUk2eFfN 10:07:43 INFO - Expected file size: 16376942 10:07:43 INFO - Obtained file size: 16376942 10:07:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:07:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:07:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:07:49 INFO - Fetch https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:07:50 INFO - Http code: 200 10:07:50 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 10:07:50 INFO - x-amz-cf-id: DpvwGSZwwoOpG38zVX4EK4DGKDo9zpnLcUs7c5fU_SokqX6abVUMIQ== 10:07:50 INFO - x-amz-version-id: rvUN9N4hBfOATglCFXLloVQGUUk2eFfN 10:07:50 INFO - Expected file size: 16376942 10:07:50 INFO - Obtained file size: 16376942 10:07:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 10:07:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:07:57 INFO - Fetch https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 10:07:58 INFO - Http code: 200 10:07:58 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 10:07:58 INFO - x-amz-cf-id: 1UxF6YORlXqO8amOh7I2JddyI8nY6r4hPJjZU5WoCC8J8oQ_NHdkRQ== 10:07:58 INFO - x-amz-version-id: BLfa.lvFpnLSWuKPT1i1QiY2XUeaIoz4 10:07:58 INFO - Expected file size: 14409028 10:07:58 INFO - Obtained file size: 14409028 10:07:58 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')]} 10:07:58 INFO - trying https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:07:58 INFO - Downloading https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 10:07:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 10:08:01 INFO - Downloaded 111523689 bytes. 10:08:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:08:01 INFO - mkdir: /builds/slave/test/properties 10:08:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:08:01 INFO - Writing to file /builds/slave/test/properties/build_url 10:08:01 INFO - Contents: 10:08:01 INFO - build_url:https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:08:02 INFO - Running post-action listener: _resource_record_post_action 10:08:02 INFO - Running post-action listener: set_extra_try_arguments 10:08:02 INFO - [mozharness: 2016-10-27 17:08:02.590844Z] Finished download-and-extract step (success) 10:08:02 INFO - [mozharness: 2016-10-27 17:08:02.590996Z] Running populate-webroot step. 10:08:02 INFO - Running pre-action listener: _resource_record_pre_action 10:08:02 INFO - Running main action method: populate_webroot 10:08:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:08:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:08:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:08:02 INFO - '--tppagecycles', 10:08:02 INFO - '7'], 10:08:02 INFO - 'tests': ['tsvgm']}}, 10:08:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:08:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:08:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:08:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:08:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:08:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:08:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:02 INFO - 'talos_options': ['--disable-e10s'], 10:08:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:02 INFO - 'talos_options': ['--disable-e10s'], 10:08:02 INFO - 'tests': ['damp', 'tps']}, 10:08:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:02 INFO - 'tests': ['damp', 'tps']}, 10:08:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:08:02 INFO - 'tests': ['dromaeo_dom']}, 10:08:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:08:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:08:02 INFO - 'tests': ['basic_compositor_video']}, 10:08:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:08:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:08:02 INFO - 'tests': ['a11yr', 10:08:02 INFO - 'ts_paint', 10:08:02 INFO - 'tpaint', 10:08:02 INFO - 'sessionrestore', 10:08:02 INFO - 'sessionrestore_no_auto_restore', 10:08:02 INFO - 'tabpaint']}, 10:08:02 INFO - 'other-e10s': {'tests': ['a11yr', 10:08:02 INFO - 'ts_paint', 10:08:02 INFO - 'tpaint', 10:08:02 INFO - 'sessionrestore', 10:08:02 INFO - 'sessionrestore_no_auto_restore', 10:08:02 INFO - 'tabpaint']}, 10:08:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:08:02 INFO - 'ts_paint', 10:08:02 INFO - 'tpaint', 10:08:02 INFO - 'sessionrestore', 10:08:02 INFO - 'sessionrestore_no_auto_restore', 10:08:02 INFO - 'tabpaint']}, 10:08:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:08:02 INFO - 'ts_paint', 10:08:02 INFO - 'tpaint', 10:08:02 INFO - 'sessionrestore', 10:08:02 INFO - 'sessionrestore_no_auto_restore', 10:08:02 INFO - 'tabpaint']}, 10:08:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:08:02 INFO - 'tests': ['a11yr', 10:08:02 INFO - 'ts_paint', 10:08:02 INFO - 'tpaint', 10:08:02 INFO - 'sessionrestore', 10:08:02 INFO - 'sessionrestore_no_auto_restore', 10:08:02 INFO - 'tabpaint']}, 10:08:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:08:02 INFO - 'tests': ['a11yr', 10:08:02 INFO - 'ts_paint', 10:08:02 INFO - 'tpaint', 10:08:02 INFO - 'sessionrestore', 10:08:02 INFO - 'sessionrestore_no_auto_restore', 10:08:02 INFO - 'tabpaint']}, 10:08:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:08:02 INFO - 'tests': ['tsvgx', 10:08:02 INFO - 'tsvgr_opacity', 10:08:02 INFO - 'tart', 10:08:02 INFO - 'tscrollx', 10:08:02 INFO - 'cart']}, 10:08:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:08:02 INFO - 'tsvgr_opacity', 10:08:02 INFO - 'tart', 10:08:02 INFO - 'tscrollx', 10:08:02 INFO - 'cart']}, 10:08:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:02 INFO - 'talos_options': ['--disable-e10s'], 10:08:02 INFO - 'tests': ['tp5o']}, 10:08:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:02 INFO - 'tests': ['tp5o']}, 10:08:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:02 INFO - 'talos_options': ['--disable-e10s', 10:08:02 INFO - '--xperf_path', 10:08:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:02 INFO - 'tests': ['tp5n']}, 10:08:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:02 INFO - 'talos_options': ['--xperf_path', 10:08:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:02 INFO - 'tests': ['tp5n']}}, 10:08:02 INFO - 'talos.zip': {'path': '', 10:08:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:08:02 INFO - Running post-action listener: _resource_record_post_action 10:08:02 INFO - [mozharness: 2016-10-27 17:08:02.609907Z] Finished populate-webroot step (success) 10:08:02 INFO - [mozharness: 2016-10-27 17:08:02.610048Z] Running create-virtualenv step. 10:08:02 INFO - Running pre-action listener: _resource_record_pre_action 10:08:02 INFO - Running main action method: create_virtualenv 10:08:02 INFO - Creating virtualenv /builds/slave/test/build/venv 10:08:02 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 10:08:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:08:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:08:02 INFO - Using real prefix '/tools/python27' 10:08:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:08:03 INFO - Installing distribute.............................................................................................................................................................................................done. 10:08:06 INFO - Installing pip.................done. 10:08:06 INFO - Return code: 0 10:08:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:08:06 INFO - Reading from file tmpfile_stdout 10:08:06 INFO - Output received: 10:08:06 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) 10:08:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:08:06 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')]} 10:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:06 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')]} 10:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:06 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 0x1098ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd40d84a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c1d30>, '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 0x1094e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b9b20>, '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.lPzzSPWE2H/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.WzhoWbqwLk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 10:08:06 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 10:08:06 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 10:08:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lPzzSPWE2H/Render', 10:08:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:06 INFO - 'HOME': '/Users/cltbld', 10:08:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:06 INFO - 'LOGNAME': 'cltbld', 10:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:06 INFO - 'MOZ_NO_REMOTE': '1', 10:08:06 INFO - 'NO_EM_RESTART': '1', 10:08:06 INFO - 'PAGER': '/bin/cat', 10:08:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:06 INFO - 'PWD': '/builds/slave/test', 10:08:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:06 INFO - 'SHELL': '/bin/bash', 10:08:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WzhoWbqwLk/Listeners', 10:08:06 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 10:08:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:06 INFO - 'USER': 'cltbld', 10:08:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:06 INFO - 'XPC_FLAGS': '0x0', 10:08:06 INFO - 'XPC_SERVICE_NAME': '0', 10:08:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:08:07 INFO - Cleaning up... 10:08:07 INFO - Return code: 0 10:08:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1098ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd40d84a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c1d30>, '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 0x1094e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b9b20>, '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.lPzzSPWE2H/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.WzhoWbqwLk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 10:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:08:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lPzzSPWE2H/Render', 10:08:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:07 INFO - 'HOME': '/Users/cltbld', 10:08:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:07 INFO - 'LOGNAME': 'cltbld', 10:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:07 INFO - 'MOZ_NO_REMOTE': '1', 10:08:07 INFO - 'NO_EM_RESTART': '1', 10:08:07 INFO - 'PAGER': '/bin/cat', 10:08:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:07 INFO - 'PWD': '/builds/slave/test', 10:08:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:07 INFO - 'SHELL': '/bin/bash', 10:08:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WzhoWbqwLk/Listeners', 10:08:07 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 10:08:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:07 INFO - 'USER': 'cltbld', 10:08:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:07 INFO - 'XPC_FLAGS': '0x0', 10:08:07 INFO - 'XPC_SERVICE_NAME': '0', 10:08:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:07 INFO - Downloading/unpacking psutil>=3.1.1 10:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:08:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:10 INFO - Installing collected packages: psutil 10:08:10 INFO - Running setup.py install for psutil 10:08:10 INFO - building 'psutil._psutil_osx' extension 10:08:10 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 10:08:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:08:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:08:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:08:11 INFO - building 'psutil._psutil_posix' extension 10:08:11 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 10:08:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:08:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:08:11 INFO - ^ 10:08:11 INFO - 1 warning generated. 10:08:11 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 10:08:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:11 INFO - Successfully installed psutil 10:08:11 INFO - Cleaning up... 10:08:11 INFO - Return code: 0 10:08:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:08:11 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')]} 10:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:11 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')]} 10:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:11 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 0x1098ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd40d84a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c1d30>, '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 0x1094e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b9b20>, '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.lPzzSPWE2H/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.WzhoWbqwLk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 10:08:11 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 10:08:11 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 10:08:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lPzzSPWE2H/Render', 10:08:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:11 INFO - 'HOME': '/Users/cltbld', 10:08:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:11 INFO - 'LOGNAME': 'cltbld', 10:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:11 INFO - 'MOZ_NO_REMOTE': '1', 10:08:11 INFO - 'NO_EM_RESTART': '1', 10:08:11 INFO - 'PAGER': '/bin/cat', 10:08:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:11 INFO - 'PWD': '/builds/slave/test', 10:08:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:11 INFO - 'SHELL': '/bin/bash', 10:08:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WzhoWbqwLk/Listeners', 10:08:11 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 10:08:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:11 INFO - 'USER': 'cltbld', 10:08:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:11 INFO - 'XPC_FLAGS': '0x0', 10:08:11 INFO - 'XPC_SERVICE_NAME': '0', 10:08:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:08:14 INFO - Installing collected packages: mozsystemmonitor 10:08:14 INFO - Running setup.py install for mozsystemmonitor 10:08:14 INFO - Successfully installed mozsystemmonitor 10:08:14 INFO - Cleaning up... 10:08:15 INFO - Return code: 0 10:08:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:08:15 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')]} 10:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:15 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')]} 10:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:15 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 0x1098ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd40d84a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c1d30>, '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 0x1094e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b9b20>, '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.lPzzSPWE2H/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.WzhoWbqwLk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 10:08:15 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 10:08:15 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 10:08:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lPzzSPWE2H/Render', 10:08:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:15 INFO - 'HOME': '/Users/cltbld', 10:08:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:15 INFO - 'LOGNAME': 'cltbld', 10:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:15 INFO - 'MOZ_NO_REMOTE': '1', 10:08:15 INFO - 'NO_EM_RESTART': '1', 10:08:15 INFO - 'PAGER': '/bin/cat', 10:08:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:15 INFO - 'PWD': '/builds/slave/test', 10:08:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:15 INFO - 'SHELL': '/bin/bash', 10:08:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WzhoWbqwLk/Listeners', 10:08:15 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 10:08:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:15 INFO - 'USER': 'cltbld', 10:08:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:15 INFO - 'XPC_FLAGS': '0x0', 10:08:15 INFO - 'XPC_SERVICE_NAME': '0', 10:08:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:15 INFO - Downloading/unpacking jsonschema==2.5.1 10:08:15 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 10:08:15 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 10:08:15 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 10:08:15 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 10:08:15 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 10:08:15 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 10:08:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:08:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:18 INFO - Downloading functools32-3.2.3-2.tar.gz 10:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:08:18 INFO - warning: no files found matching '*.txt' 10:08:18 INFO - no previously-included directories found matching 'build' 10:08:18 INFO - no previously-included directories found matching 'dist' 10:08:18 INFO - no previously-included directories found matching '.git*' 10:08:18 INFO - Installing collected packages: jsonschema, functools32 10:08:18 INFO - Running setup.py install for functools32 10:08:18 INFO - warning: no files found matching '*.txt' 10:08:18 INFO - no previously-included directories found matching 'build' 10:08:18 INFO - no previously-included directories found matching 'dist' 10:08:18 INFO - no previously-included directories found matching '.git*' 10:08:18 INFO - Successfully installed jsonschema functools32 10:08:18 INFO - Cleaning up... 10:08:18 INFO - Return code: 0 10:08:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:08:18 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')]} 10:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:18 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')]} 10:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:18 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 0x1098ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd40d84a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c1d30>, '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 0x1094e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b9b20>, '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.lPzzSPWE2H/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.WzhoWbqwLk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 10:08:18 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 10:08:18 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 10:08:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lPzzSPWE2H/Render', 10:08:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:18 INFO - 'HOME': '/Users/cltbld', 10:08:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:18 INFO - 'LOGNAME': 'cltbld', 10:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:18 INFO - 'MOZ_NO_REMOTE': '1', 10:08:18 INFO - 'NO_EM_RESTART': '1', 10:08:18 INFO - 'PAGER': '/bin/cat', 10:08:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:18 INFO - 'PWD': '/builds/slave/test', 10:08:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:18 INFO - 'SHELL': '/bin/bash', 10:08:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WzhoWbqwLk/Listeners', 10:08:18 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 10:08:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:18 INFO - 'USER': 'cltbld', 10:08:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:18 INFO - 'XPC_FLAGS': '0x0', 10:08:18 INFO - 'XPC_SERVICE_NAME': '0', 10:08:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:08:18 INFO - Cleaning up... 10:08:18 INFO - Return code: 0 10:08:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:08:18 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')]} 10:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:18 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')]} 10:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:18 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 0x1098ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd40d84a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c1d30>, '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 0x1094e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b9b20>, '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.lPzzSPWE2H/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.WzhoWbqwLk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 10:08:18 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 10:08:18 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 10:08:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lPzzSPWE2H/Render', 10:08:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:18 INFO - 'HOME': '/Users/cltbld', 10:08:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:18 INFO - 'LOGNAME': 'cltbld', 10:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:18 INFO - 'MOZ_NO_REMOTE': '1', 10:08:18 INFO - 'NO_EM_RESTART': '1', 10:08:18 INFO - 'PAGER': '/bin/cat', 10:08:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:18 INFO - 'PWD': '/builds/slave/test', 10:08:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:18 INFO - 'SHELL': '/bin/bash', 10:08:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WzhoWbqwLk/Listeners', 10:08:18 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 10:08:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:18 INFO - 'USER': 'cltbld', 10:08:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:18 INFO - 'XPC_FLAGS': '0x0', 10:08:18 INFO - 'XPC_SERVICE_NAME': '0', 10:08:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:19 INFO - Downloading/unpacking blobuploader==1.2.4 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:21 INFO - Downloading blobuploader-1.2.4.tar.gz 10:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:08:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:08:21 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 10:08:21 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 10:08:21 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 10:08:21 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 10:08:21 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 10:08:21 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 10:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:08:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:08:22 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 10:08:22 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 10:08:22 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 10:08:22 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 10:08:22 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 10:08:22 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 10:08:22 INFO - Downloading docopt-0.6.1.tar.gz 10:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:08:22 INFO - Installing collected packages: blobuploader, requests, docopt 10:08:22 INFO - Running setup.py install for blobuploader 10:08:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:08:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:08:23 INFO - Running setup.py install for requests 10:08:23 INFO - Running setup.py install for docopt 10:08:23 INFO - Successfully installed blobuploader requests docopt 10:08:23 INFO - Cleaning up... 10:08:23 INFO - Return code: 0 10:08:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:23 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')]} 10:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:23 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')]} 10:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:23 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 0x1098ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd40d84a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c1d30>, '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 0x1094e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b9b20>, '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.lPzzSPWE2H/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.WzhoWbqwLk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 10:08:23 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 10:08:23 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 10:08:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lPzzSPWE2H/Render', 10:08:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:23 INFO - 'HOME': '/Users/cltbld', 10:08:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:23 INFO - 'LOGNAME': 'cltbld', 10:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:23 INFO - 'MOZ_NO_REMOTE': '1', 10:08:23 INFO - 'NO_EM_RESTART': '1', 10:08:23 INFO - 'PAGER': '/bin/cat', 10:08:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:23 INFO - 'PWD': '/builds/slave/test', 10:08:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:23 INFO - 'SHELL': '/bin/bash', 10:08:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WzhoWbqwLk/Listeners', 10:08:23 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 10:08:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:23 INFO - 'USER': 'cltbld', 10:08:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:23 INFO - 'XPC_FLAGS': '0x0', 10:08:23 INFO - 'XPC_SERVICE_NAME': '0', 10:08:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-8_B0WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-YwkC82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-UtphTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-ElwMjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-eD8EAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-poMuvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-RzKk46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-r7rUB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-5Mv0DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:25 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-pfyF60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:25 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-eXXKnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:25 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-0RzGIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:25 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-C7UuDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:25 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-sPJlgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:25 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-P9RPm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:25 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-L60dnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:25 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-BWZrue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:08:25 INFO - Running setup.py install for manifestparser 10:08:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:08:26 INFO - Running setup.py install for mozcrash 10:08:26 INFO - Running setup.py install for mozdebug 10:08:26 INFO - Running setup.py install for mozdevice 10:08:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:08:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:08:26 INFO - Running setup.py install for mozfile 10:08:26 INFO - Running setup.py install for mozhttpd 10:08:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:08:26 INFO - Running setup.py install for mozinfo 10:08:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:08:26 INFO - Running setup.py install for mozInstall 10:08:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:08:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:08:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:08:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:08:27 INFO - Running setup.py install for mozleak 10:08:27 INFO - Running setup.py install for mozlog 10:08:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:08:27 INFO - Running setup.py install for moznetwork 10:08:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:08:27 INFO - Running setup.py install for mozprocess 10:08:27 INFO - Running setup.py install for mozprofile 10:08:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:08:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:08:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:08:27 INFO - Running setup.py install for mozrunner 10:08:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:08:28 INFO - Running setup.py install for mozscreenshot 10:08:28 INFO - Running setup.py install for moztest 10:08:28 INFO - Running setup.py install for mozversion 10:08:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:08:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:08:28 INFO - Cleaning up... 10:08:28 INFO - Return code: 0 10:08:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:28 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 0x1098ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd40d84a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c1d30>, '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 0x1094e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b9b20>, '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.lPzzSPWE2H/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.WzhoWbqwLk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 10:08:28 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 10:08:28 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 10:08:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lPzzSPWE2H/Render', 10:08:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:28 INFO - 'HOME': '/Users/cltbld', 10:08:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:28 INFO - 'LOGNAME': 'cltbld', 10:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:28 INFO - 'MOZ_NO_REMOTE': '1', 10:08:28 INFO - 'NO_EM_RESTART': '1', 10:08:28 INFO - 'PAGER': '/bin/cat', 10:08:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:28 INFO - 'PWD': '/builds/slave/test', 10:08:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:28 INFO - 'SHELL': '/bin/bash', 10:08:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WzhoWbqwLk/Listeners', 10:08:28 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 10:08:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:28 INFO - 'USER': 'cltbld', 10:08:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:28 INFO - 'XPC_FLAGS': '0x0', 10:08:28 INFO - 'XPC_SERVICE_NAME': '0', 10:08:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-fJAqz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:28 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)) 10:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-hOYisw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-2Nj7w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:29 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)) 10:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-nZSPAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:29 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)) 10:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-JXywLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:29 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)) 10:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-C8Eia2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:29 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)) 10:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-vTRmmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:29 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)) 10:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-1b6Jrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:29 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)) 10:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-QxiGei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:29 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)) 10:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-CkJKtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:29 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)) 10:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-prXxgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:29 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)) 10:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-1ntoTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:30 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)) 10:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:30 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-4rBvvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:30 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)) 10:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:30 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-Qmotd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:30 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-tDRb3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:30 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)) 10:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:30 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-AA5rRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:30 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)) 10:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:30 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-GXRtna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:30 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)) 10:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:30 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)) 10:08:30 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)) 10:08:30 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)) 10:08:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:08:30 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 10:08:30 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 10:08:30 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 10:08:30 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 10:08:30 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 10:08:30 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 10:08:33 INFO - Downloading blessings-1.6.tar.gz 10:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:08:33 INFO - Installing collected packages: blessings 10:08:33 INFO - Running setup.py install for blessings 10:08:33 INFO - Successfully installed blessings 10:08:33 INFO - Cleaning up... 10:08:33 INFO - Return code: 0 10:08:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:08:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:33 INFO - Reading from file tmpfile_stdout 10:08:33 INFO - Current package versions: 10:08:33 INFO - blessings == 1.6 10:08:33 INFO - blobuploader == 1.2.4 10:08:33 INFO - docopt == 0.6.1 10:08:33 INFO - functools32 == 3.2.3-2 10:08:33 INFO - jsonschema == 2.5.1 10:08:33 INFO - manifestparser == 1.1 10:08:33 INFO - mozInstall == 1.12 10:08:33 INFO - mozcrash == 0.17 10:08:33 INFO - mozdebug == 0.1 10:08:33 INFO - mozdevice == 0.48 10:08:33 INFO - mozfile == 1.2 10:08:33 INFO - mozhttpd == 0.7 10:08:33 INFO - mozinfo == 0.9 10:08:33 INFO - mozleak == 0.1 10:08:33 INFO - mozlog == 3.4 10:08:33 INFO - moznetwork == 0.27 10:08:33 INFO - mozprocess == 0.23 10:08:33 INFO - mozprofile == 0.28 10:08:33 INFO - mozrunner == 6.12 10:08:33 INFO - mozscreenshot == 0.1 10:08:33 INFO - mozsystemmonitor == 0.3 10:08:33 INFO - moztest == 0.7 10:08:33 INFO - mozversion == 1.4 10:08:33 INFO - psutil == 3.1.1 10:08:33 INFO - requests == 1.2.3 10:08:33 INFO - wsgiref == 0.1.2 10:08:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:34 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')]} 10:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:34 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 0x1098ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd40d84a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c1d30>, '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 0x1094e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b9b20>, '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.lPzzSPWE2H/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.WzhoWbqwLk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 10:08:34 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 10:08:34 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 10:08:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lPzzSPWE2H/Render', 10:08:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:34 INFO - 'HOME': '/Users/cltbld', 10:08:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:34 INFO - 'LOGNAME': 'cltbld', 10:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:34 INFO - 'MOZ_NO_REMOTE': '1', 10:08:34 INFO - 'NO_EM_RESTART': '1', 10:08:34 INFO - 'PAGER': '/bin/cat', 10:08:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:34 INFO - 'PWD': '/builds/slave/test', 10:08:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:34 INFO - 'SHELL': '/bin/bash', 10:08:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WzhoWbqwLk/Listeners', 10:08:34 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 10:08:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:34 INFO - 'USER': 'cltbld', 10:08:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:34 INFO - 'XPC_FLAGS': '0x0', 10:08:34 INFO - 'XPC_SERVICE_NAME': '0', 10:08:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:34 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)) 10:08:34 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)) 10:08:34 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)) 10:08:34 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)) 10:08:34 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)) 10:08:34 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)) 10:08:34 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)) 10:08:34 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)) 10:08:34 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)) 10:08:34 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)) 10:08:34 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)) 10:08:34 INFO - Cleaning up... 10:08:34 INFO - Return code: 0 10:08:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:08:34 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')]} 10:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:34 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')]} 10:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1098ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109823570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd40d84a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c1d30>, '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 0x1094e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b9b20>, '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.lPzzSPWE2H/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.WzhoWbqwLk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 10:08:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:08:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lPzzSPWE2H/Render', 10:08:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:35 INFO - 'HOME': '/Users/cltbld', 10:08:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:35 INFO - 'LOGNAME': 'cltbld', 10:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:35 INFO - 'MOZ_NO_REMOTE': '1', 10:08:35 INFO - 'NO_EM_RESTART': '1', 10:08:35 INFO - 'PAGER': '/bin/cat', 10:08:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:35 INFO - 'PWD': '/builds/slave/test', 10:08:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:35 INFO - 'SHELL': '/bin/bash', 10:08:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WzhoWbqwLk/Listeners', 10:08:35 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 10:08:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:35 INFO - 'USER': 'cltbld', 10:08:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:35 INFO - 'XPC_FLAGS': '0x0', 10:08:35 INFO - 'XPC_SERVICE_NAME': '0', 10:08:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:08:35 INFO - Cleaning up... 10:08:35 INFO - Return code: 0 10:08:35 INFO - Running post-action listener: _resource_record_post_action 10:08:35 INFO - Running post-action listener: _start_resource_monitoring 10:08:35 INFO - Starting resource monitoring. 10:08:35 INFO - [mozharness: 2016-10-27 17:08:35.388920Z] Finished create-virtualenv step (success) 10:08:35 INFO - [mozharness: 2016-10-27 17:08:35.389932Z] Running install step. 10:08:35 INFO - Running pre-action listener: _resource_record_pre_action 10:08:35 INFO - Running main action method: install 10:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:35 INFO - Reading from file tmpfile_stdout 10:08:35 INFO - Detecting whether we're running mozinstall >=1.0... 10:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:08:35 INFO - Reading from file tmpfile_stdout 10:08:35 INFO - Output received: 10:08:35 INFO - Usage: mozinstall [options] installer 10:08:35 INFO - Options: 10:08:35 INFO - -h, --help show this help message and exit 10:08:35 INFO - -d DEST, --destination=DEST 10:08:35 INFO - Directory to install application into. [default: 10:08:35 INFO - "/builds/slave/test"] 10:08:35 INFO - --app=APP Application being installed. [default: firefox] 10:08:35 INFO - mkdir: /builds/slave/test/build/application 10:08:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:09:10 INFO - Reading from file tmpfile_stdout 10:09:10 INFO - Output received: 10:09:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:09:10 INFO - Running post-action listener: _resource_record_post_action 10:09:10 INFO - [mozharness: 2016-10-27 17:09:10.794403Z] Finished install step (success) 10:09:10 INFO - [mozharness: 2016-10-27 17:09:10.794529Z] Running run-tests step. 10:09:10 INFO - Running pre-action listener: _resource_record_pre_action 10:09:10 INFO - Running main action method: run_tests 10:09:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:09:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:09:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:09:10 INFO - 2016-10-27 10:09:10.808 screenresolution[1639:7728] starting screenresolution argv=screenresolution get 10:09:10 INFO - 2016-10-27 10:09:10.811 screenresolution[1639:7728] Display 0: 1600x1200x32@60 10:09:10 INFO - 2016-10-27 10:09:10.817 screenresolution[1640:7730] starting screenresolution argv=screenresolution list 10:09:10 INFO - Available Modes on Display 0 10:09:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:09:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:09:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:09:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:09:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:09:11 INFO - Intel Iris: 10:09:11 INFO - Chipset Model: Intel Iris 10:09:11 INFO - Type: GPU 10:09:11 INFO - Bus: Built-In 10:09:11 INFO - VRAM (Dynamic, Max): 1536 MB 10:09:11 INFO - Vendor: Intel (0x8086) 10:09:11 INFO - Device ID: 0x0a2e 10:09:11 INFO - Revision ID: 0x0009 10:09:11 INFO - Displays: 10:09:11 INFO - Display: 10:09:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:09:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:09:11 INFO - Display Serial Number: 1600x1200 60 10:09:11 INFO - Main Display: Yes 10:09:11 INFO - Mirror: Off 10:09:11 INFO - Online: Yes 10:09:11 INFO - Rotation: Supported 10:09:11 INFO - Return code: 0 10:09:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:09:11 INFO - Python 2.7.3 10:09:11 INFO - Return code: 0 10:09:11 INFO - grabbing minidump binary from tooltool 10:09:11 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')]} 10:09:11 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 0x1096c1d30>, '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 0x1094e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096b9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:09:11 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 10:09:11 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 10:09:11 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 10:09:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:09:11 INFO - Return code: 0 10:09:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:09:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:09:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:09:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:09:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:09:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0273 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:09:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lPzzSPWE2H/Render', 10:09:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:11 INFO - 'HOME': '/Users/cltbld', 10:09:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:11 INFO - 'LOGNAME': 'cltbld', 10:09:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:09:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:11 INFO - 'MOZ_NO_REMOTE': '1', 10:09:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:09:11 INFO - 'NO_EM_RESTART': '1', 10:09:11 INFO - 'PAGER': '/bin/cat', 10:09:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:11 INFO - 'PWD': '/builds/slave/test', 10:09:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:09:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:11 INFO - 'SHELL': '/bin/bash', 10:09:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WzhoWbqwLk/Listeners', 10:09:11 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 10:09:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:11 INFO - 'USER': 'cltbld', 10:09:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:11 INFO - 'XPC_FLAGS': '0x0', 10:09:11 INFO - 'XPC_SERVICE_NAME': '0', 10:09:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:09:11 INFO - mozversion application_buildid: 20161027074334 10:09:11 INFO - mozversion application_changeset: 23cbe1a93a98bb0a9822fd2d079fc259ff262899 10:09:11 INFO - mozversion application_display_name: Nightly 10:09:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:09:11 INFO - mozversion application_name: Firefox 10:09:11 INFO - mozversion application_remotingname: firefox 10:09:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:09:11 INFO - mozversion application_vendor: Mozilla 10:09:11 INFO - mozversion application_version: 52.0a1 10:09:11 INFO - mozversion platform_buildid: 20161027074334 10:09:11 INFO - mozversion platform_changeset: 23cbe1a93a98bb0a9822fd2d079fc259ff262899 10:09:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:09:11 INFO - mozversion platform_version: 52.0a1 10:09:11 INFO - using testdate: 1477588151 10:09:11 INFO - actual date: 1477588151 10:09:11 INFO - starting webserver on 'localhost:49272' 10:09:11 INFO - SUITE-START | Running 2 tests 10:09:11 INFO - TEST-START | dromaeo_css 10:09:11 INFO - operating with platform_type : mac_ 10:09:11 INFO - Initialising browser for dromaeo_css test... 10:09:11 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpWV7dpX/profile http://localhost:49272/getInfo.html) 10:09:14 INFO - PROCESS | 1650 | 2016-10-27 10:09:14.100 plugin-container[1652:7865] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 10:09:14 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:09:14 INFO - PROCESS | 1650 | 2016-10-27 10:09:14.105 plugin-container[1652:7865] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x911b, name = 'com.apple.CFPasteboardClient' 10:09:14 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:09:14 INFO - PROCESS | 1650 | 2016-10-27 10:09:14.105 plugin-container[1652:7865] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:09:14 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 10:09:14 INFO - PROCESS | 1650 | colorDepth:24 10:09:14 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 10:09:14 INFO - PROCESS | 1650 | __metrics 10:09:14 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 10:09:14 INFO - TEST-INFO | 1650: exit 0 10:09:14 INFO - Browser initialized. 10:09:14 INFO - Running cycle 1/1 for dromaeo_css test... 10:09:14 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpWV7dpX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:17 INFO - PROCESS | 1653 | 2016-10-27 10:09:17.464 plugin-container[1654:7980] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 10:09:17 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:09:17 INFO - PROCESS | 1653 | 2016-10-27 10:09:17.464 plugin-container[1654:7980] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890f, name = 'com.apple.CFPasteboardClient' 10:09:17 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:09:17 INFO - PROCESS | 1653 | 2016-10-27 10:09:17.464 plugin-container[1654:7980] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:09:27 INFO - PROCESS | 1653 | RSS: Main: 236699648 10:09:27 INFO - PROCESS | 1653 | 10:10:16 INFO - PROCESS | 1653 | 1477588216818 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] 10:12:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 10:12:31 INFO - PROCESS | 1653 | RSS: Main: 249614336 10:12:31 INFO - PROCESS | 1653 | 10:15:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 10:15:34 INFO - PROCESS | 1653 | RSS: Main: 261304320 10:15:34 INFO - PROCESS | 1653 | 10:18:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 10:18:36 INFO - PROCESS | 1653 | RSS: Main: 265895936 10:18:36 INFO - PROCESS | 1653 | 10:21:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 10:21:39 INFO - PROCESS | 1653 | RSS: Main: 264503296 10:21:39 INFO - PROCESS | 1653 | 10:24:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 10:24:42 INFO - PROCESS | 1653 | RSS: Main: 268955648 10:24:42 INFO - PROCESS | 1653 | 10:27:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 10:27:45 INFO - PROCESS | 1653 | RSS: Main: 271073280 10:27:45 INFO - PROCESS | 1653 | 10:27:45 INFO - PROCESS | 1653 | __start_tp_report 10:27:45 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 10:27:45 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 10:27:45 INFO - PROCESS | 1653 | |i|pagename|runs| 10:27:45 INFO - PROCESS | 1653 | |0;dojo.html;2784.7190292465466;3358.5633867597226;3409.21588034752;3437.98281008595;3442.3459542686874;4919.63102767293;5117.283580298761;5261.86845328867;5652.491275785179;5683.65898046117;5642.520385767215;5655.773769049233;5716.542676585874;5792.275965504312;5797.072468405056;4354.738715677054;5146.897062058757;5169.844904652867;5186.740662966837;5274.892272622735;4214.840918747338;5199;5288.418273989877;5306.310179676637;5355.2770375999135;5065.442801291855;5121.0270048691;5193.740312984373;5213.843584692465;5264.894702105975;5121.795128194905;5138.152204886189;5142.100132476839;5165.405978312467;5169.638125331228;5043.218301163325;5108.540231379194;5143.408508021551;5174;5194.27280180775;4865.902681946377;5383.542398896098;5611.663300202001;5709.571782116358;5756.050251708463;6159.045347971027;6163.19878415803;6252.437280644718;6263.34234905333;6272.968635156795;6172.47533959614;6245.56281060326;6246.781362652286;6254.061890716429;6256.998880179195;5683.886322273532;5724.227229324071;5761.962846687637;5860.765569377219;5890.852728681774;6137.683438940261;6184.443400094013;6201.81394558164;6225.00399936008;6227.6263424193785;6119.694015299217;6125.693715314216;6131.540134489931;6139.048447490557;6166.414190651881;5068.543831055223;5176.663516871391;6095.329513753483;6120.204373431426;6228.719707613168;6083.270007599116;6090.440755581031;6132.753252973555;6157.138000679908;6161.168242287324;6105.611380716528;6116.244470650343;6123;6131.022516543111;6147.616786223064;4818.397700287464;4871.878203044952;4877.292792545061;4877.3903262092235;4900.117978763786;4343.9348409773875;4401.097774956126;4401.779911004437;4440.245158323093;4498.910021799611;5720.3421606515785;5799.768009279666;5800.709964501758;5814.825555233349;5817.50551203144;6025.096235564701;6233.2208473940755;6269.185005949197;6285.088662143963;6296.212973378328;4890.559849613552;5808.30300363959;5833.445822646841;5852.531797456193;5949.25634295713;5368.302120724359;5378.085725426687;5384.246205531229;5384.380796208487;5388.434214407431;5422.457754224546;5662.773489060474;5737.684427356536;6264.780732674334;6266.373362663697;5954.255718035246;6134.834601026089;6148.877022459436;6161.476274516716;6269.592476489196;5203.297554830049;6213;6218.036204388327;6224.284207316216;6242;6046.5767396281835;6107.236595425572;6129.419919118684;6157.599756015845;6176.505879529716;6149.600275982047;6151.72317245716;6181.505479561714;6237.438630523275;6243.406876346739;6076.150710806279;6077.24034495688;6081.695915204311;6102.9694851525455;6147;5926.7925622603;6046.2139921809885;6105.114758360101;6152.876942461216;6172.629642221481;5791.594588378773;5912.083627037816;5986.790462333797;6002.87994240104;6083.726232319645;5235.921461178009;6051.667158306335;6080.4831589313635;6115.449609534985;6148;5707.714614269353;6007.849803754941;6021.518278537794;6038;6045.153678484928 10:27:45 INFO - PROCESS | 1653 | |1;ext.html;456.9131864945658;511.83109573840636;514.3133916221843;526.2606038515881;536.7718719544192;39950.60049399509;41337.58662413375;41399.58600413999;41608.79195604025;41624.99999999996;42324;42853.57146428535;42874.35688464675;43055.56944430555;43062.78468607661;9426.952865235664;9545.665901693443;9557;9576.664816731416;9608.567614457366;9430.434173949585;9519.095685909828;9521.523923803818;9523.333366664336;9534.80930381392;9519.143277105093;9523.476208808514;9547.23622110233;9550.997145299747;9557.522123893812;9469.526523673789;9476.099770521789;9521.047895210424;9539.332246742732;9563.999999999965;9334.253259739204;9384.155426011623;9393.342466027381;9413.011633778424;9432.151106400388;40038;40235;40380.59619403827;40508;40535.7973210135;3153.621565412165;3471.5139880416764;3819.2743378757946;4101.507819061731;4112.383142528614;30188.84905575458;30724.2318942026;30736.385272294654;30923.690763092305;31261.84369078163;3171.1913462067027;3186.617605887285;3222;3229.9031029069165;3338.4491558892755;502578;505153;505605;505797.94202058244;508512;61465;61510.38489615046;61651;61695.6915215421;61823;64662;64698.353016469235;65111.34888651148;65219.67390163019;65365.67317163384;16042;16255;16293.266802993894;16302.755458668129;16309.266083026056;12503.812442813365;12569;12571.811422828665;12594;12595.87404125947;16202.837971620133;17757.46727598174;17766.555836104202;17789.843660162307;17821.554461138574;6274.592151510137;6288.371162883766;6344.143540621957;6378.425941665179;6391.488680905516;742.6806473216461;812.1107387410776;850.7022542110212;1072.8873468285717;1151.654503648902;22160;27300.590491142648;29669.554956675667;30354.392912141633;30448.782048718247;881.678187461572;975.4098770244042;1050.7163065972297;1059.3273271472517;1090.983635245472;13571.796423053662;13926.721465570632;14300.141991480545;15303;15827.762583561256;652439;656631;665870;666065;666746;58583;59053.40946590565;59405.514862128795;59526;59586.70206649026;1359.0690377091723;1386.272207091265;1386.2791348498724;1411.9294035298194;1414.9009569330049;28952;29897.70102298949;30483.69516304897;30739.538906916863;30915.381692366478;43513.34729978989;58239.417605825096;58245.417545825694;58503.4149658498;58553.828923422145;613083;615002;618482;619942;620046;26472.735272647027;26694.866525667247;26739.732602673725;26937.86531067332;27063.323416913947;47718.284225737334;47969.76015119902;48730.512694872596;49215;49485.50514494809;40576.59423405728;40658.390124148755;41002.363691322156;41935.790321048196;42840;33366.99899003034;35210.47184292289;39925;40458.9885252871;40982;32849.83575082109;33730.15674608154;36527.45208821923;38640.61359386483;39312.6068739309;32010.6798932017;32714.50928236126;35621.46567801537;35918.461223081154;36276;23880.447770894836;25749.485010299315;25888;26291.4741705161;26356 10:27:45 INFO - PROCESS | 1653 | |2;jquery.html;325.3655372024552;358.14760869131464;362.06587005525745;365.5960164018761;388.71235285888434;19290.71063934042;19372.418827435184;19823;20181.29365472209;20412.183512659474;19769.11039003245;19987.60024799507;20114.09486573104;20344.898275508604;20381.18475260988;4839.225723884179;5612.438756124396;5792.594518383715;5914.674692891889;5952.285725712921;5720.628159169641;5902.88194236115;5906.202662640553;5913.852153696149;5923.970380148093;5792.986227410207;5809.186713860063;5827.796027139051;5836.387179346171;5886.852828679274;4638.814447422099;4815.349927759743;5168;5536.916946245769;5605.327360716719;4819.108464933964;4980.97889932563;4999.450060493343;5002.549770520671;5091.363579552556;17617.29530818766;24686;24744.752552474605;24882.626760598607;24932.626010609856;2263.2983775029793;2374;2395.2454976682466;2404.0744313439277;2471.4686342436285;11772.882271177265;15297.082175069532;15535.533933981886;15758.109026916729;15971.201439928072;1850.6206227723285;1861.5625328048034;1890.6691329017367;1912.416712902564;1916.444231172958;86174;109441;112194;112640;112673;10415;10503.579856805794;10526.263161578769;10539.473026348653;10872.836907446237;13376.866231337757;13381.264030478222;13381.53164639233;13381.799273010913;13386.263755493346;6517.771877984343;7801.414893882981;7982.521048737094;8095.676172953016;8108.797025175023;6675.863723608399;7607.885881711779;7670.27132422419;7762.961185194038;7888.763337099781;5420.4850539198715;6125.418085281891;6440.516961227927;6553.836154096186;6590.868182636321;1706.223668230952;1801.4865763257671;1833.1109411935201;1842.2907180735513;1843.368618772396;855.6833971430486;909.5492689160778;941.3363578677016;957.363353370015;997.581015973293;21373.46566335854;21842;22004.77995220059;22066.44833879134;22147.00338484772;919.9310051746146;941.5762906692016;959.1703176752059;974.2254907348674;1005.2058873490007;10880.238383313092;11003.834942475869;11337.206395552397;11515.827262591069;11569.305841649528;580839;584068;591512;598108;600401;109880;110080;112545;116226.41886790511;116329.4183529077;937.7093101138669;951.9048095190564;959.7792507723262;996.2179688944144;998.3211416236884;18718.069205467003;19029.048547572842;19117.71323430122;19202;19398.933058681345;41666;47412;53207.46792532025;54257.72871135619;54892;57427.1385929203;80516.19483805321;80749.59625202071;81072.59463702644;82090;7681.6543255552515;7802.531848089133;7802.804929876798;7865.921340786747;7920.920790792018;9921;12000.699982500159;12163.026957843174;12163.878361216628;12303.44634491432;9322;10331.623726542786;10586.153107751208;10598.417087060287;10719.678409647722;9025.41334813235;9872.950635246778;10130.544125514516;10166;10487.213458990758;10253.538590763284;10586.153107751516;10639.255252132276;10668.253222274367;10722.839157412489;6212.565120441706;7525.811854703457;7625.6568454418575;7750.496217745828;7903.091144518454;7881.881771773543;9438.150566449052;10669.626563070255;10756.677299681021;10775.353478791298 10:27:45 INFO - PROCESS | 1653 | |3;mootools.html;1537.3235776258446;1559.1035154785998;1626.0650126177452;1663.3263528271038;1769.6283780406113;7749.263819937111;8025.919740802605;8294.419390642657;8789.560521973899;8825.33809964252;8276.710315138971;8558.27254683351;8571.485710857352;8660.480371177733;8687;1977.7441324758738;2266.875321857297;2330.463993281546;2343.2267351773876;2343.894524746382;2311.653252012195;2345.0736958901307;2364.657124716915;2369.123424332999;2369.763023697634;1833.6424397242542;2129.2228336657085;2315.0623997281127;2332.7783860533223;2334.579775640384;2287.588234117858;2291.644795056769;2314.5718042162252;2317.5017371265176;2318.2581573896277;2305.389071895932;2329.9301020969397;2336.299110266913;2337.22871452422;2341.5785158671433;8615.913840861636;8685;8735.563221838882;8747.518886461243;8756.605952732143;5150.768215430315;5294.338207724035;5319.0957537218765;5319.255304257407;5328.520433160996;3100.3489267253904;3286.1291757684235;3383.137299988487;3615.313090512794;3644.3075815594952;1028.7325295423168;1040.136686550169;1061.941593212373;1079.379356869803;1085.2674444749762;11250.09999200062;11324.377159256237;11334.943325283402;11350.716232094099;11370.658880233606;4545.886352841206;4668.719876807402;4785.186518291829;4793;4798.7840547174765;9596.520173991272;9731.56207970643;9747.268954828416;9757.560909759079;9768;5327.3074500314715;5331.706756128373;5334.386545547234;5337.2527846101575;5345.599080069011;4138.296489596776;4809.038192361541;4844.183431213295;4868.367112275381;4887.535684110004;3834.501514803058;3840.9807950960067;3916.6670832979516;3926.430667553189;3943.684505239574;1260.5966090851023;1262.4003598290922;1265.544404014554;1278.2969366848197;1283.775339315616;823.9917600824035;908.5094049213351;912.7353067610452;921.6635927886273;958.5303201431387;5721.656700597978;5767.307923049261;5915.852103697356;5971.98476259037;6079.908801367983;408.2610475040187;429.27024059099654;431.040933922021;437.2501160509741;439.969202155846;3815.503984482055;3888.9805550972064;3991.7006224533275;4019.1559772448113;4047.919041619151;10173.44046077458;10427;10584;10589.57641694339;10612.20408469368;10254.000469908297;10354.275200736027;10398.428086455318;10457.11114555256;10528.99974502421;8023.959880200561;8029.437939344307;8062.072861620872;8144.999999999882;8185.3042491387705;5724.284464441945;5752.798652047159;5793.3337666167245;5793.8551536211935;5888.970555147197;9527.90472095298;9588.328816982745;9592.76018099553;9659.323847330901;9724.951375243361;9657.826988927434;9797.31418800677;9862.358946668444;9873.555689993824;9884.456354900549;6748.595084294958;6961.060256865258;7173.0675012248075;7386.556806591621;7467.2532746727065;8108.472949258279;8358.28954538871;8366.330693544624;8368.330533557179;8380.874286885579;7189.209186989531;7340.412766978522;7383.224761399975;7408.148062972827;7438.851222975619;5831.014293266265;7050.5769653820935;7120.928790712027;7257.0565826442225;7386.372158366599;6896.551724137915;6922.58464492132;6983.266756990442;6991;7005.754798582026;4915.386411162037;4930.605551555938;5020.347354843993;5059.266406371129;5060.266261392151;4870.634702397264;4969.527894849984;4985.750712464434;5121.8719532012;5197.92203116946 10:27:45 INFO - PROCESS | 1653 | |4;prototype.html;213.9882306473144;297.9299864531836;308.2770902234261;310.784005116444;311.82849432811975;5501.724913754307;5680.715964201784;5756.453136951988;5770.653760774351;5840.299164100304;4773.379460670117;5431.809886653968;5593.692346920918;5651.937042979313;5696.145578163268;3507.631698671641;3551.6625920537635;4248.596383343585;4249.596288352602;4253.680973926952;4000.399940008993;4154.501459824825;4234.179302899752;4282.700210985232;4293;3579.355715971124;3832.4442955771397;4224.577542245782;4229.513605935311;4241.703080784347;3397.5583174187445;3988.962869653882;4184.4141820145205;4247.702660813744;4263.424437700902;3188.617365916082;3632.854685812564;3691.53855768029;3698.537682789651;3701.5002974598356;4520.864374068783;4650.767461626905;5468.589855760833;5546.4453554644615;5595.18869763882;4587.623712886154;4901.460839307673;4926.088673595361;4959.404871415417;4968.906840495085;5246.580273578104;5725.826205627836;5976.760929562813;5984.700764961734;5994.460498555151;3661.4873917651285;4054.675625949917;4059.3707975263883;4071.857484988011;4072.3484242521054;5459.3994660587305;6232;6238.532110091761;6285.025820997707;6310.1481300024825;3524.506569080331;3578.9642103579154;3603.7117030637487;4091.8977025574004;4117.21772863155;3427.503012063237;4114.441008527602;4166.66666666666;4184.916301673949;4187.785542192791;3938.547067087264;4417.249067658441;4450.46594408673;4730.716157030521;4938.407391113089;4887.853364399074;4998.575121114746;5327.600429967691;5981.880362392728;6036.521052342205;1233.2908577567935;1236.4806781151938;1343.3216225805907;1415.3701602786662;1442.596073099534;792.3938187286731;806.1978331560135;880.665347168072;905.8360007390471;907.4827348411474;3976.0258736609717;4190.958090419057;4500.504944456107;4566.972431203019;4653.603918824339;4753;5176.120059589879;5184.68180364567;5215.496561650353;5232.3982741985155;3722.585417541371;3820.751651142667;4452.287633978613;4465.910681786411;4471.150481408522;2500.5874030784717;2509.256067033394;2634.841909485437;2713.6743590769233;2725.945481090367;4456.7548784817145;4669.673122881433;4712.811487540528;5034.370703662043;5199.506046925536;4936.827211047668;5035.332162248492;5117.541500672365;5293.682379057269;5353.411124776271;4541.205289074399;4804.0872234275375;5005.374328209046;5109.923351149736;5143.382794064587;4214.81033353506;4362.890927726705;4674.649401294849;5171.01750667372;5221.034108689904;4289.892752681208;4450.488193857748;4595.37962375075;4600.953990460052;5016.724080175625;5232.764525596282;5410.864728381822;6381.766381766344;6439.484841212598;6466.838329041811;3696.8890933272046;3736.7384283099923;4067.0071664884586;4076.878858313987;4085.6731461483605;5472.589555783253;5644.588852786804;6339.96830015847;6351.523635727246;6355.364463553793;5742.425757424224;6070.271567411939;6080.574359794772;6100.603460775035;6127.724252408563;6091.269047714302;6100.938990610214;6121.755129794937;6129;6161.4146656067605;5214.869628259324;5688.943110568841;5837.6497410155525;5894.115882617471;5939.455741507153;6024.608400453956;6026.969865150646;6033.728482218223;6063.242094738158;6083.117947897618;5677.602567820213;5898.380670029585;5899.380565040609;5918.615290006136;5959.106134079922 10:27:45 INFO - PROCESS | 1653 | |5;yui.html;689.8447849233924;709.1844378964194;739.3309055304951;743.7619961612282;745.9146941200554;14626;15053.698926021472;15400.383984640615;15519.689606207883;15734.9772264803;14387.136771793674;14478.058926169791;14492;14523.92738036311;14536.709265814703;863.1282404771194;885.420049867338;895.5880295064278;903.6972614174259;904.7964208053169;716.8064622551908;894.7226359828474;900.0774206438388;904.2991681446898;905.1762895764855;769.3422124083911;916.9174774270315;947.0766003146946;947.3747326764337;947.900470450603;917.4128557723062;934.5981228071927;937.779621788879;940.2618944128826;940.6754669639032;568.2811243776625;621.816564113583;648.4196644003638;658.6278752504819;697.2051860878603;13276.402561884739;14804.925975370053;15038.624034399118;15070.547883563511;15135.318910649048;13088.149270297401;13158.14472059313;13169.670758231025;13181.60455186346;13641.132219940608;10838.458077096193;12298.692532686666;12311.19977201488;12747.808782868264;12772.872271277261;4315.287977483711;4481.641468682497;4564.88587785308;4646.581807637295;4656.511066338019;88433;96526.0347396524;97162.51418742932;97533.0246697531;97595;10347.63783267582;10538.209634277306;10572.15422766177;10573.89426105729;10607.84088238677;17766.84515506488;18728.719069213974;19992.400227992894;20086.39740807778;20127.295544655866;7371.963140184372;7497.437692173109;7524.623768811538;7588.696452141852;7710.653020614086;4253.319938624226;4258.53156152823;4286.314189729628;4294.018938031931;4389.670774691911;3285.983570082134;3389.8983030509125;3392.779469334535;3396.1849156202334;3405.4210784166753;624.9593776404519;629.3989240275525;641.6086187425667;656.9868602627921;657.3722095398882;593.6467801658007;608.9238845144357;621.273110460762;628.5976974736172;637.200313606421;8556.229939305367;8765.649374025095;8875.334349923782;9661.13049825519;9730.533692022836;610.490240649063;648.3160265919406;648.4650163615037;692.9688164032631;698.5773606967813;4169;4506.842260520866;4530.29780384041;4535.274356103007;4555.840545580889;97999;102788.48605756923;104714;107503;107615.38576921352;94244;96173;97010.0298997015;97407.51296243473;99241.50379248058;75618.62190689011;76280;78315.60842195753;81587.59206203932;81678.59160704158;8801.779955501164;8863.759073729812;8890.89171375233;8947.418417802823;9080.682176124068;52597.21104183364;52597.47402526079;53489;54332;54859;61916.69041654763;71774.28225717676;74520.62739686483;77761;78692;11315.547378104784;11539.4807233673;11627.883721163018;11648.359340236368;11653.41732913368;12494.73021163457;12618.116731828684;12713.8092928608;12769.744605108031;13090.345482726016;11400.429978501208;11576.768464630828;11682.415879205835;11828.940855295668;12227.449764760786;11797.52809887595;11978.700532486757;12009.519619215134;12357;12388.81416778767;11274.661760147208;11516.136289778467;11560.6531804046;11712.180147389601;12034.217775844541;9629.374090684083;9688.304546704157;9990.300678952404;10034.64878729241;10134.797304054026;10125.64560240388;10198.694039178836;10344.482775861328;10399.896001039893;10403.53184106732 10:27:45 INFO - PROCESS | 1653 | __end_tp_report 10:27:45 INFO - PROCESS | 1653 | __start_cc_report 10:27:45 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,362 10:27:45 INFO - PROCESS | 1653 | __end_cc_report 10:27:45 INFO - PROCESS | 1653 | __startTimestamp1477589265575__endTimestamp 10:27:45 INFO - PROCESS | 1653 | 10:27:45 INFO - PROCESS | 1653 | ------- Summary: start ------- 10:27:45 INFO - PROCESS | 1653 | Number of tests: 6 10:27:45 INFO - PROCESS | 1653 | 10:27:45 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5655.23 Median:5890.85 stddev:664.44 (11.3%) stddev-sans-first:627.16 10:27:45 INFO - PROCESS | 1653 | Values: 2784.7 3358.6 3409.2 3438.0 3442.3 4919.6 5117.3 5261.9 5652.5 5683.7 5642.5 5655.8 5716.5 5792.3 5797.1 4354.7 5146.9 5169.8 5186.7 5274.9 4214.8 5199.0 5288.4 5306.3 5355.3 5065.4 5121.0 5193.7 5213.8 5264.9 5121.8 5138.2 5142.1 5165.4 5169.6 5043.2 5108.5 5143.4 5174.0 5194.3 4865.9 5383.5 5611.7 5709.6 5756.1 6159.0 6163.2 6252.4 6263.3 6273.0 6172.5 6245.6 6246.8 6254.1 6257.0 5683.9 5724.2 5762.0 5860.8 5890.9 6137.7 6184.4 6201.8 6225.0 6227.6 6119.7 6125.7 6131.5 6139.0 6166.4 5068.5 5176.7 6095.3 6120.2 6228.7 6083.3 6090.4 6132.8 6157.1 6161.2 6105.6 6116.2 6123.0 6131.0 6147.6 4818.4 4871.9 4877.3 4877.4 4900.1 4343.9 4401.1 4401.8 4440.2 4498.9 5720.3 5799.8 5800.7 5814.8 5817.5 6025.1 6233.2 6269.2 6285.1 6296.2 4890.6 5808.3 5833.4 5852.5 5949.3 5368.3 5378.1 5384.2 5384.4 5388.4 5422.5 5662.8 5737.7 6264.8 6266.4 5954.3 6134.8 6148.9 6161.5 6269.6 5203.3 6213.0 6218.0 6224.3 6242.0 6046.6 6107.2 6129.4 6157.6 6176.5 6149.6 6151.7 6181.5 6237.4 6243.4 6076.2 6077.2 6081.7 6103.0 6147.0 5926.8 6046.2 6105.1 6152.9 6172.6 5791.6 5912.1 5986.8 6002.9 6083.7 5235.9 6051.7 6080.5 6115.4 6148.0 5707.7 6007.8 6021.5 6038.0 6045.2 10:27:45 INFO - PROCESS | 1653 | 10:27:45 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:72656.17 Median:41504.19 stddev:160099.14 (385.7%) stddev-sans-first:160456.48 10:27:45 INFO - PROCESS | 1653 | Values: 456.9 511.8 514.3 526.3 536.8 39950.6 41337.6 41399.6 41608.8 41625.0 42324.0 42853.6 42874.4 43055.6 43062.8 9427.0 9545.7 9557.0 9576.7 9608.6 9430.4 9519.1 9521.5 9523.3 9534.8 9519.1 9523.5 9547.2 9551.0 9557.5 9469.5 9476.1 9521.0 9539.3 9564.0 9334.3 9384.2 9393.3 9413.0 9432.2 40038.0 40235.0 40380.6 40508.0 40535.8 3153.6 3471.5 3819.3 4101.5 4112.4 30188.8 30724.2 30736.4 30923.7 31261.8 3171.2 3186.6 3222.0 3229.9 3338.4 502578.0 505153.0 505605.0 505797.9 508512.0 61465.0 61510.4 61651.0 61695.7 61823.0 64662.0 64698.4 65111.3 65219.7 65365.7 16042.0 16255.0 16293.3 16302.8 16309.3 12503.8 12569.0 12571.8 12594.0 12595.9 16202.8 17757.5 17766.6 17789.8 17821.6 6274.6 6288.4 6344.1 6378.4 6391.5 742.7 812.1 850.7 1072.9 1151.7 22160.0 27300.6 29669.6 30354.4 30448.8 881.7 975.4 1050.7 1059.3 1091.0 13571.8 13926.7 14300.1 15303.0 15827.8 652439.0 656631.0 665870.0 666065.0 666746.0 58583.0 59053.4 59405.5 59526.0 59586.7 1359.1 1386.3 1386.3 1411.9 1414.9 28952.0 29897.7 30483.7 30739.5 30915.4 43513.3 58239.4 58245.4 58503.4 58553.8 613083.0 615002.0 618482.0 619942.0 620046.0 26472.7 26694.9 26739.7 26937.9 27063.3 47718.3 47969.8 48730.5 49215.0 49485.5 40576.6 40658.4 41002.4 41935.8 42840.0 33367.0 35210.5 39925.0 40459.0 40982.0 32849.8 33730.2 36527.5 38640.6 39312.6 32010.7 32714.5 35621.5 35918.5 36276.0 23880.4 25749.5 25888.0 26291.5 26356.0 10:27:45 INFO - PROCESS | 1653 | 10:27:45 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:33819.59 Median:360.11 stddev:98126.11 (27249.2%) stddev-sans-first:98369.15 10:27:45 INFO - PROCESS | 1653 | Values: 325.4 358.1 362.1 365.6 388.7 19290.7 19372.4 19823.0 20181.3 20412.2 19769.1 19987.6 20114.1 20344.9 20381.2 4839.2 5612.4 5792.6 5914.7 5952.3 5720.6 5902.9 5906.2 5913.9 5924.0 5793.0 5809.2 5827.8 5836.4 5886.9 4638.8 4815.3 5168.0 5536.9 5605.3 4819.1 4981.0 4999.5 5002.5 5091.4 17617.3 24686.0 24744.8 24882.6 24932.6 2263.3 2374.0 2395.2 2404.1 2471.5 11772.9 15297.1 15535.5 15758.1 15971.2 1850.6 1861.6 1890.7 1912.4 1916.4 86174.0 109441.0 112194.0 112640.0 112673.0 10415.0 10503.6 10526.3 10539.5 10872.8 13376.9 13381.3 13381.5 13381.8 13386.3 6517.8 7801.4 7982.5 8095.7 8108.8 6675.9 7607.9 7670.3 7763.0 7888.8 5420.5 6125.4 6440.5 6553.8 6590.9 1706.2 1801.5 1833.1 1842.3 1843.4 855.7 909.5 941.3 957.4 997.6 21373.5 21842.0 22004.8 22066.4 22147.0 919.9 941.6 959.2 974.2 1005.2 10880.2 11003.8 11337.2 11515.8 11569.3 580839.0 584068.0 591512.0 598108.0 600401.0 109880.0 110080.0 112545.0 116226.4 116329.4 937.7 951.9 959.8 996.2 998.3 18718.1 19029.0 19117.7 19202.0 19398.9 41666.0 47412.0 53207.5 54257.7 54892.0 57427.1 80516.2 80749.6 81072.6 82090.0 7681.7 7802.5 7802.8 7865.9 7920.9 9921.0 12000.7 12163.0 12163.9 12303.4 9322.0 10331.6 10586.2 10598.4 10719.7 9025.4 9873.0 10130.5 10166.0 10487.2 10253.5 10586.2 10639.3 10668.3 10722.8 6212.6 7525.8 7625.7 7750.5 7903.1 7881.9 9438.2 10669.6 10756.7 10775.4 10:27:45 INFO - PROCESS | 1653 | 10:27:45 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5596.51 Median:5039.81 stddev:3134.57 (62.2%) stddev-sans-first:3128.52 10:27:45 INFO - PROCESS | 1653 | Values: 1537.3 1559.1 1626.1 1663.3 1769.6 7749.3 8025.9 8294.4 8789.6 8825.3 8276.7 8558.3 8571.5 8660.5 8687.0 1977.7 2266.9 2330.5 2343.2 2343.9 2311.7 2345.1 2364.7 2369.1 2369.8 1833.6 2129.2 2315.1 2332.8 2334.6 2287.6 2291.6 2314.6 2317.5 2318.3 2305.4 2329.9 2336.3 2337.2 2341.6 8615.9 8685.0 8735.6 8747.5 8756.6 5150.8 5294.3 5319.1 5319.3 5328.5 3100.3 3286.1 3383.1 3615.3 3644.3 1028.7 1040.1 1061.9 1079.4 1085.3 11250.1 11324.4 11334.9 11350.7 11370.7 4545.9 4668.7 4785.2 4793.0 4798.8 9596.5 9731.6 9747.3 9757.6 9768.0 5327.3 5331.7 5334.4 5337.3 5345.6 4138.3 4809.0 4844.2 4868.4 4887.5 3834.5 3841.0 3916.7 3926.4 3943.7 1260.6 1262.4 1265.5 1278.3 1283.8 824.0 908.5 912.7 921.7 958.5 5721.7 5767.3 5915.9 5972.0 6079.9 408.3 429.3 431.0 437.3 440.0 3815.5 3889.0 3991.7 4019.2 4047.9 10173.4 10427.0 10584.0 10589.6 10612.2 10254.0 10354.3 10398.4 10457.1 10529.0 8024.0 8029.4 8062.1 8145.0 8185.3 5724.3 5752.8 5793.3 5793.9 5889.0 9527.9 9588.3 9592.8 9659.3 9725.0 9657.8 9797.3 9862.4 9873.6 9884.5 6748.6 6961.1 7173.1 7386.6 7467.3 8108.5 8358.3 8366.3 8368.3 8380.9 7189.2 7340.4 7383.2 7408.1 7438.9 5831.0 7050.6 7120.9 7257.1 7386.4 6896.6 6922.6 6983.3 6991.0 7005.8 4915.4 4930.6 5020.3 5059.3 5060.3 4870.6 4969.5 4985.8 5121.9 5197.9 10:27:45 INFO - PROCESS | 1653 | 10:27:45 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4535.05 Median:4845.97 stddev:1444.44 (29.8%) stddev-sans-first:1411.61 10:27:45 INFO - PROCESS | 1653 | Values: 214.0 297.9 308.3 310.8 311.8 5501.7 5680.7 5756.5 5770.7 5840.3 4773.4 5431.8 5593.7 5651.9 5696.1 3507.6 3551.7 4248.6 4249.6 4253.7 4000.4 4154.5 4234.2 4282.7 4293.0 3579.4 3832.4 4224.6 4229.5 4241.7 3397.6 3989.0 4184.4 4247.7 4263.4 3188.6 3632.9 3691.5 3698.5 3701.5 4520.9 4650.8 5468.6 5546.4 5595.2 4587.6 4901.5 4926.1 4959.4 4968.9 5246.6 5725.8 5976.8 5984.7 5994.5 3661.5 4054.7 4059.4 4071.9 4072.3 5459.4 6232.0 6238.5 6285.0 6310.1 3524.5 3579.0 3603.7 4091.9 4117.2 3427.5 4114.4 4166.7 4184.9 4187.8 3938.5 4417.2 4450.5 4730.7 4938.4 4887.9 4998.6 5327.6 5981.9 6036.5 1233.3 1236.5 1343.3 1415.4 1442.6 792.4 806.2 880.7 905.8 907.5 3976.0 4191.0 4500.5 4567.0 4653.6 4753.0 5176.1 5184.7 5215.5 5232.4 3722.6 3820.8 4452.3 4465.9 4471.2 2500.6 2509.3 2634.8 2713.7 2725.9 4456.8 4669.7 4712.8 5034.4 5199.5 4936.8 5035.3 5117.5 5293.7 5353.4 4541.2 4804.1 5005.4 5109.9 5143.4 4214.8 4362.9 4674.6 5171.0 5221.0 4289.9 4450.5 4595.4 4601.0 5016.7 5232.8 5410.9 6381.8 6439.5 6466.8 3696.9 3736.7 4067.0 4076.9 4085.7 5472.6 5644.6 6340.0 6351.5 6355.4 5742.4 6070.3 6080.6 6100.6 6127.7 6091.3 6100.9 6121.8 6129.0 6161.4 5214.9 5688.9 5837.6 5894.1 5939.5 6024.6 6027.0 6033.7 6063.2 6083.1 5677.6 5898.4 5899.4 5918.6 5959.1 10:27:45 INFO - PROCESS | 1653 | 10:27:45 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:20288.53 Median:28626.86 stddev:29731.23 (103.9%) stddev-sans-first:29778.21 10:27:45 INFO - PROCESS | 1653 | Values: 689.8 709.2 739.3 743.8 745.9 14626.0 15053.7 15400.4 15519.7 15735.0 14387.1 14478.1 14492.0 14523.9 14536.7 863.1 885.4 895.6 903.7 904.8 716.8 894.7 900.1 904.3 905.2 769.3 916.9 947.1 947.4 947.9 917.4 934.6 937.8 940.3 940.7 568.3 621.8 648.4 658.6 697.2 13276.4 14804.9 15038.6 15070.5 15135.3 13088.1 13158.1 13169.7 13181.6 13641.1 10838.5 12298.7 12311.2 12747.8 12772.9 4315.3 4481.6 4564.9 4646.6 4656.5 88433.0 96526.0 97162.5 97533.0 97595.0 10347.6 10538.2 10572.2 10573.9 10607.8 17766.8 18728.7 19992.4 20086.4 20127.3 7372.0 7497.4 7524.6 7588.7 7710.7 4253.3 4258.5 4286.3 4294.0 4389.7 3286.0 3389.9 3392.8 3396.2 3405.4 625.0 629.4 641.6 657.0 657.4 593.6 608.9 621.3 628.6 637.2 8556.2 8765.6 8875.3 9661.1 9730.5 610.5 648.3 648.5 693.0 698.6 4169.0 4506.8 4530.3 4535.3 4555.8 97999.0 102788.5 104714.0 107503.0 107615.4 94244.0 96173.0 97010.0 97407.5 99241.5 75618.6 76280.0 78315.6 81587.6 81678.6 8801.8 8863.8 8890.9 8947.4 9080.7 52597.2 52597.5 53489.0 54332.0 54859.0 61916.7 71774.3 74520.6 77761.0 78692.0 11315.5 11539.5 11627.9 11648.4 11653.4 12494.7 12618.1 12713.8 12769.7 13090.3 11400.4 11576.8 11682.4 11828.9 12227.4 11797.5 11978.7 12009.5 12357.0 12388.8 11274.7 11516.1 11560.7 11712.2 12034.2 9629.4 9688.3 9990.3 10034.6 10134.8 10125.6 10198.7 10344.5 10399.9 10403.5 10:27:45 INFO - PROCESS | 1653 | -------- Summary: end -------- 10:27:45 INFO - PROCESS | 1653 | 10:27:46 INFO - TEST-INFO | 1653: exit 0 10:27:46 INFO - TEST-OK | dromaeo_css | took 1114836ms 10:27:46 INFO - TEST-START | kraken 10:27:46 INFO - operating with platform_type : mac_ 10:27:46 INFO - Initialising browser for kraken test... 10:27:46 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpjS6vS2/profile http://localhost:49272/getInfo.html) 10:27:48 INFO - PROCESS | 1665 | 2016-10-27 10:27:48.775 plugin-container[1666:10388] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 10:27:48 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:48 INFO - PROCESS | 1665 | 2016-10-27 10:27:48.778 plugin-container[1666:10388] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4807, name = 'com.apple.CFPasteboardClient' 10:27:48 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:48 INFO - PROCESS | 1665 | 2016-10-27 10:27:48.778 plugin-container[1666:10388] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:27:48 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 10:27:48 INFO - PROCESS | 1665 | colorDepth:24 10:27:48 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 10:27:48 INFO - PROCESS | 1665 | __metrics 10:27:48 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 10:27:49 INFO - TEST-INFO | 1665: exit 0 10:27:49 INFO - Browser initialized. 10:27:49 INFO - Running cycle 1/1 for kraken test... 10:27:49 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpjS6vS2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:52 INFO - PROCESS | 1667 | 2016-10-27 10:27:52.157 plugin-container[1668:10508] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 10:27:52 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:52 INFO - PROCESS | 1667 | 2016-10-27 10:27:52.157 plugin-container[1668:10508] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 10:27:52 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:52 INFO - PROCESS | 1667 | 2016-10-27 10:27:52.157 plugin-container[1668:10508] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:28:01 INFO - PROCESS | 1667 | RSS: Main: 236687360 10:28:01 INFO - PROCESS | 1667 | 10:28:04 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 10:28:05 INFO - PROCESS | 1667 | RSS: Main: 249303040 10:28:05 INFO - PROCESS | 1667 | 10:28:08 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 10:28:08 INFO - PROCESS | 1667 | RSS: Main: 256823296 10:28:08 INFO - PROCESS | 1667 | 10:28:12 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 10:28:12 INFO - PROCESS | 1667 | RSS: Main: 259723264 10:28:12 INFO - PROCESS | 1667 | 10:28:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 10:28:15 INFO - PROCESS | 1667 | RSS: Main: 262254592 10:28:15 INFO - PROCESS | 1667 | 10:28:17 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:17 INFO - PROCESS | 1667 | RSS: Main: 262361088 10:28:17 INFO - PROCESS | 1667 | 10:28:20 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 10:28:21 INFO - PROCESS | 1667 | RSS: Main: 263237632 10:28:21 INFO - PROCESS | 1667 | 10:28:24 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 10:28:25 INFO - PROCESS | 1667 | RSS: Main: 263225344 10:28:25 INFO - PROCESS | 1667 | 10:28:28 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 10:28:28 INFO - PROCESS | 1667 | RSS: Main: 263696384 10:28:28 INFO - PROCESS | 1667 | 10:28:30 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:28:31 INFO - PROCESS | 1667 | RSS: Main: 263155712 10:28:31 INFO - PROCESS | 1667 | 10:28:33 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:28:33 INFO - PROCESS | 1667 | RSS: Main: 263245824 10:28:33 INFO - PROCESS | 1667 | 10:28:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:28:36 INFO - PROCESS | 1667 | RSS: Main: 263208960 10:28:36 INFO - PROCESS | 1667 | 10:28:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:28:40 INFO - PROCESS | 1667 | RSS: Main: 263634944 10:28:40 INFO - PROCESS | 1667 | 10:28:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:28:44 INFO - PROCESS | 1667 | RSS: Main: 263671808 10:28:44 INFO - PROCESS | 1667 | 10:28:45 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 10:28:46 INFO - PROCESS | 1667 | RSS: Main: 265072640 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | __start_tp_report 10:28:46 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 10:28:46 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 10:28:46 INFO - PROCESS | 1667 | |i|pagename|runs| 10:28:46 INFO - PROCESS | 1667 | |0;ai-astar;106;118;118;117;118;117;117;116;123;162 10:28:46 INFO - PROCESS | 1667 | |1;audio-beat-detection;150;134;147;165;114;125;141;144;147;116 10:28:46 INFO - PROCESS | 1667 | |2;audio-dft;200;203;203;214;196;199;201;198;200;201 10:28:46 INFO - PROCESS | 1667 | |3;audio-fft;70;84;55;111;49;59;73;84;103;53 10:28:46 INFO - PROCESS | 1667 | |4;audio-oscillator;87;63;91;103;98;91;89;70;68;86 10:28:46 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;91;89;92;88;85;131;137;93;91;87 10:28:46 INFO - PROCESS | 1667 | |6;imaging-darkroom;120;154;110;96;99;108;134;153;119;152 10:28:46 INFO - PROCESS | 1667 | |7;imaging-desaturate;103;123;85;115;111;87;90;89;129;141 10:28:46 INFO - PROCESS | 1667 | |8;json-parse-financial;59;58;56;72;75;90;91;90;89;83 10:28:46 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;69;73;68;77;92;71;71;72;75;72 10:28:46 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;89;92;86;92;88;85;90;93;88;91 10:28:46 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;153;172;154;146;155;151;148;153;190;134 10:28:46 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;175;178;177;176;177;175;177;179;174;174 10:28:46 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;71;72;68;69;71;68;69;71;69;69 10:28:46 INFO - PROCESS | 1667 | __end_tp_report 10:28:46 INFO - PROCESS | 1667 | __start_cc_report 10:28:46 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,953 10:28:46 INFO - PROCESS | 1667 | __end_cc_report 10:28:46 INFO - PROCESS | 1667 | __startTimestamp1477589326057__endTimestamp 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | ------- Summary: start ------- 10:28:46 INFO - PROCESS | 1667 | Number of tests: 14 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:121.20 Median:118.00 stddev:14.94 (12.7%) stddev-sans-first:14.80 10:28:46 INFO - PROCESS | 1667 | Values: 106.0 118.0 118.0 117.0 118.0 117.0 117.0 116.0 123.0 162.0 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:145.50 stddev:16.07 (11.0%) stddev-sans-first:16.48 10:28:46 INFO - PROCESS | 1667 | Values: 150.0 134.0 147.0 165.0 114.0 125.0 141.0 144.0 147.0 116.0 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:201.50 Median:201.00 stddev:4.88 (2.4%) stddev-sans-first:5.15 10:28:46 INFO - PROCESS | 1667 | Values: 200.0 203.0 203.0 214.0 196.0 199.0 201.0 198.0 200.0 201.0 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:74.10 Median:64.50 stddev:21.29 (33.0%) stddev-sans-first:22.53 10:28:46 INFO - PROCESS | 1667 | Values: 70.0 84.0 55.0 111.0 49.0 59.0 73.0 84.0 103.0 53.0 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:84.60 Median:88.00 stddev:13.26 (15.1%) stddev-sans-first:14.04 10:28:46 INFO - PROCESS | 1667 | Values: 87.0 63.0 91.0 103.0 98.0 91.0 89.0 70.0 68.0 86.0 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:98.40 Median:90.00 stddev:18.97 (21.1%) stddev-sans-first:19.93 10:28:46 INFO - PROCESS | 1667 | Values: 91.0 89.0 92.0 88.0 85.0 131.0 137.0 93.0 91.0 87.0 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:124.50 Median:152.50 stddev:22.42 (14.7%) stddev-sans-first:23.72 10:28:46 INFO - PROCESS | 1667 | Values: 120.0 154.0 110.0 96.0 99.0 108.0 134.0 153.0 119.0 152.0 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:107.30 Median:113.00 stddev:19.69 (17.4%) stddev-sans-first:20.82 10:28:46 INFO - PROCESS | 1667 | Values: 103.0 123.0 85.0 115.0 111.0 87.0 90.0 89.0 129.0 141.0 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:76.30 Median:86.00 stddev:14.39 (16.7%) stddev-sans-first:13.84 10:28:46 INFO - PROCESS | 1667 | Values: 59.0 58.0 56.0 72.0 75.0 90.0 91.0 90.0 89.0 83.0 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:74.00 Median:72.50 stddev:6.85 (9.4%) stddev-sans-first:7.02 10:28:46 INFO - PROCESS | 1667 | Values: 69.0 73.0 68.0 77.0 92.0 71.0 71.0 72.0 75.0 72.0 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:90.50 stddev:2.67 (3.0%) stddev-sans-first:2.83 10:28:46 INFO - PROCESS | 1667 | Values: 89.0 92.0 86.0 92.0 88.0 85.0 90.0 93.0 88.0 91.0 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:155.60 Median:153.50 stddev:15.30 (10.0%) stddev-sans-first:16.20 10:28:46 INFO - PROCESS | 1667 | Values: 153.0 172.0 154.0 146.0 155.0 151.0 148.0 153.0 190.0 134.0 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:177.00 stddev:1.69 (1.0%) stddev-sans-first:1.73 10:28:46 INFO - PROCESS | 1667 | Values: 175.0 178.0 177.0 176.0 177.0 175.0 177.0 179.0 174.0 174.0 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.42 (2.0%) stddev-sans-first:1.42 10:28:46 INFO - PROCESS | 1667 | Values: 71.0 72.0 68.0 69.0 71.0 68.0 69.0 71.0 69.0 69.0 10:28:46 INFO - PROCESS | 1667 | -------- Summary: end -------- 10:28:46 INFO - PROCESS | 1667 | 10:28:46 INFO - TEST-INFO | 1667: exit 0 10:28:46 INFO - TEST-OK | kraken | took 60655ms 10:28:46 INFO - SUITE-END | took 1175s 10:28:47 INFO - Completed test suite (00:19:35) 10:28:47 INFO - javascript benchmark 10:28:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7184.385479772968, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2784.7190292465466, 3358.5633867597226, 3409.21588034752, 3437.98281008595, 3442.3459542686874, 4919.63102767293, 5117.283580298761, 5261.86845328867, 5652.491275785179, 5683.65898046117, 5642.520385767215, 5655.773769049233, 5716.542676585874, 5792.275965504312, 5797.072468405056, 4354.738715677054, 5146.897062058757, 5169.844904652867, 5186.740662966837, 5274.892272622735, 4214.840918747338, 5199.0, 5288.418273989877, 5306.310179676637, 5355.2770375999135, 5065.442801291855, 5121.0270048691, 5193.740312984373, 5213.843584692465, 5264.894702105975, 5121.795128194905, 5138.152204886189, 5142.100132476839, 5165.405978312467, 5169.638125331228, 5043.218301163325, 5108.540231379194, 5143.408508021551, 5174.0, 5194.27280180775, 4865.902681946377, 5383.542398896098, 5611.663300202001, 5709.571782116358, 5756.050251708463, 6159.045347971027, 6163.19878415803, 6252.437280644718, 6263.34234905333, 6272.968635156795, 6172.47533959614, 6245.56281060326, 6246.781362652286, 6254.061890716429, 6256.998880179195, 5683.886322273532, 5724.227229324071, 5761.962846687637, 5860.765569377219, 5890.852728681774, 6137.683438940261, 6184.443400094013, 6201.81394558164, 6225.00399936008, 6227.6263424193785, 6119.694015299217, 6125.693715314216, 6131.540134489931, 6139.048447490557, 6166.414190651881, 5068.543831055223, 5176.663516871391, 6095.329513753483, 6120.204373431426, 6228.719707613168, 6083.270007599116, 6090.440755581031, 6132.753252973555, 6157.138000679908, 6161.168242287324, 6105.611380716528, 6116.244470650343, 6123.0, 6131.022516543111, 6147.616786223064, 4818.397700287464, 4871.878203044952, 4877.292792545061, 4877.3903262092235, 4900.117978763786, 4343.9348409773875, 4401.097774956126, 4401.779911004437, 4440.245158323093, 4498.910021799611, 5720.3421606515785, 5799.768009279666, 5800.709964501758, 5814.825555233349, 5817.50551203144, 6025.096235564701, 6233.2208473940755, 6269.185005949197, 6285.088662143963, 6296.212973378328, 4890.559849613552, 5808.30300363959, 5833.445822646841, 5852.531797456193, 5949.25634295713, 5368.302120724359, 5378.085725426687, 5384.246205531229, 5384.380796208487, 5388.434214407431, 5422.457754224546, 5662.773489060474, 5737.684427356536, 6264.780732674334, 6266.373362663697, 5954.255718035246, 6134.834601026089, 6148.877022459436, 6161.476274516716, 6269.592476489196, 5203.297554830049, 6213.0, 6218.036204388327, 6224.284207316216, 6242.0, 6046.5767396281835, 6107.236595425572, 6129.419919118684, 6157.599756015845, 6176.505879529716, 6149.600275982047, 6151.72317245716, 6181.505479561714, 6237.438630523275, 6243.406876346739, 6076.150710806279, 6077.24034495688, 6081.695915204311, 6102.9694851525455, 6147.0, 5926.7925622603, 6046.2139921809885, 6105.114758360101, 6152.876942461216, 6172.629642221481, 5791.594588378773, 5912.083627037816, 5986.790462333797, 6002.87994240104, 6083.726232319645, 5235.921461178009, 6051.667158306335, 6080.4831589313635, 6115.449609534985, 6148.0, 5707.714614269353, 6007.849803754941, 6021.518278537794, 6038.0, 6045.153678484928], "value": 5613.619080034689, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.9131864945658, 511.83109573840636, 514.3133916221843, 526.2606038515881, 536.7718719544192, 39950.60049399509, 41337.58662413375, 41399.58600413999, 41608.79195604025, 41624.99999999996, 42324.0, 42853.57146428535, 42874.35688464675, 43055.56944430555, 43062.78468607661, 9426.952865235664, 9545.665901693443, 9557.0, 9576.664816731416, 9608.567614457366, 9430.434173949585, 9519.095685909828, 9521.523923803818, 9523.333366664336, 9534.80930381392, 9519.143277105093, 9523.476208808514, 9547.23622110233, 9550.997145299747, 9557.522123893812, 9469.526523673789, 9476.099770521789, 9521.047895210424, 9539.332246742732, 9563.999999999965, 9334.253259739204, 9384.155426011623, 9393.342466027381, 9413.011633778424, 9432.151106400388, 40038.0, 40235.0, 40380.59619403827, 40508.0, 40535.7973210135, 3153.621565412165, 3471.5139880416764, 3819.2743378757946, 4101.507819061731, 4112.383142528614, 30188.84905575458, 30724.2318942026, 30736.385272294654, 30923.690763092305, 31261.84369078163, 3171.1913462067027, 3186.617605887285, 3222.0, 3229.9031029069165, 3338.4491558892755, 502578.0, 505153.0, 505605.0, 505797.94202058244, 508512.0, 61465.0, 61510.38489615046, 61651.0, 61695.6915215421, 61823.0, 64662.0, 64698.353016469235, 65111.34888651148, 65219.67390163019, 65365.67317163384, 16042.0, 16255.0, 16293.266802993894, 16302.755458668129, 16309.266083026056, 12503.812442813365, 12569.0, 12571.811422828665, 12594.0, 12595.87404125947, 16202.837971620133, 17757.46727598174, 17766.555836104202, 17789.843660162307, 17821.554461138574, 6274.592151510137, 6288.371162883766, 6344.143540621957, 6378.425941665179, 6391.488680905516, 742.6806473216461, 812.1107387410776, 850.7022542110212, 1072.8873468285717, 1151.654503648902, 22160.0, 27300.590491142648, 29669.554956675667, 30354.392912141633, 30448.782048718247, 881.678187461572, 975.4098770244042, 1050.7163065972297, 1059.3273271472517, 1090.983635245472, 13571.796423053662, 13926.721465570632, 14300.141991480545, 15303.0, 15827.762583561256, 652439.0, 656631.0, 665870.0, 666065.0, 666746.0, 58583.0, 59053.40946590565, 59405.514862128795, 59526.0, 59586.70206649026, 1359.0690377091723, 1386.272207091265, 1386.2791348498724, 1411.9294035298194, 1414.9009569330049, 28952.0, 29897.70102298949, 30483.69516304897, 30739.538906916863, 30915.381692366478, 43513.34729978989, 58239.417605825096, 58245.417545825694, 58503.4149658498, 58553.828923422145, 613083.0, 615002.0, 618482.0, 619942.0, 620046.0, 26472.735272647027, 26694.866525667247, 26739.732602673725, 26937.86531067332, 27063.323416913947, 47718.284225737334, 47969.76015119902, 48730.512694872596, 49215.0, 49485.50514494809, 40576.59423405728, 40658.390124148755, 41002.363691322156, 41935.790321048196, 42840.0, 33366.99899003034, 35210.47184292289, 39925.0, 40458.9885252871, 40982.0, 32849.83575082109, 33730.15674608154, 36527.45208821923, 38640.61359386483, 39312.6068739309, 32010.6798932017, 32714.50928236126, 35621.46567801537, 35918.461223081154, 36276.0, 23880.447770894836, 25749.485010299315, 25888.0, 26291.4741705161, 26356.0], "value": 19990.02824998693, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.3655372024552, 358.14760869131464, 362.06587005525745, 365.5960164018761, 388.71235285888434, 19290.71063934042, 19372.418827435184, 19823.0, 20181.29365472209, 20412.183512659474, 19769.11039003245, 19987.60024799507, 20114.09486573104, 20344.898275508604, 20381.18475260988, 4839.225723884179, 5612.438756124396, 5792.594518383715, 5914.674692891889, 5952.285725712921, 5720.628159169641, 5902.88194236115, 5906.202662640553, 5913.852153696149, 5923.970380148093, 5792.986227410207, 5809.186713860063, 5827.796027139051, 5836.387179346171, 5886.852828679274, 4638.814447422099, 4815.349927759743, 5168.0, 5536.916946245769, 5605.327360716719, 4819.108464933964, 4980.97889932563, 4999.450060493343, 5002.549770520671, 5091.363579552556, 17617.29530818766, 24686.0, 24744.752552474605, 24882.626760598607, 24932.626010609856, 2263.2983775029793, 2374.0, 2395.2454976682466, 2404.0744313439277, 2471.4686342436285, 11772.882271177265, 15297.082175069532, 15535.533933981886, 15758.109026916729, 15971.201439928072, 1850.6206227723285, 1861.5625328048034, 1890.6691329017367, 1912.416712902564, 1916.444231172958, 86174.0, 109441.0, 112194.0, 112640.0, 112673.0, 10415.0, 10503.579856805794, 10526.263161578769, 10539.473026348653, 10872.836907446237, 13376.866231337757, 13381.264030478222, 13381.53164639233, 13381.799273010913, 13386.263755493346, 6517.771877984343, 7801.414893882981, 7982.521048737094, 8095.676172953016, 8108.797025175023, 6675.863723608399, 7607.885881711779, 7670.27132422419, 7762.961185194038, 7888.763337099781, 5420.4850539198715, 6125.418085281891, 6440.516961227927, 6553.836154096186, 6590.868182636321, 1706.223668230952, 1801.4865763257671, 1833.1109411935201, 1842.2907180735513, 1843.368618772396, 855.6833971430486, 909.5492689160778, 941.3363578677016, 957.363353370015, 997.581015973293, 21373.46566335854, 21842.0, 22004.77995220059, 22066.44833879134, 22147.00338484772, 919.9310051746146, 941.5762906692016, 959.1703176752059, 974.2254907348674, 1005.2058873490007, 10880.238383313092, 11003.834942475869, 11337.206395552397, 11515.827262591069, 11569.305841649528, 580839.0, 584068.0, 591512.0, 598108.0, 600401.0, 109880.0, 110080.0, 112545.0, 116226.41886790511, 116329.4183529077, 937.7093101138669, 951.9048095190564, 959.7792507723262, 996.2179688944144, 998.3211416236884, 18718.069205467003, 19029.048547572842, 19117.71323430122, 19202.0, 19398.933058681345, 41666.0, 47412.0, 53207.46792532025, 54257.72871135619, 54892.0, 57427.1385929203, 80516.19483805321, 80749.59625202071, 81072.59463702644, 82090.0, 7681.6543255552515, 7802.531848089133, 7802.804929876798, 7865.921340786747, 7920.920790792018, 9921.0, 12000.699982500159, 12163.026957843174, 12163.878361216628, 12303.44634491432, 9322.0, 10331.623726542786, 10586.153107751208, 10598.417087060287, 10719.678409647722, 9025.41334813235, 9872.950635246778, 10130.544125514516, 10166.0, 10487.213458990758, 10253.538590763284, 10586.153107751516, 10639.255252132276, 10668.253222274367, 10722.839157412489, 6212.565120441706, 7525.811854703457, 7625.6568454418575, 7750.496217745828, 7903.091144518454, 7881.881771773543, 9438.150566449052, 10669.626563070255, 10756.677299681021, 10775.353478791298], "value": 9332.660927056066, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.3235776258446, 1559.1035154785998, 1626.0650126177452, 1663.3263528271038, 1769.6283780406113, 7749.263819937111, 8025.919740802605, 8294.419390642657, 8789.560521973899, 8825.33809964252, 8276.710315138971, 8558.27254683351, 8571.485710857352, 8660.480371177733, 8687.0, 1977.7441324758738, 2266.875321857297, 2330.463993281546, 2343.2267351773876, 2343.894524746382, 2311.653252012195, 2345.0736958901307, 2364.657124716915, 2369.123424332999, 2369.763023697634, 1833.6424397242542, 2129.2228336657085, 2315.0623997281127, 2332.7783860533223, 2334.579775640384, 2287.588234117858, 2291.644795056769, 2314.5718042162252, 2317.5017371265176, 2318.2581573896277, 2305.389071895932, 2329.9301020969397, 2336.299110266913, 2337.22871452422, 2341.5785158671433, 8615.913840861636, 8685.0, 8735.563221838882, 8747.518886461243, 8756.605952732143, 5150.768215430315, 5294.338207724035, 5319.0957537218765, 5319.255304257407, 5328.520433160996, 3100.3489267253904, 3286.1291757684235, 3383.137299988487, 3615.313090512794, 3644.3075815594952, 1028.7325295423168, 1040.136686550169, 1061.941593212373, 1079.379356869803, 1085.2674444749762, 11250.09999200062, 11324.377159256237, 11334.943325283402, 11350.716232094099, 11370.658880233606, 4545.886352841206, 4668.719876807402, 4785.186518291829, 4793.0, 4798.7840547174765, 9596.520173991272, 9731.56207970643, 9747.268954828416, 9757.560909759079, 9768.0, 5327.3074500314715, 5331.706756128373, 5334.386545547234, 5337.2527846101575, 5345.599080069011, 4138.296489596776, 4809.038192361541, 4844.183431213295, 4868.367112275381, 4887.535684110004, 3834.501514803058, 3840.9807950960067, 3916.6670832979516, 3926.430667553189, 3943.684505239574, 1260.5966090851023, 1262.4003598290922, 1265.544404014554, 1278.2969366848197, 1283.775339315616, 823.9917600824035, 908.5094049213351, 912.7353067610452, 921.6635927886273, 958.5303201431387, 5721.656700597978, 5767.307923049261, 5915.852103697356, 5971.98476259037, 6079.908801367983, 408.2610475040187, 429.27024059099654, 431.040933922021, 437.2501160509741, 439.969202155846, 3815.503984482055, 3888.9805550972064, 3991.7006224533275, 4019.1559772448113, 4047.919041619151, 10173.44046077458, 10427.0, 10584.0, 10589.57641694339, 10612.20408469368, 10254.000469908297, 10354.275200736027, 10398.428086455318, 10457.11114555256, 10528.99974502421, 8023.959880200561, 8029.437939344307, 8062.072861620872, 8144.999999999882, 8185.3042491387705, 5724.284464441945, 5752.798652047159, 5793.3337666167245, 5793.8551536211935, 5888.970555147197, 9527.90472095298, 9588.328816982745, 9592.76018099553, 9659.323847330901, 9724.951375243361, 9657.826988927434, 9797.31418800677, 9862.358946668444, 9873.555689993824, 9884.456354900549, 6748.595084294958, 6961.060256865258, 7173.0675012248075, 7386.556806591621, 7467.2532746727065, 8108.472949258279, 8358.28954538871, 8366.330693544624, 8368.330533557179, 8380.874286885579, 7189.209186989531, 7340.412766978522, 7383.224761399975, 7408.148062972827, 7438.851222975619, 5831.014293266265, 7050.5769653820935, 7120.928790712027, 7257.0565826442225, 7386.372158366599, 6896.551724137915, 6922.58464492132, 6983.266756990442, 6991.0, 7005.754798582026, 4915.386411162037, 4930.605551555938, 5020.347354843993, 5059.266406371129, 5060.266261392151, 4870.634702397264, 4969.527894849984, 4985.750712464434, 5121.8719532012, 5197.92203116946], "value": 4425.508543519395, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [213.9882306473144, 297.9299864531836, 308.2770902234261, 310.784005116444, 311.82849432811975, 5501.724913754307, 5680.715964201784, 5756.453136951988, 5770.653760774351, 5840.299164100304, 4773.379460670117, 5431.809886653968, 5593.692346920918, 5651.937042979313, 5696.145578163268, 3507.631698671641, 3551.6625920537635, 4248.596383343585, 4249.596288352602, 4253.680973926952, 4000.399940008993, 4154.501459824825, 4234.179302899752, 4282.700210985232, 4293.0, 3579.355715971124, 3832.4442955771397, 4224.577542245782, 4229.513605935311, 4241.703080784347, 3397.5583174187445, 3988.962869653882, 4184.4141820145205, 4247.702660813744, 4263.424437700902, 3188.617365916082, 3632.854685812564, 3691.53855768029, 3698.537682789651, 3701.5002974598356, 4520.864374068783, 4650.767461626905, 5468.589855760833, 5546.4453554644615, 5595.18869763882, 4587.623712886154, 4901.460839307673, 4926.088673595361, 4959.404871415417, 4968.906840495085, 5246.580273578104, 5725.826205627836, 5976.760929562813, 5984.700764961734, 5994.460498555151, 3661.4873917651285, 4054.675625949917, 4059.3707975263883, 4071.857484988011, 4072.3484242521054, 5459.3994660587305, 6232.0, 6238.532110091761, 6285.025820997707, 6310.1481300024825, 3524.506569080331, 3578.9642103579154, 3603.7117030637487, 4091.8977025574004, 4117.21772863155, 3427.503012063237, 4114.441008527602, 4166.66666666666, 4184.916301673949, 4187.785542192791, 3938.547067087264, 4417.249067658441, 4450.46594408673, 4730.716157030521, 4938.407391113089, 4887.853364399074, 4998.575121114746, 5327.600429967691, 5981.880362392728, 6036.521052342205, 1233.2908577567935, 1236.4806781151938, 1343.3216225805907, 1415.3701602786662, 1442.596073099534, 792.3938187286731, 806.1978331560135, 880.665347168072, 905.8360007390471, 907.4827348411474, 3976.0258736609717, 4190.958090419057, 4500.504944456107, 4566.972431203019, 4653.603918824339, 4753.0, 5176.120059589879, 5184.68180364567, 5215.496561650353, 5232.3982741985155, 3722.585417541371, 3820.751651142667, 4452.287633978613, 4465.910681786411, 4471.150481408522, 2500.5874030784717, 2509.256067033394, 2634.841909485437, 2713.6743590769233, 2725.945481090367, 4456.7548784817145, 4669.673122881433, 4712.811487540528, 5034.370703662043, 5199.506046925536, 4936.827211047668, 5035.332162248492, 5117.541500672365, 5293.682379057269, 5353.411124776271, 4541.205289074399, 4804.0872234275375, 5005.374328209046, 5109.923351149736, 5143.382794064587, 4214.81033353506, 4362.890927726705, 4674.649401294849, 5171.01750667372, 5221.034108689904, 4289.892752681208, 4450.488193857748, 4595.37962375075, 4600.953990460052, 5016.724080175625, 5232.764525596282, 5410.864728381822, 6381.766381766344, 6439.484841212598, 6466.838329041811, 3696.8890933272046, 3736.7384283099923, 4067.0071664884586, 4076.878858313987, 4085.6731461483605, 5472.589555783253, 5644.588852786804, 6339.96830015847, 6351.523635727246, 6355.364463553793, 5742.425757424224, 6070.271567411939, 6080.574359794772, 6100.603460775035, 6127.724252408563, 6091.269047714302, 6100.938990610214, 6121.755129794937, 6129.0, 6161.4146656067605, 5214.869628259324, 5688.943110568841, 5837.6497410155525, 5894.115882617471, 5939.455741507153, 6024.608400453956, 6026.969865150646, 6033.728482218223, 6063.242094738158, 6083.117947897618, 5677.602567820213, 5898.380670029585, 5899.380565040609, 5918.615290006136, 5959.106134079922], "value": 4071.791353983854, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.8447849233924, 709.1844378964194, 739.3309055304951, 743.7619961612282, 745.9146941200554, 14626.0, 15053.698926021472, 15400.383984640615, 15519.689606207883, 15734.9772264803, 14387.136771793674, 14478.058926169791, 14492.0, 14523.92738036311, 14536.709265814703, 863.1282404771194, 885.420049867338, 895.5880295064278, 903.6972614174259, 904.7964208053169, 716.8064622551908, 894.7226359828474, 900.0774206438388, 904.2991681446898, 905.1762895764855, 769.3422124083911, 916.9174774270315, 947.0766003146946, 947.3747326764337, 947.900470450603, 917.4128557723062, 934.5981228071927, 937.779621788879, 940.2618944128826, 940.6754669639032, 568.2811243776625, 621.816564113583, 648.4196644003638, 658.6278752504819, 697.2051860878603, 13276.402561884739, 14804.925975370053, 15038.624034399118, 15070.547883563511, 15135.318910649048, 13088.149270297401, 13158.14472059313, 13169.670758231025, 13181.60455186346, 13641.132219940608, 10838.458077096193, 12298.692532686666, 12311.19977201488, 12747.808782868264, 12772.872271277261, 4315.287977483711, 4481.641468682497, 4564.88587785308, 4646.581807637295, 4656.511066338019, 88433.0, 96526.0347396524, 97162.51418742932, 97533.0246697531, 97595.0, 10347.63783267582, 10538.209634277306, 10572.15422766177, 10573.89426105729, 10607.84088238677, 17766.84515506488, 18728.719069213974, 19992.400227992894, 20086.39740807778, 20127.295544655866, 7371.963140184372, 7497.437692173109, 7524.623768811538, 7588.696452141852, 7710.653020614086, 4253.319938624226, 4258.53156152823, 4286.314189729628, 4294.018938031931, 4389.670774691911, 3285.983570082134, 3389.8983030509125, 3392.779469334535, 3396.1849156202334, 3405.4210784166753, 624.9593776404519, 629.3989240275525, 641.6086187425667, 656.9868602627921, 657.3722095398882, 593.6467801658007, 608.9238845144357, 621.273110460762, 628.5976974736172, 637.200313606421, 8556.229939305367, 8765.649374025095, 8875.334349923782, 9661.13049825519, 9730.533692022836, 610.490240649063, 648.3160265919406, 648.4650163615037, 692.9688164032631, 698.5773606967813, 4169.0, 4506.842260520866, 4530.29780384041, 4535.274356103007, 4555.840545580889, 97999.0, 102788.48605756923, 104714.0, 107503.0, 107615.38576921352, 94244.0, 96173.0, 97010.0298997015, 97407.51296243473, 99241.50379248058, 75618.62190689011, 76280.0, 78315.60842195753, 81587.59206203932, 81678.59160704158, 8801.779955501164, 8863.759073729812, 8890.89171375233, 8947.418417802823, 9080.682176124068, 52597.21104183364, 52597.47402526079, 53489.0, 54332.0, 54859.0, 61916.69041654763, 71774.28225717676, 74520.62739686483, 77761.0, 78692.0, 11315.547378104784, 11539.4807233673, 11627.883721163018, 11648.359340236368, 11653.41732913368, 12494.73021163457, 12618.116731828684, 12713.8092928608, 12769.744605108031, 13090.345482726016, 11400.429978501208, 11576.768464630828, 11682.415879205835, 11828.940855295668, 12227.449764760786, 11797.52809887595, 11978.700532486757, 12009.519619215134, 12357.0, 12388.81416778767, 11274.661760147208, 11516.136289778467, 11560.6531804046, 11712.180147389601, 12034.217775844541, 9629.374090684083, 9688.304546704157, 9990.300678952404, 10034.64878729241, 10134.797304054026, 10125.64560240388, 10198.694039178836, 10344.482775861328, 10399.896001039893, 10403.53184106732], "value": 7285.84469342761, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 116.0, 123.0, 162.0], "value": 121.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 134.0, 147.0, 165.0, 114.0, 125.0, 141.0, 144.0, 147.0, 116.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 203.0, 203.0, 214.0, 196.0, 199.0, 201.0, 198.0, 200.0, 201.0], "value": 201.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 84.0, 55.0, 111.0, 49.0, 59.0, 73.0, 84.0, 103.0, 53.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 63.0, 91.0, 103.0, 98.0, 91.0, 89.0, 70.0, 68.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 92.0, 88.0, 85.0, 131.0, 137.0, 93.0, 91.0, 87.0], "value": 98.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 154.0, 110.0, 96.0, 99.0, 108.0, 134.0, 153.0, 119.0, 152.0], "value": 124.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 123.0, 85.0, 115.0, 111.0, 87.0, 90.0, 89.0, 129.0, 141.0], "value": 107.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 56.0, 72.0, 75.0, 90.0, 91.0, 90.0, 89.0, 83.0], "value": 76.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 68.0, 77.0, 92.0, 71.0, 71.0, 72.0, 75.0, 72.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 86.0, 92.0, 88.0, 85.0, 90.0, 93.0, 88.0, 91.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 172.0, 154.0, 146.0, 155.0, 151.0, 148.0, 153.0, 190.0, 134.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 178.0, 177.0, 176.0, 177.0, 175.0, 177.0, 179.0, 174.0, 174.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 68.0, 69.0, 71.0, 68.0, 69.0, 71.0, 69.0, 69.0], "value": 69.7, "unit": "score"}]}]} 10:28:47 INFO - Return code: 0 10:28:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:28:47 ERROR - # TBPL SUCCESS # 10:28:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:28:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:28:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:28:47 INFO - 2016-10-27 10:28:47.397 screenresolution[1672:10884] starting screenresolution argv=screenresolution get 10:28:47 INFO - 2016-10-27 10:28:47.400 screenresolution[1672:10884] Display 0: 1600x1200x32@60 10:28:47 INFO - 2016-10-27 10:28:47.405 screenresolution[1673:10888] starting screenresolution argv=screenresolution list 10:28:47 INFO - Available Modes on Display 0 10:28:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:28:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:28:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:28:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:28:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:28:47 INFO - Intel Iris: 10:28:47 INFO - Chipset Model: Intel Iris 10:28:47 INFO - Type: GPU 10:28:47 INFO - Bus: Built-In 10:28:47 INFO - VRAM (Dynamic, Max): 1536 MB 10:28:47 INFO - Vendor: Intel (0x8086) 10:28:47 INFO - Device ID: 0x0a2e 10:28:47 INFO - Revision ID: 0x0009 10:28:47 INFO - Displays: 10:28:47 INFO - Display: 10:28:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:28:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:28:47 INFO - Display Serial Number: 1600x1200 60 10:28:47 INFO - Main Display: Yes 10:28:47 INFO - Mirror: Off 10:28:47 INFO - Online: Yes 10:28:47 INFO - Rotation: Supported 10:28:47 INFO - Return code: 0 10:28:47 INFO - Running post-action listener: _resource_record_post_action 10:28:47 INFO - [mozharness: 2016-10-27 17:28:47.649587Z] Finished run-tests step (success) 10:28:47 INFO - Running post-run listener: _resource_record_post_run 10:28:47 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 38332928; Write bytes: 709951488; Read time: 249; Write time: 2014 10:28:47 INFO - TinderboxPrint: CPU usage
54.9% 10:28:47 INFO - TinderboxPrint: I/O read bytes / time
38,332,928 / 249 10:28:47 INFO - TinderboxPrint: I/O write bytes / time
709,951,488 / 2,014 10:28:47 INFO - TinderboxPrint: CPU idle
2,186.2 (45.1%) 10:28:47 INFO - TinderboxPrint: CPU system
986.7 (20.4%) 10:28:47 INFO - TinderboxPrint: CPU user
1,672.9 (34.5%) 10:28:47 INFO - TinderboxPrint: Swap in / out
443,830,272 / 0 10:28:47 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 400495104; Write bytes: 392304640; Read time: 30775; Write time: 810 10:28:47 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 36231680; Write bytes: 301164544; Read time: 228; Write time: 1159 10:28:48 INFO - Running post-run listener: _upload_blobber_files 10:28:48 INFO - Blob upload gear active. 10:28:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:28:48 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 10:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:28:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:28:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:28:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:28:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:49 INFO - (blobuploader) - INFO - Done attempting. 10:28:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:28:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:28:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:50 INFO - (blobuploader) - INFO - Done attempting. 10:28:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:28:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:28:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:52 INFO - (blobuploader) - INFO - Done attempting. 10:28:52 INFO - (blobuploader) - INFO - Iteration through files over. 10:28:52 INFO - Return code: 0 10:28:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:28:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:28:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d52c66babdda1ffe52b8da391ae48d503c9d65f2a66ffd7f208696e0167e774bceb153b7f7badee82129dba877ee612232c8937692645b0fcef9bef2a9e771d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85851a23ff2bd6767e98b2e30674af39eec423ed23de5bcb8f8c6cff38f58d5e48af2ae317ad997c0f5abbb72d2e663e31d7c119fc80c120d5643dd21acca30a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1a2015be85a76daaf34c5ea6114bd75896f4c867f43e86c91cef9c109971480cfc415c1510bebccda4f58f71193cc259b242cd76a6a35a6091cd08c762acd09"} 10:28:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:28:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:28:52 INFO - Contents: 10:28:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d52c66babdda1ffe52b8da391ae48d503c9d65f2a66ffd7f208696e0167e774bceb153b7f7badee82129dba877ee612232c8937692645b0fcef9bef2a9e771d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85851a23ff2bd6767e98b2e30674af39eec423ed23de5bcb8f8c6cff38f58d5e48af2ae317ad997c0f5abbb72d2e663e31d7c119fc80c120d5643dd21acca30a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1a2015be85a76daaf34c5ea6114bd75896f4c867f43e86c91cef9c109971480cfc415c1510bebccda4f58f71193cc259b242cd76a6a35a6091cd08c762acd09"} 10:28:52 INFO - Running post-run listener: copy_logs_to_upload_dir 10:28:52 INFO - Copying logs to upload dir... 10:28:52 INFO - mkdir: /builds/slave/test/build/upload/logs 10:28:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.703466 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-27 10:28:52.861930) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 10:28:52.865787) ========= 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.lPzzSPWE2H/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.WzhoWbqwLk/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d52c66babdda1ffe52b8da391ae48d503c9d65f2a66ffd7f208696e0167e774bceb153b7f7badee82129dba877ee612232c8937692645b0fcef9bef2a9e771d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85851a23ff2bd6767e98b2e30674af39eec423ed23de5bcb8f8c6cff38f58d5e48af2ae317ad997c0f5abbb72d2e663e31d7c119fc80c120d5643dd21acca30a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1a2015be85a76daaf34c5ea6114bd75896f4c867f43e86c91cef9c109971480cfc415c1510bebccda4f58f71193cc259b242cd76a6a35a6091cd08c762acd09"} build_url:https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011134 build_url: 'https://queue.taskcluster.net/v1/task/WiKjDjkuRj2Tq1kkQ5oOZg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d52c66babdda1ffe52b8da391ae48d503c9d65f2a66ffd7f208696e0167e774bceb153b7f7badee82129dba877ee612232c8937692645b0fcef9bef2a9e771d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85851a23ff2bd6767e98b2e30674af39eec423ed23de5bcb8f8c6cff38f58d5e48af2ae317ad997c0f5abbb72d2e663e31d7c119fc80c120d5643dd21acca30a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1a2015be85a76daaf34c5ea6114bd75896f4c867f43e86c91cef9c109971480cfc415c1510bebccda4f58f71193cc259b242cd76a6a35a6091cd08c762acd09"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 10:28:52.898707) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 10:28:52.899044) ========= 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.lPzzSPWE2H/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.WzhoWbqwLk/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.005071 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 10:28:52.947950) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 10:28:52.948255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 10:28:52.948550) ========= ========= Total master_lag: 0.17 =========