builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0124 starttime: 1482330740.97 results: success (0) buildid: 20161221040853 builduid: 2c1493cdf51e45c397e84a271b21b857 revision: e6ec59a1128a587af3d45b9d529105cee4e1205d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:20.970344) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:20.970797) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:20.971066) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:20.997399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:20.997754) ========= 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.XJXyKw3sXn/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.4UAhciNVCH/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-12-21 06:32:21-- 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% 15.2M=0.001s 2016-12-21 06:32:21 (15.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146654 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:21.168138) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:21.168443) ========= 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.XJXyKw3sXn/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.4UAhciNVCH/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.027359 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:21.217458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:21.217835) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e6ec59a1128a587af3d45b9d529105cee4e1205d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e6ec59a1128a587af3d45b9d529105cee4e1205d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XJXyKw3sXn/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.4UAhciNVCH/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-12-21 06:32:21,311 truncating revision to first 12 chars 2016-12-21 06:32:21,311 Setting DEBUG logging. 2016-12-21 06:32:21,311 attempt 1/10 2016-12-21 06:32:21,312 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e6ec59a1128a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 06:32:21,975 unpacking tar archive at: mozilla-aurora-e6ec59a1128a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.928243 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:22.171321) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:22.171652) ========= script_repo_revision: e6ec59a1128a587af3d45b9d529105cee4e1205d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:22.172034) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:22.172295) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:22.191959) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-12-21 06:32:22.192300) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XJXyKw3sXn/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.4UAhciNVCH/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:32:22 INFO - MultiFileLogger online at 20161221 06:32:22 in /builds/slave/test 06:32:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:32:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:32:22 INFO - {'append_to_log': False, 06:32:22 INFO - 'base_work_dir': '/builds/slave/test', 06:32:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:32:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:32:22 INFO - 'branch': 'Mozilla-Aurora', 06:32:22 INFO - 'buildbot_json_path': 'buildprops.json', 06:32:22 INFO - 'config_files': ('talos/mac_config.py',), 06:32:22 INFO - 'default_actions': ('clobber', 06:32:22 INFO - 'read-buildbot-config', 06:32:22 INFO - 'download-and-extract', 06:32:22 INFO - 'populate-webroot', 06:32:22 INFO - 'create-virtualenv', 06:32:22 INFO - 'install', 06:32:22 INFO - 'run-tests'), 06:32:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:32:22 INFO - 'download_minidump_stackwalk': True, 06:32:22 INFO - 'download_symbols': 'ondemand', 06:32:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:32:22 INFO - 'tooltool.py': '/tools/tooltool.py', 06:32:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:32:22 INFO - '/tools/misc-python/virtualenv.py')}, 06:32:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:32:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:32:22 INFO - 'installer_path': 'installer.exe', 06:32:22 INFO - 'log_level': 'info', 06:32:22 INFO - 'log_name': 'talos', 06:32:22 INFO - 'log_to_console': True, 06:32:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:32:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:32:22 INFO - 'opt_config_files': (), 06:32:22 INFO - 'pip_index': False, 06:32:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:32:22 INFO - 'cmd': ('bash', 06:32:22 INFO - '-c', 06:32:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:32:22 INFO - 'enabled': True, 06:32:22 INFO - 'halt_on_failure': False, 06:32:22 INFO - 'name': 'check_screen_resolution'},), 06:32:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:32:22 INFO - 'cmd': ('bash', 06:32:22 INFO - '-c', 06:32:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:32:22 INFO - 'enabled': True, 06:32:22 INFO - 'halt_on_failure': False, 06:32:22 INFO - 'name': 'check_screen_resolution'},), 06:32:22 INFO - 'run_cmd_checks_enabled': True, 06:32:22 INFO - 'sps_profile': False, 06:32:22 INFO - 'sps_profile_interval': 0, 06:32:22 INFO - 'suite': 'dromaeojs-e10s', 06:32:22 INFO - 'system_bits': '32', 06:32:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:32:22 INFO - 'title': 't-yosemite-r7-0124', 06:32:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:32:22 INFO - 'use_talos_json': True, 06:32:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:32:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:32:22 INFO - 'work_dir': 'build'} 06:32:22 INFO - [mozharness: 2016-12-21 14:32:22.395613Z] Running clobber step. 06:32:22 INFO - Running pre-action listener: _resource_record_pre_action 06:32:22 INFO - Running main action method: clobber 06:32:22 INFO - rmtree: /builds/slave/test/build 06:32:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:32:25 INFO - Running post-action listener: _resource_record_post_action 06:32:25 INFO - [mozharness: 2016-12-21 14:32:25.032781Z] Finished clobber step (success) 06:32:25 INFO - [mozharness: 2016-12-21 14:32:25.032972Z] Running read-buildbot-config step. 06:32:25 INFO - Running pre-action listener: _resource_record_pre_action 06:32:25 INFO - Running main action method: read_buildbot_config 06:32:25 INFO - Using buildbot properties: 06:32:25 INFO - { 06:32:25 INFO - "project": "", 06:32:25 INFO - "product": "firefox", 06:32:25 INFO - "script_repo_revision": "production", 06:32:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 06:32:25 INFO - "repository": "", 06:32:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 06:32:25 INFO - "buildid": "20161221040853", 06:32:25 INFO - "pgo_build": "False", 06:32:25 INFO - "basedir": "/builds/slave/test", 06:32:25 INFO - "buildnumber": 53, 06:32:25 INFO - "slavename": "t-yosemite-r7-0124", 06:32:25 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 06:32:25 INFO - "platform": "yosemite_r7", 06:32:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:32:25 INFO - "branch": "mozilla-aurora", 06:32:25 INFO - "repo_path": "releases/mozilla-aurora", 06:32:25 INFO - "revision": "e6ec59a1128a587af3d45b9d529105cee4e1205d", 06:32:25 INFO - "stage_platform": "macosx64", 06:32:25 INFO - "builduid": "2c1493cdf51e45c397e84a271b21b857", 06:32:25 INFO - "slavebuilddir": "test" 06:32:25 INFO - } 06:32:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 06:32:25 INFO - Running post-action listener: _resource_record_post_action 06:32:25 INFO - [mozharness: 2016-12-21 14:32:25.038499Z] Finished read-buildbot-config step (success) 06:32:25 INFO - [mozharness: 2016-12-21 14:32:25.038671Z] Running download-and-extract step. 06:32:25 INFO - Running pre-action listener: _resource_record_pre_action 06:32:25 INFO - Running main action method: download_and_extract 06:32:25 INFO - mkdir: /builds/slave/test/build/tests 06:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:25 INFO - trying https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 06:32:25 INFO - Downloading https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 06:32:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 06:32:25 INFO - Downloaded 1199 bytes. 06:32:25 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 06:32:25 INFO - Using the following test package requirements: 06:32:25 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 06:32:25 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:25 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 06:32:25 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:25 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 06:32:25 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:25 INFO - u'jsshell-mac.zip'], 06:32:25 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:25 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 06:32:25 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 06:32:25 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:25 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 06:32:25 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:25 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 06:32:25 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:25 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 06:32:25 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:25 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 06:32:25 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:32:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 06:32:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:32:25 INFO - Fetch https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 06:32:26 INFO - Http code: 200 06:32:26 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 06:32:26 INFO - x-amz-cf-id: 7N6fikOyASY3C6WLVThm1sZaBhMrmeS-oAFuWd88cIE4oX4T--2ltw== 06:32:26 INFO - x-amz-version-id: 02mpgtb29FNicEEbZW7KIlOO6hMJvJ9S 06:32:26 INFO - Expected file size: 16267640 06:32:26 INFO - Obtained file size: 16267640 06:32:33 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 06:32:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 06:32:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:32:33 INFO - Fetch https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 06:32:33 INFO - Http code: 200 06:32:33 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 06:32:33 INFO - x-amz-cf-id: KmI022k392FMCSwpYo5uugwfq5q2gEbfC87-b8R06X0BwLTPdi6Z_A== 06:32:33 INFO - x-amz-version-id: 02mpgtb29FNicEEbZW7KIlOO6hMJvJ9S 06:32:34 INFO - Expected file size: 16267640 06:32:34 INFO - Obtained file size: 16267640 06:32:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 06:32:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:32:40 INFO - Fetch https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 06:32:41 INFO - Http code: 200 06:32:41 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 06:32:41 INFO - x-amz-cf-id: 8Q91Tt64zdDCvvJnhDUXVgokJu0vjHBIRBO8vWrDShpZh1DbZsOq0A== 06:32:41 INFO - x-amz-version-id: 9Pmv9xzdD5J0on8kd8qlDZkOH9zvtNRj 06:32:42 INFO - Expected file size: 14409038 06:32:42 INFO - Obtained file size: 14409038 06:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:42 INFO - trying https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 06:32:42 INFO - Downloading https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 06:32:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 06:32:45 INFO - Downloaded 109803563 bytes. 06:32:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 06:32:45 INFO - mkdir: /builds/slave/test/properties 06:32:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:32:45 INFO - Writing to file /builds/slave/test/properties/build_url 06:32:45 INFO - Contents: 06:32:45 INFO - build_url:https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 06:32:46 INFO - Running post-action listener: _resource_record_post_action 06:32:46 INFO - Running post-action listener: set_extra_try_arguments 06:32:46 INFO - [mozharness: 2016-12-21 14:32:46.148557Z] Finished download-and-extract step (success) 06:32:46 INFO - [mozharness: 2016-12-21 14:32:46.148675Z] Running populate-webroot step. 06:32:46 INFO - Running pre-action listener: _resource_record_pre_action 06:32:46 INFO - Running main action method: populate_webroot 06:32:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:32:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:32:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:32:46 INFO - '--tppagecycles', 06:32:46 INFO - '7'], 06:32:46 INFO - 'tests': ['tsvgm']}}, 06:32:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:32:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:32:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:32:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:32:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:32:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:32:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:46 INFO - 'talos_options': ['--disable-e10s'], 06:32:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:32:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:32:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:46 INFO - 'talos_options': ['--disable-e10s'], 06:32:46 INFO - 'tests': ['damp', 'tps']}, 06:32:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:46 INFO - 'tests': ['damp', 'tps']}, 06:32:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:32:46 INFO - 'tests': ['dromaeo_dom']}, 06:32:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:32:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:32:46 INFO - 'tests': ['basic_compositor_video']}, 06:32:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:32:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:32:46 INFO - 'tests': ['a11yr', 06:32:46 INFO - 'ts_paint', 06:32:46 INFO - 'tpaint', 06:32:46 INFO - 'sessionrestore', 06:32:46 INFO - 'sessionrestore_no_auto_restore', 06:32:46 INFO - 'tabpaint']}, 06:32:46 INFO - 'other-e10s': {'tests': ['a11yr', 06:32:46 INFO - 'ts_paint', 06:32:46 INFO - 'tpaint', 06:32:46 INFO - 'sessionrestore', 06:32:46 INFO - 'sessionrestore_no_auto_restore', 06:32:46 INFO - 'tabpaint']}, 06:32:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:32:46 INFO - 'ts_paint', 06:32:46 INFO - 'tpaint', 06:32:46 INFO - 'sessionrestore', 06:32:46 INFO - 'sessionrestore_no_auto_restore', 06:32:46 INFO - 'tabpaint']}, 06:32:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:32:46 INFO - 'ts_paint', 06:32:46 INFO - 'tpaint', 06:32:46 INFO - 'sessionrestore', 06:32:46 INFO - 'sessionrestore_no_auto_restore', 06:32:46 INFO - 'tabpaint']}, 06:32:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:32:46 INFO - 'tests': ['a11yr', 06:32:46 INFO - 'ts_paint', 06:32:46 INFO - 'tpaint', 06:32:46 INFO - 'sessionrestore', 06:32:46 INFO - 'sessionrestore_no_auto_restore', 06:32:46 INFO - 'tabpaint']}, 06:32:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:32:46 INFO - 'tests': ['a11yr', 06:32:46 INFO - 'ts_paint', 06:32:46 INFO - 'tpaint', 06:32:46 INFO - 'sessionrestore', 06:32:46 INFO - 'sessionrestore_no_auto_restore', 06:32:46 INFO - 'tabpaint']}, 06:32:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:32:46 INFO - 'tests': ['tsvgx', 06:32:46 INFO - 'tsvgr_opacity', 06:32:46 INFO - 'tart', 06:32:46 INFO - 'tscrollx', 06:32:46 INFO - 'cart']}, 06:32:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:32:46 INFO - 'tsvgr_opacity', 06:32:46 INFO - 'tart', 06:32:46 INFO - 'tscrollx', 06:32:46 INFO - 'cart']}, 06:32:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:46 INFO - 'talos_options': ['--disable-e10s'], 06:32:46 INFO - 'tests': ['tp5o']}, 06:32:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:46 INFO - 'tests': ['tp5o']}, 06:32:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:46 INFO - 'talos_options': ['--disable-e10s', 06:32:46 INFO - '--xperf_path', 06:32:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:32:46 INFO - 'tests': ['tp5n']}, 06:32:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:46 INFO - 'talos_options': ['--xperf_path', 06:32:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:32:46 INFO - 'tests': ['tp5n']}}, 06:32:46 INFO - 'talos.zip': {'path': '', 06:32:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:32:46 INFO - Running post-action listener: _resource_record_post_action 06:32:46 INFO - [mozharness: 2016-12-21 14:32:46.167635Z] Finished populate-webroot step (success) 06:32:46 INFO - [mozharness: 2016-12-21 14:32:46.167771Z] Running create-virtualenv step. 06:32:46 INFO - Running pre-action listener: _resource_record_pre_action 06:32:46 INFO - Running main action method: create_virtualenv 06:32:46 INFO - Creating virtualenv /builds/slave/test/build/venv 06:32:46 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 06:32:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:32:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:32:46 INFO - Using real prefix '/tools/python27' 06:32:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:32:47 INFO - Installing distribute.............................................................................................................................................................................................done. 06:32:49 INFO - Installing pip.................done. 06:32:49 INFO - Return code: 0 06:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:32:50 INFO - Reading from file tmpfile_stdout 06:32:50 INFO - Output received: 06:32:50 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) 06:32:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:50 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 0x10966c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b3c80370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109480d30>, '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 0x1092e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109478b20>, '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.XJXyKw3sXn/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.4UAhciNVCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:32:50 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 06:32:50 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 06:32:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJXyKw3sXn/Render', 06:32:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:32:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:32:50 INFO - 'HOME': '/Users/cltbld', 06:32:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:32:50 INFO - 'LOGNAME': 'cltbld', 06:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:50 INFO - 'MOZ_NO_REMOTE': '1', 06:32:50 INFO - 'NO_EM_RESTART': '1', 06:32:50 INFO - 'PAGER': '/bin/cat', 06:32:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:50 INFO - 'PWD': '/builds/slave/test', 06:32:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:32:50 INFO - 'SHELL': '/bin/bash', 06:32:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4UAhciNVCH/Listeners', 06:32:50 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:32:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:32:50 INFO - 'USER': 'cltbld', 06:32:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:32:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:50 INFO - 'XPC_FLAGS': '0x0', 06:32:50 INFO - 'XPC_SERVICE_NAME': '0', 06:32:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:50 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 06:32:50 INFO - Cleaning up... 06:32:50 INFO - Return code: 0 06:32:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:50 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 0x10966c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b3c80370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109480d30>, '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 0x1092e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109478b20>, '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.XJXyKw3sXn/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.4UAhciNVCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:32:50 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 06:32:50 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 06:32:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJXyKw3sXn/Render', 06:32:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:32:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:32:50 INFO - 'HOME': '/Users/cltbld', 06:32:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:32:50 INFO - 'LOGNAME': 'cltbld', 06:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:50 INFO - 'MOZ_NO_REMOTE': '1', 06:32:50 INFO - 'NO_EM_RESTART': '1', 06:32:50 INFO - 'PAGER': '/bin/cat', 06:32:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:50 INFO - 'PWD': '/builds/slave/test', 06:32:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:32:50 INFO - 'SHELL': '/bin/bash', 06:32:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4UAhciNVCH/Listeners', 06:32:50 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:32:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:32:50 INFO - 'USER': 'cltbld', 06:32:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:32:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:50 INFO - 'XPC_FLAGS': '0x0', 06:32:50 INFO - 'XPC_SERVICE_NAME': '0', 06:32:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:50 INFO - Downloading/unpacking psutil>=3.1.1 06:32:50 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 06:32:50 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 06:32:50 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 06:32:50 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 06:32:50 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 06:32:50 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 06:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:32:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:32:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:32:54 INFO - Installing collected packages: psutil 06:32:54 INFO - Running setup.py install for psutil 06:32:54 INFO - building 'psutil._psutil_osx' extension 06:32:54 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 06:32:54 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 06:32:54 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 06:32:55 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 06:32:55 INFO - building 'psutil._psutil_posix' extension 06:32:55 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 06:32:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:32:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:32:55 INFO - ^ 06:32:55 INFO - 1 warning generated. 06:32:55 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 06:32:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:32:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:32:55 INFO - Successfully installed psutil 06:32:55 INFO - Cleaning up... 06:32:55 INFO - Return code: 0 06:32:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10966c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b3c80370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109480d30>, '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 0x1092e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109478b20>, '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.XJXyKw3sXn/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.4UAhciNVCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJXyKw3sXn/Render', 06:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:32:55 INFO - 'HOME': '/Users/cltbld', 06:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:32:55 INFO - 'LOGNAME': 'cltbld', 06:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:55 INFO - 'MOZ_NO_REMOTE': '1', 06:32:55 INFO - 'NO_EM_RESTART': '1', 06:32:55 INFO - 'PAGER': '/bin/cat', 06:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:55 INFO - 'PWD': '/builds/slave/test', 06:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:32:55 INFO - 'SHELL': '/bin/bash', 06:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4UAhciNVCH/Listeners', 06:32:55 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:32:55 INFO - 'USER': 'cltbld', 06:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:55 INFO - 'XPC_FLAGS': '0x0', 06:32:55 INFO - 'XPC_SERVICE_NAME': '0', 06:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:32:58 INFO - Installing collected packages: mozsystemmonitor 06:32:58 INFO - Running setup.py install for mozsystemmonitor 06:32:58 INFO - Successfully installed mozsystemmonitor 06:32:58 INFO - Cleaning up... 06:32:58 INFO - Return code: 0 06:32:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:32: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')]} 06:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32: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')]} 06:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:58 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 0x10966c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b3c80370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109480d30>, '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 0x1092e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109478b20>, '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.XJXyKw3sXn/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.4UAhciNVCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:32:58 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 06:32:58 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 06:32:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJXyKw3sXn/Render', 06:32:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:32:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:32:58 INFO - 'HOME': '/Users/cltbld', 06:32:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:32:58 INFO - 'LOGNAME': 'cltbld', 06:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:58 INFO - 'MOZ_NO_REMOTE': '1', 06:32:58 INFO - 'NO_EM_RESTART': '1', 06:32:58 INFO - 'PAGER': '/bin/cat', 06:32:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:58 INFO - 'PWD': '/builds/slave/test', 06:32:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:32:58 INFO - 'SHELL': '/bin/bash', 06:32:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4UAhciNVCH/Listeners', 06:32:58 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:32:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:32:58 INFO - 'USER': 'cltbld', 06:32:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:32:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:58 INFO - 'XPC_FLAGS': '0x0', 06:32:58 INFO - 'XPC_SERVICE_NAME': '0', 06:32:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:58 INFO - Downloading/unpacking jsonschema==2.5.1 06:32:58 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 06:32:58 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 06:32:58 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 06:32:58 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 06:32:58 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 06:32:58 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 06:33:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:33:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:33:01 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 06:33:01 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 06:33:01 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 06:33:01 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 06:33:01 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 06:33:01 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 06:33:01 INFO - Downloading functools32-3.2.3-2.tar.gz 06:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:33:01 INFO - warning: no files found matching '*.txt' 06:33:01 INFO - no previously-included directories found matching 'build' 06:33:01 INFO - no previously-included directories found matching 'dist' 06:33:01 INFO - no previously-included directories found matching '.git*' 06:33:01 INFO - Installing collected packages: jsonschema, functools32 06:33:02 INFO - Running setup.py install for functools32 06:33:02 INFO - warning: no files found matching '*.txt' 06:33:02 INFO - no previously-included directories found matching 'build' 06:33:02 INFO - no previously-included directories found matching 'dist' 06:33:02 INFO - no previously-included directories found matching '.git*' 06:33:02 INFO - Successfully installed jsonschema functools32 06:33:02 INFO - Cleaning up... 06:33:02 INFO - Return code: 0 06:33:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:02 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 0x10966c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b3c80370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109480d30>, '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 0x1092e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109478b20>, '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.XJXyKw3sXn/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.4UAhciNVCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:33:02 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 06:33:02 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 06:33:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJXyKw3sXn/Render', 06:33:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:02 INFO - 'HOME': '/Users/cltbld', 06:33:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:02 INFO - 'LOGNAME': 'cltbld', 06:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:02 INFO - 'MOZ_NO_REMOTE': '1', 06:33:02 INFO - 'NO_EM_RESTART': '1', 06:33:02 INFO - 'PAGER': '/bin/cat', 06:33:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:02 INFO - 'PWD': '/builds/slave/test', 06:33:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:02 INFO - 'SHELL': '/bin/bash', 06:33:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4UAhciNVCH/Listeners', 06:33:02 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:33:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:02 INFO - 'USER': 'cltbld', 06:33:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:02 INFO - 'XPC_FLAGS': '0x0', 06:33:02 INFO - 'XPC_SERVICE_NAME': '0', 06:33:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:33:02 INFO - Cleaning up... 06:33:02 INFO - Return code: 0 06:33:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:02 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 0x10966c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b3c80370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109480d30>, '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 0x1092e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109478b20>, '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.XJXyKw3sXn/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.4UAhciNVCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:33:02 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 06:33:02 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 06:33:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJXyKw3sXn/Render', 06:33:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:02 INFO - 'HOME': '/Users/cltbld', 06:33:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:02 INFO - 'LOGNAME': 'cltbld', 06:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:02 INFO - 'MOZ_NO_REMOTE': '1', 06:33:02 INFO - 'NO_EM_RESTART': '1', 06:33:02 INFO - 'PAGER': '/bin/cat', 06:33:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:02 INFO - 'PWD': '/builds/slave/test', 06:33:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:02 INFO - 'SHELL': '/bin/bash', 06:33:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4UAhciNVCH/Listeners', 06:33:02 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:33:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:02 INFO - 'USER': 'cltbld', 06:33:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:02 INFO - 'XPC_FLAGS': '0x0', 06:33:02 INFO - 'XPC_SERVICE_NAME': '0', 06:33:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:02 INFO - Downloading/unpacking blobuploader==1.2.4 06:33:02 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 06:33:02 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 06:33:02 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 06:33:02 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 06:33:02 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 06:33:02 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 06:33:05 INFO - Downloading blobuploader-1.2.4.tar.gz 06:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:33:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:33:05 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 06:33:05 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 06:33:05 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 06:33:05 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 06:33:05 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 06:33:05 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 06:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:33:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:33:06 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 06:33:06 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 06:33:06 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 06:33:06 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 06:33:06 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 06:33:06 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 06:33:06 INFO - Downloading docopt-0.6.1.tar.gz 06:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:33:06 INFO - Installing collected packages: blobuploader, requests, docopt 06:33:06 INFO - Running setup.py install for blobuploader 06:33:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:33:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:33:06 INFO - Running setup.py install for requests 06:33:07 INFO - Running setup.py install for docopt 06:33:07 INFO - Successfully installed blobuploader requests docopt 06:33:07 INFO - Cleaning up... 06:33:07 INFO - Return code: 0 06:33:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33: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')]} 06:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33: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')]} 06:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:07 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 0x10966c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b3c80370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109480d30>, '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 0x1092e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109478b20>, '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.XJXyKw3sXn/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.4UAhciNVCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:33:07 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 06:33:07 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 06:33:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJXyKw3sXn/Render', 06:33:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:07 INFO - 'HOME': '/Users/cltbld', 06:33:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:07 INFO - 'LOGNAME': 'cltbld', 06:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:07 INFO - 'MOZ_NO_REMOTE': '1', 06:33:07 INFO - 'NO_EM_RESTART': '1', 06:33:07 INFO - 'PAGER': '/bin/cat', 06:33:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:07 INFO - 'PWD': '/builds/slave/test', 06:33:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:07 INFO - 'SHELL': '/bin/bash', 06:33:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4UAhciNVCH/Listeners', 06:33:07 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:33:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:07 INFO - 'USER': 'cltbld', 06:33:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:07 INFO - 'XPC_FLAGS': '0x0', 06:33:07 INFO - 'XPC_SERVICE_NAME': '0', 06:33:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:33:07 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-eg2Jey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:33:08 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Gb5Das-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:33:08 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-W_CldZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:33:08 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-J50vCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:33:08 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-sxCYLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:33:08 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-EV13rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:33:08 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-ijSBUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:33:08 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-XYWCml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:33:08 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-SlKX_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:33:08 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Xoa_F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:33:08 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-3PDeso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:33:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-v2t2zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:33:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-jecyZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:33:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-PZq0wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-7uLADA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:33:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-3vpEBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:33:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-t65LNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:33:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:33:09 INFO - Running setup.py install for manifestparser 06:33:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:33:09 INFO - Running setup.py install for mozcrash 06:33:09 INFO - Running setup.py install for mozdebug 06:33:10 INFO - Running setup.py install for mozdevice 06:33:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:33:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:33:10 INFO - Running setup.py install for mozfile 06:33:10 INFO - Running setup.py install for mozhttpd 06:33:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:33:10 INFO - Running setup.py install for mozinfo 06:33:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:33:10 INFO - Running setup.py install for mozInstall 06:33:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:33:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:33:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:33:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:33:10 INFO - Running setup.py install for mozleak 06:33:10 INFO - Running setup.py install for mozlog 06:33:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:33:11 INFO - Running setup.py install for moznetwork 06:33:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:33:11 INFO - Running setup.py install for mozprocess 06:33:11 INFO - Running setup.py install for mozprofile 06:33:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:33:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:33:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:33:11 INFO - Running setup.py install for mozrunner 06:33:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:33:11 INFO - Running setup.py install for mozscreenshot 06:33:11 INFO - Running setup.py install for moztest 06:33:12 INFO - Running setup.py install for mozversion 06:33:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:33:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:33:12 INFO - Cleaning up... 06:33:12 INFO - Return code: 0 06:33:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33:12 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')]} 06:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:12 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')]} 06:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:12 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 0x10966c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b3c80370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109480d30>, '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 0x1092e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109478b20>, '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.XJXyKw3sXn/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.4UAhciNVCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:33:12 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 06:33:12 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 06:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJXyKw3sXn/Render', 06:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:12 INFO - 'HOME': '/Users/cltbld', 06:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:12 INFO - 'LOGNAME': 'cltbld', 06:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:12 INFO - 'MOZ_NO_REMOTE': '1', 06:33:12 INFO - 'NO_EM_RESTART': '1', 06:33:12 INFO - 'PAGER': '/bin/cat', 06:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:12 INFO - 'PWD': '/builds/slave/test', 06:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:12 INFO - 'SHELL': '/bin/bash', 06:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4UAhciNVCH/Listeners', 06:33:12 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:12 INFO - 'USER': 'cltbld', 06:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:12 INFO - 'XPC_FLAGS': '0x0', 06:33:12 INFO - 'XPC_SERVICE_NAME': '0', 06:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:33:12 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-tSeo0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:33:12 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)) 06:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:33:12 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-2abobz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:33:12 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Adq8OD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:33:12 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)) 06:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:33:12 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-dmWzoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:33:12 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)) 06:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:33:12 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-wGi9mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:33:13 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)) 06:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:33:13 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-cAmEF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:33:13 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)) 06:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:33:13 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-mMuBh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:33:13 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)) 06:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:33:13 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Nh5VQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:33:13 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)) 06:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:33:13 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-O9LHy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:33:13 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)) 06:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:33:13 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Csx7fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:33:13 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)) 06:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:33:13 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-RVodY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:33:13 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)) 06:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:33:13 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-vK_Luf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:33:13 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)) 06:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:33:13 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-I3RkYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:33:13 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)) 06:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:33:13 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-zrWWPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:14 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-f7Bsgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:14 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)) 06:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:33:14 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-6LxX2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:33:14 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)) 06:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:33:14 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-ehfh29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:33:14 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)) 06:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:33:14 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)) 06:33:14 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)) 06:33:14 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)) 06:33:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:33:14 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 06:33:14 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 06:33:14 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 06:33:14 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 06:33:14 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 06:33:14 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 06:33:17 INFO - Downloading blessings-1.6.tar.gz 06:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:33:17 INFO - Installing collected packages: blessings 06:33:17 INFO - Running setup.py install for blessings 06:33:17 INFO - Successfully installed blessings 06:33:17 INFO - Cleaning up... 06:33:17 INFO - Return code: 0 06:33:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:33:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:33:17 INFO - Reading from file tmpfile_stdout 06:33:17 INFO - Current package versions: 06:33:17 INFO - blessings == 1.6 06:33:17 INFO - blobuploader == 1.2.4 06:33:17 INFO - docopt == 0.6.1 06:33:17 INFO - functools32 == 3.2.3-2 06:33:17 INFO - jsonschema == 2.5.1 06:33:17 INFO - manifestparser == 1.1 06:33:17 INFO - mozInstall == 1.12 06:33:17 INFO - mozcrash == 1.0 06:33:17 INFO - mozdebug == 0.1 06:33:17 INFO - mozdevice == 0.48 06:33:17 INFO - mozfile == 1.2 06:33:17 INFO - mozhttpd == 0.7 06:33:17 INFO - mozinfo == 0.9 06:33:17 INFO - mozleak == 0.1 06:33:17 INFO - mozlog == 3.4 06:33:17 INFO - moznetwork == 0.27 06:33:17 INFO - mozprocess == 0.23 06:33:17 INFO - mozprofile == 0.28 06:33:17 INFO - mozrunner == 6.13 06:33:17 INFO - mozscreenshot == 0.1 06:33:17 INFO - mozsystemmonitor == 0.3 06:33:17 INFO - moztest == 0.7 06:33:17 INFO - mozversion == 1.4 06:33:17 INFO - psutil == 3.1.1 06:33:17 INFO - requests == 1.2.3 06:33:17 INFO - wsgiref == 0.1.2 06:33:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33: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')]} 06:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:18 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 0x10966c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b3c80370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109480d30>, '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 0x1092e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109478b20>, '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.XJXyKw3sXn/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.4UAhciNVCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:33:18 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 06:33:18 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 06:33:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJXyKw3sXn/Render', 06:33:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:18 INFO - 'HOME': '/Users/cltbld', 06:33:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:18 INFO - 'LOGNAME': 'cltbld', 06:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:18 INFO - 'MOZ_NO_REMOTE': '1', 06:33:18 INFO - 'NO_EM_RESTART': '1', 06:33:18 INFO - 'PAGER': '/bin/cat', 06:33:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:18 INFO - 'PWD': '/builds/slave/test', 06:33:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:18 INFO - 'SHELL': '/bin/bash', 06:33:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4UAhciNVCH/Listeners', 06:33:18 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:33:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:18 INFO - 'USER': 'cltbld', 06:33:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:18 INFO - 'XPC_FLAGS': '0x0', 06:33:18 INFO - 'XPC_SERVICE_NAME': '0', 06:33:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:18 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)) 06:33:18 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)) 06:33:18 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)) 06:33:18 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)) 06:33:18 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)) 06:33:18 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)) 06:33:18 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)) 06:33:18 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)) 06:33:18 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)) 06:33:18 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)) 06:33:18 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)) 06:33:18 INFO - Cleaning up... 06:33:18 INFO - Return code: 0 06:33:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:33: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')]} 06:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33: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')]} 06:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:19 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 0x10966c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b3c80370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109480d30>, '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 0x1092e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109478b20>, '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.XJXyKw3sXn/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.4UAhciNVCH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:33:19 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 06:33:19 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 06:33:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJXyKw3sXn/Render', 06:33:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:19 INFO - 'HOME': '/Users/cltbld', 06:33:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:19 INFO - 'LOGNAME': 'cltbld', 06:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:19 INFO - 'MOZ_NO_REMOTE': '1', 06:33:19 INFO - 'NO_EM_RESTART': '1', 06:33:19 INFO - 'PAGER': '/bin/cat', 06:33:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:19 INFO - 'PWD': '/builds/slave/test', 06:33:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:19 INFO - 'SHELL': '/bin/bash', 06:33:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4UAhciNVCH/Listeners', 06:33:19 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:33:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:19 INFO - 'USER': 'cltbld', 06:33:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:19 INFO - 'XPC_FLAGS': '0x0', 06:33:19 INFO - 'XPC_SERVICE_NAME': '0', 06:33:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:33:19 INFO - Cleaning up... 06:33:19 INFO - Return code: 0 06:33:19 INFO - Running post-action listener: _resource_record_post_action 06:33:19 INFO - Running post-action listener: _start_resource_monitoring 06:33:19 INFO - Starting resource monitoring. 06:33:19 INFO - [mozharness: 2016-12-21 14:33:19.386851Z] Finished create-virtualenv step (success) 06:33:19 INFO - [mozharness: 2016-12-21 14:33:19.387812Z] Running install step. 06:33:19 INFO - Running pre-action listener: _resource_record_pre_action 06:33:19 INFO - Running main action method: install 06:33:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:33:19 INFO - Reading from file tmpfile_stdout 06:33:19 INFO - Detecting whether we're running mozinstall >=1.0... 06:33:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:33:19 INFO - Reading from file tmpfile_stdout 06:33:19 INFO - Output received: 06:33:19 INFO - Usage: mozinstall [options] installer 06:33:19 INFO - Options: 06:33:19 INFO - -h, --help show this help message and exit 06:33:19 INFO - -d DEST, --destination=DEST 06:33:19 INFO - Directory to install application into. [default: 06:33:19 INFO - "/builds/slave/test"] 06:33:19 INFO - --app=APP Application being installed. [default: firefox] 06:33:19 INFO - mkdir: /builds/slave/test/build/application 06:33:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 06:33:50 INFO - Reading from file tmpfile_stdout 06:33:50 INFO - Output received: 06:33:50 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:33:50 INFO - Running post-action listener: _resource_record_post_action 06:33:50 INFO - [mozharness: 2016-12-21 14:33:50.644098Z] Finished install step (success) 06:33:50 INFO - [mozharness: 2016-12-21 14:33:50.644246Z] Running run-tests step. 06:33:50 INFO - Running pre-action listener: _resource_record_pre_action 06:33:50 INFO - Running main action method: run_tests 06:33:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:33:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:33:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:33:50 INFO - 2016-12-21 06:33:50.658 screenresolution[1623:7686] starting screenresolution argv=screenresolution get 06:33:50 INFO - 2016-12-21 06:33:50.661 screenresolution[1623:7686] Display 0: 1600x1200x32@60 06:33:50 INFO - 2016-12-21 06:33:50.667 screenresolution[1624:7688] starting screenresolution argv=screenresolution list 06:33:50 INFO - Available Modes on Display 0 06:33:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:33:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:33:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:33:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:33:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:33:50 INFO - Intel Iris: 06:33:50 INFO - Chipset Model: Intel Iris 06:33:50 INFO - Type: GPU 06:33:50 INFO - Bus: Built-In 06:33:50 INFO - VRAM (Dynamic, Max): 1536 MB 06:33:50 INFO - Vendor: Intel (0x8086) 06:33:50 INFO - Device ID: 0x0a2e 06:33:50 INFO - Revision ID: 0x0009 06:33:50 INFO - Displays: 06:33:50 INFO - Display: 06:33:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:33:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:33:50 INFO - Display Serial Number: 1600x1200 60 06:33:50 INFO - Main Display: Yes 06:33:50 INFO - Mirror: Off 06:33:50 INFO - Online: Yes 06:33:50 INFO - Rotation: Supported 06:33:50 INFO - Return code: 0 06:33:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:33:50 INFO - Python 2.7.3 06:33:50 INFO - Return code: 0 06:33:50 INFO - grabbing minidump binary from tooltool 06:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:50 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 0x109480d30>, '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 0x1092e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109478b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:33:50 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 06:33:50 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 06:33:50 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 06:33:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:33:51 INFO - Return code: 0 06:33:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:33:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:33:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:33:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:33:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--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 06:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0124 --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 06:33:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XJXyKw3sXn/Render', 06:33:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:51 INFO - 'HOME': '/Users/cltbld', 06:33:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:51 INFO - 'LOGNAME': 'cltbld', 06:33:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:33:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:51 INFO - 'MOZ_NO_REMOTE': '1', 06:33:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:33:51 INFO - 'NO_EM_RESTART': '1', 06:33:51 INFO - 'PAGER': '/bin/cat', 06:33:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:51 INFO - 'PWD': '/builds/slave/test', 06:33:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:33:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:51 INFO - 'SHELL': '/bin/bash', 06:33:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4UAhciNVCH/Listeners', 06:33:51 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:33:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:51 INFO - 'USER': 'cltbld', 06:33:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:51 INFO - 'XPC_FLAGS': '0x0', 06:33:51 INFO - 'XPC_SERVICE_NAME': '0', 06:33:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--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 06:33:51 INFO - mozversion application_buildid: 20161221040853 06:33:51 INFO - mozversion application_changeset: e6ec59a1128a587af3d45b9d529105cee4e1205d 06:33:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:33:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:33:51 INFO - mozversion application_name: Firefox 06:33:51 INFO - mozversion application_remotingname: firefox-dev 06:33:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:33:51 INFO - mozversion application_vendor: Mozilla 06:33:51 INFO - mozversion application_version: 52.0a2 06:33:51 INFO - mozversion platform_buildid: 20161221040853 06:33:51 INFO - mozversion platform_changeset: e6ec59a1128a587af3d45b9d529105cee4e1205d 06:33:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:33:51 INFO - mozversion platform_version: 52.0a2 06:33:51 INFO - using testdate: 1482330831 06:33:51 INFO - actual date: 1482330831 06:33:51 INFO - starting webserver on 'localhost:49249' 06:33:51 INFO - SUITE-START | Running 2 tests 06:33:51 INFO - TEST-START | dromaeo_css 06:33:51 INFO - operating with platform_type : mac_ 06:33:51 INFO - Initialising browser for dromaeo_css test... 06:33:51 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpBDAGtl/profile http://localhost:49249/getInfo.html) 06:33:54 INFO - PROCESS | 1634 | 2016-12-21 06:33:54.417 plugin-container[1636:7861] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4853, name = 'com.apple.tsm.portname' 06:33:54 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:33:54 INFO - PROCESS | 1634 | 2016-12-21 06:33:54.419 plugin-container[1636:7861] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920b, name = 'com.apple.CFPasteboardClient' 06:33:54 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:33:54 INFO - PROCESS | 1634 | 2016-12-21 06:33:54.419 plugin-container[1636:7861] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:33:54 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 06:33:54 INFO - PROCESS | 1634 | colorDepth:24 06:33:54 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 06:33:54 INFO - PROCESS | 1634 | __metrics 06:33:54 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 06:33:55 INFO - TEST-INFO | 1634: exit 0 06:33:55 INFO - Browser initialized. 06:33:55 INFO - Running cycle 1/1 for dromaeo_css test... 06:33:55 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpBDAGtl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:33:57 INFO - PROCESS | 1637 | 2016-12-21 06:33:57.878 plugin-container[1638:7994] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 06:33:57 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:33:57 INFO - PROCESS | 1637 | 2016-12-21 06:33:57.878 plugin-container[1638:7994] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4223, name = 'com.apple.CFPasteboardClient' 06:33:57 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:33:57 INFO - PROCESS | 1637 | 2016-12-21 06:33:57.878 plugin-container[1638:7994] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:34:07 INFO - PROCESS | 1637 | RSS: Main: 229445632 06:34:07 INFO - PROCESS | 1637 | 06:34:57 INFO - PROCESS | 1637 | 1482330897171 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] 06:37:11 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 06:37:13 INFO - PROCESS | 1637 | RSS: Main: 232263680 06:37:13 INFO - PROCESS | 1637 | 06:40:15 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 06:40:16 INFO - PROCESS | 1637 | RSS: Main: 243482624 06:40:16 INFO - PROCESS | 1637 | 06:43:17 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 06:43:18 INFO - PROCESS | 1637 | RSS: Main: 246439936 06:43:18 INFO - PROCESS | 1637 | 06:46:20 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 06:46:21 INFO - PROCESS | 1637 | RSS: Main: 247943168 06:46:21 INFO - PROCESS | 1637 | 06:49:23 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 06:49:24 INFO - PROCESS | 1637 | RSS: Main: 251367424 06:49:24 INFO - PROCESS | 1637 | 06:52:27 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 06:52:27 INFO - PROCESS | 1637 | RSS: Main: 252776448 06:52:27 INFO - PROCESS | 1637 | 06:52:27 INFO - PROCESS | 1637 | __start_tp_report 06:52:27 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 06:52:27 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 06:52:27 INFO - PROCESS | 1637 | |i|pagename|runs| 06:52:27 INFO - PROCESS | 1637 | |0;dojo.html;3389.1188291044336;3395.049386171871;3399.8640054397824;3409.9659003409956;3426.7772594781336;4829.227323628215;5756.280464941882;5816.651000939942;5855.619384739989;5860.062390017598;5268.5521730652845;5268.710220937847;5768.451997060283;5870.943230218559;5922.822315330536;5049.823256186034;5253.947460525394;5311.203319502086;5312.442193569658;5339.70631615261;5377.5966802489775;5382.838514844561;5401.594880383967;5419.107593736579;5447.4824891635235;5197.714125723083;5223.425423203445;5357.866053348658;5359.5444387227135;5363.141897296433;5238.764255608507;5272.051030814452;5324;5349.679019258857;5405.972970135163;5237.9476205238225;5316.308879845634;5319.680819150824;5325.174597937287;5340.412554619028;5565.554755619541;5849.532037436995;5927.081302398092;5942.227510423617;5953.434423729739;6120.9347721082095;6137.754489820401;6168.1056246843955;6210.31686514483;6231.439170474634;6158.507319414481;6199.380061993809;6208.1308616793685;6220;6237.500999919996;5972.193753843176;5973.402659734035;5986.341502434729;5992.0994238748335;6018.187544681499;6110.103144028831;6205.22434695663;6215.751369945242;6222.688865556704;6357.268914074941;6186.752529898754;6217.253929528486;6234.189555357774;6239.688015599202;6277.435030847246;6278.215223097113;6302.747890084437;6304.590201636879;6310.905336419957;6316.778912738032;6108.2813625860135;6114.054067497291;6186.783462578788;6217.129601855744;6248.125262463259;6149.292831324455;6178.258608966953;6186.783462578788;6194.4115309045565;6239.875202495925;4142.565030671796;4976.726280054631;4981.850544483671;5007.924881126786;5030.974845125824;3796.5823759386444;4388.319810429389;4484.887877803016;4486.75322857246;4520.299353600197;5657.349404818498;5795.739191736382;5909.734061967221;5916.852078698067;5917.940820591739;4636.026434448736;6112.991356426229;6231.470325022424;6271.310155882849;6281.214848143982;4889.437714662859;5179.507946745129;5791.710414479259;5900.911486327708;5934.347221805598;5484.012877682056;5486.91769623456;5510.641808282529;5511.559075273968;5523.447655234444;5116.897662046664;6201.821653885747;6229.781957631461;6318.526110541636;6324.30432652417;6140.4428991762525;6243.125962365181;6243.219597550306;6257.56197066201;6294.71673774672;4978.726170060681;5443.237946687546;6312.747490100344;6324.209473815773;6340.968295158495;6082.908756368746;6132.294322189813;6254.21822272216;6282.591631543935;6284.622922624657;6091.8781624366375;6195.31851496326;6203.96898015507;6206.782762603287;6217.626942383291;5158.793648254028;6117.888303246575;6123.374132580251;6143.8633852737385;6144.849302744004;5927.644341339534;6071.150038994632;6138.109974053827;6140.785072522441;6148.1699970503405;4949.307097006494;5573.498385145356;5906.7341969612335;5975.103734439869;6048.6975651218145;6127.662978536223;6129.969350153221;6176.752929882934;6194.946859034065;6199.1011303361665;5932.228810254812;6035.752995649482;6074.088886667036;6082.11809287642;6095.817125486243 06:52:27 INFO - PROCESS | 1637 | |1;ext.html;446.58244541353827;510.50991048593346;526.5761062344811;553.3746866041378;589.1104432307214;33168.66831331689;39583.802080989626;39624.40563391548;39680.80159599198;39711.61009364673;40205.79897100518;40836.18327633453;40871.18257634845;40884.77345679627;40918;9286.349955503118;9419.717408477722;9454.101860323293;9468.621255149821;9498.952505237465;7923.603819808986;9410.576524056434;9411.341206115574;9417.670381536647;9441.008694087124;9416.858747118764;9418.246540276796;9421;9457.716268511957;9465;9332.020137885525;9378.296627752912;9404.482753448558;9412.435253884789;9438.38650487716;9314.487703176323;9373.625054997792;9398.248140148771;9402.247820174369;9420.858687119699;38462.84611461661;38792.61207387918;38901.832945011694;38924;38990.80504597487;3151.1806930198086;3332.2502436951736;3703.31614221291;3865.8067096645336;3945.0926286954164;26837.0607028755;29312.12063638073;29468.410631787243;30234;30387.088387348416;2714.782817374605;3105.394448082625;3119.7036281553214;3201.983990080035;3203.855826487814;399388;445807;446127;450496;451887;57908;60159.69920150371;60333.69833150894;60526;60734.39265607376;63194;63868;63951;63968.72062558723;64008.67995660085;16115.19424028794;16253.674926501404;16357.100359480104;16379.262933168036;16392.672146557;12328.013758899266;12551.811722824164;12577.93711031439;12580.559680411141;12609.243445393306;17619.647607047787;18210.998395088132;18455.354062607745;18541.16564754589;18563.721544176577;3178.523221516745;3267;3300.6864347886913;7519.135299440525;7754.340881025176;914.2548822709471;989.4211886046743;1014.7209517382779;1050.7740835720356;1055.7835643693024;29116.961812673333;29347.972820951163;29865.701342986726;30126.84936575303;30593.69406305953;885.1060428966662;913.5980168725739;999.2805180270194;1023.8413045977885;1056.8097742406287;14994.925025374803;15288.694226115414;15365.231738413035;15832.129232892301;15837.366505339658;484646;490402;492136;493237;493704;45872.082558348644;56314.718426407606;56756.43243567594;56823;57007.42992570104;1325.2777236406182;1335.3123141582093;1360.2450639894755;1362.9727405452034;1363.7272545490941;28732.13803585896;29264.56103158412;29267.853660732413;29379.706202937698;29956;48671.75664121798;48850.75574622104;49155.26267106068;49202.99999999857;49206.50793492019;545894;547482;548318;550274;555772;26424.471510569296;26516.806743696194;26789.196324110308;26813.329666758487;26854.731452685224;45011.774941125084;45346.093078137594;45382;48361.75819120882;49288.50711492839;37724.81137594295;38199.04502387463;38228.80885595554;38860;38976.6102338973;30873.073807785804;38121.80939095287;38683.64607238846;39052.609473906035;39445;37021;37766.24467510689;37854.81072594619;37958.051048724;38003;26665;31917.8404107978;33488.66511334856;34184.316313674084;34763.91416515017;25716.871415642803;25726.485470290863;25742.356441089123;25871.870640646677;25944.351391215372 06:52:27 INFO - PROCESS | 1637 | |2;jquery.html;369.67099281639344;377.69406780507785;386.9516310461193;391.3015267747072;404.0000997531111;16195.70434365251;19839.900800495976;19994.30019949302;20406.387808365736;20580.691289630668;19210.327638532654;19591.118399672014;19662.60674786507;19959.401217963485;19997.40007799765;4733.810647574093;5711.914321285184;5974.074018527135;5979.162917191575;6539.34606539347;5709.972205003098;6539.509536784736;6589.637569933651;6670.3329667033395;6676.3657452542175;5167.379914410257;5520.613557051008;6505.121808555832;6543.05125756765;6544.312847151052;5673.943260567424;6507.577007494498;6584.835379115512;6590.901136482957;6591.209054913417;5787.50806181475;5874.089516125007;5911.201987731644;5930.673812940287;5941.940580594225;13085.149465284727;15735.842641573552;24267.393315167086;24290.635640465407;24514.387140321458;2168.2086038595958;2207.5033117548583;2227.8774667393286;2272.6022945984387;2332.4518738096535;9935.552900119512;9939.950300248525;10084.193264538819;10224.386536807815;10385.42880141592;1786.56229223841;1818.480419235884;1821.799602043774;1837.6049149432936;1917.4631103291101;118037;120513.19230211554;122327.77672223253;125306.74693253043;125813.74186258111;11173.385463799406;11425.485853136628;11486.655400338002;11524.769504609862;11671.649850504498;14337.6415589609;14429.278536073154;14475.638109047359;14481.420743170365;14487.565373038826;8233.629486673113;8527.360447966428;8539.188777066292;8621.396502244783;8670.263027642595;8417.957910210409;8445.915540844513;8448.746537603882;8515.659373625109;8611.741647750578;3764.849406023783;3795;4426.291793313118;4535.909281814411;4699.553542413465;1909.3889955214477;1939.2921583621876;1945.6886898096236;1959.3925882976323;1961.4900125967351;802.6388125343502;850.7150104714866;907.138218692245;953.814006268771;954.1108604962213;20003.09986050602;20556.17775288972;21537.461563460725;21736.891315543322;22663;882.2589025218847;886.8869568691251;899.3434792601438;981.906718861707;1028.753099256173;8757.949046114507;10539.473026348805;10758.408287544104;11429.485673144729;11503.07975361969;425714.87142564706;495648;500026;595180;596659;79562.60218698869;82416.58791706002;116097;142614.2869285647;147763;932.9720108396759;957.8467445208734;997.5710444508786;1000.6047611193537;1001.5793366786113;18904.621907562047;19495.70756438683;19724.506887327356;19811.801881980995;19926.003699815243;56809;57411.564710882565;57443;57787;58124;52956.73521632367;75074.24925750891;76880;82946.17053829384;83713;7825.726099586487;8108.918910810817;8261.793455163428;8325.916740832514;8377.916220837713;8345.791355215926;9010.954945225232;11208.374785656197;13036.739265214832;13176.341182941007;10881.619143329945;11079.224454288122;11159.497822598165;11312.83030754523;11438.885611144115;9706.70879873605;10931.01620854127;11122.944385278022;11437.370944598128;11504.82742758876;10186.388816671024;10423.739406514898;10839.077015283125;11115.166362522681;11617.477213525242;8049.39629527776;8069.394795390486;8183.468074575134;8304.87542686848;8360.247577718035;8057.919420805717;8250.587470626564;9757.463339516395;10396;11264.324140551593 06:52:27 INFO - PROCESS | 1637 | |3;mootools.html;1449.978250326245;1487.15232317579;1620.90274583525;1726.861851051916;1772.6986412309914;7548.88676669849;7789.766307010798;7959.801004974878;8476.23713865752;8501.48991060536;7972.202779722025;8297.253247207751;8311.75064748057;8369.790755231106;8423.326133909288;2312.7626719704917;2355.9528809423887;2360.9645855312097;2361.551305252005;2365.775251351119;1968.5570746581975;2324.5815753164425;2366.526694661066;2381.940451488709;2383.3207535852284;1962.6859702447612;1975.2000439821823;2301.838871279011;2320.628699408095;2347.1550241912896;2297.7472478027403;2303.516261585069;2306.8615883047073;2318.281332786833;2328.860268383902;2292.3123063081007;2354.046611122481;2354.482013956927;2359.398353419884;2368.9052437902465;8342.16578342167;8399.244068033846;8413.200745929127;8419.70531031411;8426.368022398283;5079.466656001104;5232.659877107976;5236.266922630834;5244.16093425054;5249.42256351801;2730.604062410939;3118.984405077983;3235.498497732855;3544.2379888324135;3561.4479755637917;1001.9849702254472;1046.7958748044134;1057.1912486947492;1057.2070946789909;1069.107295408335;10565;10918.399488028155;10924.453777311102;10936.12510999126;11123.944380278046;4350.825966961349;4423.336499525032;4515.616172625298;4522.3442600823355;4562;8614.39699221061;8675.869861952076;8703.39076264668;8706.303495720327;8720.997085335268;5143.8456846294675;5154.690718556899;5156.381234251914;5157.845264641992;5170.97414512925;4297.484301883794;4325.891852703645;4751.097291514601;4770.284457331359;4835.637327200474;3682.3187710273687;3709.9814500927864;3785.280796648628;3799.8100094995693;3823.25446537928;1053.5680371047833;1133.659902029388;1155.722626569634;1169.7309618787556;1170.39724541861;825.3562221467265;827.1976183102381;849.2229609906866;906.5014242166782;907.9273658107336;5030.8239211627415;5383.569314454834;5633.183188437653;5654.943450565442;5771.538276937835;781.6482582837746;809.4819315637997;929.549902152644;944.6032666280179;980.8479685648736;3622.5290712207243;3739.8317075731657;3834.1373191032353;3838.558565764917;3863.03424143964;9844.310898237054;10119.13987311072;10366.429846358522;10382.688519344432;10436.321639093587;10252;10262.230332725076;10294.485275736184;10322.277440579088;10403.219758518142;6015.879682406327;6358.268799088071;6580.934190658032;6906.205786334636;7802.960985195038;5026.321446604661;5472.577129946163;5517.834464966058;5793.217915581343;5809.012467880386;7845.764627061198;9331.953340233254;9456.00711925238;9498.24550880237;9528.428294302365;7691.88462173079;9397;9657.517124143624;9675.371100878421;9773.804523909625;6646.60120392778;6673.733050677918;6854.897176542456;7046.823829404306;7330.413566914741;7898.368130549427;7951.244631759973;8024.83950321002;8046.879296810435;8155.347572194329;6973.372396484341;7153.749618763319;7223.386012189023;7263.983042373966;7413.332800048021;6937.89593156093;7074.186468556182;7113.253108423541;7198.8920166198595;7294.489385743159;6584.901226481702;6722.764703235363;6730.697118629576;6737;6757.189137303555;4820.469748327751;4864.148773964613;4866.586340161126;4896.730679812645;4899.534544218293;4741.193997020584;4788.712677239377;4799.424069111589;4834.734089624963;4903.730294833818 06:52:27 INFO - PROCESS | 1637 | |4;prototype.html;255.52472401333506;286.34998553284044;302.39671854649964;312.9342838004019;314.9590603056896;4371.934420983684;4970.676906001107;4972.751362431873;5423.864403389917;5456.372517160527;5280.231122573933;5401.756920938557;5433.755481003354;5490.972545137279;5515.503604675579;3431.708304794089;3466.6879980801723;3622.048030854858;3923.3722604383306;4143.254214241435;3972.9471690002174;4168.041350489374;4181.686373521983;4197.370394440828;4208.936865947013;3723.7765734056043;3865.729398942075;4145.419641250227;4146.958530414702;4157.937630935523;4088.4889388826396;4101.241270364992;4118.588141185887;4133.46264985553;4159.230542349675;3590.910227244314;3596.29872174926;3628.872989445383;3641.326354624403;3664.9633503665154;4673.696209746356;4869.659123861331;5016.523430274118;5353.330833645794;5406.216098665672;3687;3958.168784555247;4356.106998065389;4700.365450664151;4711.4346278446465;5121.359830021247;5754.568407369464;5825.417458254183;5861.443162899518;5861.794837180678;3248.7888287261253;3368.528406023159;3627.836747346376;3895.474110995008;3941.7043721720984;6003.8198854034445;6035.818925432201;6116.785912493041;6134.846628834271;6135.233095863017;3968.206358728208;3983.3029219886403;4018.557958624549;4027.35562310029;4048.6153815387493;3194.7923384979904;3439.329330780524;3953.3081710700512;3980.1840622672285;3991.4611527444004;4633.374494443275;4649.767511624473;4668.95331046692;4669;4675.672702910763;5828.446297601721;5830.7959221427045;5858.882822343615;5865.178874957509;5868.94131058684;1208.2810727617054;1243.6331282271751;1300.4719454640758;1302.8957683385495;1311.5310851845993;817.1654635343691;834.460420524132;865.7705707987388;875.3609864798606;882.8410886040574;4369.71596846204;4700.600448961808;5181.611379146579;5212.921806172911;5224.686518808808;4738.573528382462;5240.71176085319;5316.441773613792;5694.213348123451;5718.599698021182;4658.487566367697;4755.597098855846;4881.997571493506;5125.104920260629;5259.368875734936;2832.546792513188;2842.3888863894363;2998.8050776699447;3000.774941879368;3008.909732708022;4480.116672826634;4929.901401971941;5698.686572238566;5777;5812.534997200214;4741.1465936131135;5246.554042906319;5428.4028756836715;5462.842177339929;5833.125031245262;5685.374608793029;5736.62711923732;5755.625884317506;5756.798512052058;5827.213326201078;5211.791528338824;5530.723463826873;5544.833654990357;5565.220869078251;5581.804636837691;5137.3560460653725;5149.197780776698;5595.832125036255;5596.608237423504;5653.349864765604;5361.954418888279;5789.6394347327505;5790.681512516852;5792.333881603669;5808.273965754281;3031.5448584679916;3215.4051500472488;3330.5170750240595;3772.962270377261;3791.962080379161;4668.463126740333;4863.927041094457;5300.867478313073;5420;5624.563155267099;4981.37732783402;5593.916091258716;5644;5760.164776107525;5816.5055970243;5497.862553436196;5739.7417116229035;5754.625949313281;5783.397471137921;5838.211841401357;4728.668993170582;5067.6199285053035;5385.219143224289;5651.208830763614;5802.796902108406;4963.305137280856;5452.827642056818;5845.152452894392;5861.655337864718;5923.674197918984;5229.738513074407;5274.578033757213;5683.77264909399;5718.342390625131;5748.827535173951 06:52:27 INFO - PROCESS | 1637 | |5;yui.html;605.1648724759831;739.8150462384403;746.1941103608103;753.1639879733494;792.3779832831228;14029.859701402984;14910.701785964275;14953.850461495369;14965.251737413113;14990.475333363334;13249.536266230683;13253.33733313333;13343.332833358318;13386.196828190316;13391.59825205243;629.7858728032468;649.9707513161895;769.4267770510977;778.0507780507771;798.4331124901298;788.1251810490351;796.1759578835906;801.2228138705475;801.2228138705475;801.6432687454085;845.5265051571109;846.5851732650988;848.240824462106;849.6601359456205;851.3742399336513;839.2237180607974;839.5340585974782;841.142035124176;842.0232530264894;845.3152946113668;620.0822782282247;625.1935003845034;628.3339659960411;629.0438533429208;629.2197674883158;13710.931445342809;13978;14050.578482645536;14052.437902483889;14102.85897141036;13426.992975526777;13601.931990340085;13623.523176688868;13819.378127984264;13981;11072.612458563912;11209.943950280278;11245.943770281096;11273.492692828842;11467.655970320904;3582.42681171014;3595.137167079908;3620.5836328821997;3623.8912832615065;3685.594584595692;92358.5382073092;93900.53049734776;94450;96647;96920;7580.772576822704;8271.54506502148;8867.73396798097;9157.175854173023;10560.788784224273;15807.36770529189;19018.049097545343;19085.522861928286;19182;19320.71018934717;7483;7614.124375696755;7711.26742959418;7734.922650773533;8021.879671804928;3765.755225910362;4116.958830411718;4165.271077561415;4224.704270701083;4350.71720338177;2764.654418197725;3029.0912726182496;3469.9826500867334;3518.1028837646236;3532.982335088308;615.7198474694003;651.2445563146726;654.5780611736594;658.26932105363;671.5970417749311;559.8068666310116;585.5754577930966;647.6696884588894;661.8510835062169;663.9170103737033;8288.70989515364;8933.731988040368;9015.864762028576;9146.292983502311;9326.813463730687;527.8258174802306;531.9680819150864;632.9493640508748;652.5236577298504;669.5279827721445;3900.6294402031763;4312.900210446316;4449.221386257456;4457.910841783146;4503.347014682852;85161.57419212864;102453.97546024593;105662;106549;108513;75743;87004.56497717598;89659.55170224106;93627.0637293632;96559.03440965641;74445.25554744492;74706;77780;82450;88835.55582222177;8759.992600850983;9014.639414423349;9395.765105872408;9719.708408747749;9774.560144793359;51156.48843511666;52536;53078.67303317448;54198.45801541934;56164.43835561592;62563;67081;73778.26221737714;76496;77511.61244193742;11768.823467648162;11851.940740296242;12083.628278880456;12221.511139554319;12307.446164922421;13679.179249245077;13685.384157712728;13888.444462221802;13929.442822286996;14260.857391426369;12469.251844889335;12559;12686.111972162229;12763.298018608693;13016.674583135497;10601.628942986958;12860.164089334163;13083.738325233633;13138.408771605491;13243.80134297967;11847.407629618658;12155.088368372231;12548.30984295836;12937.741245175232;13177.209367437985;9288.489133097744;10828.24202305831;10955.17836162307;11363.602273920373;11388.886111138783;10716.73208169802;11100.5559777608;11185.496652650487;11246.100311974858;11481.196316258116 06:52:27 INFO - PROCESS | 1637 | __end_tp_report 06:52:27 INFO - PROCESS | 1637 | __start_cc_report 06:52:27 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,361 06:52:27 INFO - PROCESS | 1637 | __end_cc_report 06:52:27 INFO - PROCESS | 1637 | __startTimestamp1482331947378__endTimestamp 06:52:27 INFO - PROCESS | 1637 | 06:52:27 INFO - PROCESS | 1637 | ------- Summary: start ------- 06:52:27 INFO - PROCESS | 1637 | Number of tests: 6 06:52:27 INFO - PROCESS | 1637 | 06:52:27 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5726.90 Median:5975.10 stddev:656.84 (11.0%) stddev-sans-first:632.74 06:52:27 INFO - PROCESS | 1637 | Values: 3389.1 3395.0 3399.9 3410.0 3426.8 4829.2 5756.3 5816.7 5855.6 5860.1 5268.6 5268.7 5768.5 5870.9 5922.8 5049.8 5253.9 5311.2 5312.4 5339.7 5377.6 5382.8 5401.6 5419.1 5447.5 5197.7 5223.4 5357.9 5359.5 5363.1 5238.8 5272.1 5324.0 5349.7 5406.0 5237.9 5316.3 5319.7 5325.2 5340.4 5565.6 5849.5 5927.1 5942.2 5953.4 6120.9 6137.8 6168.1 6210.3 6231.4 6158.5 6199.4 6208.1 6220.0 6237.5 5972.2 5973.4 5986.3 5992.1 6018.2 6110.1 6205.2 6215.8 6222.7 6357.3 6186.8 6217.3 6234.2 6239.7 6277.4 6278.2 6302.7 6304.6 6310.9 6316.8 6108.3 6114.1 6186.8 6217.1 6248.1 6149.3 6178.3 6186.8 6194.4 6239.9 4142.6 4976.7 4981.9 5007.9 5031.0 3796.6 4388.3 4484.9 4486.8 4520.3 5657.3 5795.7 5909.7 5916.9 5917.9 4636.0 6113.0 6231.5 6271.3 6281.2 4889.4 5179.5 5791.7 5900.9 5934.3 5484.0 5486.9 5510.6 5511.6 5523.4 5116.9 6201.8 6229.8 6318.5 6324.3 6140.4 6243.1 6243.2 6257.6 6294.7 4978.7 5443.2 6312.7 6324.2 6341.0 6082.9 6132.3 6254.2 6282.6 6284.6 6091.9 6195.3 6204.0 6206.8 6217.6 5158.8 6117.9 6123.4 6143.9 6144.8 5927.6 6071.2 6138.1 6140.8 6148.2 4949.3 5573.5 5906.7 5975.1 6048.7 6127.7 6130.0 6176.8 6194.9 6199.1 5932.2 6035.8 6074.1 6082.1 6095.8 06:52:27 INFO - PROCESS | 1637 | 06:52:27 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:63396.61 Median:39021.71 stddev:131793.96 (337.7%) stddev-sans-first:132078.93 06:52:27 INFO - PROCESS | 1637 | Values: 446.6 510.5 526.6 553.4 589.1 33168.7 39583.8 39624.4 39680.8 39711.6 40205.8 40836.2 40871.2 40884.8 40918.0 9286.3 9419.7 9454.1 9468.6 9499.0 7923.6 9410.6 9411.3 9417.7 9441.0 9416.9 9418.2 9421.0 9457.7 9465.0 9332.0 9378.3 9404.5 9412.4 9438.4 9314.5 9373.6 9398.2 9402.2 9420.9 38462.8 38792.6 38901.8 38924.0 38990.8 3151.2 3332.3 3703.3 3865.8 3945.1 26837.1 29312.1 29468.4 30234.0 30387.1 2714.8 3105.4 3119.7 3202.0 3203.9 399388.0 445807.0 446127.0 450496.0 451887.0 57908.0 60159.7 60333.7 60526.0 60734.4 63194.0 63868.0 63951.0 63968.7 64008.7 16115.2 16253.7 16357.1 16379.3 16392.7 12328.0 12551.8 12577.9 12580.6 12609.2 17619.6 18211.0 18455.4 18541.2 18563.7 3178.5 3267.0 3300.7 7519.1 7754.3 914.3 989.4 1014.7 1050.8 1055.8 29117.0 29348.0 29865.7 30126.8 30593.7 885.1 913.6 999.3 1023.8 1056.8 14994.9 15288.7 15365.2 15832.1 15837.4 484646.0 490402.0 492136.0 493237.0 493704.0 45872.1 56314.7 56756.4 56823.0 57007.4 1325.3 1335.3 1360.2 1363.0 1363.7 28732.1 29264.6 29267.9 29379.7 29956.0 48671.8 48850.8 49155.3 49203.0 49206.5 545894.0 547482.0 548318.0 550274.0 555772.0 26424.5 26516.8 26789.2 26813.3 26854.7 45011.8 45346.1 45382.0 48361.8 49288.5 37724.8 38199.0 38228.8 38860.0 38976.6 30873.1 38121.8 38683.6 39052.6 39445.0 37021.0 37766.2 37854.8 37958.1 38003.0 26665.0 31917.8 33488.7 34184.3 34763.9 25716.9 25726.5 25742.4 25871.9 25944.4 06:52:27 INFO - PROCESS | 1637 | 06:52:27 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:32454.56 Median:2090.98 stddev:88578.89 (4236.2%) stddev-sans-first:88794.61 06:52:27 INFO - PROCESS | 1637 | Values: 369.7 377.7 387.0 391.3 404.0 16195.7 19839.9 19994.3 20406.4 20580.7 19210.3 19591.1 19662.6 19959.4 19997.4 4733.8 5711.9 5974.1 5979.2 6539.3 5710.0 6539.5 6589.6 6670.3 6676.4 5167.4 5520.6 6505.1 6543.1 6544.3 5673.9 6507.6 6584.8 6590.9 6591.2 5787.5 5874.1 5911.2 5930.7 5941.9 13085.1 15735.8 24267.4 24290.6 24514.4 2168.2 2207.5 2227.9 2272.6 2332.5 9935.6 9940.0 10084.2 10224.4 10385.4 1786.6 1818.5 1821.8 1837.6 1917.5 118037.0 120513.2 122327.8 125306.7 125813.7 11173.4 11425.5 11486.7 11524.8 11671.6 14337.6 14429.3 14475.6 14481.4 14487.6 8233.6 8527.4 8539.2 8621.4 8670.3 8418.0 8445.9 8448.7 8515.7 8611.7 3764.8 3795.0 4426.3 4535.9 4699.6 1909.4 1939.3 1945.7 1959.4 1961.5 802.6 850.7 907.1 953.8 954.1 20003.1 20556.2 21537.5 21736.9 22663.0 882.3 886.9 899.3 981.9 1028.8 8757.9 10539.5 10758.4 11429.5 11503.1 425714.9 495648.0 500026.0 595180.0 596659.0 79562.6 82416.6 116097.0 142614.3 147763.0 933.0 957.8 997.6 1000.6 1001.6 18904.6 19495.7 19724.5 19811.8 19926.0 56809.0 57411.6 57443.0 57787.0 58124.0 52956.7 75074.2 76880.0 82946.2 83713.0 7825.7 8108.9 8261.8 8325.9 8377.9 8345.8 9011.0 11208.4 13036.7 13176.3 10881.6 11079.2 11159.5 11312.8 11438.9 9706.7 10931.0 11122.9 11437.4 11504.8 10186.4 10423.7 10839.1 11115.2 11617.5 8049.4 8069.4 8183.5 8304.9 8360.2 8057.9 8250.6 9757.5 10396.0 11264.3 06:52:27 INFO - PROCESS | 1637 | 06:52:27 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5384.66 Median:5055.15 stddev:2967.37 (58.7%) stddev-sans-first:2960.96 06:52:27 INFO - PROCESS | 1637 | Values: 1450.0 1487.2 1620.9 1726.9 1772.7 7548.9 7789.8 7959.8 8476.2 8501.5 7972.2 8297.3 8311.8 8369.8 8423.3 2312.8 2356.0 2361.0 2361.6 2365.8 1968.6 2324.6 2366.5 2381.9 2383.3 1962.7 1975.2 2301.8 2320.6 2347.2 2297.7 2303.5 2306.9 2318.3 2328.9 2292.3 2354.0 2354.5 2359.4 2368.9 8342.2 8399.2 8413.2 8419.7 8426.4 5079.5 5232.7 5236.3 5244.2 5249.4 2730.6 3119.0 3235.5 3544.2 3561.4 1002.0 1046.8 1057.2 1057.2 1069.1 10565.0 10918.4 10924.5 10936.1 11123.9 4350.8 4423.3 4515.6 4522.3 4562.0 8614.4 8675.9 8703.4 8706.3 8721.0 5143.8 5154.7 5156.4 5157.8 5171.0 4297.5 4325.9 4751.1 4770.3 4835.6 3682.3 3710.0 3785.3 3799.8 3823.3 1053.6 1133.7 1155.7 1169.7 1170.4 825.4 827.2 849.2 906.5 907.9 5030.8 5383.6 5633.2 5654.9 5771.5 781.6 809.5 929.5 944.6 980.8 3622.5 3739.8 3834.1 3838.6 3863.0 9844.3 10119.1 10366.4 10382.7 10436.3 10252.0 10262.2 10294.5 10322.3 10403.2 6015.9 6358.3 6580.9 6906.2 7803.0 5026.3 5472.6 5517.8 5793.2 5809.0 7845.8 9332.0 9456.0 9498.2 9528.4 7691.9 9397.0 9657.5 9675.4 9773.8 6646.6 6673.7 6854.9 7046.8 7330.4 7898.4 7951.2 8024.8 8046.9 8155.3 6973.4 7153.7 7223.4 7264.0 7413.3 6937.9 7074.2 7113.3 7198.9 7294.5 6584.9 6722.8 6730.7 6737.0 6757.2 4820.5 4864.1 4866.6 4896.7 4899.5 4741.2 4788.7 4799.4 4834.7 4903.7 06:52:27 INFO - PROCESS | 1637 | 06:52:27 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4528.57 Median:5094.49 stddev:1412.79 (27.7%) stddev-sans-first:1379.87 06:52:27 INFO - PROCESS | 1637 | Values: 255.5 286.3 302.4 312.9 315.0 4371.9 4970.7 4972.8 5423.9 5456.4 5280.2 5401.8 5433.8 5491.0 5515.5 3431.7 3466.7 3622.0 3923.4 4143.3 3972.9 4168.0 4181.7 4197.4 4208.9 3723.8 3865.7 4145.4 4147.0 4157.9 4088.5 4101.2 4118.6 4133.5 4159.2 3590.9 3596.3 3628.9 3641.3 3665.0 4673.7 4869.7 5016.5 5353.3 5406.2 3687.0 3958.2 4356.1 4700.4 4711.4 5121.4 5754.6 5825.4 5861.4 5861.8 3248.8 3368.5 3627.8 3895.5 3941.7 6003.8 6035.8 6116.8 6134.8 6135.2 3968.2 3983.3 4018.6 4027.4 4048.6 3194.8 3439.3 3953.3 3980.2 3991.5 4633.4 4649.8 4669.0 4669.0 4675.7 5828.4 5830.8 5858.9 5865.2 5868.9 1208.3 1243.6 1300.5 1302.9 1311.5 817.2 834.5 865.8 875.4 882.8 4369.7 4700.6 5181.6 5212.9 5224.7 4738.6 5240.7 5316.4 5694.2 5718.6 4658.5 4755.6 4882.0 5125.1 5259.4 2832.5 2842.4 2998.8 3000.8 3008.9 4480.1 4929.9 5698.7 5777.0 5812.5 4741.1 5246.6 5428.4 5462.8 5833.1 5685.4 5736.6 5755.6 5756.8 5827.2 5211.8 5530.7 5544.8 5565.2 5581.8 5137.4 5149.2 5595.8 5596.6 5653.3 5362.0 5789.6 5790.7 5792.3 5808.3 3031.5 3215.4 3330.5 3773.0 3792.0 4668.5 4863.9 5300.9 5420.0 5624.6 4981.4 5593.9 5644.0 5760.2 5816.5 5497.9 5739.7 5754.6 5783.4 5838.2 4728.7 5067.6 5385.2 5651.2 5802.8 4963.3 5452.8 5845.2 5861.7 5923.7 5229.7 5274.6 5683.8 5718.3 5748.8 06:52:27 INFO - PROCESS | 1637 | 06:52:27 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19928.22 Median:26531.91 stddev:28971.72 (109.2%) stddev-sans-first:29016.66 06:52:27 INFO - PROCESS | 1637 | Values: 605.2 739.8 746.2 753.2 792.4 14029.9 14910.7 14953.9 14965.3 14990.5 13249.5 13253.3 13343.3 13386.2 13391.6 629.8 650.0 769.4 778.1 798.4 788.1 796.2 801.2 801.2 801.6 845.5 846.6 848.2 849.7 851.4 839.2 839.5 841.1 842.0 845.3 620.1 625.2 628.3 629.0 629.2 13710.9 13978.0 14050.6 14052.4 14102.9 13427.0 13601.9 13623.5 13819.4 13981.0 11072.6 11209.9 11245.9 11273.5 11467.7 3582.4 3595.1 3620.6 3623.9 3685.6 92358.5 93900.5 94450.0 96647.0 96920.0 7580.8 8271.5 8867.7 9157.2 10560.8 15807.4 19018.0 19085.5 19182.0 19320.7 7483.0 7614.1 7711.3 7734.9 8021.9 3765.8 4117.0 4165.3 4224.7 4350.7 2764.7 3029.1 3470.0 3518.1 3533.0 615.7 651.2 654.6 658.3 671.6 559.8 585.6 647.7 661.9 663.9 8288.7 8933.7 9015.9 9146.3 9326.8 527.8 532.0 632.9 652.5 669.5 3900.6 4312.9 4449.2 4457.9 4503.3 85161.6 102454.0 105662.0 106549.0 108513.0 75743.0 87004.6 89659.6 93627.1 96559.0 74445.3 74706.0 77780.0 82450.0 88835.6 8760.0 9014.6 9395.8 9719.7 9774.6 51156.5 52536.0 53078.7 54198.5 56164.4 62563.0 67081.0 73778.3 76496.0 77511.6 11768.8 11851.9 12083.6 12221.5 12307.4 13679.2 13685.4 13888.4 13929.4 14260.9 12469.3 12559.0 12686.1 12763.3 13016.7 10601.6 12860.2 13083.7 13138.4 13243.8 11847.4 12155.1 12548.3 12937.7 13177.2 9288.5 10828.2 10955.2 11363.6 11388.9 10716.7 11100.6 11185.5 11246.1 11481.2 06:52:27 INFO - PROCESS | 1637 | -------- Summary: end -------- 06:52:27 INFO - PROCESS | 1637 | 06:52:28 INFO - TEST-INFO | 1637: exit 0 06:52:28 INFO - TEST-OK | dromaeo_css | took 1116919ms 06:52:28 INFO - TEST-START | kraken 06:52:28 INFO - operating with platform_type : mac_ 06:52:28 INFO - Initialising browser for kraken test... 06:52:28 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmp0kYk2b/profile http://localhost:49249/getInfo.html) 06:52:31 INFO - PROCESS | 1649 | 2016-12-21 06:52:31.233 plugin-container[1650:10392] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8737, name = 'com.apple.tsm.portname' 06:52:31 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:52:31 INFO - PROCESS | 1649 | 2016-12-21 06:52:31.236 plugin-container[1650:10392] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 06:52:31 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:52:31 INFO - PROCESS | 1649 | 2016-12-21 06:52:31.236 plugin-container[1650:10392] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:52:31 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 06:52:31 INFO - PROCESS | 1649 | colorDepth:24 06:52:31 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 06:52:31 INFO - PROCESS | 1649 | __metrics 06:52:31 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 06:52:32 INFO - TEST-INFO | 1649: exit 0 06:52:32 INFO - Browser initialized. 06:52:32 INFO - Running cycle 1/1 for kraken test... 06:52:32 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmp0kYk2b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:52:34 INFO - PROCESS | 1651 | 2016-12-21 06:52:34.823 plugin-container[1652:10517] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 06:52:34 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:52:34 INFO - PROCESS | 1651 | 2016-12-21 06:52:34.823 plugin-container[1652:10517] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4613, name = 'com.apple.CFPasteboardClient' 06:52:34 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:52:34 INFO - PROCESS | 1651 | 2016-12-21 06:52:34.823 plugin-container[1652:10517] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:52:44 INFO - PROCESS | 1651 | RSS: Main: 229769216 06:52:44 INFO - PROCESS | 1651 | 06:52:47 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 06:52:48 INFO - PROCESS | 1651 | RSS: Main: 241565696 06:52:48 INFO - PROCESS | 1651 | 06:52:51 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 06:52:51 INFO - PROCESS | 1651 | RSS: Main: 249028608 06:52:51 INFO - PROCESS | 1651 | 06:52:55 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 06:52:56 INFO - PROCESS | 1651 | RSS: Main: 250839040 06:52:56 INFO - PROCESS | 1651 | 06:52:58 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 06:52:58 INFO - PROCESS | 1651 | RSS: Main: 253464576 06:52:58 INFO - PROCESS | 1651 | 06:53:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:53:01 INFO - PROCESS | 1651 | RSS: Main: 253812736 06:53:01 INFO - PROCESS | 1651 | 06:53:03 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 06:53:04 INFO - PROCESS | 1651 | RSS: Main: 258785280 06:53:04 INFO - PROCESS | 1651 | 06:53:07 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 06:53:08 INFO - PROCESS | 1651 | RSS: Main: 257986560 06:53:08 INFO - PROCESS | 1651 | 06:53:10 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 06:53:11 INFO - PROCESS | 1651 | RSS: Main: 258228224 06:53:11 INFO - PROCESS | 1651 | 06:53:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:53:13 INFO - PROCESS | 1651 | RSS: Main: 256921600 06:53:13 INFO - PROCESS | 1651 | 06:53:15 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:53:16 INFO - PROCESS | 1651 | RSS: Main: 257122304 06:53:16 INFO - PROCESS | 1651 | 06:53:18 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:53:19 INFO - PROCESS | 1651 | RSS: Main: 257032192 06:53:19 INFO - PROCESS | 1651 | 06:53:22 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:53:22 INFO - PROCESS | 1651 | RSS: Main: 257384448 06:53:22 INFO - PROCESS | 1651 | 06:53:25 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:53:26 INFO - PROCESS | 1651 | RSS: Main: 257941504 06:53:26 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 06:53:28 INFO - PROCESS | 1651 | RSS: Main: 259399680 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | __start_tp_report 06:53:28 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 06:53:28 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 06:53:28 INFO - PROCESS | 1651 | |i|pagename|runs| 06:53:28 INFO - PROCESS | 1651 | |0;ai-astar;116;119;132;174;155;117;119;117;123;142 06:53:28 INFO - PROCESS | 1651 | |1;audio-beat-detection;182;105;147;179;147;118;113;120;176;151 06:53:28 INFO - PROCESS | 1651 | |2;audio-dft;229;250;216;187;228;276;172;253;274;246 06:53:28 INFO - PROCESS | 1651 | |3;audio-fft;76;61;61;78;88;58;70;51;71;69 06:53:28 INFO - PROCESS | 1651 | |4;audio-oscillator;82;71;91;72;69;71;86;70;70;88 06:53:28 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;90;87;88;87;102;85;89;86;90;86 06:53:28 INFO - PROCESS | 1651 | |6;imaging-darkroom;95;96;95;95;114;95;95;95;96;117 06:53:28 INFO - PROCESS | 1651 | |7;imaging-desaturate;86;91;117;144;87;89;91;89;89;90 06:53:28 INFO - PROCESS | 1651 | |8;json-parse-financial;57;56;56;61;61;60;62;61;60;62 06:53:28 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;68;78;69;84;79;76;69;72;71;72 06:53:28 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;82;83;84;83;86;85;84;85;86;103 06:53:28 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;141;144;150;154;161;145;149;145;214;322 06:53:28 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;171;171;169;165;163;223;230;230;171;168 06:53:28 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;69;71;70;68;71;71;71;67;65;73 06:53:28 INFO - PROCESS | 1651 | __end_tp_report 06:53:28 INFO - PROCESS | 1651 | __start_cc_report 06:53:28 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,971 06:53:28 INFO - PROCESS | 1651 | __end_cc_report 06:53:28 INFO - PROCESS | 1651 | __startTimestamp1482332008573__endTimestamp 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | ------- Summary: start ------- 06:53:28 INFO - PROCESS | 1651 | Number of tests: 14 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:131.40 Median:127.50 stddev:19.76 (15.5%) stddev-sans-first:20.16 06:53:28 INFO - PROCESS | 1651 | Values: 116.0 119.0 132.0 174.0 155.0 117.0 119.0 117.0 123.0 142.0 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:149.00 stddev:28.86 (19.4%) stddev-sans-first:27.09 06:53:28 INFO - PROCESS | 1651 | Values: 182.0 105.0 147.0 179.0 147.0 118.0 113.0 120.0 176.0 151.0 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:233.10 Median:248.00 stddev:34.25 (13.8%) stddev-sans-first:36.29 06:53:28 INFO - PROCESS | 1651 | Values: 229.0 250.0 216.0 187.0 228.0 276.0 172.0 253.0 274.0 246.0 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:68.30 Median:70.50 stddev:10.87 (15.4%) stddev-sans-first:11.17 06:53:28 INFO - PROCESS | 1651 | Values: 76.0 61.0 61.0 78.0 88.0 58.0 70.0 51.0 71.0 69.0 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:77.00 stddev:8.71 (11.3%) stddev-sans-first:9.04 06:53:28 INFO - PROCESS | 1651 | Values: 82.0 71.0 91.0 72.0 69.0 71.0 86.0 70.0 70.0 88.0 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:87.50 stddev:4.88 (5.6%) stddev-sans-first:5.16 06:53:28 INFO - PROCESS | 1651 | Values: 90.0 87.0 88.0 87.0 102.0 85.0 89.0 86.0 90.0 86.0 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:99.30 Median:95.00 stddev:8.58 (9.0%) stddev-sans-first:8.96 06:53:28 INFO - PROCESS | 1651 | Values: 95.0 96.0 95.0 95.0 114.0 95.0 95.0 95.0 96.0 117.0 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:89.00 stddev:18.68 (21.0%) stddev-sans-first:19.37 06:53:28 INFO - PROCESS | 1651 | Values: 86.0 91.0 117.0 144.0 87.0 89.0 91.0 89.0 89.0 90.0 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:61.00 stddev:2.37 (3.9%) stddev-sans-first:2.32 06:53:28 INFO - PROCESS | 1651 | Values: 57.0 56.0 56.0 61.0 61.0 60.0 62.0 61.0 60.0 62.0 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:74.00 stddev:5.25 (7.1%) stddev-sans-first:5.13 06:53:28 INFO - PROCESS | 1651 | Values: 68.0 78.0 69.0 84.0 79.0 76.0 69.0 72.0 71.0 72.0 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:84.50 stddev:6.08 (7.2%) stddev-sans-first:6.27 06:53:28 INFO - PROCESS | 1651 | Values: 82.0 83.0 84.0 83.0 86.0 85.0 84.0 85.0 86.0 103.0 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:172.50 Median:152.00 stddev:56.69 (37.3%) stddev-sans-first:58.97 06:53:28 INFO - PROCESS | 1651 | Values: 141.0 144.0 150.0 154.0 161.0 145.0 149.0 145.0 214.0 322.0 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.10 Median:171.00 stddev:28.87 (16.9%) stddev-sans-first:30.09 06:53:28 INFO - PROCESS | 1651 | Values: 171.0 171.0 169.0 165.0 163.0 223.0 230.0 230.0 171.0 168.0 06:53:28 INFO - PROCESS | 1651 | 06:53:28 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:71.00 stddev:2.37 (3.3%) stddev-sans-first:2.50 06:53:28 INFO - PROCESS | 1651 | Values: 69.0 71.0 70.0 68.0 71.0 71.0 71.0 67.0 65.0 73.0 06:53:28 INFO - PROCESS | 1651 | -------- Summary: end -------- 06:53:28 INFO - PROCESS | 1651 | 06:53:29 INFO - TEST-INFO | 1651: exit 0 06:53:29 INFO - TEST-OK | kraken | took 61430ms 06:53:29 INFO - SUITE-END | took 1178s 06:53:29 INFO - Completed test suite (00:19:38) 06:53:29 INFO - javascript benchmark 06:53:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7114.658311332711, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3389.1188291044336, 3395.049386171871, 3399.8640054397824, 3409.9659003409956, 3426.7772594781336, 4829.227323628215, 5756.280464941882, 5816.651000939942, 5855.619384739989, 5860.062390017598, 5268.5521730652845, 5268.710220937847, 5768.451997060283, 5870.943230218559, 5922.822315330536, 5049.823256186034, 5253.947460525394, 5311.203319502086, 5312.442193569658, 5339.70631615261, 5377.5966802489775, 5382.838514844561, 5401.594880383967, 5419.107593736579, 5447.4824891635235, 5197.714125723083, 5223.425423203445, 5357.866053348658, 5359.5444387227135, 5363.141897296433, 5238.764255608507, 5272.051030814452, 5324.0, 5349.679019258857, 5405.972970135163, 5237.9476205238225, 5316.308879845634, 5319.680819150824, 5325.174597937287, 5340.412554619028, 5565.554755619541, 5849.532037436995, 5927.081302398092, 5942.227510423617, 5953.434423729739, 6120.9347721082095, 6137.754489820401, 6168.1056246843955, 6210.31686514483, 6231.439170474634, 6158.507319414481, 6199.380061993809, 6208.1308616793685, 6220.0, 6237.500999919996, 5972.193753843176, 5973.402659734035, 5986.341502434729, 5992.0994238748335, 6018.187544681499, 6110.103144028831, 6205.22434695663, 6215.751369945242, 6222.688865556704, 6357.268914074941, 6186.752529898754, 6217.253929528486, 6234.189555357774, 6239.688015599202, 6277.435030847246, 6278.215223097113, 6302.747890084437, 6304.590201636879, 6310.905336419957, 6316.778912738032, 6108.2813625860135, 6114.054067497291, 6186.783462578788, 6217.129601855744, 6248.125262463259, 6149.292831324455, 6178.258608966953, 6186.783462578788, 6194.4115309045565, 6239.875202495925, 4142.565030671796, 4976.726280054631, 4981.850544483671, 5007.924881126786, 5030.974845125824, 3796.5823759386444, 4388.319810429389, 4484.887877803016, 4486.75322857246, 4520.299353600197, 5657.349404818498, 5795.739191736382, 5909.734061967221, 5916.852078698067, 5917.940820591739, 4636.026434448736, 6112.991356426229, 6231.470325022424, 6271.310155882849, 6281.214848143982, 4889.437714662859, 5179.507946745129, 5791.710414479259, 5900.911486327708, 5934.347221805598, 5484.012877682056, 5486.91769623456, 5510.641808282529, 5511.559075273968, 5523.447655234444, 5116.897662046664, 6201.821653885747, 6229.781957631461, 6318.526110541636, 6324.30432652417, 6140.4428991762525, 6243.125962365181, 6243.219597550306, 6257.56197066201, 6294.71673774672, 4978.726170060681, 5443.237946687546, 6312.747490100344, 6324.209473815773, 6340.968295158495, 6082.908756368746, 6132.294322189813, 6254.21822272216, 6282.591631543935, 6284.622922624657, 6091.8781624366375, 6195.31851496326, 6203.96898015507, 6206.782762603287, 6217.626942383291, 5158.793648254028, 6117.888303246575, 6123.374132580251, 6143.8633852737385, 6144.849302744004, 5927.644341339534, 6071.150038994632, 6138.109974053827, 6140.785072522441, 6148.1699970503405, 4949.307097006494, 5573.498385145356, 5906.7341969612335, 5975.103734439869, 6048.6975651218145, 6127.662978536223, 6129.969350153221, 6176.752929882934, 6194.946859034065, 6199.1011303361665, 5932.228810254812, 6035.752995649482, 6074.088886667036, 6082.11809287642, 6095.817125486243], "value": 5688.200668895407, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.58244541353827, 510.50991048593346, 526.5761062344811, 553.3746866041378, 589.1104432307214, 33168.66831331689, 39583.802080989626, 39624.40563391548, 39680.80159599198, 39711.61009364673, 40205.79897100518, 40836.18327633453, 40871.18257634845, 40884.77345679627, 40918.0, 9286.349955503118, 9419.717408477722, 9454.101860323293, 9468.621255149821, 9498.952505237465, 7923.603819808986, 9410.576524056434, 9411.341206115574, 9417.670381536647, 9441.008694087124, 9416.858747118764, 9418.246540276796, 9421.0, 9457.716268511957, 9465.0, 9332.020137885525, 9378.296627752912, 9404.482753448558, 9412.435253884789, 9438.38650487716, 9314.487703176323, 9373.625054997792, 9398.248140148771, 9402.247820174369, 9420.858687119699, 38462.84611461661, 38792.61207387918, 38901.832945011694, 38924.0, 38990.80504597487, 3151.1806930198086, 3332.2502436951736, 3703.31614221291, 3865.8067096645336, 3945.0926286954164, 26837.0607028755, 29312.12063638073, 29468.410631787243, 30234.0, 30387.088387348416, 2714.782817374605, 3105.394448082625, 3119.7036281553214, 3201.983990080035, 3203.855826487814, 399388.0, 445807.0, 446127.0, 450496.0, 451887.0, 57908.0, 60159.69920150371, 60333.69833150894, 60526.0, 60734.39265607376, 63194.0, 63868.0, 63951.0, 63968.72062558723, 64008.67995660085, 16115.19424028794, 16253.674926501404, 16357.100359480104, 16379.262933168036, 16392.672146557, 12328.013758899266, 12551.811722824164, 12577.93711031439, 12580.559680411141, 12609.243445393306, 17619.647607047787, 18210.998395088132, 18455.354062607745, 18541.16564754589, 18563.721544176577, 3178.523221516745, 3267.0, 3300.6864347886913, 7519.135299440525, 7754.340881025176, 914.2548822709471, 989.4211886046743, 1014.7209517382779, 1050.7740835720356, 1055.7835643693024, 29116.961812673333, 29347.972820951163, 29865.701342986726, 30126.84936575303, 30593.69406305953, 885.1060428966662, 913.5980168725739, 999.2805180270194, 1023.8413045977885, 1056.8097742406287, 14994.925025374803, 15288.694226115414, 15365.231738413035, 15832.129232892301, 15837.366505339658, 484646.0, 490402.0, 492136.0, 493237.0, 493704.0, 45872.082558348644, 56314.718426407606, 56756.43243567594, 56823.0, 57007.42992570104, 1325.2777236406182, 1335.3123141582093, 1360.2450639894755, 1362.9727405452034, 1363.7272545490941, 28732.13803585896, 29264.56103158412, 29267.853660732413, 29379.706202937698, 29956.0, 48671.75664121798, 48850.75574622104, 49155.26267106068, 49202.99999999857, 49206.50793492019, 545894.0, 547482.0, 548318.0, 550274.0, 555772.0, 26424.471510569296, 26516.806743696194, 26789.196324110308, 26813.329666758487, 26854.731452685224, 45011.774941125084, 45346.093078137594, 45382.0, 48361.75819120882, 49288.50711492839, 37724.81137594295, 38199.04502387463, 38228.80885595554, 38860.0, 38976.6102338973, 30873.073807785804, 38121.80939095287, 38683.64607238846, 39052.609473906035, 39445.0, 37021.0, 37766.24467510689, 37854.81072594619, 37958.051048724, 38003.0, 26665.0, 31917.8404107978, 33488.66511334856, 34184.316313674084, 34763.91416515017, 25716.871415642803, 25726.485470290863, 25742.356441089123, 25871.870640646677, 25944.351391215372], "value": 19228.720469310214, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.67099281639344, 377.69406780507785, 386.9516310461193, 391.3015267747072, 404.0000997531111, 16195.70434365251, 19839.900800495976, 19994.30019949302, 20406.387808365736, 20580.691289630668, 19210.327638532654, 19591.118399672014, 19662.60674786507, 19959.401217963485, 19997.40007799765, 4733.810647574093, 5711.914321285184, 5974.074018527135, 5979.162917191575, 6539.34606539347, 5709.972205003098, 6539.509536784736, 6589.637569933651, 6670.3329667033395, 6676.3657452542175, 5167.379914410257, 5520.613557051008, 6505.121808555832, 6543.05125756765, 6544.312847151052, 5673.943260567424, 6507.577007494498, 6584.835379115512, 6590.901136482957, 6591.209054913417, 5787.50806181475, 5874.089516125007, 5911.201987731644, 5930.673812940287, 5941.940580594225, 13085.149465284727, 15735.842641573552, 24267.393315167086, 24290.635640465407, 24514.387140321458, 2168.2086038595958, 2207.5033117548583, 2227.8774667393286, 2272.6022945984387, 2332.4518738096535, 9935.552900119512, 9939.950300248525, 10084.193264538819, 10224.386536807815, 10385.42880141592, 1786.56229223841, 1818.480419235884, 1821.799602043774, 1837.6049149432936, 1917.4631103291101, 118037.0, 120513.19230211554, 122327.77672223253, 125306.74693253043, 125813.74186258111, 11173.385463799406, 11425.485853136628, 11486.655400338002, 11524.769504609862, 11671.649850504498, 14337.6415589609, 14429.278536073154, 14475.638109047359, 14481.420743170365, 14487.565373038826, 8233.629486673113, 8527.360447966428, 8539.188777066292, 8621.396502244783, 8670.263027642595, 8417.957910210409, 8445.915540844513, 8448.746537603882, 8515.659373625109, 8611.741647750578, 3764.849406023783, 3795.0, 4426.291793313118, 4535.909281814411, 4699.553542413465, 1909.3889955214477, 1939.2921583621876, 1945.6886898096236, 1959.3925882976323, 1961.4900125967351, 802.6388125343502, 850.7150104714866, 907.138218692245, 953.814006268771, 954.1108604962213, 20003.09986050602, 20556.17775288972, 21537.461563460725, 21736.891315543322, 22663.0, 882.2589025218847, 886.8869568691251, 899.3434792601438, 981.906718861707, 1028.753099256173, 8757.949046114507, 10539.473026348805, 10758.408287544104, 11429.485673144729, 11503.07975361969, 425714.87142564706, 495648.0, 500026.0, 595180.0, 596659.0, 79562.60218698869, 82416.58791706002, 116097.0, 142614.2869285647, 147763.0, 932.9720108396759, 957.8467445208734, 997.5710444508786, 1000.6047611193537, 1001.5793366786113, 18904.621907562047, 19495.70756438683, 19724.506887327356, 19811.801881980995, 19926.003699815243, 56809.0, 57411.564710882565, 57443.0, 57787.0, 58124.0, 52956.73521632367, 75074.24925750891, 76880.0, 82946.17053829384, 83713.0, 7825.726099586487, 8108.918910810817, 8261.793455163428, 8325.916740832514, 8377.916220837713, 8345.791355215926, 9010.954945225232, 11208.374785656197, 13036.739265214832, 13176.341182941007, 10881.619143329945, 11079.224454288122, 11159.497822598165, 11312.83030754523, 11438.885611144115, 9706.70879873605, 10931.01620854127, 11122.944385278022, 11437.370944598128, 11504.82742758876, 10186.388816671024, 10423.739406514898, 10839.077015283125, 11115.166362522681, 11617.477213525242, 8049.39629527776, 8069.394795390486, 8183.468074575134, 8304.87542686848, 8360.247577718035, 8057.919420805717, 8250.587470626564, 9757.463339516395, 10396.0, 11264.324140551593], "value": 9405.17679930014, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.978250326245, 1487.15232317579, 1620.90274583525, 1726.861851051916, 1772.6986412309914, 7548.88676669849, 7789.766307010798, 7959.801004974878, 8476.23713865752, 8501.48991060536, 7972.202779722025, 8297.253247207751, 8311.75064748057, 8369.790755231106, 8423.326133909288, 2312.7626719704917, 2355.9528809423887, 2360.9645855312097, 2361.551305252005, 2365.775251351119, 1968.5570746581975, 2324.5815753164425, 2366.526694661066, 2381.940451488709, 2383.3207535852284, 1962.6859702447612, 1975.2000439821823, 2301.838871279011, 2320.628699408095, 2347.1550241912896, 2297.7472478027403, 2303.516261585069, 2306.8615883047073, 2318.281332786833, 2328.860268383902, 2292.3123063081007, 2354.046611122481, 2354.482013956927, 2359.398353419884, 2368.9052437902465, 8342.16578342167, 8399.244068033846, 8413.200745929127, 8419.70531031411, 8426.368022398283, 5079.466656001104, 5232.659877107976, 5236.266922630834, 5244.16093425054, 5249.42256351801, 2730.604062410939, 3118.984405077983, 3235.498497732855, 3544.2379888324135, 3561.4479755637917, 1001.9849702254472, 1046.7958748044134, 1057.1912486947492, 1057.2070946789909, 1069.107295408335, 10565.0, 10918.399488028155, 10924.453777311102, 10936.12510999126, 11123.944380278046, 4350.825966961349, 4423.336499525032, 4515.616172625298, 4522.3442600823355, 4562.0, 8614.39699221061, 8675.869861952076, 8703.39076264668, 8706.303495720327, 8720.997085335268, 5143.8456846294675, 5154.690718556899, 5156.381234251914, 5157.845264641992, 5170.97414512925, 4297.484301883794, 4325.891852703645, 4751.097291514601, 4770.284457331359, 4835.637327200474, 3682.3187710273687, 3709.9814500927864, 3785.280796648628, 3799.8100094995693, 3823.25446537928, 1053.5680371047833, 1133.659902029388, 1155.722626569634, 1169.7309618787556, 1170.39724541861, 825.3562221467265, 827.1976183102381, 849.2229609906866, 906.5014242166782, 907.9273658107336, 5030.8239211627415, 5383.569314454834, 5633.183188437653, 5654.943450565442, 5771.538276937835, 781.6482582837746, 809.4819315637997, 929.549902152644, 944.6032666280179, 980.8479685648736, 3622.5290712207243, 3739.8317075731657, 3834.1373191032353, 3838.558565764917, 3863.03424143964, 9844.310898237054, 10119.13987311072, 10366.429846358522, 10382.688519344432, 10436.321639093587, 10252.0, 10262.230332725076, 10294.485275736184, 10322.277440579088, 10403.219758518142, 6015.879682406327, 6358.268799088071, 6580.934190658032, 6906.205786334636, 7802.960985195038, 5026.321446604661, 5472.577129946163, 5517.834464966058, 5793.217915581343, 5809.012467880386, 7845.764627061198, 9331.953340233254, 9456.00711925238, 9498.24550880237, 9528.428294302365, 7691.88462173079, 9397.0, 9657.517124143624, 9675.371100878421, 9773.804523909625, 6646.60120392778, 6673.733050677918, 6854.897176542456, 7046.823829404306, 7330.413566914741, 7898.368130549427, 7951.244631759973, 8024.83950321002, 8046.879296810435, 8155.347572194329, 6973.372396484341, 7153.749618763319, 7223.386012189023, 7263.983042373966, 7413.332800048021, 6937.89593156093, 7074.186468556182, 7113.253108423541, 7198.8920166198595, 7294.489385743159, 6584.901226481702, 6722.764703235363, 6730.697118629576, 6737.0, 6757.189137303555, 4820.469748327751, 4864.148773964613, 4866.586340161126, 4896.730679812645, 4899.534544218293, 4741.193997020584, 4788.712677239377, 4799.424069111589, 4834.734089624963, 4903.730294833818], "value": 4357.09980904613, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.52472401333506, 286.34998553284044, 302.39671854649964, 312.9342838004019, 314.9590603056896, 4371.934420983684, 4970.676906001107, 4972.751362431873, 5423.864403389917, 5456.372517160527, 5280.231122573933, 5401.756920938557, 5433.755481003354, 5490.972545137279, 5515.503604675579, 3431.708304794089, 3466.6879980801723, 3622.048030854858, 3923.3722604383306, 4143.254214241435, 3972.9471690002174, 4168.041350489374, 4181.686373521983, 4197.370394440828, 4208.936865947013, 3723.7765734056043, 3865.729398942075, 4145.419641250227, 4146.958530414702, 4157.937630935523, 4088.4889388826396, 4101.241270364992, 4118.588141185887, 4133.46264985553, 4159.230542349675, 3590.910227244314, 3596.29872174926, 3628.872989445383, 3641.326354624403, 3664.9633503665154, 4673.696209746356, 4869.659123861331, 5016.523430274118, 5353.330833645794, 5406.216098665672, 3687.0, 3958.168784555247, 4356.106998065389, 4700.365450664151, 4711.4346278446465, 5121.359830021247, 5754.568407369464, 5825.417458254183, 5861.443162899518, 5861.794837180678, 3248.7888287261253, 3368.528406023159, 3627.836747346376, 3895.474110995008, 3941.7043721720984, 6003.8198854034445, 6035.818925432201, 6116.785912493041, 6134.846628834271, 6135.233095863017, 3968.206358728208, 3983.3029219886403, 4018.557958624549, 4027.35562310029, 4048.6153815387493, 3194.7923384979904, 3439.329330780524, 3953.3081710700512, 3980.1840622672285, 3991.4611527444004, 4633.374494443275, 4649.767511624473, 4668.95331046692, 4669.0, 4675.672702910763, 5828.446297601721, 5830.7959221427045, 5858.882822343615, 5865.178874957509, 5868.94131058684, 1208.2810727617054, 1243.6331282271751, 1300.4719454640758, 1302.8957683385495, 1311.5310851845993, 817.1654635343691, 834.460420524132, 865.7705707987388, 875.3609864798606, 882.8410886040574, 4369.71596846204, 4700.600448961808, 5181.611379146579, 5212.921806172911, 5224.686518808808, 4738.573528382462, 5240.71176085319, 5316.441773613792, 5694.213348123451, 5718.599698021182, 4658.487566367697, 4755.597098855846, 4881.997571493506, 5125.104920260629, 5259.368875734936, 2832.546792513188, 2842.3888863894363, 2998.8050776699447, 3000.774941879368, 3008.909732708022, 4480.116672826634, 4929.901401971941, 5698.686572238566, 5777.0, 5812.534997200214, 4741.1465936131135, 5246.554042906319, 5428.4028756836715, 5462.842177339929, 5833.125031245262, 5685.374608793029, 5736.62711923732, 5755.625884317506, 5756.798512052058, 5827.213326201078, 5211.791528338824, 5530.723463826873, 5544.833654990357, 5565.220869078251, 5581.804636837691, 5137.3560460653725, 5149.197780776698, 5595.832125036255, 5596.608237423504, 5653.349864765604, 5361.954418888279, 5789.6394347327505, 5790.681512516852, 5792.333881603669, 5808.273965754281, 3031.5448584679916, 3215.4051500472488, 3330.5170750240595, 3772.962270377261, 3791.962080379161, 4668.463126740333, 4863.927041094457, 5300.867478313073, 5420.0, 5624.563155267099, 4981.37732783402, 5593.916091258716, 5644.0, 5760.164776107525, 5816.5055970243, 5497.862553436196, 5739.7417116229035, 5754.625949313281, 5783.397471137921, 5838.211841401357, 4728.668993170582, 5067.6199285053035, 5385.219143224289, 5651.208830763614, 5802.796902108406, 4963.305137280856, 5452.827642056818, 5845.152452894392, 5861.655337864718, 5923.674197918984, 5229.738513074407, 5274.578033757213, 5683.77264909399, 5718.342390625131, 5748.827535173951], "value": 4070.833659759199, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.1648724759831, 739.8150462384403, 746.1941103608103, 753.1639879733494, 792.3779832831228, 14029.859701402984, 14910.701785964275, 14953.850461495369, 14965.251737413113, 14990.475333363334, 13249.536266230683, 13253.33733313333, 13343.332833358318, 13386.196828190316, 13391.59825205243, 629.7858728032468, 649.9707513161895, 769.4267770510977, 778.0507780507771, 798.4331124901298, 788.1251810490351, 796.1759578835906, 801.2228138705475, 801.2228138705475, 801.6432687454085, 845.5265051571109, 846.5851732650988, 848.240824462106, 849.6601359456205, 851.3742399336513, 839.2237180607974, 839.5340585974782, 841.142035124176, 842.0232530264894, 845.3152946113668, 620.0822782282247, 625.1935003845034, 628.3339659960411, 629.0438533429208, 629.2197674883158, 13710.931445342809, 13978.0, 14050.578482645536, 14052.437902483889, 14102.85897141036, 13426.992975526777, 13601.931990340085, 13623.523176688868, 13819.378127984264, 13981.0, 11072.612458563912, 11209.943950280278, 11245.943770281096, 11273.492692828842, 11467.655970320904, 3582.42681171014, 3595.137167079908, 3620.5836328821997, 3623.8912832615065, 3685.594584595692, 92358.5382073092, 93900.53049734776, 94450.0, 96647.0, 96920.0, 7580.772576822704, 8271.54506502148, 8867.73396798097, 9157.175854173023, 10560.788784224273, 15807.36770529189, 19018.049097545343, 19085.522861928286, 19182.0, 19320.71018934717, 7483.0, 7614.124375696755, 7711.26742959418, 7734.922650773533, 8021.879671804928, 3765.755225910362, 4116.958830411718, 4165.271077561415, 4224.704270701083, 4350.71720338177, 2764.654418197725, 3029.0912726182496, 3469.9826500867334, 3518.1028837646236, 3532.982335088308, 615.7198474694003, 651.2445563146726, 654.5780611736594, 658.26932105363, 671.5970417749311, 559.8068666310116, 585.5754577930966, 647.6696884588894, 661.8510835062169, 663.9170103737033, 8288.70989515364, 8933.731988040368, 9015.864762028576, 9146.292983502311, 9326.813463730687, 527.8258174802306, 531.9680819150864, 632.9493640508748, 652.5236577298504, 669.5279827721445, 3900.6294402031763, 4312.900210446316, 4449.221386257456, 4457.910841783146, 4503.347014682852, 85161.57419212864, 102453.97546024593, 105662.0, 106549.0, 108513.0, 75743.0, 87004.56497717598, 89659.55170224106, 93627.0637293632, 96559.03440965641, 74445.25554744492, 74706.0, 77780.0, 82450.0, 88835.55582222177, 8759.992600850983, 9014.639414423349, 9395.765105872408, 9719.708408747749, 9774.560144793359, 51156.48843511666, 52536.0, 53078.67303317448, 54198.45801541934, 56164.43835561592, 62563.0, 67081.0, 73778.26221737714, 76496.0, 77511.61244193742, 11768.823467648162, 11851.940740296242, 12083.628278880456, 12221.511139554319, 12307.446164922421, 13679.179249245077, 13685.384157712728, 13888.444462221802, 13929.442822286996, 14260.857391426369, 12469.251844889335, 12559.0, 12686.111972162229, 12763.298018608693, 13016.674583135497, 10601.628942986958, 12860.164089334163, 13083.738325233633, 13138.408771605491, 13243.80134297967, 11847.407629618658, 12155.088368372231, 12548.30984295836, 12937.741245175232, 13177.209367437985, 9288.489133097744, 10828.24202305831, 10955.17836162307, 11363.602273920373, 11388.886111138783, 10716.73208169802, 11100.5559777608, 11185.496652650487, 11246.100311974858, 11481.196316258116], "value": 7107.303312518095, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.8999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 119.0, 132.0, 174.0, 155.0, 117.0, 119.0, 117.0, 123.0, 142.0], "value": 131.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 105.0, 147.0, 179.0, 147.0, 118.0, 113.0, 120.0, 176.0, 151.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [229.0, 250.0, 216.0, 187.0, 228.0, 276.0, 172.0, 253.0, 274.0, 246.0], "value": 233.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 61.0, 61.0, 78.0, 88.0, 58.0, 70.0, 51.0, 71.0, 69.0], "value": 68.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 71.0, 91.0, 72.0, 69.0, 71.0, 86.0, 70.0, 70.0, 88.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 88.0, 87.0, 102.0, 85.0, 89.0, 86.0, 90.0, 86.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 114.0, 95.0, 95.0, 95.0, 96.0, 117.0], "value": 99.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 117.0, 144.0, 87.0, 89.0, 91.0, 89.0, 89.0, 90.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 61.0, 61.0, 60.0, 62.0, 61.0, 60.0, 62.0], "value": 59.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 78.0, 69.0, 84.0, 79.0, 76.0, 69.0, 72.0, 71.0, 72.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 84.0, 83.0, 86.0, 85.0, 84.0, 85.0, 86.0, 103.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 144.0, 150.0, 154.0, 161.0, 145.0, 149.0, 145.0, 214.0, 322.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 169.0, 165.0, 163.0, 223.0, 230.0, 230.0, 171.0, 168.0], "value": 186.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 70.0, 68.0, 71.0, 71.0, 71.0, 67.0, 65.0, 73.0], "value": 69.6, "unit": "score"}]}]} 06:53:29 INFO - Return code: 0 06:53:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:53:29 ERROR - # TBPL SUCCESS # 06:53:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:53:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:53:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:53:29 INFO - 2016-12-21 06:53:29.881 screenresolution[1656:10909] starting screenresolution argv=screenresolution get 06:53:29 INFO - 2016-12-21 06:53:29.883 screenresolution[1656:10909] Display 0: 1600x1200x32@60 06:53:29 INFO - 2016-12-21 06:53:29.889 screenresolution[1657:10912] starting screenresolution argv=screenresolution list 06:53:29 INFO - Available Modes on Display 0 06:53:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:53:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:53:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:53:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:53:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:53:30 INFO - Intel Iris: 06:53:30 INFO - Chipset Model: Intel Iris 06:53:30 INFO - Type: GPU 06:53:30 INFO - Bus: Built-In 06:53:30 INFO - VRAM (Dynamic, Max): 1536 MB 06:53:30 INFO - Vendor: Intel (0x8086) 06:53:30 INFO - Device ID: 0x0a2e 06:53:30 INFO - Revision ID: 0x0009 06:53:30 INFO - Displays: 06:53:30 INFO - Display: 06:53:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:53:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:53:30 INFO - Display Serial Number: 1600x1200 60 06:53:30 INFO - Main Display: Yes 06:53:30 INFO - Mirror: Off 06:53:30 INFO - Online: Yes 06:53:30 INFO - Rotation: Supported 06:53:30 INFO - Return code: 0 06:53:30 INFO - Running post-action listener: _resource_record_post_action 06:53:30 INFO - [mozharness: 2016-12-21 14:53:30.135259Z] Finished run-tests step (success) 06:53:30 INFO - Running post-run listener: _resource_record_post_run 06:53:30 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 40110592; Write bytes: 661711872; Read time: 393; Write time: 1999 06:53:30 INFO - TinderboxPrint: CPU usage
54.4% 06:53:30 INFO - TinderboxPrint: I/O read bytes / time
40,110,592 / 393 06:53:30 INFO - TinderboxPrint: I/O write bytes / time
661,711,872 / 1,999 06:53:30 INFO - TinderboxPrint: CPU idle
2,207.5 (45.6%) 06:53:30 INFO - TinderboxPrint: CPU system
976.8 (20.2%) 06:53:30 INFO - TinderboxPrint: CPU user
1,657.4 (34.2%) 06:53:30 INFO - TinderboxPrint: Swap in / out
388,612,096 / 0 06:53:30 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 348031488; Write bytes: 345929728; Read time: 27169; Write time: 680 06:53:30 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35801600; Write bytes: 308507648; Read time: 361; Write time: 1289 06:53:30 INFO - Running post-run listener: _upload_blobber_files 06:53:30 INFO - Blob upload gear active. 06:53:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:53:30 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 06:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:53:31 INFO - (blobuploader) - INFO - Open directory for files ... 06:53:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:53:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:53:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:53:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:53:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:53:32 INFO - (blobuploader) - INFO - Done attempting. 06:53:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:53:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:53:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:53:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:53:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:53:33 INFO - (blobuploader) - INFO - Done attempting. 06:53:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:53:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:53:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:53:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:53:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:53:35 INFO - (blobuploader) - INFO - Done attempting. 06:53:35 INFO - (blobuploader) - INFO - Iteration through files over. 06:53:35 INFO - Return code: 0 06:53:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:53:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:53:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd44e03bf4e68abce432c8460a61604381ac6458c358095b3859c88c044fb781aac2bc477b94a93932bde1d9fd3a8baed4406ae0740657e5ff09098320f56f47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/477bba9de331523e57f9afadf6a78cb1a065a584f2e67a763fdac97b61e3b3c55bf563f559c76f82b6848b140d1e807860993a1be46172ec65308302ce548dba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b99ca8658158670f9f946675debf40a08c10e565609fdcd3bafdb3f147bd2cb4755ca4d822245fe19487ec25d09a4b26541cecfc4a142fe283e69cbb055ccbab"} 06:53:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:53:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:53:35 INFO - Contents: 06:53:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd44e03bf4e68abce432c8460a61604381ac6458c358095b3859c88c044fb781aac2bc477b94a93932bde1d9fd3a8baed4406ae0740657e5ff09098320f56f47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/477bba9de331523e57f9afadf6a78cb1a065a584f2e67a763fdac97b61e3b3c55bf563f559c76f82b6848b140d1e807860993a1be46172ec65308302ce548dba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b99ca8658158670f9f946675debf40a08c10e565609fdcd3bafdb3f147bd2cb4755ca4d822245fe19487ec25d09a4b26541cecfc4a142fe283e69cbb055ccbab"} 06:53:35 INFO - Running post-run listener: copy_logs_to_upload_dir 06:53:35 INFO - Copying logs to upload dir... 06:53:35 INFO - mkdir: /builds/slave/test/build/upload/logs 06:53:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.383561 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-12-21 06:53:35.629643) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 06:53:35.633003) ========= 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.XJXyKw3sXn/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.4UAhciNVCH/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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/Mozilla-Aurora/sha512/cd44e03bf4e68abce432c8460a61604381ac6458c358095b3859c88c044fb781aac2bc477b94a93932bde1d9fd3a8baed4406ae0740657e5ff09098320f56f47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/477bba9de331523e57f9afadf6a78cb1a065a584f2e67a763fdac97b61e3b3c55bf563f559c76f82b6848b140d1e807860993a1be46172ec65308302ce548dba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b99ca8658158670f9f946675debf40a08c10e565609fdcd3bafdb3f147bd2cb4755ca4d822245fe19487ec25d09a4b26541cecfc4a142fe283e69cbb055ccbab"} build_url:https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010881 build_url: 'https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd44e03bf4e68abce432c8460a61604381ac6458c358095b3859c88c044fb781aac2bc477b94a93932bde1d9fd3a8baed4406ae0740657e5ff09098320f56f47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/477bba9de331523e57f9afadf6a78cb1a065a584f2e67a763fdac97b61e3b3c55bf563f559c76f82b6848b140d1e807860993a1be46172ec65308302ce548dba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b99ca8658158670f9f946675debf40a08c10e565609fdcd3bafdb3f147bd2cb4755ca4d822245fe19487ec25d09a4b26541cecfc4a142fe283e69cbb055ccbab"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 06:53:35.669153) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:53:35.669529) ========= 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.XJXyKw3sXn/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.4UAhciNVCH/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.005240 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:53:35.719007) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 06:53:35.719373) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 06:53:35.719908) ========= ========= Total master_lag: 0.19 =========