builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0270 starttime: 1482330773.69 results: success (0) buildid: 20161221040853 builduid: 2c1493cdf51e45c397e84a271b21b857 revision: e6ec59a1128a587af3d45b9d529105cee4e1205d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:53.694174) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:53.694609) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:53.694878) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:53.721040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:53.721335) ========= 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.0x0TKheP2C/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.HDBtBTEetL/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:53-- 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% 166M=0s 2016-12-21 06:32:53 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.169049 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:53.918971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:53.919279) ========= 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.0x0TKheP2C/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.HDBtBTEetL/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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.024468 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:53.966703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:53.967012) ========= 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.0x0TKheP2C/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.HDBtBTEetL/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:54,064 truncating revision to first 12 chars 2016-12-21 06:32:54,064 Setting DEBUG logging. 2016-12-21 06:32:54,064 attempt 1/10 2016-12-21 06:32:54,064 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:54,760 unpacking tar archive at: mozilla-aurora-e6ec59a1128a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.951425 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:54.941484) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:54.941813) ========= script_repo_revision: e6ec59a1128a587af3d45b9d529105cee4e1205d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:54.942189) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:54.942462) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 06:32:54.961727) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-21 06:32:54.961994) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0x0TKheP2C/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.HDBtBTEetL/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:55 INFO - MultiFileLogger online at 20161221 06:32:55 in /builds/slave/test 06:32:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:32:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:32:55 INFO - {'append_to_log': False, 06:32:55 INFO - 'base_work_dir': '/builds/slave/test', 06:32:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:32:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:32:55 INFO - 'branch': 'Mozilla-Aurora', 06:32:55 INFO - 'buildbot_json_path': 'buildprops.json', 06:32:55 INFO - 'config_files': ('talos/mac_config.py',), 06:32:55 INFO - 'default_actions': ('clobber', 06:32:55 INFO - 'read-buildbot-config', 06:32:55 INFO - 'download-and-extract', 06:32:55 INFO - 'populate-webroot', 06:32:55 INFO - 'create-virtualenv', 06:32:55 INFO - 'install', 06:32:55 INFO - 'run-tests'), 06:32:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:32:55 INFO - 'download_minidump_stackwalk': True, 06:32:55 INFO - 'download_symbols': 'ondemand', 06:32:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:32:55 INFO - 'tooltool.py': '/tools/tooltool.py', 06:32:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:32:55 INFO - '/tools/misc-python/virtualenv.py')}, 06:32:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:32:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:32:55 INFO - 'installer_path': 'installer.exe', 06:32:55 INFO - 'log_level': 'info', 06:32:55 INFO - 'log_name': 'talos', 06:32:55 INFO - 'log_to_console': True, 06:32:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:32:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:32:55 INFO - 'opt_config_files': (), 06:32:55 INFO - 'pip_index': False, 06:32:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:32:55 INFO - 'cmd': ('bash', 06:32:55 INFO - '-c', 06:32:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:32:55 INFO - 'enabled': True, 06:32:55 INFO - 'halt_on_failure': False, 06:32:55 INFO - 'name': 'check_screen_resolution'},), 06:32:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:32:55 INFO - 'cmd': ('bash', 06:32:55 INFO - '-c', 06:32:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:32:55 INFO - 'enabled': True, 06:32:55 INFO - 'halt_on_failure': False, 06:32:55 INFO - 'name': 'check_screen_resolution'},), 06:32:55 INFO - 'run_cmd_checks_enabled': True, 06:32:55 INFO - 'sps_profile': False, 06:32:55 INFO - 'sps_profile_interval': 0, 06:32:55 INFO - 'suite': 'dromaeojs', 06:32:55 INFO - 'system_bits': '32', 06:32:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:32:55 INFO - 'title': 't-yosemite-r7-0270', 06:32:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:32:55 INFO - 'use_talos_json': True, 06:32:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:32:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:32:55 INFO - 'work_dir': 'build'} 06:32:55 INFO - [mozharness: 2016-12-21 14:32:55.165909Z] Running clobber step. 06:32:55 INFO - Running pre-action listener: _resource_record_pre_action 06:32:55 INFO - Running main action method: clobber 06:32:55 INFO - rmtree: /builds/slave/test/build 06:32:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:32:57 INFO - Running post-action listener: _resource_record_post_action 06:32:57 INFO - [mozharness: 2016-12-21 14:32:57.661472Z] Finished clobber step (success) 06:32:57 INFO - [mozharness: 2016-12-21 14:32:57.661663Z] Running read-buildbot-config step. 06:32:57 INFO - Running pre-action listener: _resource_record_pre_action 06:32:57 INFO - Running main action method: read_buildbot_config 06:32:57 INFO - Using buildbot properties: 06:32:57 INFO - { 06:32:57 INFO - "project": "", 06:32:57 INFO - "product": "firefox", 06:32:57 INFO - "script_repo_revision": "production", 06:32:57 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 06:32:57 INFO - "repository": "", 06:32:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 06:32:57 INFO - "buildid": "20161221040853", 06:32:57 INFO - "pgo_build": "False", 06:32:57 INFO - "basedir": "/builds/slave/test", 06:32:57 INFO - "buildnumber": 11, 06:32:57 INFO - "slavename": "t-yosemite-r7-0270", 06:32:57 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:32:57 INFO - "platform": "yosemite_r7", 06:32:57 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:32:57 INFO - "branch": "mozilla-aurora", 06:32:57 INFO - "repo_path": "releases/mozilla-aurora", 06:32:57 INFO - "revision": "e6ec59a1128a587af3d45b9d529105cee4e1205d", 06:32:57 INFO - "stage_platform": "macosx64", 06:32:57 INFO - "builduid": "2c1493cdf51e45c397e84a271b21b857", 06:32:57 INFO - "slavebuilddir": "test" 06:32:57 INFO - } 06:32:57 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:57 INFO - Running post-action listener: _resource_record_post_action 06:32:57 INFO - [mozharness: 2016-12-21 14:32:57.668988Z] Finished read-buildbot-config step (success) 06:32:57 INFO - [mozharness: 2016-12-21 14:32:57.669122Z] Running download-and-extract step. 06:32:57 INFO - Running pre-action listener: _resource_record_pre_action 06:32:57 INFO - Running main action method: download_and_extract 06:32:57 INFO - mkdir: /builds/slave/test/build/tests 06:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:57 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:57 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:57 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:58 INFO - Downloaded 1199 bytes. 06:32:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 06:32:58 INFO - Using the following test package requirements: 06:32:58 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 06:32:58 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:58 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 06:32:58 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:58 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 06:32:58 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:58 INFO - u'jsshell-mac.zip'], 06:32:58 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:58 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 06:32:58 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 06:32:58 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:58 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 06:32:58 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:58 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 06:32:58 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:58 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 06:32:58 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 06:32:58 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 06:32:58 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:32:58 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:58 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:58 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:58 INFO - Http code: 200 06:32:58 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 06:32:58 INFO - x-amz-cf-id: MN1b23zUZt6_KEbySjXlFdZRu8kUdWqQOq2zqCI0iQepQI2OA4iDgQ== 06:32:58 INFO - x-amz-version-id: 02mpgtb29FNicEEbZW7KIlOO6hMJvJ9S 06:32:59 INFO - Expected file size: 16267640 06:32:59 INFO - Obtained file size: 16267640 06:33:05 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:33:05 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:33:05 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:33:05 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:33:06 INFO - Http code: 200 06:33:06 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 06:33:06 INFO - x-amz-cf-id: NONCDlMLtwPMVhaI9hnA3Wcw2HiXTaj5SxvidvOGWRNISqd7Zo2VNw== 06:33:06 INFO - x-amz-version-id: 02mpgtb29FNicEEbZW7KIlOO6hMJvJ9S 06:33:07 INFO - Expected file size: 16267640 06:33:07 INFO - Obtained file size: 16267640 06:33:13 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:33:13 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:33:13 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:33:14 INFO - Http code: 200 06:33:14 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 06:33:14 INFO - x-amz-cf-id: jWumZLpvCfcaEg63SscONMhgdF_wPGVIKsqasPZFASBC7tuQjnzi9A== 06:33:14 INFO - x-amz-version-id: 9Pmv9xzdD5J0on8kd8qlDZkOH9zvtNRj 06:33:14 INFO - Expected file size: 14409038 06:33:14 INFO - Obtained file size: 14409038 06:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:15 INFO - trying https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 06:33:15 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:33:15 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:33:18 INFO - Downloaded 109803563 bytes. 06:33:18 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:33:18 INFO - mkdir: /builds/slave/test/properties 06:33:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:33:18 INFO - Writing to file /builds/slave/test/properties/build_url 06:33:18 INFO - Contents: 06:33:18 INFO - build_url:https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 06:33:19 INFO - Running post-action listener: _resource_record_post_action 06:33:19 INFO - Running post-action listener: set_extra_try_arguments 06:33:19 INFO - [mozharness: 2016-12-21 14:33:19.112026Z] Finished download-and-extract step (success) 06:33:19 INFO - [mozharness: 2016-12-21 14:33:19.112143Z] Running populate-webroot step. 06:33:19 INFO - Running pre-action listener: _resource_record_pre_action 06:33:19 INFO - Running main action method: populate_webroot 06:33:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:33:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:33:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:33:19 INFO - '--tppagecycles', 06:33:19 INFO - '7'], 06:33:19 INFO - 'tests': ['tsvgm']}}, 06:33:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:33:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:33:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:33:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:33:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:33:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:33:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:19 INFO - 'talos_options': ['--disable-e10s'], 06:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:33:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:33:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:19 INFO - 'talos_options': ['--disable-e10s'], 06:33:19 INFO - 'tests': ['damp', 'tps']}, 06:33:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:19 INFO - 'tests': ['damp', 'tps']}, 06:33:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:33:19 INFO - 'tests': ['dromaeo_dom']}, 06:33:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:33:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:33:19 INFO - 'tests': ['basic_compositor_video']}, 06:33:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:33:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:33:19 INFO - 'tests': ['a11yr', 06:33:19 INFO - 'ts_paint', 06:33:19 INFO - 'tpaint', 06:33:19 INFO - 'sessionrestore', 06:33:19 INFO - 'sessionrestore_no_auto_restore', 06:33:19 INFO - 'tabpaint']}, 06:33:19 INFO - 'other-e10s': {'tests': ['a11yr', 06:33:19 INFO - 'ts_paint', 06:33:19 INFO - 'tpaint', 06:33:19 INFO - 'sessionrestore', 06:33:19 INFO - 'sessionrestore_no_auto_restore', 06:33:19 INFO - 'tabpaint']}, 06:33:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:33:19 INFO - 'ts_paint', 06:33:19 INFO - 'tpaint', 06:33:19 INFO - 'sessionrestore', 06:33:19 INFO - 'sessionrestore_no_auto_restore', 06:33:19 INFO - 'tabpaint']}, 06:33:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:33:19 INFO - 'ts_paint', 06:33:19 INFO - 'tpaint', 06:33:19 INFO - 'sessionrestore', 06:33:19 INFO - 'sessionrestore_no_auto_restore', 06:33:19 INFO - 'tabpaint']}, 06:33:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:33:19 INFO - 'tests': ['a11yr', 06:33:19 INFO - 'ts_paint', 06:33:19 INFO - 'tpaint', 06:33:19 INFO - 'sessionrestore', 06:33:19 INFO - 'sessionrestore_no_auto_restore', 06:33:19 INFO - 'tabpaint']}, 06:33:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:33:19 INFO - 'tests': ['a11yr', 06:33:19 INFO - 'ts_paint', 06:33:19 INFO - 'tpaint', 06:33:19 INFO - 'sessionrestore', 06:33:19 INFO - 'sessionrestore_no_auto_restore', 06:33:19 INFO - 'tabpaint']}, 06:33:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:33:19 INFO - 'tests': ['tsvgx', 06:33:19 INFO - 'tsvgr_opacity', 06:33:19 INFO - 'tart', 06:33:19 INFO - 'tscrollx', 06:33:19 INFO - 'cart']}, 06:33:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:33:19 INFO - 'tsvgr_opacity', 06:33:19 INFO - 'tart', 06:33:19 INFO - 'tscrollx', 06:33:19 INFO - 'cart']}, 06:33:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:19 INFO - 'talos_options': ['--disable-e10s'], 06:33:19 INFO - 'tests': ['tp5o']}, 06:33:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:19 INFO - 'tests': ['tp5o']}, 06:33:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:19 INFO - 'talos_options': ['--disable-e10s', 06:33:19 INFO - '--xperf_path', 06:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:33:19 INFO - 'tests': ['tp5n']}, 06:33:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:33:19 INFO - 'talos_options': ['--xperf_path', 06:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:33:19 INFO - 'tests': ['tp5n']}}, 06:33:19 INFO - 'talos.zip': {'path': '', 06:33:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:33:19 INFO - Running post-action listener: _resource_record_post_action 06:33:19 INFO - [mozharness: 2016-12-21 14:33:19.131625Z] Finished populate-webroot step (success) 06:33:19 INFO - [mozharness: 2016-12-21 14:33:19.131717Z] Running create-virtualenv step. 06:33:19 INFO - Running pre-action listener: _resource_record_pre_action 06:33:19 INFO - Running main action method: create_virtualenv 06:33:19 INFO - Creating virtualenv /builds/slave/test/build/venv 06:33:19 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:33:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:33:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:33:19 INFO - Using real prefix '/tools/python27' 06:33:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:33:19 INFO - Installing distribute.............................................................................................................................................................................................done. 06:33:22 INFO - Installing pip.................done. 06:33:22 INFO - Return code: 0 06:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:33:23 INFO - Reading from file tmpfile_stdout 06:33:23 INFO - Output received: 06:33:23 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:33:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:23 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 0x10a7dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a753570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f869bd60d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f1d30>, '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 0x10a457db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5e9b20>, '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.0x0TKheP2C/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.HDBtBTEetL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:23 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:33:23 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:33:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x0TKheP2C/Render', 06:33:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:23 INFO - 'HOME': '/Users/cltbld', 06:33:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:23 INFO - 'LOGNAME': 'cltbld', 06:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:23 INFO - 'MOZ_NO_REMOTE': '1', 06:33:23 INFO - 'NO_EM_RESTART': '1', 06:33:23 INFO - 'PAGER': '/bin/cat', 06:33:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:23 INFO - 'PWD': '/builds/slave/test', 06:33:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:23 INFO - 'SHELL': '/bin/bash', 06:33:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HDBtBTEetL/Listeners', 06:33:23 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:33:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:23 INFO - 'USER': 'cltbld', 06:33:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:23 INFO - 'XPC_FLAGS': '0x0', 06:33:23 INFO - 'XPC_SERVICE_NAME': '0', 06:33:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:23 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:33:23 INFO - Cleaning up... 06:33:23 INFO - Return code: 0 06:33:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:23 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 0x10a7dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a753570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f869bd60d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f1d30>, '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 0x10a457db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5e9b20>, '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.0x0TKheP2C/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.HDBtBTEetL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:23 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:33:23 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:33:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x0TKheP2C/Render', 06:33:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:23 INFO - 'HOME': '/Users/cltbld', 06:33:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:23 INFO - 'LOGNAME': 'cltbld', 06:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:23 INFO - 'MOZ_NO_REMOTE': '1', 06:33:23 INFO - 'NO_EM_RESTART': '1', 06:33:23 INFO - 'PAGER': '/bin/cat', 06:33:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:23 INFO - 'PWD': '/builds/slave/test', 06:33:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:23 INFO - 'SHELL': '/bin/bash', 06:33:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HDBtBTEetL/Listeners', 06:33:23 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:33:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:23 INFO - 'USER': 'cltbld', 06:33:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:23 INFO - 'XPC_FLAGS': '0x0', 06:33:23 INFO - 'XPC_SERVICE_NAME': '0', 06:33:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:23 INFO - Downloading/unpacking psutil>=3.1.1 06:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:33:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:33:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:33:27 INFO - Installing collected packages: psutil 06:33:27 INFO - Running setup.py install for psutil 06:33:27 INFO - building 'psutil._psutil_osx' extension 06:33:27 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:33:27 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:33:27 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:33:27 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:33:27 INFO - building 'psutil._psutil_posix' extension 06:33:27 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:33:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:33:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:33:28 INFO - ^ 06:33:28 INFO - 1 warning generated. 06:33:28 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:33:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:33:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:33:28 INFO - Successfully installed psutil 06:33:28 INFO - Cleaning up... 06:33:28 INFO - Return code: 0 06:33:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a7dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a753570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f869bd60d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f1d30>, '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 0x10a457db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5e9b20>, '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.0x0TKheP2C/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.HDBtBTEetL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:33:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x0TKheP2C/Render', 06:33:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:28 INFO - 'HOME': '/Users/cltbld', 06:33:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:28 INFO - 'LOGNAME': 'cltbld', 06:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:28 INFO - 'MOZ_NO_REMOTE': '1', 06:33:28 INFO - 'NO_EM_RESTART': '1', 06:33:28 INFO - 'PAGER': '/bin/cat', 06:33:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:28 INFO - 'PWD': '/builds/slave/test', 06:33:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:28 INFO - 'SHELL': '/bin/bash', 06:33:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HDBtBTEetL/Listeners', 06:33:28 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:33:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:28 INFO - 'USER': 'cltbld', 06:33:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:28 INFO - 'XPC_FLAGS': '0x0', 06:33:28 INFO - 'XPC_SERVICE_NAME': '0', 06:33:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:33:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:33:31 INFO - Installing collected packages: mozsystemmonitor 06:33:31 INFO - Running setup.py install for mozsystemmonitor 06:33:31 INFO - Successfully installed mozsystemmonitor 06:33:31 INFO - Cleaning up... 06:33:31 INFO - Return code: 0 06:33:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:33:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:31 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 0x10a7dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a753570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f869bd60d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f1d30>, '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 0x10a457db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5e9b20>, '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.0x0TKheP2C/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.HDBtBTEetL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:31 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:33:31 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:33:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x0TKheP2C/Render', 06:33:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:31 INFO - 'HOME': '/Users/cltbld', 06:33:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:31 INFO - 'LOGNAME': 'cltbld', 06:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:31 INFO - 'MOZ_NO_REMOTE': '1', 06:33:31 INFO - 'NO_EM_RESTART': '1', 06:33:31 INFO - 'PAGER': '/bin/cat', 06:33:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:31 INFO - 'PWD': '/builds/slave/test', 06:33:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:31 INFO - 'SHELL': '/bin/bash', 06:33:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HDBtBTEetL/Listeners', 06:33:31 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:33:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:31 INFO - 'USER': 'cltbld', 06:33:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:31 INFO - 'XPC_FLAGS': '0x0', 06:33:31 INFO - 'XPC_SERVICE_NAME': '0', 06:33:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:31 INFO - Downloading/unpacking jsonschema==2.5.1 06:33:31 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:31 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:31 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:31 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:31 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:31 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:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:33:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:33:34 INFO - Downloading functools32-3.2.3-2.tar.gz 06:33:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:33:35 INFO - warning: no files found matching '*.txt' 06:33:35 INFO - no previously-included directories found matching 'build' 06:33:35 INFO - no previously-included directories found matching 'dist' 06:33:35 INFO - no previously-included directories found matching '.git*' 06:33:35 INFO - Installing collected packages: jsonschema, functools32 06:33:35 INFO - Running setup.py install for functools32 06:33:35 INFO - warning: no files found matching '*.txt' 06:33:35 INFO - no previously-included directories found matching 'build' 06:33:35 INFO - no previously-included directories found matching 'dist' 06:33:35 INFO - no previously-included directories found matching '.git*' 06:33:35 INFO - Successfully installed jsonschema functools32 06:33:35 INFO - Cleaning up... 06:33:35 INFO - Return code: 0 06:33:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a7dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a753570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f869bd60d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f1d30>, '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 0x10a457db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5e9b20>, '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.0x0TKheP2C/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.HDBtBTEetL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:33:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x0TKheP2C/Render', 06:33:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:35 INFO - 'HOME': '/Users/cltbld', 06:33:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:35 INFO - 'LOGNAME': 'cltbld', 06:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:35 INFO - 'MOZ_NO_REMOTE': '1', 06:33:35 INFO - 'NO_EM_RESTART': '1', 06:33:35 INFO - 'PAGER': '/bin/cat', 06:33:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:35 INFO - 'PWD': '/builds/slave/test', 06:33:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:35 INFO - 'SHELL': '/bin/bash', 06:33:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HDBtBTEetL/Listeners', 06:33:35 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:33:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:35 INFO - 'USER': 'cltbld', 06:33:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:35 INFO - 'XPC_FLAGS': '0x0', 06:33:35 INFO - 'XPC_SERVICE_NAME': '0', 06:33:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:33:35 INFO - Cleaning up... 06:33:35 INFO - Return code: 0 06:33:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a7dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a753570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f869bd60d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f1d30>, '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 0x10a457db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5e9b20>, '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.0x0TKheP2C/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.HDBtBTEetL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:33:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x0TKheP2C/Render', 06:33:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:35 INFO - 'HOME': '/Users/cltbld', 06:33:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:35 INFO - 'LOGNAME': 'cltbld', 06:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:35 INFO - 'MOZ_NO_REMOTE': '1', 06:33:35 INFO - 'NO_EM_RESTART': '1', 06:33:35 INFO - 'PAGER': '/bin/cat', 06:33:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:35 INFO - 'PWD': '/builds/slave/test', 06:33:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:35 INFO - 'SHELL': '/bin/bash', 06:33:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HDBtBTEetL/Listeners', 06:33:35 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:33:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:35 INFO - 'USER': 'cltbld', 06:33:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:35 INFO - 'XPC_FLAGS': '0x0', 06:33:35 INFO - 'XPC_SERVICE_NAME': '0', 06:33:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:35 INFO - Downloading/unpacking blobuploader==1.2.4 06:33:35 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:35 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:35 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:35 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:35 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:35 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:38 INFO - Downloading blobuploader-1.2.4.tar.gz 06:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:33:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:33:38 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:38 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:38 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:38 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:38 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:38 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:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:33:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:33:39 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:39 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:39 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:39 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:39 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:39 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:39 INFO - Downloading docopt-0.6.1.tar.gz 06:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:33:39 INFO - Installing collected packages: blobuploader, requests, docopt 06:33:39 INFO - Running setup.py install for blobuploader 06:33:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:33:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:33:40 INFO - Running setup.py install for requests 06:33:40 INFO - Running setup.py install for docopt 06:33:40 INFO - Successfully installed blobuploader requests docopt 06:33:40 INFO - Cleaning up... 06:33:40 INFO - Return code: 0 06:33:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:40 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 0x10a7dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a753570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f869bd60d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f1d30>, '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 0x10a457db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5e9b20>, '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.0x0TKheP2C/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.HDBtBTEetL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:40 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:40 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:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x0TKheP2C/Render', 06:33:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:40 INFO - 'HOME': '/Users/cltbld', 06:33:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:40 INFO - 'LOGNAME': 'cltbld', 06:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:40 INFO - 'MOZ_NO_REMOTE': '1', 06:33:40 INFO - 'NO_EM_RESTART': '1', 06:33:40 INFO - 'PAGER': '/bin/cat', 06:33:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:40 INFO - 'PWD': '/builds/slave/test', 06:33:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:40 INFO - 'SHELL': '/bin/bash', 06:33:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HDBtBTEetL/Listeners', 06:33:40 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:33:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:40 INFO - 'USER': 'cltbld', 06:33:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:40 INFO - 'XPC_FLAGS': '0x0', 06:33:40 INFO - 'XPC_SERVICE_NAME': '0', 06:33:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:33:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-CAA52U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:33:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-uP4png-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:33:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-vT8rTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:33:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-va17zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:33:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-Zq9Y2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:33:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-pzcYGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:33:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-X6s6AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:33:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-Ccupj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:33:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-ELhPVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:33:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-UPYdkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:33:42 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-uMOoeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:33:42 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-zKJvlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:33:42 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-g4DvWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:33:42 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-yJ_Ofj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:42 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-WCBFxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:33:42 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-iQjqgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:33:42 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-MEkw79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:33:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:33:42 INFO - Running setup.py install for manifestparser 06:33:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:33:42 INFO - Running setup.py install for mozcrash 06:33:43 INFO - Running setup.py install for mozdebug 06:33:43 INFO - Running setup.py install for mozdevice 06:33:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:33:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:33:43 INFO - Running setup.py install for mozfile 06:33:43 INFO - Running setup.py install for mozhttpd 06:33:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:33:43 INFO - Running setup.py install for mozinfo 06:33:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:33:43 INFO - Running setup.py install for mozInstall 06:33:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:33:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:33:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:33:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:33:43 INFO - Running setup.py install for mozleak 06:33:44 INFO - Running setup.py install for mozlog 06:33:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:33:44 INFO - Running setup.py install for moznetwork 06:33:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:33:44 INFO - Running setup.py install for mozprocess 06:33:44 INFO - Running setup.py install for mozprofile 06:33:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:33:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:33:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:33:44 INFO - Running setup.py install for mozrunner 06:33:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:33:44 INFO - Running setup.py install for mozscreenshot 06:33:45 INFO - Running setup.py install for moztest 06:33:45 INFO - Running setup.py install for mozversion 06:33:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:33:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:33:45 INFO - Cleaning up... 06:33:45 INFO - Return code: 0 06:33:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:45 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 0x10a7dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a753570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f869bd60d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f1d30>, '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 0x10a457db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5e9b20>, '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.0x0TKheP2C/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.HDBtBTEetL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:45 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:45 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:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x0TKheP2C/Render', 06:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:45 INFO - 'HOME': '/Users/cltbld', 06:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:45 INFO - 'LOGNAME': 'cltbld', 06:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:45 INFO - 'MOZ_NO_REMOTE': '1', 06:33:45 INFO - 'NO_EM_RESTART': '1', 06:33:45 INFO - 'PAGER': '/bin/cat', 06:33:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:45 INFO - 'PWD': '/builds/slave/test', 06:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:45 INFO - 'SHELL': '/bin/bash', 06:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HDBtBTEetL/Listeners', 06:33:45 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:45 INFO - 'USER': 'cltbld', 06:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:45 INFO - 'XPC_FLAGS': '0x0', 06:33:45 INFO - 'XPC_SERVICE_NAME': '0', 06:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:33:45 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-r951gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:33:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:33:45 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-Zm2dcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:33:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:33:45 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-7t0aWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:33:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:33:45 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-lbNLIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:33:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:33:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-4rsSMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:33:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:33:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-HHzlnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:33:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:33:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-JkXJGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:33:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:33:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-chTB5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:33:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:33:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-czSE9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:33:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:33:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-F7kYru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:33:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:33:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-__YY9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:33:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:33:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-lH9UUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:33:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:33:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-AxnN1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:33:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:33:47 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-1cDPeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:33:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:47 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-iBezSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:33:47 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-Ix_Y72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:33:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:33:47 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-ZvQd6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:33:47 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:47 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:47 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:47 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:47 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:47 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:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:33:47 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:47 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:47 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:47 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:47 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:47 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:50 INFO - Downloading blessings-1.6.tar.gz 06:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:33:50 INFO - Installing collected packages: blessings 06:33:50 INFO - Running setup.py install for blessings 06:33:50 INFO - Successfully installed blessings 06:33:50 INFO - Cleaning up... 06:33:50 INFO - Return code: 0 06:33:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:33:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:33:51 INFO - Reading from file tmpfile_stdout 06:33:51 INFO - Current package versions: 06:33:51 INFO - blessings == 1.6 06:33:51 INFO - blobuploader == 1.2.4 06:33:51 INFO - docopt == 0.6.1 06:33:51 INFO - functools32 == 3.2.3-2 06:33:51 INFO - jsonschema == 2.5.1 06:33:51 INFO - manifestparser == 1.1 06:33:51 INFO - mozInstall == 1.12 06:33:51 INFO - mozcrash == 1.0 06:33:51 INFO - mozdebug == 0.1 06:33:51 INFO - mozdevice == 0.48 06:33:51 INFO - mozfile == 1.2 06:33:51 INFO - mozhttpd == 0.7 06:33:51 INFO - mozinfo == 0.9 06:33:51 INFO - mozleak == 0.1 06:33:51 INFO - mozlog == 3.4 06:33:51 INFO - moznetwork == 0.27 06:33:51 INFO - mozprocess == 0.23 06:33:51 INFO - mozprofile == 0.28 06:33:51 INFO - mozrunner == 6.13 06:33:51 INFO - mozscreenshot == 0.1 06:33:51 INFO - mozsystemmonitor == 0.3 06:33:51 INFO - moztest == 0.7 06:33:51 INFO - mozversion == 1.4 06:33:51 INFO - psutil == 3.1.1 06:33:51 INFO - requests == 1.2.3 06:33:51 INFO - wsgiref == 0.1.2 06:33:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33:51 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:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:51 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:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:51 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 0x10a7dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a753570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f869bd60d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f1d30>, '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 0x10a457db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5e9b20>, '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.0x0TKheP2C/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.HDBtBTEetL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:51 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:51 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:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x0TKheP2C/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 - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:51 INFO - 'MOZ_NO_REMOTE': '1', 06:33:51 INFO - 'NO_EM_RESTART': '1', 06:33:51 INFO - 'PAGER': '/bin/cat', 06:33:51 INFO - 'PATH': '/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 - '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.HDBtBTEetL/Listeners', 06:33:51 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 - Ignoring indexes: https://pypi.python.org/simple/ 06:33:51 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:51 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:51 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:51 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:51 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:51 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:51 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:51 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:51 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:51 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:51 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:51 INFO - Cleaning up... 06:33:51 INFO - Return code: 0 06:33:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:33:51 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:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:51 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:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:51 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 0x10a7dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a753570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f869bd60d70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5f1d30>, '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 0x10a457db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5e9b20>, '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.0x0TKheP2C/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.HDBtBTEetL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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:51 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:51 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:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x0TKheP2C/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 - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:51 INFO - 'MOZ_NO_REMOTE': '1', 06:33:51 INFO - 'NO_EM_RESTART': '1', 06:33:51 INFO - 'PAGER': '/bin/cat', 06:33:51 INFO - 'PATH': '/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 - '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.HDBtBTEetL/Listeners', 06:33:51 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 - Ignoring indexes: https://pypi.python.org/simple/ 06:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:33:51 INFO - Cleaning up... 06:33:51 INFO - Return code: 0 06:33:51 INFO - Running post-action listener: _resource_record_post_action 06:33:51 INFO - Running post-action listener: _start_resource_monitoring 06:33:52 INFO - Starting resource monitoring. 06:33:52 INFO - [mozharness: 2016-12-21 14:33:52.024572Z] Finished create-virtualenv step (success) 06:33:52 INFO - [mozharness: 2016-12-21 14:33:52.025650Z] Running install step. 06:33:52 INFO - Running pre-action listener: _resource_record_pre_action 06:33:52 INFO - Running main action method: install 06:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:33:52 INFO - Reading from file tmpfile_stdout 06:33:52 INFO - Detecting whether we're running mozinstall >=1.0... 06:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:33:52 INFO - Reading from file tmpfile_stdout 06:33:52 INFO - Output received: 06:33:52 INFO - Usage: mozinstall [options] installer 06:33:52 INFO - Options: 06:33:52 INFO - -h, --help show this help message and exit 06:33:52 INFO - -d DEST, --destination=DEST 06:33:52 INFO - Directory to install application into. [default: 06:33:52 INFO - "/builds/slave/test"] 06:33:52 INFO - --app=APP Application being installed. [default: firefox] 06:33:52 INFO - mkdir: /builds/slave/test/build/application 06:33:52 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:52 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:34:23 INFO - Reading from file tmpfile_stdout 06:34:23 INFO - Output received: 06:34:23 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:34:23 INFO - Running post-action listener: _resource_record_post_action 06:34:23 INFO - [mozharness: 2016-12-21 14:34:23.525059Z] Finished install step (success) 06:34:23 INFO - [mozharness: 2016-12-21 14:34:23.525212Z] Running run-tests step. 06:34:23 INFO - Running pre-action listener: _resource_record_pre_action 06:34:23 INFO - Running main action method: run_tests 06:34:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:34:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:34:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:34:23 INFO - 2016-12-21 06:34:23.539 screenresolution[1627:7361] starting screenresolution argv=screenresolution get 06:34:23 INFO - 2016-12-21 06:34:23.542 screenresolution[1627:7361] Display 0: 1600x1200x32@60 06:34:23 INFO - 2016-12-21 06:34:23.548 screenresolution[1628:7363] starting screenresolution argv=screenresolution list 06:34:23 INFO - Available Modes on Display 0 06:34:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:34:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:34:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:34:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:34:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:34:23 INFO - Intel Iris: 06:34:23 INFO - Chipset Model: Intel Iris 06:34:23 INFO - Type: GPU 06:34:23 INFO - Bus: Built-In 06:34:23 INFO - VRAM (Dynamic, Max): 1536 MB 06:34:23 INFO - Vendor: Intel (0x8086) 06:34:23 INFO - Device ID: 0x0a2e 06:34:23 INFO - Revision ID: 0x0009 06:34:23 INFO - Displays: 06:34:23 INFO - Display: 06:34:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:34:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:34:23 INFO - Display Serial Number: 1600x1200 60 06:34:23 INFO - Main Display: Yes 06:34:23 INFO - Mirror: Off 06:34:23 INFO - Online: Yes 06:34:23 INFO - Rotation: Supported 06:34:23 INFO - Return code: 0 06:34:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:34:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:34:23 INFO - Python 2.7.3 06:34:23 INFO - Return code: 0 06:34:23 INFO - grabbing minidump binary from tooltool 06:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:34:23 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 0x10a5f1d30>, '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 0x10a457db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5e9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:34:23 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:34:23 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:34:23 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:34:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:34:23 INFO - Return code: 0 06:34:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:34:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:34:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:34:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:34:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:34:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0270', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:34:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0270 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:34:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x0TKheP2C/Render', 06:34:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:34:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:34:23 INFO - 'HOME': '/Users/cltbld', 06:34:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:34:23 INFO - 'LOGNAME': 'cltbld', 06:34:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:34:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:23 INFO - 'MOZ_NO_REMOTE': '1', 06:34:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:34:23 INFO - 'NO_EM_RESTART': '1', 06:34:23 INFO - 'PAGER': '/bin/cat', 06:34:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:23 INFO - 'PWD': '/builds/slave/test', 06:34:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:34:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:34:23 INFO - 'SHELL': '/bin/bash', 06:34:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HDBtBTEetL/Listeners', 06:34:23 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:34:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:34:23 INFO - 'USER': 'cltbld', 06:34:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:34:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:23 INFO - 'XPC_FLAGS': '0x0', 06:34:23 INFO - 'XPC_SERVICE_NAME': '0', 06:34:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:34:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0270', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:34:24 INFO - mozversion application_buildid: 20161221040853 06:34:24 INFO - mozversion application_changeset: e6ec59a1128a587af3d45b9d529105cee4e1205d 06:34:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:34:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:34:24 INFO - mozversion application_name: Firefox 06:34:24 INFO - mozversion application_remotingname: firefox-dev 06:34:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:34:24 INFO - mozversion application_vendor: Mozilla 06:34:24 INFO - mozversion application_version: 52.0a2 06:34:24 INFO - mozversion platform_buildid: 20161221040853 06:34:24 INFO - mozversion platform_changeset: e6ec59a1128a587af3d45b9d529105cee4e1205d 06:34:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:34:24 INFO - mozversion platform_version: 52.0a2 06:34:24 INFO - using testdate: 1482330864 06:34:24 INFO - actual date: 1482330864 06:34:24 INFO - starting webserver on 'localhost:49235' 06:34:24 INFO - SUITE-START | Running 2 tests 06:34:24 INFO - TEST-START | dromaeo_css 06:34:24 INFO - operating with platform_type : mac_ 06:34:24 INFO - Initialising browser for dromaeo_css test... 06:34:24 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmpiEHQ5w/profile http://localhost:49235/getInfo.html) 06:34:26 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 06:34:26 INFO - PROCESS | 1638 | colorDepth:24 06:34:26 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 06:34:26 INFO - PROCESS | 1638 | __metrics 06:34:26 INFO - PROCESS | 1638 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:34:26 INFO - PROCESS | 1638 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:34:27 INFO - TEST-INFO | 1638: exit 0 06:34:27 INFO - Browser initialized. 06:34:27 INFO - Running cycle 1/1 for dromaeo_css test... 06:34:27 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmpiEHQ5w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:40 INFO - PROCESS | 1640 | RSS: Main: 222617600 06:34:40 INFO - PROCESS | 1640 | 06:35:34 INFO - PROCESS | 1640 | 1482330934662 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:46 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 06:37:48 INFO - PROCESS | 1640 | RSS: Main: 375046144 06:37:48 INFO - PROCESS | 1640 | 06:40:50 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 06:40:51 INFO - PROCESS | 1640 | RSS: Main: 348774400 06:40:51 INFO - PROCESS | 1640 | 06:43:53 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 06:43:54 INFO - PROCESS | 1640 | RSS: Main: 324702208 06:43:54 INFO - PROCESS | 1640 | 06:46:56 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 06:46:57 INFO - PROCESS | 1640 | RSS: Main: 317427712 06:46:57 INFO - PROCESS | 1640 | 06:50:00 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 06:50:01 INFO - PROCESS | 1640 | RSS: Main: 305287168 06:50:01 INFO - PROCESS | 1640 | 06:53:04 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 06:53:04 INFO - PROCESS | 1640 | RSS: Main: 367026176 06:53:04 INFO - PROCESS | 1640 | 06:53:04 INFO - PROCESS | 1640 | __start_tp_report 06:53:04 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 06:53:04 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 06:53:04 INFO - PROCESS | 1640 | |i|pagename|runs| 06:53:04 INFO - PROCESS | 1640 | |0;dojo.html;3208.246062175389;3303.9008829735108;3336.7497437692177;3346.4980252962037;3389.644087370826;5655.830325090254;5663.405342439047;5692.231548740929;5695.743691533876;5724.284464441945;5609.635373700707;5617.657493791198;5638.633488823234;5674.631148975324;5753.65478071316;5190.195519694454;5217.713025783581;5220.582353411737;5242.423333433319;5273.76268067936;4426.933595996046;5203.895922081556;5207.583393328525;5212.374515058198;5247.449017853109;5236.7119808410525;5248.370195576536;5249.055170069386;5260.8158714445;5276.182191760283;5166.896662066756;5196.298499702568;5257.290265814105;5269.815556455544;5270.288511050997;5152.407473140599;5178.611604129667;5256.974889896472;5263;5292.550133238679;5703.173039909231;5757.712114394305;5794.797182098607;5817.970910145422;5820.708964551755;5660.575456840712;6008.819735407945;6113.663748493831;6122.428649698669;6145.877082458326;6171.87656246877;6271.686415679198;6279.591826531307;6302.117703521465;6360.077788720656;5775.104858746901;5829.387914269026;5833.711315027335;5838.562107841929;5882.264716910387;6182.227221597301;6237.844053898689;6255.593386429868;6321.683915804191;6325.4939604832425;6048.6673232971725;6104.236970378703;6138.815835524942;6168.0439531872635;6175.783847565313;5227.790888364423;6249.59377640461;6258.405451482102;6272.655003974825;6284.340144284875;5885.323187833454;6183.598066125687;6238.75044998195;6255.593386429868;6277.497800175975;6006.489448396936;6049.485793707496;6116.3883611638485;6129.662868542273;6132.63204207749;4822.42130944289;4834.95165048352;4839.782209800567;4851.248056551241;4853.320535125085;4319.903692612328;4386.210482113251;4436.290193569013;4454.042380888124;4456.888577785581;4690.038542098861;5427;5785.537157027427;5786.987277226469;5825;5563.777448902079;6299.496040316763;6328.272248691459;6337.461315788118;6385.744570217139;5317.750328672759;5551.167324901297;5611.3266408031295;5645.5483561314995;5778.219940308089;5362.624616276823;5387.515123638891;5416.620836541483;5426.728663566806;5441.6190866639745;6306.117143599808;6331.651759153291;6333.968330158227;6337.6197428154455;6338.080978258219;6055.091736239599;6122.326544080237;6287.151234583455;6289.49684025286;6297.055441683784;4859.635527335393;6207.410296021871;6223.626582405071;6261.78083767066;6270.968645156928;6162.7534898605345;6168.845778855564;6168.907466387918;6176.166217560752;6190.50475961931;5987.5808693391045;6093.177421048279;6182.165407670087;6236.282827474898;6266.436020758154;5836.066229403275;5878.500327472042;5937.9406205937385;5949.702514874326;5993.820185394445;6057.727402266997;6060.757569697163;6076.331603523698;6076.936536106252;6093.29927058394;5869.35437101927;5894.469497745224;5895.6462612241685;5901.822945311647;5904.0553511437965;5933.436323549256;5961.195238642727;5969.671668058299;6016.5487588431915;6022.849428764316;5853.288482077703;5873.236479257669;5879.647221166743;5915.08316210988;5922.73347699346 06:53:04 INFO - PROCESS | 1640 | |1;ext.html;466.1283400041921;487.8658368948541;496.87329730918634;497.9319359972856;522.3444577055795;27982.02062927798;30823.845880770594;30877.845610771914;34906.65093349066;37530.061748456304;39374.01564960877;39916;39924.80037599808;40032.79983600078;40038.59961400385;9319.813603727938;9482.241420686363;9498.905010949906;9502.762430939247;9516.666916657918;8242.423030387876;9345.43927364357;9454.952725236364;9458.148766611004;9458.716238512821;9436.764080897998;9452.480113593783;9462.574184161695;9472;9472.005439428864;9391.859122113174;9436.961934187233;9456.385334953206;9463.526823658858;9473.147416732527;9332.67335643256;9393.248540116843;9397.718068457958;9401.858972115424;9417.764555886157;38250.0437489065;38462.42306365407;38487.807560962014;38489.80755096207;38593.614063859284;3439.4496880499;3497.4928635347987;3676.448532720087;3853.537575490959;3880.6701430378453;27931;28352.432951341063;29495.26261843471;29787;30348.393032139455;3153.7792354534963;3191.1543440988157;3219.4687876500348;3321.96678033219;3331.916702082443;464323;472089;473879.63060184824;474082;474168;32877;57870;58251;58252;58272.70863645655;33476.33047339039;34630.30739385198;34690.13274668103;34709.305813883584;34732.30535389278;13666.453341866412;13816;13817.101888377223;13821.654458638413;13825.930870345785;11502.309861408343;11538.94230528842;11575.652730418102;11585.942070289762;11599.304041757521;7733.188015258429;7758.689652413953;7759.612019399007;7836.725714599962;7843.333316668033;3179;3238.3199528098894;3244.23760416302;3245.626752923397;3278.3607196596436;900.3382513852313;922.9907700923039;928.8374534456443;963.6097380560884;1114.7380365614074;24449;25410.491790164095;25695.48609027809;28698.713012870023;28942.276443089093;1006.6527048168371;1008.8940661230612;1088.77135801481;1090.3784842639777;1098.6045023791428;11868.525258989544;14225.573232803032;14736.590300861619;14865.925670371795;15046.774298385533;640665;643319;645376;647509;649906;53372;53929.73035134878;54001;54074.72962635162;54320;1331.4873773597042;1361.598328493097;1377.2838124175373;1380.0546625561522;1382.6197795606088;27621.03326383567;27899;28113;28879.5668064975;28942.565861511674;47971.76014119907;48275.27587086126;48391.51608484011;48406.757966209945;48525.757371212916;402449;484391;488977;493674.53162733954;495002;25530;25780.61329080103;26042.60936085998;26115.780158686724;26211.34471638148;35860.8206958974;43902.78048609736;44346.55653443424;44477;44667.55332446634;36475.63524364722;36847.63152368442;36869.44695829618;37086.25827483381;37174.814125929195;29922.551161732157;35988.28023439569;36142.63857361393;36748.63251367452;36762.89711308665;35249.64750352463;35763.46354804732;36070;36095;36641.63358366489;31953.721851125694;32146.766977430827;32437.51343729893;33036.03567571907;33176.83411582927;23470.647940280567;24236.39409014789;24531.754682452945;24616.138435154684;24821.255362339158 06:53:04 INFO - PROCESS | 1640 | |2;jquery.html;351.9612842587313;370.9721770867185;376.17617417854893;381.4469019921114;402.121364817873;14778.556643300704;15546.45587404441;15778.842211577881;20318.288859889908;20748;17130.05784681845;19451.319203827832;19894.801051989474;20411.48971275719;20788;5704.800331988392;5845.532357411397;5970.6716130612795;5979.730912108944;5982.192404025444;5103.719295438749;6545.9018114728315;6620.801375958705;6660.633665148439;6666.166729158856;5663;5951.196588460567;6608.9339106608795;6610.636414997173;6613.437857782094;5967.970160149193;5992.940070599282;6001.639901605918;6002.96998515009;6026.8794624107495;5616.382197958222;5794.739236734357;5816.47651711348;5891.617044892068;5902.498287645555;13293.135946163566;13548.390322435416;13569.457221711218;22187.334379968626;24658.753412466005;2246.359787460582;2545.8217924745277;2564.1666458401096;2811.690714021456;2927.180389490946;10051.296409251356;10051.59793608262;10133.290669653054;10454.63408780689;10517.211209159344;1805.6388722255601;1817;1838.6414649143424;1905.4950438133906;1909.1981367825408;117915.41042294819;119276.80723192744;124107;125050.37474812567;125217.37391313077;9337.90662093384;9899.317116090282;10092.394456332644;10245.282830201815;10357.585696572203;12542.372881355896;12609.684757880943;12617.432215550321;12637.43131559082;12639.304838233986;7715.961420192863;7935.365170786324;7953.363730901514;8008.599570021592;8036.147167755479;7262.636868156571;7714.190010048977;8059.959700201579;8103.432759706882;8261.545614991233;3948.2498325318097;3955.1891862168186;3970.146418520032;4012.0972781124597;4045.37296719009;1617.7007253658112;1627.7395616701508;1867.7571915650879;1910.4555201767707;1911.4552352579449;834.5785378383878;858.1932982995963;894.7852515396258;928.8374534456443;941.8932754014006;19922.60154796925;21236.575268494544;21392.14431422726;21467.57064858694;21494;900.9773906615907;913.4930113786912;919.3380765848578;940.849464085743;973.8928717841031;9350.57922393494;10372.700267105958;10681.839772403264;11064.889351106547;11215.775684486427;478045;482623;485073;570151;575988.1200593971;112206;137592;144175.2791236058;145337;146262.26868865587;866.9479831210148;941.8445956417114;993.7167907146429;1008.9495525223709;1010.1060561403211;18815.529611759815;19653.705194422382;19659.803401965797;19698.704519431933;19725;48199;53328.40014799562;55295.44704553064;55759;57516;80120.59939700265;81997.18002820134;82093;82374.58812705897;86582;6806.625635589892;7879.330256928225;8085.474444161111;8145.185481451807;8339.416240863082;12703.682407939876;12882.48470061187;13180;13181.670458238621;13204.27376494302;11152.926437615626;11185.608503702657;11308.264962777394;11381.54473821071;11484;11085.672008878226;11132.053775428856;11145.442727863736;11179.776404472028;11328.433578321215;11031.22781405294;11045.944770276097;11289.435528223721;11384.97535221834;11702.531898724295;8003.559804210824;8073.19268073188;8136;8186.467879587808;8289.4197406181;10401.53193106297;10866;10926.617568385069;11061.059809916247;11282.266652667551 06:53:04 INFO - PROCESS | 1640 | |3;mootools.html;1300.6878349196195;1435.6267370483674;1460.160407765535;1598.8081430228374;1789.7673302470669;7403.925960740397;7807.414443916715;7810.648520816556;7811.375089992801;7822.960885195566;7644.312011918926;7863.370930325575;8172.713955011576;8179.754607361774;8210.958945205266;2275.8634481931135;2330;2331.73185083715;2339.2046704120594;2339.8479098858606;2313.456337760625;2334.1363695432715;2335.4044718596733;2372.1697405907967;2375.1212051540956;2308.376738280663;2315.4442933695877;2342.1334106380577;2347.295811256625;2351.271105957159;1954.2085455390518;2292.89681964312;2306.423394151462;2323.2797832671927;2326.2090889097617;2308.8499247549025;2333.5916214662534;2336.836421450499;2337.018452250059;2340.099061861196;8158.551279679616;8190.180981901822;8265.752027439186;8267.090620031851;8268.421210515266;4996.075725990703;5068.265101560253;5230.267762513213;5233.4243233244315;5240.056789777838;3458.948115778265;3562.590302115264;3565.447355659877;3567.4292113262013;3567.7502574819773;1032.267090365841;1057.6404022632341;1061.6072053340235;1070.2187403195633;1078.563181911327;10625;10785.730356741065;10872.402017888933;10874.891251087467;10884.782304353948;4639.9536004640195;4665.930011049837;4674.11191873543;4703.45910220329;4761.214399624023;9319.440833550008;9515.191208747196;9522.285828562886;9528.904710952802;9537.14165725088;4489.730616162975;5254.290670759398;5257.185136303879;5261.210818377198;5268.9736551317;3927.587603301612;4237.258479766028;4713.952860471351;4780.450248221429;4793.544613261734;3287.375398674244;3498.1254686328416;3651.8721844735837;3694.4458331250526;3730.3844865597416;1248.3945286536023;1258.3205069262497;1262.8610852806185;1274.20362273579;1276.6616846535676;766.9003029606115;795.9562224077731;881.6209030116983;892.433304851424;917.7017469322496;5407.351117865803;5469.917951230735;5581.832545023656;5593.216949627055;5748.741306641211;422.9788510574459;440.19883811463467;453.57590652739793;454.34120525238535;456.29046832176283;3655.3420384330543;3730.981345093257;3781.243751249706;3887.3002859485;3890.7665540067687;9697.6605818796;9988.450635215133;10042.497875106215;10052.64815731446;10078.798424031478;9532.285078618992;9934.15559677421;9946.303758736818;10035.749106272402;10045.899541004497;7614.466987310946;7817.10103338112;7817.257360550739;7834.921650783534;7836.92163078362;5554.75003624846;5575.8884822304135;5581.134924086773;5690.118031705092;5797.565182611405;9421.434713917188;9432.292578056537;9455.858162127712;9463.337566370288;9466.621335146518;9101.681441149529;9141.634334626806;9433.386829856037;9604.66383676568;9606.951965240129;6133.815985520441;7105.218425973036;7125.572465652078;7224.422046236394;7238.27617238272;7690.9230907692445;7794.376449883882;7795.298423141944;7799.45403821727;7801.882971755542;6563.113979612882;6667.599944003376;6908.221482372443;7103.609301488468;7233.63831808418;6629.502787290876;6759.966200168968;6842.281560436082;6870.7595234166565;6959.721611135498;6422.32565580626;6567.146270984741;6651.135352404156;6724.092247546519;6726.091977582963;4668.5564871337165;4712.340272361804;4722.669413141047;4738.976305118453;4749.762511874462;4776.546228108324;4799.472058073679;4821.180399332192;4963.429205641253;4971.453140154653 06:53:04 INFO - PROCESS | 1640 | |4;prototype.html;298.7893535057784;301.2919638848706;305.7783107247246;311.69765327632206;312.63421796498096;4429.224885645011;4880.755962201893;4881.755912204393;5019.623528235379;5112.667676601023;3548.970798468441;4600.884977875555;4995.90335924542;5018.899622007558;5025.597952163827;3093.6287645482575;3784.6972242220554;3895.357266051098;3897.2400381925536;3899.863504777333;2912.301047748536;3911.3350730375905;3922.411638254256;3931.9017024574327;3933.724639275252;3365.4951757236367;3705.8511861323077;3913.4129880518008;3921.666658334045;3922.195949830278;3913.6909223557955;3913.710479369572;3916.1580260244186;3921.4313924480934;3930.233604447134;2862.153910727569;3447.5518182636097;3477.3566890125153;3479.3563190809527;3486.703630191437;4495.347744830566;4580;4651.813927442899;4992.925106123411;5028.421731500851;4385.101054283864;4395.7911574316995;4419.62433193179;4431.158079964796;4463.575960283801;4339.1972485090355;4527.890666786659;4665.174556863373;5264;5284.410638786967;3093.8143711377165;3690.7047436205307;3698.260347930425;3698.778073315583;3699.408094704834;5184.662996905189;5207.114790485626;5395.78416863325;5548.667079975134;5577.358603760579;3444.50054742061;3682.779033258013;3734.738568300193;3748.925021499609;3777.414500752333;3119.5476655885222;3490.5985811631986;3676.4117741161285;3734.3838266685693;3813.599572044951;3755.267722794029;4341.175176716414;4356.564343565618;4362.825486980549;4377.876729786051;4204.810783514749;4324.870253892388;5195.636305458582;5293.8882834605165;5349.812756553502;1188.453311476713;1190.856777493616;1191;1206.4570943075475;1221.5968730318973;735.1545722419261;764.2930289482318;828.8383765165735;844.6748002019267;852.9658813647385;4117.91764164721;4257.297545904953;4410.514843367227;4512.323151527297;4804.366515384786;4353.73877567347;4425.690201685851;5196.376434827845;5196.45437229093;5231.738413079331;4069.898252543651;4303.505096913832;4403.405540252089;5059.357262770873;5134.8973020540125;2328.755480674539;2525.4065294655743;2730.494858451193;2743.547314693053;2745.958810617842;4450.287953927421;4481.7983190756495;4516.485871032946;5361.249425080492;5378.2470454136455;5137.944822071201;5260.473952604709;5323.528236281542;5362.463753624685;5398.73006349681;4968.317108761228;4976.830444845458;5371.3822910365025;5378.1663842104535;5391.245225668409;4324.875532361546;4617.722936623813;5071.644984851173;5241.895162096813;5304.655197412156;4632.444106707217;5545.476808052246;5558.944410555842;5561.6384934980715;5566.860828479321;4967.119070938919;5040.067587496325;5054.721990290569;5712.34376015155;5717.656940583578;3159.842007899642;3510.508528805918;3794.8102594869592;3820.484234628401;3824.2160357127277;4991.625628077982;5436.184572314026;5444.156155795858;5493.533049690661;5509.559235261249;4701.388819453449;4911.4106307243355;5172.069027574922;5314.867128321823;5363.310557174477;4503.369528266111;5032.6784322347075;5369.167778994262;5372.8716969436855;5406.51341379262;4529.554040817921;5076.416212135504;5220.869478263074;5282.577393808409;5296.496832800878;4670.509596492455;5068.6451948363265;5289.259503669412;5329.973350133225;5331.493508116722;4192.68554858393;4340.956590434055;5329.573634109184;5336.67979921206;5339.946600533945 06:53:04 INFO - PROCESS | 1640 | |5;yui.html;657.648158235344;755.9546427214367;761.5621017914699;778.0235804065896;784.1110674941738;13916.512922047717;14507.782383264246;14681.999999999973;14703.48537801176;14703.558893233194;10983.39591322479;13031.674208144801;14040.859591404109;14453.13281203126;14593.854061459382;638.415849497709;784.6704384158638;808.7412028150994;809.522381794741;809.7530253272749;648.503894520692;771.3790398729021;791.5013541468867;792.9563873986957;795.2087672765606;846.0524212881581;848.6605357856845;848.9151084891523;849.5454931611589;850.1201256699318;839.8824164616958;840.0717207485762;841.2891107014563;842.4061036968923;842.9915700843005;495.09397802022573;503.67009608706354;596.7911231069135;611.5535658968978;614.5912967876357;14258.928705356511;14273.571792846127;14316.928415357961;14328.283585820667;14334.28328583577;12329.93835030828;12525.185862918881;12674.61976140708;12690.682732931658;12835.021143445469;12044.457999390048;12126.757464850742;12205;12220.205686630341;12263.75472490554;4244.766537840417;4255.936160957588;4330.675199360061;4353.804078816461;4479.3057076153245;81547;84111.15888841095;84428.57785711031;84484.15515844824;84882.15117848804;9933.552990115462;10089.29374943747;10146.543405546769;10165.390076595428;10171.84742228867;18888.71666924997;18963.905180474285;19025.14386852595;19130;19162.04189790533;7322.3775979042375;7446.59043752588;7457.32884040439;7556.773296801105;7619.542827430372;3987.7009224308295;4010.0776821331256;4166.645835103989;4223.809928553223;4344.739315641008;3211.935761284761;3306.5205545195813;3340.4488259437408;3340.5657264555452;3347.866085356607;549.4450604889091;621.564904566805;625.4996003197424;633.0409429713987;637.4517914593446;464.50530185353165;512.5745631126156;548.235211879426;592.5052581094834;595.3778301674673;8252.235501107076;8491.490510569261;8559.957200214083;8660.960684717875;8708.564571771387;607.1075518987082;610.6671863834221;614.649649699667;625.9593126446857;628.0829988217163;3608.4948107265004;3990.6408423242046;4173.728707634054;4279.901392972796;4314.460692413449;49149;63945;64726;111027;112893;97081.51459242658;97384;97947;98673;98728;82542;83761.16238837656;86775.56612216898;87170.1282987162;87947;7819.347488244485;8077.5961201940845;8173.18268173178;8198;8258.42191046621;53010;53935.46064539461;54017.459825401245;54122.91754164973;56149;57604.71197643985;72670;75162.62418687872;75785.62107189429;78649;9841.212702983601;10026.799464010825;10250.846237306596;10281.74295642615;10597.046265836112;11364.602238921598;11612.825807613062;13750.65623359384;13865.72268554603;14065.156090634595;12660.683482912633;12736.74526509483;12790.68023299425;13032.739345213233;13146.474141034252;12512.74974500523;12998.350082495648;13056.608301750963;13215.471381145031;13456.05807593459;12317.44571494267;12506.499740010298;12609.369531523203;12648.43082061291;12698.873011269769;10847.837282440612;10984.835227471434;11007.394593297126;11289.096872250364;11317;10991.725206869893;11288.209825312479;11417.828732568853;11506.252093613888;11520.481578329163 06:53:04 INFO - PROCESS | 1640 | __end_tp_report 06:53:04 INFO - PROCESS | 1640 | __start_cc_report 06:53:04 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1819 06:53:04 INFO - PROCESS | 1640 | __end_cc_report 06:53:04 INFO - PROCESS | 1640 | __startTimestamp1482331984577__endTimestamp 06:53:04 INFO - PROCESS | 1640 | 06:53:04 INFO - PROCESS | 1640 | ------- Summary: start ------- 06:53:04 INFO - PROCESS | 1640 | Number of tests: 6 06:53:04 INFO - PROCESS | 1640 | 06:53:04 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5690.29 Median:5878.50 stddev:645.44 (11.0%) stddev-sans-first:617.35 06:53:04 INFO - PROCESS | 1640 | Values: 3208.2 3303.9 3336.7 3346.5 3389.6 5655.8 5663.4 5692.2 5695.7 5724.3 5609.6 5617.7 5638.6 5674.6 5753.7 5190.2 5217.7 5220.6 5242.4 5273.8 4426.9 5203.9 5207.6 5212.4 5247.4 5236.7 5248.4 5249.1 5260.8 5276.2 5166.9 5196.3 5257.3 5269.8 5270.3 5152.4 5178.6 5257.0 5263.0 5292.6 5703.2 5757.7 5794.8 5818.0 5820.7 5660.6 6008.8 6113.7 6122.4 6145.9 6171.9 6271.7 6279.6 6302.1 6360.1 5775.1 5829.4 5833.7 5838.6 5882.3 6182.2 6237.8 6255.6 6321.7 6325.5 6048.7 6104.2 6138.8 6168.0 6175.8 5227.8 6249.6 6258.4 6272.7 6284.3 5885.3 6183.6 6238.8 6255.6 6277.5 6006.5 6049.5 6116.4 6129.7 6132.6 4822.4 4835.0 4839.8 4851.2 4853.3 4319.9 4386.2 4436.3 4454.0 4456.9 4690.0 5427.0 5785.5 5787.0 5825.0 5563.8 6299.5 6328.3 6337.5 6385.7 5317.8 5551.2 5611.3 5645.5 5778.2 5362.6 5387.5 5416.6 5426.7 5441.6 6306.1 6331.7 6334.0 6337.6 6338.1 6055.1 6122.3 6287.2 6289.5 6297.1 4859.6 6207.4 6223.6 6261.8 6271.0 6162.8 6168.8 6168.9 6176.2 6190.5 5987.6 6093.2 6182.2 6236.3 6266.4 5836.1 5878.5 5937.9 5949.7 5993.8 6057.7 6060.8 6076.3 6076.9 6093.3 5869.4 5894.5 5895.6 5901.8 5904.1 5933.4 5961.2 5969.7 6016.5 6022.8 5853.3 5873.2 5879.6 5915.1 5922.7 06:53:04 INFO - PROCESS | 1640 | 06:53:04 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:64342.45 Median:36805.26 stddev:143755.63 (390.6%) stddev-sans-first:144078.90 06:53:04 INFO - PROCESS | 1640 | Values: 466.1 487.9 496.9 497.9 522.3 27982.0 30823.8 30877.8 34906.7 37530.1 39374.0 39916.0 39924.8 40032.8 40038.6 9319.8 9482.2 9498.9 9502.8 9516.7 8242.4 9345.4 9455.0 9458.1 9458.7 9436.8 9452.5 9462.6 9472.0 9472.0 9391.9 9437.0 9456.4 9463.5 9473.1 9332.7 9393.2 9397.7 9401.9 9417.8 38250.0 38462.4 38487.8 38489.8 38593.6 3439.4 3497.5 3676.4 3853.5 3880.7 27931.0 28352.4 29495.3 29787.0 30348.4 3153.8 3191.2 3219.5 3322.0 3331.9 464323.0 472089.0 473879.6 474082.0 474168.0 32877.0 57870.0 58251.0 58252.0 58272.7 33476.3 34630.3 34690.1 34709.3 34732.3 13666.5 13816.0 13817.1 13821.7 13825.9 11502.3 11538.9 11575.7 11585.9 11599.3 7733.2 7758.7 7759.6 7836.7 7843.3 3179.0 3238.3 3244.2 3245.6 3278.4 900.3 923.0 928.8 963.6 1114.7 24449.0 25410.5 25695.5 28698.7 28942.3 1006.7 1008.9 1088.8 1090.4 1098.6 11868.5 14225.6 14736.6 14865.9 15046.8 640665.0 643319.0 645376.0 647509.0 649906.0 53372.0 53929.7 54001.0 54074.7 54320.0 1331.5 1361.6 1377.3 1380.1 1382.6 27621.0 27899.0 28113.0 28879.6 28942.6 47971.8 48275.3 48391.5 48406.8 48525.8 402449.0 484391.0 488977.0 493674.5 495002.0 25530.0 25780.6 26042.6 26115.8 26211.3 35860.8 43902.8 44346.6 44477.0 44667.6 36475.6 36847.6 36869.4 37086.3 37174.8 29922.6 35988.3 36142.6 36748.6 36762.9 35249.6 35763.5 36070.0 36095.0 36641.6 31953.7 32146.8 32437.5 33036.0 33176.8 23470.6 24236.4 24531.8 24616.1 24821.3 06:53:04 INFO - PROCESS | 1640 | 06:53:04 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:32946.88 Median:2554.99 stddev:88247.69 (3453.9%) stddev-sans-first:88461.31 06:53:04 INFO - PROCESS | 1640 | Values: 352.0 371.0 376.2 381.4 402.1 14778.6 15546.5 15778.8 20318.3 20748.0 17130.1 19451.3 19894.8 20411.5 20788.0 5704.8 5845.5 5970.7 5979.7 5982.2 5103.7 6545.9 6620.8 6660.6 6666.2 5663.0 5951.2 6608.9 6610.6 6613.4 5968.0 5992.9 6001.6 6003.0 6026.9 5616.4 5794.7 5816.5 5891.6 5902.5 13293.1 13548.4 13569.5 22187.3 24658.8 2246.4 2545.8 2564.2 2811.7 2927.2 10051.3 10051.6 10133.3 10454.6 10517.2 1805.6 1817.0 1838.6 1905.5 1909.2 117915.4 119276.8 124107.0 125050.4 125217.4 9337.9 9899.3 10092.4 10245.3 10357.6 12542.4 12609.7 12617.4 12637.4 12639.3 7716.0 7935.4 7953.4 8008.6 8036.1 7262.6 7714.2 8060.0 8103.4 8261.5 3948.2 3955.2 3970.1 4012.1 4045.4 1617.7 1627.7 1867.8 1910.5 1911.5 834.6 858.2 894.8 928.8 941.9 19922.6 21236.6 21392.1 21467.6 21494.0 901.0 913.5 919.3 940.8 973.9 9350.6 10372.7 10681.8 11064.9 11215.8 478045.0 482623.0 485073.0 570151.0 575988.1 112206.0 137592.0 144175.3 145337.0 146262.3 866.9 941.8 993.7 1008.9 1010.1 18815.5 19653.7 19659.8 19698.7 19725.0 48199.0 53328.4 55295.4 55759.0 57516.0 80120.6 81997.2 82093.0 82374.6 86582.0 6806.6 7879.3 8085.5 8145.2 8339.4 12703.7 12882.5 13180.0 13181.7 13204.3 11152.9 11185.6 11308.3 11381.5 11484.0 11085.7 11132.1 11145.4 11179.8 11328.4 11031.2 11045.9 11289.4 11385.0 11702.5 8003.6 8073.2 8136.0 8186.5 8289.4 10401.5 10866.0 10926.6 11061.1 11282.3 06:53:04 INFO - PROCESS | 1640 | 06:53:04 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5379.42 Median:4983.76 stddev:2968.25 (59.6%) stddev-sans-first:2960.75 06:53:04 INFO - PROCESS | 1640 | Values: 1300.7 1435.6 1460.2 1598.8 1789.8 7403.9 7807.4 7810.6 7811.4 7823.0 7644.3 7863.4 8172.7 8179.8 8211.0 2275.9 2330.0 2331.7 2339.2 2339.8 2313.5 2334.1 2335.4 2372.2 2375.1 2308.4 2315.4 2342.1 2347.3 2351.3 1954.2 2292.9 2306.4 2323.3 2326.2 2308.8 2333.6 2336.8 2337.0 2340.1 8158.6 8190.2 8265.8 8267.1 8268.4 4996.1 5068.3 5230.3 5233.4 5240.1 3458.9 3562.6 3565.4 3567.4 3567.8 1032.3 1057.6 1061.6 1070.2 1078.6 10625.0 10785.7 10872.4 10874.9 10884.8 4640.0 4665.9 4674.1 4703.5 4761.2 9319.4 9515.2 9522.3 9528.9 9537.1 4489.7 5254.3 5257.2 5261.2 5269.0 3927.6 4237.3 4714.0 4780.5 4793.5 3287.4 3498.1 3651.9 3694.4 3730.4 1248.4 1258.3 1262.9 1274.2 1276.7 766.9 796.0 881.6 892.4 917.7 5407.4 5469.9 5581.8 5593.2 5748.7 423.0 440.2 453.6 454.3 456.3 3655.3 3731.0 3781.2 3887.3 3890.8 9697.7 9988.5 10042.5 10052.6 10078.8 9532.3 9934.2 9946.3 10035.7 10045.9 7614.5 7817.1 7817.3 7834.9 7836.9 5554.8 5575.9 5581.1 5690.1 5797.6 9421.4 9432.3 9455.9 9463.3 9466.6 9101.7 9141.6 9433.4 9604.7 9607.0 6133.8 7105.2 7125.6 7224.4 7238.3 7690.9 7794.4 7795.3 7799.5 7801.9 6563.1 6667.6 6908.2 7103.6 7233.6 6629.5 6760.0 6842.3 6870.8 6959.7 6422.3 6567.1 6651.1 6724.1 6726.1 4668.6 4712.3 4722.7 4739.0 4749.8 4776.5 4799.5 4821.2 4963.4 4971.5 06:53:04 INFO - PROCESS | 1640 | 06:53:04 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4205.15 Median:4514.40 stddev:1284.54 (28.5%) stddev-sans-first:1254.23 06:53:04 INFO - PROCESS | 1640 | Values: 298.8 301.3 305.8 311.7 312.6 4429.2 4880.8 4881.8 5019.6 5112.7 3549.0 4600.9 4995.9 5018.9 5025.6 3093.6 3784.7 3895.4 3897.2 3899.9 2912.3 3911.3 3922.4 3931.9 3933.7 3365.5 3705.9 3913.4 3921.7 3922.2 3913.7 3913.7 3916.2 3921.4 3930.2 2862.2 3447.6 3477.4 3479.4 3486.7 4495.3 4580.0 4651.8 4992.9 5028.4 4385.1 4395.8 4419.6 4431.2 4463.6 4339.2 4527.9 4665.2 5264.0 5284.4 3093.8 3690.7 3698.3 3698.8 3699.4 5184.7 5207.1 5395.8 5548.7 5577.4 3444.5 3682.8 3734.7 3748.9 3777.4 3119.5 3490.6 3676.4 3734.4 3813.6 3755.3 4341.2 4356.6 4362.8 4377.9 4204.8 4324.9 5195.6 5293.9 5349.8 1188.5 1190.9 1191.0 1206.5 1221.6 735.2 764.3 828.8 844.7 853.0 4117.9 4257.3 4410.5 4512.3 4804.4 4353.7 4425.7 5196.4 5196.5 5231.7 4069.9 4303.5 4403.4 5059.4 5134.9 2328.8 2525.4 2730.5 2743.5 2746.0 4450.3 4481.8 4516.5 5361.2 5378.2 5137.9 5260.5 5323.5 5362.5 5398.7 4968.3 4976.8 5371.4 5378.2 5391.2 4324.9 4617.7 5071.6 5241.9 5304.7 4632.4 5545.5 5558.9 5561.6 5566.9 4967.1 5040.1 5054.7 5712.3 5717.7 3159.8 3510.5 3794.8 3820.5 3824.2 4991.6 5436.2 5444.2 5493.5 5509.6 4701.4 4911.4 5172.1 5314.9 5363.3 4503.4 5032.7 5369.2 5372.9 5406.5 4529.6 5076.4 5220.9 5282.6 5296.5 4670.5 5068.6 5289.3 5330.0 5331.5 4192.7 4341.0 5329.6 5336.7 5339.9 06:53:04 INFO - PROCESS | 1640 | 06:53:04 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:19459.36 Median:24806.75 stddev:28128.11 (113.4%) stddev-sans-first:28171.59 06:53:04 INFO - PROCESS | 1640 | Values: 657.6 756.0 761.6 778.0 784.1 13916.5 14507.8 14682.0 14703.5 14703.6 10983.4 13031.7 14040.9 14453.1 14593.9 638.4 784.7 808.7 809.5 809.8 648.5 771.4 791.5 793.0 795.2 846.1 848.7 848.9 849.5 850.1 839.9 840.1 841.3 842.4 843.0 495.1 503.7 596.8 611.6 614.6 14258.9 14273.6 14316.9 14328.3 14334.3 12329.9 12525.2 12674.6 12690.7 12835.0 12044.5 12126.8 12205.0 12220.2 12263.8 4244.8 4255.9 4330.7 4353.8 4479.3 81547.0 84111.2 84428.6 84484.2 84882.2 9933.6 10089.3 10146.5 10165.4 10171.8 18888.7 18963.9 19025.1 19130.0 19162.0 7322.4 7446.6 7457.3 7556.8 7619.5 3987.7 4010.1 4166.6 4223.8 4344.7 3211.9 3306.5 3340.4 3340.6 3347.9 549.4 621.6 625.5 633.0 637.5 464.5 512.6 548.2 592.5 595.4 8252.2 8491.5 8560.0 8661.0 8708.6 607.1 610.7 614.6 626.0 628.1 3608.5 3990.6 4173.7 4279.9 4314.5 49149.0 63945.0 64726.0 111027.0 112893.0 97081.5 97384.0 97947.0 98673.0 98728.0 82542.0 83761.2 86775.6 87170.1 87947.0 7819.3 8077.6 8173.2 8198.0 8258.4 53010.0 53935.5 54017.5 54122.9 56149.0 57604.7 72670.0 75162.6 75785.6 78649.0 9841.2 10026.8 10250.8 10281.7 10597.0 11364.6 11612.8 13750.7 13865.7 14065.2 12660.7 12736.7 12790.7 13032.7 13146.5 12512.7 12998.4 13056.6 13215.5 13456.1 12317.4 12506.5 12609.4 12648.4 12698.9 10847.8 10984.8 11007.4 11289.1 11317.0 10991.7 11288.2 11417.8 11506.3 11520.5 06:53:04 INFO - PROCESS | 1640 | -------- Summary: end -------- 06:53:04 INFO - PROCESS | 1640 | 06:53:05 INFO - TEST-INFO | 1640: exit 0 06:53:05 INFO - TEST-OK | dromaeo_css | took 1121113ms 06:53:05 INFO - TEST-START | kraken 06:53:05 INFO - operating with platform_type : mac_ 06:53:05 INFO - Initialising browser for kraken test... 06:53:05 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmp8r15uG/profile http://localhost:49235/getInfo.html) 06:53:07 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 06:53:07 INFO - PROCESS | 1650 | colorDepth:24 06:53:07 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 06:53:07 INFO - PROCESS | 1650 | __metrics 06:53:07 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:53:07 INFO - PROCESS | 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:53:08 INFO - TEST-INFO | 1650: exit 0 06:53:08 INFO - Browser initialized. 06:53:08 INFO - Running cycle 1/1 for kraken test... 06:53:08 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmp8r15uG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:53:21 INFO - PROCESS | 1651 | RSS: Main: 222527488 06:53:21 INFO - PROCESS | 1651 | 06:53:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 06:53:24 INFO - PROCESS | 1651 | RSS: Main: 272420864 06:53:24 INFO - PROCESS | 1651 | 06:53:27 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 06:53:27 INFO - PROCESS | 1651 | RSS: Main: 283938816 06:53:27 INFO - PROCESS | 1651 | 06:53:30 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 06:53:31 INFO - PROCESS | 1651 | RSS: Main: 380088320 06:53:31 INFO - PROCESS | 1651 | 06:53:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 06:53:34 INFO - PROCESS | 1651 | RSS: Main: 283865088 06:53:34 INFO - PROCESS | 1651 | 06:53:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:53:36 INFO - PROCESS | 1651 | RSS: Main: 284758016 06:53:36 INFO - PROCESS | 1651 | 06:53:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 06:53:40 INFO - PROCESS | 1651 | RSS: Main: 325685248 06:53:40 INFO - PROCESS | 1651 | 06:53:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 06:53:43 INFO - PROCESS | 1651 | RSS: Main: 327737344 06:53:43 INFO - PROCESS | 1651 | 06:53:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 06:53:47 INFO - PROCESS | 1651 | RSS: Main: 323817472 06:53:47 INFO - PROCESS | 1651 | 06:53:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:53:49 INFO - PROCESS | 1651 | RSS: Main: 299397120 06:53:49 INFO - PROCESS | 1651 | 06:53:51 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:53:52 INFO - PROCESS | 1651 | RSS: Main: 302149632 06:53:52 INFO - PROCESS | 1651 | 06:53:54 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:53:54 INFO - PROCESS | 1651 | RSS: Main: 304615424 06:53:54 INFO - PROCESS | 1651 | 06:53:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:53:58 INFO - PROCESS | 1651 | RSS: Main: 318222336 06:53:58 INFO - PROCESS | 1651 | 06:54:01 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:54:02 INFO - PROCESS | 1651 | RSS: Main: 312188928 06:54:02 INFO - PROCESS | 1651 | 06:54:03 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 06:54:04 INFO - PROCESS | 1651 | RSS: Main: 356130816 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | __start_tp_report 06:54:04 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 06:54:04 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 06:54:04 INFO - PROCESS | 1651 | |i|pagename|runs| 06:54:04 INFO - PROCESS | 1651 | |0;ai-astar;116;116;116;116;116;116;115;115;114;114 06:54:04 INFO - PROCESS | 1651 | |1;audio-beat-detection;146;109;110;142;121;111;109;110;139;109 06:54:04 INFO - PROCESS | 1651 | |2;audio-dft;183;182;184;185;181;186;183;183;182;184 06:54:04 INFO - PROCESS | 1651 | |3;audio-fft;81;63;59;96;85;82;82;59;83;57 06:54:04 INFO - PROCESS | 1651 | |4;audio-oscillator;88;71;96;70;69;71;89;67;71;92 06:54:04 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;89;85;89;87;88;85;125;86;88;86 06:54:04 INFO - PROCESS | 1651 | |6;imaging-darkroom;108;97;97;97;97;96;98;123;163;113 06:54:04 INFO - PROCESS | 1651 | |7;imaging-desaturate;81;81;79;81;81;83;84;82;80;84 06:54:04 INFO - PROCESS | 1651 | |8;json-parse-financial;57;54;53;53;58;58;59;58;58;58 06:54:04 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;64;79;86;107;103;96;104;72;70;72 06:54:04 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;89;83;82;83;84;83;82;83;83;98 06:54:04 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;140;139;138;141;139;142;160;153;189;141 06:54:04 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;166;166;166;165;167;163;163;163;164;164 06:54:04 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;69;74;85;86;82;75;68;67;66;64 06:54:04 INFO - PROCESS | 1651 | __end_tp_report 06:54:04 INFO - PROCESS | 1651 | __start_cc_report 06:54:04 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2035 06:54:04 INFO - PROCESS | 1651 | __end_cc_report 06:54:04 INFO - PROCESS | 1651 | __startTimestamp1482332044122__endTimestamp 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | ------- Summary: start ------- 06:54:04 INFO - PROCESS | 1651 | Number of tests: 14 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:0.84 (0.7%) stddev-sans-first:0.87 06:54:04 INFO - PROCESS | 1651 | Values: 116.0 116.0 116.0 116.0 116.0 116.0 115.0 115.0 114.0 114.0 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:120.60 Median:116.00 stddev:15.50 (13.4%) stddev-sans-first:13.44 06:54:04 INFO - PROCESS | 1651 | Values: 146.0 109.0 110.0 142.0 121.0 111.0 109.0 110.0 139.0 109.0 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:1.49 (0.8%) stddev-sans-first:1.58 06:54:04 INFO - PROCESS | 1651 | Values: 183.0 182.0 184.0 185.0 181.0 186.0 183.0 183.0 182.0 184.0 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:74.70 Median:82.00 stddev:13.82 (16.8%) stddev-sans-first:14.47 06:54:04 INFO - PROCESS | 1651 | Values: 81.0 63.0 59.0 96.0 85.0 82.0 82.0 59.0 83.0 57.0 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:79.50 stddev:11.32 (14.2%) stddev-sans-first:11.46 06:54:04 INFO - PROCESS | 1651 | Values: 88.0 71.0 96.0 70.0 69.0 71.0 89.0 67.0 71.0 92.0 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:87.50 stddev:12.11 (13.8%) stddev-sans-first:12.83 06:54:04 INFO - PROCESS | 1651 | Values: 89.0 85.0 89.0 87.0 88.0 85.0 125.0 86.0 88.0 86.0 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:108.90 Median:97.00 stddev:21.07 (21.7%) stddev-sans-first:22.34 06:54:04 INFO - PROCESS | 1651 | Values: 108.0 97.0 97.0 97.0 97.0 96.0 98.0 123.0 163.0 113.0 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:81.60 Median:81.50 stddev:1.65 (2.0%) stddev-sans-first:1.73 06:54:04 INFO - PROCESS | 1651 | Values: 81.0 81.0 79.0 81.0 81.0 83.0 84.0 82.0 80.0 84.0 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:58.00 stddev:2.32 (4.0%) stddev-sans-first:2.46 06:54:04 INFO - PROCESS | 1651 | Values: 57.0 54.0 53.0 53.0 58.0 58.0 59.0 58.0 58.0 58.0 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:85.30 Median:72.00 stddev:16.09 (22.3%) stddev-sans-first:15.11 06:54:04 INFO - PROCESS | 1651 | Values: 64.0 79.0 86.0 107.0 103.0 96.0 104.0 72.0 70.0 72.0 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:83.00 stddev:4.99 (6.0%) stddev-sans-first:5.08 06:54:04 INFO - PROCESS | 1651 | Values: 89.0 83.0 82.0 83.0 84.0 83.0 82.0 83.0 83.0 98.0 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:141.50 stddev:16.02 (11.3%) stddev-sans-first:16.71 06:54:04 INFO - PROCESS | 1651 | Values: 140.0 139.0 138.0 141.0 139.0 142.0 160.0 153.0 189.0 141.0 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.50 stddev:1.49 (0.9%) stddev-sans-first:1.51 06:54:04 INFO - PROCESS | 1651 | Values: 166.0 166.0 166.0 165.0 167.0 163.0 163.0 163.0 164.0 164.0 06:54:04 INFO - PROCESS | 1651 | 06:54:04 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.50 stddev:8.18 (11.0%) stddev-sans-first:8.51 06:54:04 INFO - PROCESS | 1651 | Values: 69.0 74.0 85.0 86.0 82.0 75.0 68.0 67.0 66.0 64.0 06:54:04 INFO - PROCESS | 1651 | -------- Summary: end -------- 06:54:04 INFO - PROCESS | 1651 | 06:54:05 INFO - TEST-INFO | 1651: exit 0 06:54:05 INFO - TEST-OK | kraken | took 59932ms 06:54:05 INFO - SUITE-END | took 1181s 06:54:05 INFO - Completed test suite (00:19:41) 06:54:05 INFO - javascript benchmark 06:54:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3208.246062175389, 3303.9008829735108, 3336.7497437692177, 3346.4980252962037, 3389.644087370826, 5655.830325090254, 5663.405342439047, 5692.231548740929, 5695.743691533876, 5724.284464441945, 5609.635373700707, 5617.657493791198, 5638.633488823234, 5674.631148975324, 5753.65478071316, 5190.195519694454, 5217.713025783581, 5220.582353411737, 5242.423333433319, 5273.76268067936, 4426.933595996046, 5203.895922081556, 5207.583393328525, 5212.374515058198, 5247.449017853109, 5236.7119808410525, 5248.370195576536, 5249.055170069386, 5260.8158714445, 5276.182191760283, 5166.896662066756, 5196.298499702568, 5257.290265814105, 5269.815556455544, 5270.288511050997, 5152.407473140599, 5178.611604129667, 5256.974889896472, 5263.0, 5292.550133238679, 5703.173039909231, 5757.712114394305, 5794.797182098607, 5817.970910145422, 5820.708964551755, 5660.575456840712, 6008.819735407945, 6113.663748493831, 6122.428649698669, 6145.877082458326, 6171.87656246877, 6271.686415679198, 6279.591826531307, 6302.117703521465, 6360.077788720656, 5775.104858746901, 5829.387914269026, 5833.711315027335, 5838.562107841929, 5882.264716910387, 6182.227221597301, 6237.844053898689, 6255.593386429868, 6321.683915804191, 6325.4939604832425, 6048.6673232971725, 6104.236970378703, 6138.815835524942, 6168.0439531872635, 6175.783847565313, 5227.790888364423, 6249.59377640461, 6258.405451482102, 6272.655003974825, 6284.340144284875, 5885.323187833454, 6183.598066125687, 6238.75044998195, 6255.593386429868, 6277.497800175975, 6006.489448396936, 6049.485793707496, 6116.3883611638485, 6129.662868542273, 6132.63204207749, 4822.42130944289, 4834.95165048352, 4839.782209800567, 4851.248056551241, 4853.320535125085, 4319.903692612328, 4386.210482113251, 4436.290193569013, 4454.042380888124, 4456.888577785581, 4690.038542098861, 5427.0, 5785.537157027427, 5786.987277226469, 5825.0, 5563.777448902079, 6299.496040316763, 6328.272248691459, 6337.461315788118, 6385.744570217139, 5317.750328672759, 5551.167324901297, 5611.3266408031295, 5645.5483561314995, 5778.219940308089, 5362.624616276823, 5387.515123638891, 5416.620836541483, 5426.728663566806, 5441.6190866639745, 6306.117143599808, 6331.651759153291, 6333.968330158227, 6337.6197428154455, 6338.080978258219, 6055.091736239599, 6122.326544080237, 6287.151234583455, 6289.49684025286, 6297.055441683784, 4859.635527335393, 6207.410296021871, 6223.626582405071, 6261.78083767066, 6270.968645156928, 6162.7534898605345, 6168.845778855564, 6168.907466387918, 6176.166217560752, 6190.50475961931, 5987.5808693391045, 6093.177421048279, 6182.165407670087, 6236.282827474898, 6266.436020758154, 5836.066229403275, 5878.500327472042, 5937.9406205937385, 5949.702514874326, 5993.820185394445, 6057.727402266997, 6060.757569697163, 6076.331603523698, 6076.936536106252, 6093.29927058394, 5869.35437101927, 5894.469497745224, 5895.6462612241685, 5901.822945311647, 5904.0553511437965, 5933.436323549256, 5961.195238642727, 5969.671668058299, 6016.5487588431915, 6022.849428764316, 5853.288482077703, 5873.236479257669, 5879.647221166743, 5915.08316210988, 5922.73347699346], "value": 5649.806530350879, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.1283400041921, 487.8658368948541, 496.87329730918634, 497.9319359972856, 522.3444577055795, 27982.02062927798, 30823.845880770594, 30877.845610771914, 34906.65093349066, 37530.061748456304, 39374.01564960877, 39916.0, 39924.80037599808, 40032.79983600078, 40038.59961400385, 9319.813603727938, 9482.241420686363, 9498.905010949906, 9502.762430939247, 9516.666916657918, 8242.423030387876, 9345.43927364357, 9454.952725236364, 9458.148766611004, 9458.716238512821, 9436.764080897998, 9452.480113593783, 9462.574184161695, 9472.0, 9472.005439428864, 9391.859122113174, 9436.961934187233, 9456.385334953206, 9463.526823658858, 9473.147416732527, 9332.67335643256, 9393.248540116843, 9397.718068457958, 9401.858972115424, 9417.764555886157, 38250.0437489065, 38462.42306365407, 38487.807560962014, 38489.80755096207, 38593.614063859284, 3439.4496880499, 3497.4928635347987, 3676.448532720087, 3853.537575490959, 3880.6701430378453, 27931.0, 28352.432951341063, 29495.26261843471, 29787.0, 30348.393032139455, 3153.7792354534963, 3191.1543440988157, 3219.4687876500348, 3321.96678033219, 3331.916702082443, 464323.0, 472089.0, 473879.63060184824, 474082.0, 474168.0, 32877.0, 57870.0, 58251.0, 58252.0, 58272.70863645655, 33476.33047339039, 34630.30739385198, 34690.13274668103, 34709.305813883584, 34732.30535389278, 13666.453341866412, 13816.0, 13817.101888377223, 13821.654458638413, 13825.930870345785, 11502.309861408343, 11538.94230528842, 11575.652730418102, 11585.942070289762, 11599.304041757521, 7733.188015258429, 7758.689652413953, 7759.612019399007, 7836.725714599962, 7843.333316668033, 3179.0, 3238.3199528098894, 3244.23760416302, 3245.626752923397, 3278.3607196596436, 900.3382513852313, 922.9907700923039, 928.8374534456443, 963.6097380560884, 1114.7380365614074, 24449.0, 25410.491790164095, 25695.48609027809, 28698.713012870023, 28942.276443089093, 1006.6527048168371, 1008.8940661230612, 1088.77135801481, 1090.3784842639777, 1098.6045023791428, 11868.525258989544, 14225.573232803032, 14736.590300861619, 14865.925670371795, 15046.774298385533, 640665.0, 643319.0, 645376.0, 647509.0, 649906.0, 53372.0, 53929.73035134878, 54001.0, 54074.72962635162, 54320.0, 1331.4873773597042, 1361.598328493097, 1377.2838124175373, 1380.0546625561522, 1382.6197795606088, 27621.03326383567, 27899.0, 28113.0, 28879.5668064975, 28942.565861511674, 47971.76014119907, 48275.27587086126, 48391.51608484011, 48406.757966209945, 48525.757371212916, 402449.0, 484391.0, 488977.0, 493674.53162733954, 495002.0, 25530.0, 25780.61329080103, 26042.60936085998, 26115.780158686724, 26211.34471638148, 35860.8206958974, 43902.78048609736, 44346.55653443424, 44477.0, 44667.55332446634, 36475.63524364722, 36847.63152368442, 36869.44695829618, 37086.25827483381, 37174.814125929195, 29922.551161732157, 35988.28023439569, 36142.63857361393, 36748.63251367452, 36762.89711308665, 35249.64750352463, 35763.46354804732, 36070.0, 36095.0, 36641.63358366489, 31953.721851125694, 32146.766977430827, 32437.51343729893, 33036.03567571907, 33176.83411582927, 23470.647940280567, 24236.39409014789, 24531.754682452945, 24616.138435154684, 24821.255362339158], "value": 17806.736272552353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.9612842587313, 370.9721770867185, 376.17617417854893, 381.4469019921114, 402.121364817873, 14778.556643300704, 15546.45587404441, 15778.842211577881, 20318.288859889908, 20748.0, 17130.05784681845, 19451.319203827832, 19894.801051989474, 20411.48971275719, 20788.0, 5704.800331988392, 5845.532357411397, 5970.6716130612795, 5979.730912108944, 5982.192404025444, 5103.719295438749, 6545.9018114728315, 6620.801375958705, 6660.633665148439, 6666.166729158856, 5663.0, 5951.196588460567, 6608.9339106608795, 6610.636414997173, 6613.437857782094, 5967.970160149193, 5992.940070599282, 6001.639901605918, 6002.96998515009, 6026.8794624107495, 5616.382197958222, 5794.739236734357, 5816.47651711348, 5891.617044892068, 5902.498287645555, 13293.135946163566, 13548.390322435416, 13569.457221711218, 22187.334379968626, 24658.753412466005, 2246.359787460582, 2545.8217924745277, 2564.1666458401096, 2811.690714021456, 2927.180389490946, 10051.296409251356, 10051.59793608262, 10133.290669653054, 10454.63408780689, 10517.211209159344, 1805.6388722255601, 1817.0, 1838.6414649143424, 1905.4950438133906, 1909.1981367825408, 117915.41042294819, 119276.80723192744, 124107.0, 125050.37474812567, 125217.37391313077, 9337.90662093384, 9899.317116090282, 10092.394456332644, 10245.282830201815, 10357.585696572203, 12542.372881355896, 12609.684757880943, 12617.432215550321, 12637.43131559082, 12639.304838233986, 7715.961420192863, 7935.365170786324, 7953.363730901514, 8008.599570021592, 8036.147167755479, 7262.636868156571, 7714.190010048977, 8059.959700201579, 8103.432759706882, 8261.545614991233, 3948.2498325318097, 3955.1891862168186, 3970.146418520032, 4012.0972781124597, 4045.37296719009, 1617.7007253658112, 1627.7395616701508, 1867.7571915650879, 1910.4555201767707, 1911.4552352579449, 834.5785378383878, 858.1932982995963, 894.7852515396258, 928.8374534456443, 941.8932754014006, 19922.60154796925, 21236.575268494544, 21392.14431422726, 21467.57064858694, 21494.0, 900.9773906615907, 913.4930113786912, 919.3380765848578, 940.849464085743, 973.8928717841031, 9350.57922393494, 10372.700267105958, 10681.839772403264, 11064.889351106547, 11215.775684486427, 478045.0, 482623.0, 485073.0, 570151.0, 575988.1200593971, 112206.0, 137592.0, 144175.2791236058, 145337.0, 146262.26868865587, 866.9479831210148, 941.8445956417114, 993.7167907146429, 1008.9495525223709, 1010.1060561403211, 18815.529611759815, 19653.705194422382, 19659.803401965797, 19698.704519431933, 19725.0, 48199.0, 53328.40014799562, 55295.44704553064, 55759.0, 57516.0, 80120.59939700265, 81997.18002820134, 82093.0, 82374.58812705897, 86582.0, 6806.625635589892, 7879.330256928225, 8085.474444161111, 8145.185481451807, 8339.416240863082, 12703.682407939876, 12882.48470061187, 13180.0, 13181.670458238621, 13204.27376494302, 11152.926437615626, 11185.608503702657, 11308.264962777394, 11381.54473821071, 11484.0, 11085.672008878226, 11132.053775428856, 11145.442727863736, 11179.776404472028, 11328.433578321215, 11031.22781405294, 11045.944770276097, 11289.435528223721, 11384.97535221834, 11702.531898724295, 8003.559804210824, 8073.19268073188, 8136.0, 8186.467879587808, 8289.4197406181, 10401.53193106297, 10866.0, 10926.617568385069, 11061.059809916247, 11282.266652667551], "value": 9351.056100677199, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.6878349196195, 1435.6267370483674, 1460.160407765535, 1598.8081430228374, 1789.7673302470669, 7403.925960740397, 7807.414443916715, 7810.648520816556, 7811.375089992801, 7822.960885195566, 7644.312011918926, 7863.370930325575, 8172.713955011576, 8179.754607361774, 8210.958945205266, 2275.8634481931135, 2330.0, 2331.73185083715, 2339.2046704120594, 2339.8479098858606, 2313.456337760625, 2334.1363695432715, 2335.4044718596733, 2372.1697405907967, 2375.1212051540956, 2308.376738280663, 2315.4442933695877, 2342.1334106380577, 2347.295811256625, 2351.271105957159, 1954.2085455390518, 2292.89681964312, 2306.423394151462, 2323.2797832671927, 2326.2090889097617, 2308.8499247549025, 2333.5916214662534, 2336.836421450499, 2337.018452250059, 2340.099061861196, 8158.551279679616, 8190.180981901822, 8265.752027439186, 8267.090620031851, 8268.421210515266, 4996.075725990703, 5068.265101560253, 5230.267762513213, 5233.4243233244315, 5240.056789777838, 3458.948115778265, 3562.590302115264, 3565.447355659877, 3567.4292113262013, 3567.7502574819773, 1032.267090365841, 1057.6404022632341, 1061.6072053340235, 1070.2187403195633, 1078.563181911327, 10625.0, 10785.730356741065, 10872.402017888933, 10874.891251087467, 10884.782304353948, 4639.9536004640195, 4665.930011049837, 4674.11191873543, 4703.45910220329, 4761.214399624023, 9319.440833550008, 9515.191208747196, 9522.285828562886, 9528.904710952802, 9537.14165725088, 4489.730616162975, 5254.290670759398, 5257.185136303879, 5261.210818377198, 5268.9736551317, 3927.587603301612, 4237.258479766028, 4713.952860471351, 4780.450248221429, 4793.544613261734, 3287.375398674244, 3498.1254686328416, 3651.8721844735837, 3694.4458331250526, 3730.3844865597416, 1248.3945286536023, 1258.3205069262497, 1262.8610852806185, 1274.20362273579, 1276.6616846535676, 766.9003029606115, 795.9562224077731, 881.6209030116983, 892.433304851424, 917.7017469322496, 5407.351117865803, 5469.917951230735, 5581.832545023656, 5593.216949627055, 5748.741306641211, 422.9788510574459, 440.19883811463467, 453.57590652739793, 454.34120525238535, 456.29046832176283, 3655.3420384330543, 3730.981345093257, 3781.243751249706, 3887.3002859485, 3890.7665540067687, 9697.6605818796, 9988.450635215133, 10042.497875106215, 10052.64815731446, 10078.798424031478, 9532.285078618992, 9934.15559677421, 9946.303758736818, 10035.749106272402, 10045.899541004497, 7614.466987310946, 7817.10103338112, 7817.257360550739, 7834.921650783534, 7836.92163078362, 5554.75003624846, 5575.8884822304135, 5581.134924086773, 5690.118031705092, 5797.565182611405, 9421.434713917188, 9432.292578056537, 9455.858162127712, 9463.337566370288, 9466.621335146518, 9101.681441149529, 9141.634334626806, 9433.386829856037, 9604.66383676568, 9606.951965240129, 6133.815985520441, 7105.218425973036, 7125.572465652078, 7224.422046236394, 7238.27617238272, 7690.9230907692445, 7794.376449883882, 7795.298423141944, 7799.45403821727, 7801.882971755542, 6563.113979612882, 6667.599944003376, 6908.221482372443, 7103.609301488468, 7233.63831808418, 6629.502787290876, 6759.966200168968, 6842.281560436082, 6870.7595234166565, 6959.721611135498, 6422.32565580626, 6567.146270984741, 6651.135352404156, 6724.092247546519, 6726.091977582963, 4668.5564871337165, 4712.340272361804, 4722.669413141047, 4738.976305118453, 4749.762511874462, 4776.546228108324, 4799.472058073679, 4821.180399332192, 4963.429205641253, 4971.453140154653], "value": 4290.537719303558, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.7893535057784, 301.2919638848706, 305.7783107247246, 311.69765327632206, 312.63421796498096, 4429.224885645011, 4880.755962201893, 4881.755912204393, 5019.623528235379, 5112.667676601023, 3548.970798468441, 4600.884977875555, 4995.90335924542, 5018.899622007558, 5025.597952163827, 3093.6287645482575, 3784.6972242220554, 3895.357266051098, 3897.2400381925536, 3899.863504777333, 2912.301047748536, 3911.3350730375905, 3922.411638254256, 3931.9017024574327, 3933.724639275252, 3365.4951757236367, 3705.8511861323077, 3913.4129880518008, 3921.666658334045, 3922.195949830278, 3913.6909223557955, 3913.710479369572, 3916.1580260244186, 3921.4313924480934, 3930.233604447134, 2862.153910727569, 3447.5518182636097, 3477.3566890125153, 3479.3563190809527, 3486.703630191437, 4495.347744830566, 4580.0, 4651.813927442899, 4992.925106123411, 5028.421731500851, 4385.101054283864, 4395.7911574316995, 4419.62433193179, 4431.158079964796, 4463.575960283801, 4339.1972485090355, 4527.890666786659, 4665.174556863373, 5264.0, 5284.410638786967, 3093.8143711377165, 3690.7047436205307, 3698.260347930425, 3698.778073315583, 3699.408094704834, 5184.662996905189, 5207.114790485626, 5395.78416863325, 5548.667079975134, 5577.358603760579, 3444.50054742061, 3682.779033258013, 3734.738568300193, 3748.925021499609, 3777.414500752333, 3119.5476655885222, 3490.5985811631986, 3676.4117741161285, 3734.3838266685693, 3813.599572044951, 3755.267722794029, 4341.175176716414, 4356.564343565618, 4362.825486980549, 4377.876729786051, 4204.810783514749, 4324.870253892388, 5195.636305458582, 5293.8882834605165, 5349.812756553502, 1188.453311476713, 1190.856777493616, 1191.0, 1206.4570943075475, 1221.5968730318973, 735.1545722419261, 764.2930289482318, 828.8383765165735, 844.6748002019267, 852.9658813647385, 4117.91764164721, 4257.297545904953, 4410.514843367227, 4512.323151527297, 4804.366515384786, 4353.73877567347, 4425.690201685851, 5196.376434827845, 5196.45437229093, 5231.738413079331, 4069.898252543651, 4303.505096913832, 4403.405540252089, 5059.357262770873, 5134.8973020540125, 2328.755480674539, 2525.4065294655743, 2730.494858451193, 2743.547314693053, 2745.958810617842, 4450.287953927421, 4481.7983190756495, 4516.485871032946, 5361.249425080492, 5378.2470454136455, 5137.944822071201, 5260.473952604709, 5323.528236281542, 5362.463753624685, 5398.73006349681, 4968.317108761228, 4976.830444845458, 5371.3822910365025, 5378.1663842104535, 5391.245225668409, 4324.875532361546, 4617.722936623813, 5071.644984851173, 5241.895162096813, 5304.655197412156, 4632.444106707217, 5545.476808052246, 5558.944410555842, 5561.6384934980715, 5566.860828479321, 4967.119070938919, 5040.067587496325, 5054.721990290569, 5712.34376015155, 5717.656940583578, 3159.842007899642, 3510.508528805918, 3794.8102594869592, 3820.484234628401, 3824.2160357127277, 4991.625628077982, 5436.184572314026, 5444.156155795858, 5493.533049690661, 5509.559235261249, 4701.388819453449, 4911.4106307243355, 5172.069027574922, 5314.867128321823, 5363.310557174477, 4503.369528266111, 5032.6784322347075, 5369.167778994262, 5372.8716969436855, 5406.51341379262, 4529.554040817921, 5076.416212135504, 5220.869478263074, 5282.577393808409, 5296.496832800878, 4670.509596492455, 5068.6451948363265, 5289.259503669412, 5329.973350133225, 5331.493508116722, 4192.68554858393, 4340.956590434055, 5329.573634109184, 5336.67979921206, 5339.946600533945], "value": 3802.4957947088396, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.648158235344, 755.9546427214367, 761.5621017914699, 778.0235804065896, 784.1110674941738, 13916.512922047717, 14507.782383264246, 14681.999999999973, 14703.48537801176, 14703.558893233194, 10983.39591322479, 13031.674208144801, 14040.859591404109, 14453.13281203126, 14593.854061459382, 638.415849497709, 784.6704384158638, 808.7412028150994, 809.522381794741, 809.7530253272749, 648.503894520692, 771.3790398729021, 791.5013541468867, 792.9563873986957, 795.2087672765606, 846.0524212881581, 848.6605357856845, 848.9151084891523, 849.5454931611589, 850.1201256699318, 839.8824164616958, 840.0717207485762, 841.2891107014563, 842.4061036968923, 842.9915700843005, 495.09397802022573, 503.67009608706354, 596.7911231069135, 611.5535658968978, 614.5912967876357, 14258.928705356511, 14273.571792846127, 14316.928415357961, 14328.283585820667, 14334.28328583577, 12329.93835030828, 12525.185862918881, 12674.61976140708, 12690.682732931658, 12835.021143445469, 12044.457999390048, 12126.757464850742, 12205.0, 12220.205686630341, 12263.75472490554, 4244.766537840417, 4255.936160957588, 4330.675199360061, 4353.804078816461, 4479.3057076153245, 81547.0, 84111.15888841095, 84428.57785711031, 84484.15515844824, 84882.15117848804, 9933.552990115462, 10089.29374943747, 10146.543405546769, 10165.390076595428, 10171.84742228867, 18888.71666924997, 18963.905180474285, 19025.14386852595, 19130.0, 19162.04189790533, 7322.3775979042375, 7446.59043752588, 7457.32884040439, 7556.773296801105, 7619.542827430372, 3987.7009224308295, 4010.0776821331256, 4166.645835103989, 4223.809928553223, 4344.739315641008, 3211.935761284761, 3306.5205545195813, 3340.4488259437408, 3340.5657264555452, 3347.866085356607, 549.4450604889091, 621.564904566805, 625.4996003197424, 633.0409429713987, 637.4517914593446, 464.50530185353165, 512.5745631126156, 548.235211879426, 592.5052581094834, 595.3778301674673, 8252.235501107076, 8491.490510569261, 8559.957200214083, 8660.960684717875, 8708.564571771387, 607.1075518987082, 610.6671863834221, 614.649649699667, 625.9593126446857, 628.0829988217163, 3608.4948107265004, 3990.6408423242046, 4173.728707634054, 4279.901392972796, 4314.460692413449, 49149.0, 63945.0, 64726.0, 111027.0, 112893.0, 97081.51459242658, 97384.0, 97947.0, 98673.0, 98728.0, 82542.0, 83761.16238837656, 86775.56612216898, 87170.1282987162, 87947.0, 7819.347488244485, 8077.5961201940845, 8173.18268173178, 8198.0, 8258.42191046621, 53010.0, 53935.46064539461, 54017.459825401245, 54122.91754164973, 56149.0, 57604.71197643985, 72670.0, 75162.62418687872, 75785.62107189429, 78649.0, 9841.212702983601, 10026.799464010825, 10250.846237306596, 10281.74295642615, 10597.046265836112, 11364.602238921598, 11612.825807613062, 13750.65623359384, 13865.72268554603, 14065.156090634595, 12660.683482912633, 12736.74526509483, 12790.68023299425, 13032.739345213233, 13146.474141034252, 12512.74974500523, 12998.350082495648, 13056.608301750963, 13215.471381145031, 13456.05807593459, 12317.44571494267, 12506.499740010298, 12609.369531523203, 12648.43082061291, 12698.873011269769, 10847.837282440612, 10984.835227471434, 11007.394593297126, 11289.096872250364, 11317.0, 10991.725206869893, 11288.209825312479, 11417.828732568853, 11506.252093613888, 11520.481578329163], "value": 7018.279274880469, "unit": "score"}], "name": "dromaeo_css", "value": 6897.994132201346, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 116.0, 116.0, 115.0, 115.0, 114.0, 114.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 109.0, 110.0, 142.0, 121.0, 111.0, 109.0, 110.0, 139.0, 109.0], "value": 120.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 184.0, 185.0, 181.0, 186.0, 183.0, 183.0, 182.0, 184.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 63.0, 59.0, 96.0, 85.0, 82.0, 82.0, 59.0, 83.0, 57.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 96.0, 70.0, 69.0, 71.0, 89.0, 67.0, 71.0, 92.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 87.0, 88.0, 85.0, 125.0, 86.0, 88.0, 86.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 97.0, 97.0, 97.0, 97.0, 96.0, 98.0, 123.0, 163.0, 113.0], "value": 108.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 79.0, 81.0, 81.0, 83.0, 84.0, 82.0, 80.0, 84.0], "value": 81.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 53.0, 53.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 79.0, 86.0, 107.0, 103.0, 96.0, 104.0, 72.0, 70.0, 72.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 82.0, 83.0, 84.0, 83.0, 82.0, 83.0, 83.0, 98.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 138.0, 141.0, 139.0, 142.0, 160.0, 153.0, 189.0, 141.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 166.0, 165.0, 167.0, 163.0, 163.0, 163.0, 164.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 85.0, 86.0, 82.0, 75.0, 68.0, 67.0, 66.0, 64.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1467.1, "alertThreshold": 2.0}]} 06:54:05 INFO - Return code: 0 06:54:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:54:05 INFO - # TBPL SUCCESS # 06:54:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:54:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:54:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:54:05 INFO - 2016-12-21 06:54:05.450 screenresolution[1655:9769] starting screenresolution argv=screenresolution get 06:54:05 INFO - 2016-12-21 06:54:05.452 screenresolution[1655:9769] Display 0: 1600x1200x32@60 06:54:05 INFO - 2016-12-21 06:54:05.459 screenresolution[1656:9772] starting screenresolution argv=screenresolution list 06:54:05 INFO - Available Modes on Display 0 06:54:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:54:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:54:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:54:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:54:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:54:05 INFO - Intel Iris: 06:54:05 INFO - Chipset Model: Intel Iris 06:54:05 INFO - Type: GPU 06:54:05 INFO - Bus: Built-In 06:54:05 INFO - VRAM (Dynamic, Max): 1536 MB 06:54:05 INFO - Vendor: Intel (0x8086) 06:54:05 INFO - Device ID: 0x0a2e 06:54:05 INFO - Revision ID: 0x0009 06:54:05 INFO - Displays: 06:54:05 INFO - Display: 06:54:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:54:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:54:05 INFO - Display Serial Number: 1600x1200 60 06:54:05 INFO - Main Display: Yes 06:54:05 INFO - Mirror: Off 06:54:05 INFO - Online: Yes 06:54:05 INFO - Rotation: Supported 06:54:05 INFO - Return code: 0 06:54:05 INFO - Running post-action listener: _resource_record_post_action 06:54:05 INFO - [mozharness: 2016-12-21 14:54:05.706789Z] Finished run-tests step (success) 06:54:05 INFO - Running post-run listener: _resource_record_post_run 06:54:05 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 37671936; Write bytes: 658153472; Read time: 234; Write time: 1900 06:54:05 INFO - TinderboxPrint: CPU usage
53.3% 06:54:05 INFO - TinderboxPrint: I/O read bytes / time
37,671,936 / 234 06:54:05 INFO - TinderboxPrint: I/O write bytes / time
658,153,472 / 1,900 06:54:05 INFO - TinderboxPrint: CPU idle
2,265.4 (46.7%) 06:54:05 INFO - TinderboxPrint: CPU system
968.0 (19.9%) 06:54:05 INFO - TinderboxPrint: CPU user
1,620.2 (33.4%) 06:54:05 INFO - TinderboxPrint: Swap in / out
386,486,272 / 0 06:54:05 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 344861184; Write bytes: 345360384; Read time: 26744; Write time: 719 06:54:05 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 35677184; Write bytes: 305911808; Read time: 217; Write time: 1154 06:54:06 INFO - Running post-run listener: _upload_blobber_files 06:54:06 INFO - Blob upload gear active. 06:54:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:54:06 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:54:06 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:54:06 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:54:06 INFO - (blobuploader) - INFO - Open directory for files ... 06:54:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:54:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:54:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:07 INFO - (blobuploader) - INFO - Done attempting. 06:54:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:54:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:54:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:08 INFO - (blobuploader) - INFO - Done attempting. 06:54:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:54:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:54:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:11 INFO - (blobuploader) - INFO - Done attempting. 06:54:11 INFO - (blobuploader) - INFO - Iteration through files over. 06:54:11 INFO - Return code: 0 06:54:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:54:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:54:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfcd163df08c7944368ac46f458344d343f8508defe2e4639d4557fadbe13a6e53aa31ec9a2a5ec6a59abf353182d4b7b4bdf6fd0da3fa03fe669ca0e8d70085", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8dc1f68bc94e34789d21d236e711734dd934ddb2d102a0cb47018b3a94f4fac27857f02ad1bc30ab036d57eb17f50a7963549f89cf22e79cfc5665031238bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/563a0032e2782a4135e1f21ff73409557b0ba69d0f74cf1848cbd9424b8f19ddbc8998ed77ee152dc35a4de72b32dec3dc20a1fec622a3edfd651060770ba066"} 06:54:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:54:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:54:11 INFO - Contents: 06:54:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfcd163df08c7944368ac46f458344d343f8508defe2e4639d4557fadbe13a6e53aa31ec9a2a5ec6a59abf353182d4b7b4bdf6fd0da3fa03fe669ca0e8d70085", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8dc1f68bc94e34789d21d236e711734dd934ddb2d102a0cb47018b3a94f4fac27857f02ad1bc30ab036d57eb17f50a7963549f89cf22e79cfc5665031238bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/563a0032e2782a4135e1f21ff73409557b0ba69d0f74cf1848cbd9424b8f19ddbc8998ed77ee152dc35a4de72b32dec3dc20a1fec622a3edfd651060770ba066"} 06:54:11 INFO - Running post-run listener: copy_logs_to_upload_dir 06:54:11 INFO - Copying logs to upload dir... 06:54:11 INFO - mkdir: /builds/slave/test/build/upload/logs 06:54:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.079558 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-21 06:54:11.076897) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 06:54:11.080769) ========= 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.0x0TKheP2C/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.HDBtBTEetL/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfcd163df08c7944368ac46f458344d343f8508defe2e4639d4557fadbe13a6e53aa31ec9a2a5ec6a59abf353182d4b7b4bdf6fd0da3fa03fe669ca0e8d70085", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8dc1f68bc94e34789d21d236e711734dd934ddb2d102a0cb47018b3a94f4fac27857f02ad1bc30ab036d57eb17f50a7963549f89cf22e79cfc5665031238bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/563a0032e2782a4135e1f21ff73409557b0ba69d0f74cf1848cbd9424b8f19ddbc8998ed77ee152dc35a4de72b32dec3dc20a1fec622a3edfd651060770ba066"} 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.011431 build_url: 'https://queue.taskcluster.net/v1/task/U2PfsxIjQ-aSZ-Az6ZvpWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfcd163df08c7944368ac46f458344d343f8508defe2e4639d4557fadbe13a6e53aa31ec9a2a5ec6a59abf353182d4b7b4bdf6fd0da3fa03fe669ca0e8d70085", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8dc1f68bc94e34789d21d236e711734dd934ddb2d102a0cb47018b3a94f4fac27857f02ad1bc30ab036d57eb17f50a7963549f89cf22e79cfc5665031238bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/563a0032e2782a4135e1f21ff73409557b0ba69d0f74cf1848cbd9424b8f19ddbc8998ed77ee152dc35a4de72b32dec3dc20a1fec622a3edfd651060770ba066"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 06:54:11.115498) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:54:11.115835) ========= 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.0x0TKheP2C/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.HDBtBTEetL/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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.005145 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 06:54:11.164200) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 06:54:11.164517) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 06:54:11.164835) ========= ========= Total master_lag: 0.18 =========