builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0273 starttime: 1473337122.11 results: success (0) buildid: 20160908030015 builduid: 06c0129cdbba4326b2ecf8829f391e97 revision: bd28be90aed86db495c8f0fdb6fc86c47c4484ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 05:18:42.114730) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 05:18:42.115156) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 05:18:42.115430) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 05:18:42.140897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 05:18:42.141160) ========= 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.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-08 05:18:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 44.5M=0s 2016-09-08 05:18:42 (44.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132274 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 05:18:42.295924) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 05:18:42.296243) ========= 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.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025566 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 05:18:42.343998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 05:18:42.344318) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bd28be90aed86db495c8f0fdb6fc86c47c4484ea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bd28be90aed86db495c8f0fdb6fc86c47c4484ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-08 05:18:42,425 truncating revision to first 12 chars 2016-09-08 05:18:42,425 Setting DEBUG logging. 2016-09-08 05:18:42,425 attempt 1/10 2016-09-08 05:18:42,425 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bd28be90aed8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-08 05:18:43,060 unpacking tar archive at: mozilla-central-bd28be90aed8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.924566 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 05:18:43.294876) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 05:18:43.295666) ========= script_repo_revision: bd28be90aed86db495c8f0fdb6fc86c47c4484ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 05:18:43.296701) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 05:18:43.297009) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 05:18:43.316690) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-08 05:18:43.317339) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:18:43 INFO - MultiFileLogger online at 20160908 05:18:43 in /builds/slave/test 05:18:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:18:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:18:43 INFO - {'append_to_log': False, 05:18:43 INFO - 'base_work_dir': '/builds/slave/test', 05:18:43 INFO - 'blob_upload_branch': 'Firefox', 05:18:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:18:43 INFO - 'branch': 'Firefox', 05:18:43 INFO - 'buildbot_json_path': 'buildprops.json', 05:18:43 INFO - 'config_files': ('talos/mac_config.py',), 05:18:43 INFO - 'default_actions': ('clobber', 05:18:43 INFO - 'read-buildbot-config', 05:18:43 INFO - 'download-and-extract', 05:18:43 INFO - 'populate-webroot', 05:18:43 INFO - 'create-virtualenv', 05:18:43 INFO - 'install', 05:18:43 INFO - 'run-tests'), 05:18:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:18:43 INFO - 'download_minidump_stackwalk': True, 05:18:43 INFO - 'download_symbols': 'ondemand', 05:18:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:18:43 INFO - 'tooltool.py': '/tools/tooltool.py', 05:18:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:18:43 INFO - '/tools/misc-python/virtualenv.py')}, 05:18:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:18:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:18:43 INFO - 'installer_path': 'installer.exe', 05:18:43 INFO - 'log_level': 'info', 05:18:43 INFO - 'log_name': 'talos', 05:18:43 INFO - 'log_to_console': True, 05:18:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:18:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:18:43 INFO - 'opt_config_files': (), 05:18:43 INFO - 'pip_index': False, 05:18:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:18:43 INFO - 'cmd': ('bash', 05:18:43 INFO - '-c', 05:18:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:18:43 INFO - 'enabled': True, 05:18:43 INFO - 'halt_on_failure': False, 05:18:43 INFO - 'name': 'check_screen_resolution'},), 05:18:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:18:43 INFO - 'cmd': ('bash', 05:18:43 INFO - '-c', 05:18:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:18:43 INFO - 'enabled': True, 05:18:43 INFO - 'halt_on_failure': False, 05:18:43 INFO - 'name': 'check_screen_resolution'},), 05:18:43 INFO - 'run_cmd_checks_enabled': True, 05:18:43 INFO - 'sps_profile': False, 05:18:43 INFO - 'sps_profile_interval': 0, 05:18:43 INFO - 'suite': 'dromaeojs', 05:18:43 INFO - 'system_bits': '32', 05:18:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:18:43 INFO - 'title': 't-yosemite-r7-0273', 05:18:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:18:43 INFO - 'use_talos_json': True, 05:18:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:18:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:18:43 INFO - 'work_dir': 'build'} 05:18:43 INFO - [mozharness: 2016-09-08 12:18:43.513832Z] Running clobber step. 05:18:43 INFO - Running pre-action listener: _resource_record_pre_action 05:18:43 INFO - Running main action method: clobber 05:18:43 INFO - rmtree: /builds/slave/test/build 05:18:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:18:45 INFO - Running post-action listener: _resource_record_post_action 05:18:45 INFO - [mozharness: 2016-09-08 12:18:45.517395Z] Finished clobber step (success) 05:18:45 INFO - [mozharness: 2016-09-08 12:18:45.517545Z] Running read-buildbot-config step. 05:18:45 INFO - Running pre-action listener: _resource_record_pre_action 05:18:45 INFO - Running main action method: read_buildbot_config 05:18:45 INFO - Using buildbot properties: 05:18:45 INFO - { 05:18:45 INFO - "project": "", 05:18:45 INFO - "product": "firefox", 05:18:45 INFO - "script_repo_revision": "production", 05:18:45 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:18:45 INFO - "repository": "", 05:18:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:18:45 INFO - "buildid": "20160908030015", 05:18:45 INFO - "pgo_build": "False", 05:18:45 INFO - "basedir": "/builds/slave/test", 05:18:45 INFO - "buildnumber": 101, 05:18:45 INFO - "slavename": "t-yosemite-r7-0273", 05:18:45 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:18:45 INFO - "platform": "yosemite_r7", 05:18:45 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:18:45 INFO - "branch": "mozilla-central", 05:18:45 INFO - "repo_path": "mozilla-central", 05:18:45 INFO - "revision": "bd28be90aed86db495c8f0fdb6fc86c47c4484ea", 05:18:45 INFO - "stage_platform": "macosx64", 05:18:45 INFO - "builduid": "06c0129cdbba4326b2ecf8829f391e97", 05:18:45 INFO - "slavebuilddir": "test" 05:18:45 INFO - } 05:18:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:18:45 INFO - Running post-action listener: _resource_record_post_action 05:18:45 INFO - [mozharness: 2016-09-08 12:18:45.520850Z] Finished read-buildbot-config step (success) 05:18:45 INFO - [mozharness: 2016-09-08 12:18:45.520966Z] Running download-and-extract step. 05:18:45 INFO - Running pre-action listener: _resource_record_pre_action 05:18:45 INFO - Running main action method: download_and_extract 05:18:45 INFO - mkdir: /builds/slave/test/build/tests 05:18: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')]} 05:18:45 INFO - trying https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:18:45 INFO - Downloading https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:18:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 05:18:46 INFO - Downloaded 1199 bytes. 05:18:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:18:46 INFO - Using the following test package requirements: 05:18:46 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:18:46 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:18:46 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:18:46 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:18:46 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:18:46 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:18:46 INFO - u'jsshell-mac.zip'], 05:18:46 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:18:46 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:18:46 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:18:46 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:18:46 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:18:46 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:18:46 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:18:46 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:18:46 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:18:46 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:18:46 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:18:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:18:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:18:47 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 05:18:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:18:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:18:55 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 05:19:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:19:02 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 05:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:02 INFO - trying https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:19:02 INFO - Downloading https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 05:19:05 INFO - Downloaded 111495158 bytes. 05:19:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:19:05 INFO - mkdir: /builds/slave/test/properties 05:19:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:19:05 INFO - Writing to file /builds/slave/test/properties/build_url 05:19:05 INFO - Contents: 05:19:05 INFO - build_url:https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:19:06 INFO - Running post-action listener: _resource_record_post_action 05:19:06 INFO - Running post-action listener: set_extra_try_arguments 05:19:06 INFO - [mozharness: 2016-09-08 12:19:06.266464Z] Finished download-and-extract step (success) 05:19:06 INFO - [mozharness: 2016-09-08 12:19:06.266625Z] Running populate-webroot step. 05:19:06 INFO - Running pre-action listener: _resource_record_pre_action 05:19:06 INFO - Running main action method: populate_webroot 05:19:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:19:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:19:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:19:06 INFO - '--tppagecycles', 05:19:06 INFO - '7'], 05:19:06 INFO - 'tests': ['tsvgm']}}, 05:19:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:19:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:19:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:19:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:19:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:19:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:19:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'talos_options': ['--disable-e10s'], 05:19:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'talos_options': ['--disable-e10s'], 05:19:06 INFO - 'tests': ['damp', 'tps']}, 05:19:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'tests': ['damp', 'tps']}, 05:19:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:19:06 INFO - 'tests': ['dromaeo_dom']}, 05:19:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:19:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:19:06 INFO - 'tests': ['basic_compositor_video']}, 05:19:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:19:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:19:06 INFO - 'tests': ['a11yr', 05:19:06 INFO - 'ts_paint', 05:19:06 INFO - 'tpaint', 05:19:06 INFO - 'sessionrestore', 05:19:06 INFO - 'sessionrestore_no_auto_restore', 05:19:06 INFO - 'tabpaint']}, 05:19:06 INFO - 'other-e10s': {'tests': ['a11yr', 05:19:06 INFO - 'ts_paint', 05:19:06 INFO - 'tpaint', 05:19:06 INFO - 'sessionrestore', 05:19:06 INFO - 'sessionrestore_no_auto_restore', 05:19:06 INFO - 'tabpaint']}, 05:19:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:19:06 INFO - 'ts_paint', 05:19:06 INFO - 'tpaint', 05:19:06 INFO - 'sessionrestore', 05:19:06 INFO - 'sessionrestore_no_auto_restore', 05:19:06 INFO - 'tabpaint']}, 05:19:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:19:06 INFO - 'ts_paint', 05:19:06 INFO - 'tpaint', 05:19:06 INFO - 'sessionrestore', 05:19:06 INFO - 'sessionrestore_no_auto_restore', 05:19:06 INFO - 'tabpaint']}, 05:19:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:19:06 INFO - 'tests': ['a11yr', 05:19:06 INFO - 'ts_paint', 05:19:06 INFO - 'tpaint', 05:19:06 INFO - 'sessionrestore', 05:19:06 INFO - 'sessionrestore_no_auto_restore', 05:19:06 INFO - 'tabpaint']}, 05:19:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:19:06 INFO - 'tests': ['a11yr', 05:19:06 INFO - 'ts_paint', 05:19:06 INFO - 'tpaint', 05:19:06 INFO - 'sessionrestore', 05:19:06 INFO - 'sessionrestore_no_auto_restore', 05:19:06 INFO - 'tabpaint']}, 05:19:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:19:06 INFO - 'tests': ['tsvgx', 05:19:06 INFO - 'tsvgr_opacity', 05:19:06 INFO - 'tart', 05:19:06 INFO - 'tscrollx', 05:19:06 INFO - 'cart']}, 05:19:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:19:06 INFO - 'tsvgr_opacity', 05:19:06 INFO - 'tart', 05:19:06 INFO - 'tscrollx', 05:19:06 INFO - 'cart']}, 05:19:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'talos_options': ['--disable-e10s'], 05:19:06 INFO - 'tests': ['tp5o']}, 05:19:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'tests': ['tp5o']}, 05:19:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'talos_options': ['--disable-e10s', 05:19:06 INFO - '--xperf_path', 05:19:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:06 INFO - 'tests': ['tp5n']}, 05:19:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:06 INFO - 'talos_options': ['--xperf_path', 05:19:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:06 INFO - 'tests': ['tp5n']}}, 05:19:06 INFO - 'talos.zip': {'path': '', 05:19:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:19:06 INFO - Running post-action listener: _resource_record_post_action 05:19:06 INFO - [mozharness: 2016-09-08 12:19:06.285818Z] Finished populate-webroot step (success) 05:19:06 INFO - [mozharness: 2016-09-08 12:19:06.285950Z] Running create-virtualenv step. 05:19:06 INFO - Running pre-action listener: _resource_record_pre_action 05:19:06 INFO - Running main action method: create_virtualenv 05:19:06 INFO - Creating virtualenv /builds/slave/test/build/venv 05:19:06 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 05:19:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:19:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:19:06 INFO - Using real prefix '/tools/python27' 05:19:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:19:07 INFO - Installing distribute.............................................................................................................................................................................................done. 05:19:09 INFO - Installing pip.................done. 05:19:09 INFO - Return code: 0 05:19:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:09 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 0x100806a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10089b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ca560e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076ad30>, '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 0x1004cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100762b20>, '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.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:19:09 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 05:19:09 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 05:19:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SjP1c8GFV/Render', 05:19:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:09 INFO - 'HOME': '/Users/cltbld', 05:19:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:09 INFO - 'LOGNAME': 'cltbld', 05:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:09 INFO - 'MOZ_NO_REMOTE': '1', 05:19:09 INFO - 'NO_EM_RESTART': '1', 05:19:09 INFO - 'PAGER': '/bin/cat', 05:19:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:09 INFO - 'PWD': '/builds/slave/test', 05:19:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:09 INFO - 'SHELL': '/bin/bash', 05:19:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nw6hy5kQpJ/Listeners', 05:19:09 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 05:19:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:09 INFO - 'USER': 'cltbld', 05:19:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:09 INFO - 'XPC_FLAGS': '0x0', 05:19:09 INFO - 'XPC_SERVICE_NAME': '0', 05:19:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:10 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 05:19:10 INFO - Cleaning up... 05:19:10 INFO - Return code: 0 05:19:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:19:10 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')]} 05:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:10 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')]} 05:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:10 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 0x100806a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10089b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ca560e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076ad30>, '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 0x1004cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100762b20>, '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.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:19:10 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 05:19:10 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 05:19:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SjP1c8GFV/Render', 05:19:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:10 INFO - 'HOME': '/Users/cltbld', 05:19:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:10 INFO - 'LOGNAME': 'cltbld', 05:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:10 INFO - 'MOZ_NO_REMOTE': '1', 05:19:10 INFO - 'NO_EM_RESTART': '1', 05:19:10 INFO - 'PAGER': '/bin/cat', 05:19:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:10 INFO - 'PWD': '/builds/slave/test', 05:19:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:10 INFO - 'SHELL': '/bin/bash', 05:19:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nw6hy5kQpJ/Listeners', 05:19:10 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 05:19:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:10 INFO - 'USER': 'cltbld', 05:19:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:10 INFO - 'XPC_FLAGS': '0x0', 05:19:10 INFO - 'XPC_SERVICE_NAME': '0', 05:19:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:10 INFO - Downloading/unpacking psutil>=3.1.1 05:19:10 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 05:19:10 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 05:19:10 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 05:19:10 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 05:19:10 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 05:19:10 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 05:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:19:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:13 INFO - Installing collected packages: psutil 05:19:13 INFO - Running setup.py install for psutil 05:19:13 INFO - building 'psutil._psutil_osx' extension 05:19:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:19:14 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 05:19:14 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 05:19:14 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 05:19:14 INFO - building 'psutil._psutil_posix' extension 05:19:14 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 05:19:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:19:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:19:14 INFO - ^ 05:19:14 INFO - 1 warning generated. 05:19:14 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 05:19:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:14 INFO - Successfully installed psutil 05:19:14 INFO - Cleaning up... 05:19:14 INFO - Return code: 0 05:19:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:19:14 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')]} 05:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:14 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')]} 05:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:14 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 0x100806a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10089b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ca560e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076ad30>, '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 0x1004cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100762b20>, '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.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:19:14 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 05:19:14 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 05:19:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SjP1c8GFV/Render', 05:19:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:14 INFO - 'HOME': '/Users/cltbld', 05:19:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:14 INFO - 'LOGNAME': 'cltbld', 05:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:14 INFO - 'MOZ_NO_REMOTE': '1', 05:19:14 INFO - 'NO_EM_RESTART': '1', 05:19:14 INFO - 'PAGER': '/bin/cat', 05:19:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:14 INFO - 'PWD': '/builds/slave/test', 05:19:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:14 INFO - 'SHELL': '/bin/bash', 05:19:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nw6hy5kQpJ/Listeners', 05:19:14 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 05:19:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:14 INFO - 'USER': 'cltbld', 05:19:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:14 INFO - 'XPC_FLAGS': '0x0', 05:19:14 INFO - 'XPC_SERVICE_NAME': '0', 05:19:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:19:17 INFO - Installing collected packages: mozsystemmonitor 05:19:17 INFO - Running setup.py install for mozsystemmonitor 05:19:17 INFO - Successfully installed mozsystemmonitor 05:19:17 INFO - Cleaning up... 05:19:17 INFO - Return code: 0 05:19:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:17 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 0x100806a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10089b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ca560e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076ad30>, '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 0x1004cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100762b20>, '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.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:19:17 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 05:19:17 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 05:19:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SjP1c8GFV/Render', 05:19:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:17 INFO - 'HOME': '/Users/cltbld', 05:19:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:17 INFO - 'LOGNAME': 'cltbld', 05:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:17 INFO - 'MOZ_NO_REMOTE': '1', 05:19:17 INFO - 'NO_EM_RESTART': '1', 05:19:17 INFO - 'PAGER': '/bin/cat', 05:19:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:17 INFO - 'PWD': '/builds/slave/test', 05:19:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:17 INFO - 'SHELL': '/bin/bash', 05:19:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nw6hy5kQpJ/Listeners', 05:19:17 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 05:19:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:17 INFO - 'USER': 'cltbld', 05:19:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:17 INFO - 'XPC_FLAGS': '0x0', 05:19:17 INFO - 'XPC_SERVICE_NAME': '0', 05:19:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:17 INFO - Downloading/unpacking jsonschema==2.5.1 05:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:19:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:20 INFO - Downloading functools32-3.2.3-2.tar.gz 05:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:19:20 INFO - warning: no files found matching '*.txt' 05:19:20 INFO - no previously-included directories found matching 'build' 05:19:20 INFO - no previously-included directories found matching 'dist' 05:19:20 INFO - no previously-included directories found matching '.git*' 05:19:20 INFO - Installing collected packages: jsonschema, functools32 05:19:20 INFO - Running setup.py install for functools32 05:19:21 INFO - warning: no files found matching '*.txt' 05:19:21 INFO - no previously-included directories found matching 'build' 05:19:21 INFO - no previously-included directories found matching 'dist' 05:19:21 INFO - no previously-included directories found matching '.git*' 05:19:21 INFO - Successfully installed jsonschema functools32 05:19:21 INFO - Cleaning up... 05:19:21 INFO - Return code: 0 05:19:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:19:21 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')]} 05:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:21 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')]} 05:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:21 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 0x100806a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10089b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ca560e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076ad30>, '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 0x1004cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100762b20>, '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.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:19:21 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 05:19:21 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 05:19:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SjP1c8GFV/Render', 05:19:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:21 INFO - 'HOME': '/Users/cltbld', 05:19:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:21 INFO - 'LOGNAME': 'cltbld', 05:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:21 INFO - 'MOZ_NO_REMOTE': '1', 05:19:21 INFO - 'NO_EM_RESTART': '1', 05:19:21 INFO - 'PAGER': '/bin/cat', 05:19:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:21 INFO - 'PWD': '/builds/slave/test', 05:19:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:21 INFO - 'SHELL': '/bin/bash', 05:19:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nw6hy5kQpJ/Listeners', 05:19:21 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 05:19:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:21 INFO - 'USER': 'cltbld', 05:19:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:21 INFO - 'XPC_FLAGS': '0x0', 05:19:21 INFO - 'XPC_SERVICE_NAME': '0', 05:19:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:19:21 INFO - Cleaning up... 05:19:21 INFO - Return code: 0 05:19:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:19:21 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')]} 05:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:21 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')]} 05:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:21 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 0x100806a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10089b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ca560e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076ad30>, '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 0x1004cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100762b20>, '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.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:19:21 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 05:19:21 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 05:19:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SjP1c8GFV/Render', 05:19:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:21 INFO - 'HOME': '/Users/cltbld', 05:19:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:21 INFO - 'LOGNAME': 'cltbld', 05:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:21 INFO - 'MOZ_NO_REMOTE': '1', 05:19:21 INFO - 'NO_EM_RESTART': '1', 05:19:21 INFO - 'PAGER': '/bin/cat', 05:19:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:21 INFO - 'PWD': '/builds/slave/test', 05:19:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:21 INFO - 'SHELL': '/bin/bash', 05:19:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nw6hy5kQpJ/Listeners', 05:19:21 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 05:19:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:21 INFO - 'USER': 'cltbld', 05:19:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:21 INFO - 'XPC_FLAGS': '0x0', 05:19:21 INFO - 'XPC_SERVICE_NAME': '0', 05:19:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:24 INFO - Downloading blobuploader-1.2.4.tar.gz 05:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:19:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:19:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:25 INFO - Downloading docopt-0.6.1.tar.gz 05:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:19:25 INFO - Installing collected packages: blobuploader, requests, docopt 05:19:25 INFO - Running setup.py install for blobuploader 05:19:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:19:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:19:25 INFO - Running setup.py install for requests 05:19:26 INFO - Running setup.py install for docopt 05:19:26 INFO - Successfully installed blobuploader requests docopt 05:19:26 INFO - Cleaning up... 05:19:26 INFO - Return code: 0 05:19:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:26 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')]} 05:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:26 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')]} 05:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:26 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 0x100806a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10089b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ca560e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076ad30>, '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 0x1004cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100762b20>, '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.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:19:26 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 05:19:26 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 05:19:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SjP1c8GFV/Render', 05:19:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:26 INFO - 'HOME': '/Users/cltbld', 05:19:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:26 INFO - 'LOGNAME': 'cltbld', 05:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:26 INFO - 'MOZ_NO_REMOTE': '1', 05:19:26 INFO - 'NO_EM_RESTART': '1', 05:19:26 INFO - 'PAGER': '/bin/cat', 05:19:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:26 INFO - 'PWD': '/builds/slave/test', 05:19:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:26 INFO - 'SHELL': '/bin/bash', 05:19:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nw6hy5kQpJ/Listeners', 05:19:26 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 05:19:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:26 INFO - 'USER': 'cltbld', 05:19:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:26 INFO - 'XPC_FLAGS': '0x0', 05:19:26 INFO - 'XPC_SERVICE_NAME': '0', 05:19:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:19:26 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-i4ZPi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:19:26 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-nDMrPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:19:26 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-yJBY30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:19:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-zQ8bkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:19:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-BsI0rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:19:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-vCzAeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:19:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-vi3j3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:19:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-eMENGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:19:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-n3Mzi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:19:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-bBCwCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:19:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-U33IfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:19:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-hA_xIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:19:27 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-ChB2uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:19:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-Ch3Awf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-bPQ0e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:19:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-qTGllM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:19:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-vG_gpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:19:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:19:28 INFO - Running setup.py install for manifestparser 05:19:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:19:28 INFO - Running setup.py install for mozcrash 05:19:28 INFO - Running setup.py install for mozdebug 05:19:28 INFO - Running setup.py install for mozdevice 05:19:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:19:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:19:29 INFO - Running setup.py install for mozfile 05:19:29 INFO - Running setup.py install for mozhttpd 05:19:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:19:29 INFO - Running setup.py install for mozinfo 05:19:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:19:29 INFO - Running setup.py install for mozInstall 05:19:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:19:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:19:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:19:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:19:29 INFO - Running setup.py install for mozleak 05:19:29 INFO - Running setup.py install for mozlog 05:19:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:19:29 INFO - Running setup.py install for moznetwork 05:19:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:19:30 INFO - Running setup.py install for mozprocess 05:19:30 INFO - Running setup.py install for mozprofile 05:19:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:19:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:19:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:19:30 INFO - Running setup.py install for mozrunner 05:19:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:19:30 INFO - Running setup.py install for mozscreenshot 05:19:30 INFO - Running setup.py install for moztest 05:19:30 INFO - Running setup.py install for mozversion 05:19:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:19:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:19:31 INFO - Cleaning up... 05:19:31 INFO - Return code: 0 05:19:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19: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')]} 05:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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')]} 05:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:31 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 0x100806a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10089b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ca560e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076ad30>, '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 0x1004cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100762b20>, '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.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:19:31 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 05:19:31 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 05:19:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SjP1c8GFV/Render', 05:19:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:31 INFO - 'HOME': '/Users/cltbld', 05:19:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:31 INFO - 'LOGNAME': 'cltbld', 05:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:31 INFO - 'MOZ_NO_REMOTE': '1', 05:19:31 INFO - 'NO_EM_RESTART': '1', 05:19:31 INFO - 'PAGER': '/bin/cat', 05:19:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:31 INFO - 'PWD': '/builds/slave/test', 05:19:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:31 INFO - 'SHELL': '/bin/bash', 05:19:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nw6hy5kQpJ/Listeners', 05:19:31 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 05:19:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:31 INFO - 'USER': 'cltbld', 05:19:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:31 INFO - 'XPC_FLAGS': '0x0', 05:19:31 INFO - 'XPC_SERVICE_NAME': '0', 05:19:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:19:31 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-5sL4u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:19:31 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)) 05:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:19:31 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-KNteT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:19:31 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-HiRlua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:19:31 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)) 05:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:19:31 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-tq3Vrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:19:31 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)) 05:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:19:31 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-YaKCBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:19:31 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)) 05:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:19:31 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-EiM05q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:19:31 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-d2ux62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:19:32 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)) 05:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:19:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-posofs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:19:32 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)) 05:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:19:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-IpaabT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:19:32 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)) 05:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:19:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-7JJYfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 05:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:19:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-sEicjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:19:32 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)) 05:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:19:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-yWxZLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:19:32 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)) 05:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:19:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-Q8HwuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:19:32 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)) 05:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:19:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-sv5Cq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-DKQBwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:19:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-kVpiAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:19:33 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)) 05:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:19:33 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-INvU7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:19:33 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)) 05:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:19:33 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)) 05:19:33 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)) 05:19:33 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)) 05:19:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:19:33 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 05:19:33 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 05:19:33 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 05:19:33 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 05:19:33 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 05:19:33 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 05:19:35 INFO - Downloading blessings-1.6.tar.gz 05:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:19:35 INFO - Installing collected packages: blessings 05:19:35 INFO - Running setup.py install for blessings 05:19:35 INFO - Successfully installed blessings 05:19:35 INFO - Cleaning up... 05:19:36 INFO - Return code: 0 05:19:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:19:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:19:36 INFO - Reading from file tmpfile_stdout 05:19:36 INFO - Current package versions: 05:19:36 INFO - blessings == 1.6 05:19:36 INFO - blobuploader == 1.2.4 05:19:36 INFO - docopt == 0.6.1 05:19:36 INFO - functools32 == 3.2.3-2 05:19:36 INFO - jsonschema == 2.5.1 05:19:36 INFO - manifestparser == 1.1 05:19:36 INFO - mozInstall == 1.12 05:19:36 INFO - mozcrash == 0.17 05:19:36 INFO - mozdebug == 0.1 05:19:36 INFO - mozdevice == 0.48 05:19:36 INFO - mozfile == 1.2 05:19:36 INFO - mozhttpd == 0.7 05:19:36 INFO - mozinfo == 0.9 05:19:36 INFO - mozleak == 0.1 05:19:36 INFO - mozlog == 3.3 05:19:36 INFO - moznetwork == 0.27 05:19:36 INFO - mozprocess == 0.23 05:19:36 INFO - mozprofile == 0.28 05:19:36 INFO - mozrunner == 6.12 05:19:36 INFO - mozscreenshot == 0.1 05:19:36 INFO - mozsystemmonitor == 0.3 05:19:36 INFO - moztest == 0.7 05:19:36 INFO - mozversion == 1.4 05:19:36 INFO - psutil == 3.1.1 05:19:36 INFO - requests == 1.2.3 05:19:36 INFO - wsgiref == 0.1.2 05:19:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100806a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10089b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ca560e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076ad30>, '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 0x1004cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100762b20>, '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.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:19:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:19:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SjP1c8GFV/Render', 05:19:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:36 INFO - 'HOME': '/Users/cltbld', 05:19:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:36 INFO - 'LOGNAME': 'cltbld', 05:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:36 INFO - 'MOZ_NO_REMOTE': '1', 05:19:36 INFO - 'NO_EM_RESTART': '1', 05:19:36 INFO - 'PAGER': '/bin/cat', 05:19:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:36 INFO - 'PWD': '/builds/slave/test', 05:19:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:36 INFO - 'SHELL': '/bin/bash', 05:19:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nw6hy5kQpJ/Listeners', 05:19:36 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 05:19:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:36 INFO - 'USER': 'cltbld', 05:19:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:36 INFO - 'XPC_FLAGS': '0x0', 05:19:36 INFO - 'XPC_SERVICE_NAME': '0', 05:19:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:19:36 INFO - Cleaning up... 05:19:36 INFO - Return code: 0 05:19:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100806a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10089b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ca560e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10076ad30>, '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 0x1004cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100762b20>, '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.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:19:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:19:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SjP1c8GFV/Render', 05:19:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:36 INFO - 'HOME': '/Users/cltbld', 05:19:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:36 INFO - 'LOGNAME': 'cltbld', 05:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:36 INFO - 'MOZ_NO_REMOTE': '1', 05:19:36 INFO - 'NO_EM_RESTART': '1', 05:19:36 INFO - 'PAGER': '/bin/cat', 05:19:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:36 INFO - 'PWD': '/builds/slave/test', 05:19:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:36 INFO - 'SHELL': '/bin/bash', 05:19:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nw6hy5kQpJ/Listeners', 05:19:36 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 05:19:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:36 INFO - 'USER': 'cltbld', 05:19:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:36 INFO - 'XPC_FLAGS': '0x0', 05:19:36 INFO - 'XPC_SERVICE_NAME': '0', 05:19:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:19:37 INFO - Cleaning up... 05:19:37 INFO - Return code: 0 05:19:37 INFO - Running post-action listener: _resource_record_post_action 05:19:37 INFO - Running post-action listener: _start_resource_monitoring 05:19:37 INFO - Starting resource monitoring. 05:19:37 INFO - [mozharness: 2016-09-08 12:19:37.231042Z] Finished create-virtualenv step (success) 05:19:37 INFO - [mozharness: 2016-09-08 12:19:37.232128Z] Running install step. 05:19:37 INFO - Running pre-action listener: _resource_record_pre_action 05:19:37 INFO - Running main action method: install 05:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:19:37 INFO - Reading from file tmpfile_stdout 05:19:37 INFO - Detecting whether we're running mozinstall >=1.0... 05:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:19:37 INFO - Reading from file tmpfile_stdout 05:19:37 INFO - Output received: 05:19:37 INFO - Usage: mozinstall [options] installer 05:19:37 INFO - Options: 05:19:37 INFO - -h, --help show this help message and exit 05:19:37 INFO - -d DEST, --destination=DEST 05:19:37 INFO - Directory to install application into. [default: 05:19:37 INFO - "/builds/slave/test"] 05:19:37 INFO - --app=APP Application being installed. [default: firefox] 05:19:37 INFO - mkdir: /builds/slave/test/build/application 05:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:20:12 INFO - Reading from file tmpfile_stdout 05:20:12 INFO - Output received: 05:20:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:20:12 INFO - Running post-action listener: _resource_record_post_action 05:20:12 INFO - [mozharness: 2016-09-08 12:20:12.355863Z] Finished install step (success) 05:20:12 INFO - [mozharness: 2016-09-08 12:20:12.355963Z] Running run-tests step. 05:20:12 INFO - Running pre-action listener: _resource_record_pre_action 05:20:12 INFO - Running main action method: run_tests 05:20:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:20:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:20:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:20:12 INFO - 2016-09-08 05:20:12.370 screenresolution[1638:7695] starting screenresolution argv=screenresolution get 05:20:12 INFO - 2016-09-08 05:20:12.373 screenresolution[1638:7695] Display 0: 1600x1200x32@60 05:20:12 INFO - 2016-09-08 05:20:12.378 screenresolution[1639:7697] starting screenresolution argv=screenresolution list 05:20:12 INFO - Available Modes on Display 0 05:20:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:20:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:20:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:20:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:20:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:20:12 INFO - Intel Iris: 05:20:12 INFO - Chipset Model: Intel Iris 05:20:12 INFO - Type: GPU 05:20:12 INFO - Bus: Built-In 05:20:12 INFO - VRAM (Dynamic, Max): 1536 MB 05:20:12 INFO - Vendor: Intel (0x8086) 05:20:12 INFO - Device ID: 0x0a2e 05:20:12 INFO - Revision ID: 0x0009 05:20:12 INFO - Displays: 05:20:12 INFO - Display: 05:20:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:20:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:20:12 INFO - Display Serial Number: 1600x1200 60 05:20:12 INFO - Main Display: Yes 05:20:12 INFO - Mirror: Off 05:20:12 INFO - Online: Yes 05:20:12 INFO - Rotation: Supported 05:20:12 INFO - Return code: 0 05:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:20:12 INFO - Python 2.7.3 05:20:12 INFO - Return code: 0 05:20:12 INFO - grabbing minidump binary from tooltool 05:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:12 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 0x10076ad30>, '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 0x1004cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100762b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:20:12 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 05:20:12 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 05:20:12 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 05:20:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:20:12 INFO - Return code: 0 05:20:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:20:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:20:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:20:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:20:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0273 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:20:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SjP1c8GFV/Render', 05:20:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:20:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:20:12 INFO - 'HOME': '/Users/cltbld', 05:20:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:20:12 INFO - 'LOGNAME': 'cltbld', 05:20:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:20:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:12 INFO - 'MOZ_NO_REMOTE': '1', 05:20:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:20:12 INFO - 'NO_EM_RESTART': '1', 05:20:12 INFO - 'PAGER': '/bin/cat', 05:20:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:12 INFO - 'PWD': '/builds/slave/test', 05:20:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:20:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:20:12 INFO - 'SHELL': '/bin/bash', 05:20:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nw6hy5kQpJ/Listeners', 05:20:12 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 05:20:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:20:12 INFO - 'USER': 'cltbld', 05:20:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:20:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:12 INFO - 'XPC_FLAGS': '0x0', 05:20:12 INFO - 'XPC_SERVICE_NAME': '0', 05:20:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:20:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:20:12 INFO - mozversion application_buildid: 20160908030015 05:20:12 INFO - mozversion application_changeset: bd28be90aed86db495c8f0fdb6fc86c47c4484ea 05:20:12 INFO - mozversion application_display_name: Nightly 05:20:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:20:12 INFO - mozversion application_name: Firefox 05:20:12 INFO - mozversion application_remotingname: firefox 05:20:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:20:12 INFO - mozversion application_vendor: Mozilla 05:20:12 INFO - mozversion application_version: 51.0a1 05:20:12 INFO - mozversion platform_buildid: 20160908030015 05:20:12 INFO - mozversion platform_changeset: bd28be90aed86db495c8f0fdb6fc86c47c4484ea 05:20:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:20:12 INFO - mozversion platform_version: 51.0a1 05:20:12 INFO - using testdate: 1473337212 05:20:12 INFO - actual date: 1473337212 05:20:12 INFO - starting webserver on 'localhost:49273' 05:20:12 INFO - SUITE-START | Running 2 tests 05:20:12 INFO - TEST-START | dromaeo_css 05:20:12 INFO - operating with platform_type : mac_ 05:20:12 INFO - Initialising browser for dromaeo_css test... 05:20:12 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmp8TnRbA/profile http://localhost:49273/getInfo.html) 05:20:15 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 05:20:15 INFO - PROCESS | 1649 | colorDepth:24 05:20:15 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 05:20:15 INFO - PROCESS | 1649 | __metrics 05:20:15 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:20:15 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:20:16 INFO - TEST-INFO | 1649: exit 0 05:20:16 INFO - Browser initialized. 05:20:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:20:16 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmp8TnRbA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:28 INFO - PROCESS | 1651 | RSS: Main: 232517632 05:20:28 INFO - PROCESS | 1651 | 05:21:19 INFO - PROCESS | 1651 | 1473337279196 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] 05:23:31 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 05:23:32 INFO - PROCESS | 1651 | RSS: Main: 373153792 05:23:32 INFO - PROCESS | 1651 | 05:26:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 05:26:36 INFO - PROCESS | 1651 | RSS: Main: 373092352 05:26:36 INFO - PROCESS | 1651 | 05:29:38 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 05:29:39 INFO - PROCESS | 1651 | RSS: Main: 363032576 05:29:39 INFO - PROCESS | 1651 | 05:32:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 05:32:42 INFO - PROCESS | 1651 | RSS: Main: 344739840 05:32:42 INFO - PROCESS | 1651 | 05:35:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 05:35:46 INFO - PROCESS | 1651 | RSS: Main: 330137600 05:35:46 INFO - PROCESS | 1651 | 05:38:49 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 05:38:49 INFO - PROCESS | 1651 | RSS: Main: 474308608 05:38:49 INFO - PROCESS | 1651 | 05:38:49 INFO - PROCESS | 1651 | __start_tp_report 05:38:49 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 05:38:49 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 05:38:49 INFO - PROCESS | 1651 | |i|pagename|runs| 05:38:49 INFO - PROCESS | 1651 | |0;dojo.html;2842.8436435996023;3306.553615261939;3350.162459385155;3381.695647391737;3419.2990436960426;4039.697022723293;5537.473939975706;5672.631278966869;5781.306243250805;5787.334456537495;5696.174054762057;5734.713264336777;5734.885302293952;5747.741351639176;5760.4815566599;5159.226116082589;5180.404253510838;5195.6622819516615;5230.633855630107;5265.473452654742;5211.088059589576;5288.365396152467;5289.153735402337;5289.2859463972445;5299.867503312409;5149.562287205592;5189.792408303663;5211.218317252405;5223.608229382792;5292.126799078167;5276.630635855492;5286.762095705702;5293.417724050351;5300.549453296474;5332.733363331818;5084.059449001947;5102.668326558799;5135.666181698178;5181.5077567631015;5204.843854684365;5727.599068065237;5760.654360738327;5778.942210577925;5827;5859.531237501033;6209;6215.906761398583;6216.720247588869;6230.408111229426;6241.21984751906;6073.399325508986;6128.105930682418;6205.162303089115;6222.3466536013975;6229.688515574248;5935.465808077251;5936.347001829795;5987.9101813472835;5988.580799344091;5990.7903223386975;6221.96889015552;6288.371162883675;6295.685215739195;6307.590006649553;6311.147995020705;5996.400359963969;6087.66517841523;6095.61970315344;6191.442770150618;6203.7828675997025;5171.81898633546;5201.635885487979;6223.502119830403;6229.470495007885;6236.407541283571;6215.502759779207;6218.347073557211;6224;6228.906566401508;6240.157578726905;6094.8943112006145;6112.807455516588;6145.924463218918;6227.283862355796;6276.843078923063;4974.626902982291;4980.726060066731;4983.800647974041;4999.225120106389;5000.299958005882;4417;4441.511433742286;4460.30865215892;4465.173942820588;4514.142312960527;5731.340895797037;5770.13447982806;5774.68239246837;5778;5780.971095144498;6145.354737752472;6212.285587157445;6281.403266689657;6286.5599408041;6293.056041593706;5644.068728659725;5728.312602487728;5732.77068917247;5740.339860915965;5745.91381129275;4579.9542004579525;5467.343918729778;5472.425395333512;5472.644278121909;5472.781088756406;6185.474234690102;6189.04069869171;6224.408681175371;6244.937550624436;6252.374762523802;6301.40136687014;6303.684815759102;6307.05394190875;6309.90535141964;6328.588641738273;5325.97337013328;6296;6301.527385446018;6330.050492426173;6332.145160403471;6116.305337586134;6119.959572021022;6123.693815309128;6232.283287422005;6255.56211065221;6110.969445152746;6184.196054513064;6238.064290356483;6287.119803227461;6309.33751956038;6174.104754810617;6183.227096612924;6187.721552530057;6197.876042479215;6218.284897236876;6038.577299589162;6152.538559607958;6191.7523299069335;6195.938040619536;6210;5904.173415721888;5979.103134529855;5996.914674268573;6021.969890150521;6055.757769689163;6139.109829074849;6162.22972128484;6173.629582225081;6188.3502232266765;6195.411435913581;6003.249593800775;6008.8798224036145;6009.609375390585;6048.909266361096;6094.39056094387 05:38:49 INFO - PROCESS | 1651 | |1;ext.html;487.264231011173;491.48394186104593;521.9556337711294;522.0029743190507;528.9418164001959;26549.734502654966;32365.67634323653;40137.1972560549;41248.968775780544;41511.58488415115;42095.158096838044;42388.57611423885;42427.78786106065;42431;42662.93342666435;9758.902410975907;9950.800983980316;9954.800903981915;9957.302988790787;9962.352447090952;7468.3278504934815;11956.342401167933;12183.08626852985;12216.144869859114;12345.753084938297;12146.33195174265;12195.207311524768;12252.387380630977;12253.387330633434;12257.632271031884;8779.64881404743;12190.024798016137;12270.693232669166;12279.447424865903;12294.385280735973;11747.882521174764;12016.339101349422;12048.819267710991;12230.14388992771;12258.26450412978;40366;40647.39028914569;40701.79649101765;40712.185756285005;40771.1845763086;3343.36476069546;3364.2934983653463;3457.6715212054814;3458.9308213835584;4136.296829538986;29650.258743531584;30713.38573228523;31132.688673113207;31133.221669458217;31137.844310778302;3148.480500717379;3168.30297334586;3312.188513814107;3336.7831090979007;3386.153461634591;502373;503707;505833;507817.92182078445;508002.9999999963;57124.71437642868;57581;57638.7118064407;57694;57756.71121644365;60652;60749.08876366858;60795;60866.391336086956;60879;16028.519144425685;16268.918655406647;16303.592410189603;16309.51071467858;16336.346546138022;11468;11692.47383867728;12755.553555625509;12826.55107071248;12827.102102852898;15570;15890.602734931488;15966;16133.757993630104;16170.595735106717;7109.8933515997305;7114.928850711427;7118.786436406813;7155;7235.710571577078;841.9326453883674;929.3587424676952;971.7619183299995;998.8701468809008;1061.442742560162;28578.142655720363;29601.555976660366;29793;30332;30410;964.6864768950119;1017.5980487707462;1077.6928575355985;1158.7450760832603;1228.705110773408;13244.20534767917;14026.018178727596;14789.926050369895;15272.389104435699;15724.842751572567;641743;647992;648299;649167.7541612262;649529;56346;56675;56682.43317566771;56734;56813.43186568164;1199.8080307150815;1214.5020541578087;1299.6555912682957;1346.0913883128849;1360.5646193218274;29971.958046842825;30693.846530767205;30998.535021975138;31100.377992440477;31605.36789264248;47709;48347.516524834304;48380.27429588488;48499.75750121368;48544.514554854;536540;539684;540671;540745;541012;25546.616800748376;26275.868620656773;26280.34299142537;26931.192064238105;38403;46427.303590445496;46723.29915051345;46765.76617116893;47113.764431177624;47837;38096;38185.85442436732;38493.230135396574;38541.80729096336;39706.80146599249;32893.50659740154;38539.6146038536;38803.80598097105;38889.41665874958;39081.80459097686;36630.63369366379;37548.6245137556;37845.810770945965;37894.431583525715;38148.04629884275;31162;32237;33171.00973941571;33429.997100087036;33623;20600.27899023527;24189.032438702256;24563.263102106965;25027;25377 05:38:49 INFO - PROCESS | 1651 | |2;jquery.html;347.7200853313085;362.2573723866074;370.46097927515484;373.2069352625671;398.6671129606778;15331;16467.917660411713;19959.501012474695;20635.484112897186;20729.99999999998;19792.208311667553;20073.498162545944;20450.07974641141;20454.590908181828;20808.895955520202;5290.550303224211;5894.145348924414;6109.389061093877;6150.1082343060225;6150.1082343060225;4243.830246790125;4447.377367168583;6037.094435834638;6121.081837724332;6552.082708420801;6762.492813039017;6848.1097457330725;6870.553414028072;6873.725050997979;6880.6215658139035;6538.1827271591055;6720.428763555079;6813.693383797691;6821.113255276832;6826.965865170692;5248.71132087735;5720.771169153229;5790.449907258803;5886.70566471679;5903.468687818074;25055.62416563753;26108.086216982316;26155.476890462083;26248.60627090595;26524.336891577674;2201.4936564590075;2269.341890851651;2397.2209032064648;2509.560826855293;2953.8523073846436;13997.790033149511;15604.453844115515;15637.921810390875;15848.92075539615;16459.25933333003;1851.7129844873932;1876.8873867567854;1879.6898511745546;1915.7126431035317;1923.1249781349452;108976.4551177239;111812.4409377956;112038;112513.87486125116;114357;10264.332818366931;10467.214958878114;10532.736681583021;10722;10897.782044359226;13315.06794524374;13328;13350.532731354357;13363.331833408485;13377.331133443484;8292.668293268322;8560.914390856136;8584.227419532272;8688.218060374596;8750.781230469162;8692.174243446863;8695.217430431165;8714.69498567547;8835;8884.37809353339;5809.506191973645;6275.905861412082;6421.486281097595;6542.378474044958;6574.112494813235;1650.2161473300087;1757.1829099468807;1759.876808623384;1774.97337539937;1802.4682718598044;893.9471704130322;924.8890133184061;937.8593211018265;938.0150841616276;992.8014397120605;21397;22885.656715149285;23434.64848027281;23552.882235588713;23606.527869442514;916.6654171227455;973.1047436358567;980.9558569864373;988.4316518002178;1016.898310168992;11668.591599294154;11809.645710628694;12062.276263424223;12075;12448.62654120378;490670.5466472645;495749;498690;583640;586740;122013;128001;133174;141984;144705;936.134075979716;939.5865819039601;982.7101005203482;996.1781530237583;998.930074894765;18403;18909;19106.522336941132;19183.80816191876;19207.711884322027;54427;55474.44525554854;56354.43645563656;57042.7147864258;57848.71075644595;81900;82080;83492.0777772775;86276.56861715902;86650.56674716838;6503.447206987459;7428.702851885864;7858;7965.4822436541435;8220.958895205486;10639.616849809476;12727;13081.803772943604;13405.324334458193;13427.26150061756;7638.885416718865;8229.464930408489;8325.000999880052;8431.95784021076;11092.611758588411;11158.218924675195;11255.943720281346;11375.658730237776;11722.824157637471;11826.58606948787;10456.63401780934;10892.455377231265;11524.193306468467;11529.711757206136;11798.174127810971;6709.295523969913;8186.8771968421715;8235.83528329418;8251.876221856797;8418.905542279464;8280.875786863322;9555.665551705657;9827.361221520578;11034.889651103707;11771.529138834694 05:38:49 INFO - PROCESS | 1651 | |3;mootools.html;1403.8385585657647;1528.9311980960856;1721.8794684372092;1825.4067428085875;1903.448000079976;8520.446170998888;9067.455952642846;9073.954630226855;9083.636654533828;9088.772780680478;7984.92015079849;8199;8666;8852.77868053299;8920.241779448756;2385.8926348314367;2422.8304018718695;2424.1394305021727;2426.4904370082304;2429.0283886445477;2042.213747707136;2393.772591603795;2396.664466974625;2413.8431001984814;2414.6498757680124;1944.6596845552042;2256.4697296135396;2370.8577485350847;2384.3681424422543;2399.8200134989947;2358.7995020423286;2372.3120295114395;2384.010635586238;2384.71383433989;2391.796697280733;1973.7236786849853;2368.5973384524673;2370.6207006878817;2373.6202207646693;2375.1212051541042;8792;8921.01868794432;8925.107489251088;8928.73213803587;9021.097890210927;5244.580433565306;5273.815416460406;5415.214793854909;5446.373667028302;5453.863653408696;3559.2169722660974;3612.4581312803025;3699.667029967316;3706.166112624665;3738.4018557030745;1034.3897100710617;1071.7320669832543;1073.940933248671;1088.8149014667526;1089.1939964426347;11822.704432389173;11907.047436205083;11924.046076313874;11932.343721095336;11953.641390758377;4562.817487300471;4691.46048204454;4847.466778654345;4860.4896485869185;4861.683990540603;10017;10043.19654427644;10046.899531004743;10052;10069.496525173858;5431.131019036935;5437.918431223535;5440.863978400493;5465.043617366945;5467.988422141916;4435.290353543418;4574.908501829945;4834.20235661112;4940.456549779521;4949.529794669501;3406;3842.442845787345;3903.2193561287854;3976.9602303977167;4002.2595819773437;1280.238258236348;1287.7488889666424;1288.1176394170025;1298.5260379961246;1300.5058077930514;833.6707000734676;854.6666799948025;898.573177740568;908.4957848394073;949.4350861237552;5721.828345149652;5815.621984570989;6013.128096426081;6021.066734656135;6130.295016073209;936.5832204668993;937.7514958535993;938.5776400619749;945.4988855906381;997.4065431068502;3868.9226215476097;3933.901652458654;3962.8612998544913;4076.5923407658997;4084.1627466369323;10626.840597391045;10991.725206869733;11028.22802403824;11028.2280240384;11043.950824671643;10299.794004119876;10686.625968091079;10689.518971646294;10947.397893115796;10965.56137754481;8033.995750531183;8259.876101858477;8263.256306932284;8269.04905935825;8269.545175015312;5820.912686309794;5865.94134058654;5897.852553686193;6091.086337049301;6263.843403914939;9658.855117173107;9795.118439340493;10213.08082272599;10227.335223210468;10277.126444252322;10193.0316619921;10301.227407944583;10337.586496540054;10337.84493232587;10345.793084138124;7029.121359830021;7046.859062818818;7427.294407031323;7502.474826762293;7604.2395760423515;8302.916970830456;8546.35902307317;8547.444416112932;8547.786305342168;8562.186592273723;6275.748970041147;7470.178280389261;7521.811954701177;7551.320381165721;7647.19704431049;7358.77923662291;7365.968764372885;7377.889331660137;7415.406767458482;7417.851642967218;6898.827529311808;7062.646867656494;7066.328698773608;7070.186928503288;7073.82315442118;4290.50659174199;5046;5064.164412871983;5112.795488180431;5213.270142180174;4919.581835544019;5020.673656212334;5113.284140220298;5154.175331946871;5258.474152584711 05:38:49 INFO - PROCESS | 1651 | |4;prototype.html;252.835656823065;267.2770156726056;308.1909986285999;308.9320349523104;311.0357890539327;4464.709793863397;5267.947320526793;5315.813946511868;5323.7338133093335;5336.212368856428;5012.949870501294;5051.080589376032;5195.19474481456;5259.289995850559;5283.996040752264;3938.1926705025403;4072.8778136655947;4130.979345103286;4134.276501612221;4139.565345638703;3578.320119177348;4105.835766569334;4129.834806607747;4159.708820382574;4206.284931561642;3738.1962877981227;3778.9418962690493;3987.322155233617;4042.5957404259634;4053.1893621275863;3175.4601717707815;3790.65884070435;3823.8661646842365;3968.861089861841;4021.698372622065;3200.9039728808175;3319.751018673609;3492.2840817632323;3504.704418605792;3509.6665816747623;4423.938254818852;5015.5736762375245;5091.032703786306;5183.377994640629;5216.843494695166;3814.9427758583643;4239.788010599457;4482.462104547442;4562.543745625444;4563.498015218323;5522.514868309237;5530.446955304477;5538.6122971392015;5547.639403438804;5567.2762540869835;3253.886113986023;3805.315043292206;3807.9238415231816;3827.789471579062;3847.153626202231;5582.246396736429;5725.599208055396;5744.454276843693;5763.6541807491685;5857.326407463153;3796.9430458543143;3803.6006219347123;3806.7335286530233;3811.4092315691114;3823.5794062653085;3858.5176852893387;3880.4567360569545;3909.6872250219913;3915.2169566086895;3929.4695216146024;4278.935815962763;4427.955720442818;4481.865544033684;4498.437695288089;4554.590086892195;5539.612227144142;5544.390117087117;5545.530434434878;5550.00299838091;5605.80379686709;1233.9814902776466;1254.4417734108417;1255.8681338459512;1308.5158491358068;1337.197681391177;836.6151570277618;860.2300940658076;861.2636196052285;863.8099618084011;866.2247288676599;4579.931301030487;4706.623470122382;5158.38099428071;5193.662411943212;5203.427622961472;5622.662640241599;5638.718064096779;5653.971730141405;5666.631668941505;5677.716114194273;4768.974670445871;4973.403191616957;5177.249298851645;5264.13123341216;5300.92048619271;2862.441823844372;2959.9852000739857;2987.970120298769;2999.710124646423;3008.736330741094;5152.213123354331;5314.813981510706;5540.556755459554;5848.619839710405;5922.92697555852;4927.28554359623;5774.797882074107;5786.971065144648;5796.3913789052385;5847.3275573308765;4781;5474.808381706621;5833.766649333979;5886.852828679317;5924.999999999914;5275.472452754694;5652.886942261214;5683.545316374597;5690.487856092972;5721;5171.50870667286;5282.445343238905;5318.601104917069;5594.440555944373;5606.887862242814;5478.808241711521;5807.593468457168;5855.882882342415;5879.823605291677;5888.293404791452;3765.246950609834;3767.6232376762105;3771.811409429463;3778.7354885157774;3805.6765174959332;5652.095664693794;5670.886582268414;5693.686847223443;5768.509676677361;5819;4990.451050384528;5152;5391.818826892152;5419.701916394636;5590.748416321357;5229.2285088902945;5566.693831839126;5608.915866262091;5610.607257491936;5629.577781666309;5347.315595587377;5500.45987123606;5510.504054635102;5543.390227074938;5568.132411807841;4752.382190315237;5366.517013468807;5588.842304098172;5624.381318055092;5739.62692424991;4668.696534725232;5028.449253425656;5132.43543210254;5516;5540.97491963988 05:38:49 INFO - PROCESS | 1651 | |5;yui.html;771.6643260181821;793.8015496125969;796.1123347467575;818.840326136403;821.6935073233558;15000.39998400064;15875.603109922258;16526.091064991422;16568.83431165688;16632.66734665306;14783.482578109768;15203.54389368318;15210.490269105612;15215.619609509768;15290.235488225571;678.1082876018045;837.623069618671;864.3992425264444;866.6013633728493;867.9045305016443;691.6576294734114;845.8984921809391;862.7756783236372;875.916787905148;876.0801158783283;887.4409122252972;889.2663552569124;889.2885691446817;892.3485855325616;892.4199270474179;707.1796715809636;884.4516399832081;886.0165216609558;886.1847100667402;888.1695614600337;536.6136381805094;539.3420027566362;540.0522083743045;655.4690700532584;675.6081472745796;15250.466233681878;15257.923710381488;15287.923560382238;15288.923555382153;15301.08193508393;13752.243626600533;13949.574811303817;14165.78751318731;14181.36183871718;14394.928025359806;10974;11535.480903359368;11658.825117623242;11823.231489953125;11928.105392095627;4546.590806827401;4585.885352866172;4588.564086411786;4612.561806628399;4791.976040119777;105299;105608.94391056144;106673.46663266711;107782;110696;10536.841947370796;10630.255882088335;10747.301425407324;10762.56949722018;11081.722956926142;20403.693944590843;20534.69197962032;20588.38234852957;20593.794062059187;20610.484737881674;7760.436543141297;7831.804204894809;7836.255555722198;7848.646810893523;8022.478538894953;4018.9397159042637;4420.115976804587;4473.530279320625;4475.910481790346;4570.771461426915;3457.5159477673146;3588.784672919633;3590.6947909427467;3592.694620957248;3594.730395220369;553.1895772693024;667.6594936582378;675.6756756756785;675.7736158386996;676.9458443324522;481.971081735097;584.8830233953141;585.6808039618418;591.1103788797832;603.3483837455537;8530.829383412298;8967.272438064141;9174.724758257264;9204.447733136034;9278;468.33028768860856;613.362103412455;626.6115008694638;641.3842710997401;642.7686033028106;4150.543440221573;4581.65637577183;4619.260918253063;4628.481198663044;4662.300654901792;149620.75568866477;150872;155552.44447555378;157731;163770;116979.9812011282;117034.68927626846;120015.39992299983;123014.76985230212;147587.5241247595;110130.44934775274;113327.86672133338;115202;115678;117948.8205117955;8933.910660893307;9507.857382139135;9571.856422153534;10083.193344532567;10096.67451588223;46760.53239467562;59620;61006.38993610007;62782;62782.058269126916;46720;79190;83941.58029209815;90367;94029.58955615535;12737.681557961125;13068.660016633323;13111.737765244832;13700.520481783089;13811.723765524432;14901.850981490046;15018.699626007201;15055.924720376328;15192.240387980777;15217.173939127375;13535.390907409386;13705;13915.304234788018;14197.432102715775;14298.213598252196;11417.123199140746;13731.931340343634;13754.449822007007;13960.511382101578;14165.645858853612;13264.33678316061;13300.933495332461;13436.596902092953;13455.798163027759;13752.724945500833;11059.391733454737;11212.83180752273;11374.20380573352;11609;11906.91628964945;11184.552617895193;11422.519308973366;11439.313641181556;11617.941910290394;11623.244489108181 05:38:49 INFO - PROCESS | 1651 | __end_tp_report 05:38:49 INFO - PROCESS | 1651 | __start_cc_report 05:38:49 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1283 05:38:49 INFO - PROCESS | 1651 | __end_cc_report 05:38:49 INFO - PROCESS | 1651 | __startTimestamp1473338329462__endTimestamp 05:38:49 INFO - PROCESS | 1651 | 05:38:49 INFO - PROCESS | 1651 | ------- Summary: start ------- 05:38:49 INFO - PROCESS | 1651 | Number of tests: 6 05:38:49 INFO - PROCESS | 1651 | 05:38:49 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5736.78 Median:6003.25 stddev:665.80 (11.1%) stddev-sans-first:627.95 05:38:49 INFO - PROCESS | 1651 | Values: 2842.8 3306.6 3350.2 3381.7 3419.3 4039.7 5537.5 5672.6 5781.3 5787.3 5696.2 5734.7 5734.9 5747.7 5760.5 5159.2 5180.4 5195.7 5230.6 5265.5 5211.1 5288.4 5289.2 5289.3 5299.9 5149.6 5189.8 5211.2 5223.6 5292.1 5276.6 5286.8 5293.4 5300.5 5332.7 5084.1 5102.7 5135.7 5181.5 5204.8 5727.6 5760.7 5778.9 5827.0 5859.5 6209.0 6215.9 6216.7 6230.4 6241.2 6073.4 6128.1 6205.2 6222.3 6229.7 5935.5 5936.3 5987.9 5988.6 5990.8 6222.0 6288.4 6295.7 6307.6 6311.1 5996.4 6087.7 6095.6 6191.4 6203.8 5171.8 5201.6 6223.5 6229.5 6236.4 6215.5 6218.3 6224.0 6228.9 6240.2 6094.9 6112.8 6145.9 6227.3 6276.8 4974.6 4980.7 4983.8 4999.2 5000.3 4417.0 4441.5 4460.3 4465.2 4514.1 5731.3 5770.1 5774.7 5778.0 5781.0 6145.4 6212.3 6281.4 6286.6 6293.1 5644.1 5728.3 5732.8 5740.3 5745.9 4580.0 5467.3 5472.4 5472.6 5472.8 6185.5 6189.0 6224.4 6244.9 6252.4 6301.4 6303.7 6307.1 6309.9 6328.6 5326.0 6296.0 6301.5 6330.1 6332.1 6116.3 6120.0 6123.7 6232.3 6255.6 6111.0 6184.2 6238.1 6287.1 6309.3 6174.1 6183.2 6187.7 6197.9 6218.3 6038.6 6152.5 6191.8 6195.9 6210.0 5904.2 5979.1 5996.9 6022.0 6055.8 6139.1 6162.2 6173.6 6188.4 6195.4 6003.2 6008.9 6009.6 6048.9 6094.4 05:38:49 INFO - PROCESS | 1651 | 05:38:49 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:69633.82 Median:37697.22 stddev:151546.40 (402.0%) stddev-sans-first:151882.61 05:38:49 INFO - PROCESS | 1651 | Values: 487.3 491.5 522.0 522.0 528.9 26549.7 32365.7 40137.2 41249.0 41511.6 42095.2 42388.6 42427.8 42431.0 42662.9 9758.9 9950.8 9954.8 9957.3 9962.4 7468.3 11956.3 12183.1 12216.1 12345.8 12146.3 12195.2 12252.4 12253.4 12257.6 8779.6 12190.0 12270.7 12279.4 12294.4 11747.9 12016.3 12048.8 12230.1 12258.3 40366.0 40647.4 40701.8 40712.2 40771.2 3343.4 3364.3 3457.7 3458.9 4136.3 29650.3 30713.4 31132.7 31133.2 31137.8 3148.5 3168.3 3312.2 3336.8 3386.2 502373.0 503707.0 505833.0 507817.9 508003.0 57124.7 57581.0 57638.7 57694.0 57756.7 60652.0 60749.1 60795.0 60866.4 60879.0 16028.5 16268.9 16303.6 16309.5 16336.3 11468.0 11692.5 12755.6 12826.6 12827.1 15570.0 15890.6 15966.0 16133.8 16170.6 7109.9 7114.9 7118.8 7155.0 7235.7 841.9 929.4 971.8 998.9 1061.4 28578.1 29601.6 29793.0 30332.0 30410.0 964.7 1017.6 1077.7 1158.7 1228.7 13244.2 14026.0 14789.9 15272.4 15724.8 641743.0 647992.0 648299.0 649167.8 649529.0 56346.0 56675.0 56682.4 56734.0 56813.4 1199.8 1214.5 1299.7 1346.1 1360.6 29972.0 30693.8 30998.5 31100.4 31605.4 47709.0 48347.5 48380.3 48499.8 48544.5 536540.0 539684.0 540671.0 540745.0 541012.0 25546.6 26275.9 26280.3 26931.2 38403.0 46427.3 46723.3 46765.8 47113.8 47837.0 38096.0 38185.9 38493.2 38541.8 39706.8 32893.5 38539.6 38803.8 38889.4 39081.8 36630.6 37548.6 37845.8 37894.4 38148.0 31162.0 32237.0 33171.0 33430.0 33623.0 20600.3 24189.0 24563.3 25027.0 25377.0 05:38:49 INFO - PROCESS | 1651 | 05:38:49 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:33587.38 Median:366.36 stddev:89743.30 (24496.0%) stddev-sans-first:89960.35 05:38:49 INFO - PROCESS | 1651 | Values: 347.7 362.3 370.5 373.2 398.7 15331.0 16467.9 19959.5 20635.5 20730.0 19792.2 20073.5 20450.1 20454.6 20808.9 5290.6 5894.1 6109.4 6150.1 6150.1 4243.8 4447.4 6037.1 6121.1 6552.1 6762.5 6848.1 6870.6 6873.7 6880.6 6538.2 6720.4 6813.7 6821.1 6827.0 5248.7 5720.8 5790.4 5886.7 5903.5 25055.6 26108.1 26155.5 26248.6 26524.3 2201.5 2269.3 2397.2 2509.6 2953.9 13997.8 15604.5 15637.9 15848.9 16459.3 1851.7 1876.9 1879.7 1915.7 1923.1 108976.5 111812.4 112038.0 112513.9 114357.0 10264.3 10467.2 10532.7 10722.0 10897.8 13315.1 13328.0 13350.5 13363.3 13377.3 8292.7 8560.9 8584.2 8688.2 8750.8 8692.2 8695.2 8714.7 8835.0 8884.4 5809.5 6275.9 6421.5 6542.4 6574.1 1650.2 1757.2 1759.9 1775.0 1802.5 893.9 924.9 937.9 938.0 992.8 21397.0 22885.7 23434.6 23552.9 23606.5 916.7 973.1 981.0 988.4 1016.9 11668.6 11809.6 12062.3 12075.0 12448.6 490670.5 495749.0 498690.0 583640.0 586740.0 122013.0 128001.0 133174.0 141984.0 144705.0 936.1 939.6 982.7 996.2 998.9 18403.0 18909.0 19106.5 19183.8 19207.7 54427.0 55474.4 56354.4 57042.7 57848.7 81900.0 82080.0 83492.1 86276.6 86650.6 6503.4 7428.7 7858.0 7965.5 8221.0 10639.6 12727.0 13081.8 13405.3 13427.3 7638.9 8229.5 8325.0 8432.0 11092.6 11158.2 11255.9 11375.7 11722.8 11826.6 10456.6 10892.5 11524.2 11529.7 11798.2 6709.3 8186.9 8235.8 8251.9 8418.9 8280.9 9555.7 9827.4 11034.9 11771.5 05:38:49 INFO - PROCESS | 1651 | 05:38:49 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5762.74 Median:4861.09 stddev:3244.78 (66.8%) stddev-sans-first:3237.35 05:38:49 INFO - PROCESS | 1651 | Values: 1403.8 1528.9 1721.9 1825.4 1903.4 8520.4 9067.5 9074.0 9083.6 9088.8 7984.9 8199.0 8666.0 8852.8 8920.2 2385.9 2422.8 2424.1 2426.5 2429.0 2042.2 2393.8 2396.7 2413.8 2414.6 1944.7 2256.5 2370.9 2384.4 2399.8 2358.8 2372.3 2384.0 2384.7 2391.8 1973.7 2368.6 2370.6 2373.6 2375.1 8792.0 8921.0 8925.1 8928.7 9021.1 5244.6 5273.8 5415.2 5446.4 5453.9 3559.2 3612.5 3699.7 3706.2 3738.4 1034.4 1071.7 1073.9 1088.8 1089.2 11822.7 11907.0 11924.0 11932.3 11953.6 4562.8 4691.5 4847.5 4860.5 4861.7 10017.0 10043.2 10046.9 10052.0 10069.5 5431.1 5437.9 5440.9 5465.0 5468.0 4435.3 4574.9 4834.2 4940.5 4949.5 3406.0 3842.4 3903.2 3977.0 4002.3 1280.2 1287.7 1288.1 1298.5 1300.5 833.7 854.7 898.6 908.5 949.4 5721.8 5815.6 6013.1 6021.1 6130.3 936.6 937.8 938.6 945.5 997.4 3868.9 3933.9 3962.9 4076.6 4084.2 10626.8 10991.7 11028.2 11028.2 11044.0 10299.8 10686.6 10689.5 10947.4 10965.6 8034.0 8259.9 8263.3 8269.0 8269.5 5820.9 5865.9 5897.9 6091.1 6263.8 9658.9 9795.1 10213.1 10227.3 10277.1 10193.0 10301.2 10337.6 10337.8 10345.8 7029.1 7046.9 7427.3 7502.5 7604.2 8302.9 8546.4 8547.4 8547.8 8562.2 6275.7 7470.2 7521.8 7551.3 7647.2 7358.8 7366.0 7377.9 7415.4 7417.9 6898.8 7062.6 7066.3 7070.2 7073.8 4290.5 5046.0 5064.2 5112.8 5213.3 4919.6 5020.7 5113.3 5154.2 5258.5 05:38:49 INFO - PROCESS | 1651 | 05:38:49 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4516.43 Median:5174.38 stddev:1389.17 (26.8%) stddev-sans-first:1355.71 05:38:49 INFO - PROCESS | 1651 | Values: 252.8 267.3 308.2 308.9 311.0 4464.7 5267.9 5315.8 5323.7 5336.2 5012.9 5051.1 5195.2 5259.3 5284.0 3938.2 4072.9 4131.0 4134.3 4139.6 3578.3 4105.8 4129.8 4159.7 4206.3 3738.2 3778.9 3987.3 4042.6 4053.2 3175.5 3790.7 3823.9 3968.9 4021.7 3200.9 3319.8 3492.3 3504.7 3509.7 4423.9 5015.6 5091.0 5183.4 5216.8 3814.9 4239.8 4482.5 4562.5 4563.5 5522.5 5530.4 5538.6 5547.6 5567.3 3253.9 3805.3 3807.9 3827.8 3847.2 5582.2 5725.6 5744.5 5763.7 5857.3 3796.9 3803.6 3806.7 3811.4 3823.6 3858.5 3880.5 3909.7 3915.2 3929.5 4278.9 4428.0 4481.9 4498.4 4554.6 5539.6 5544.4 5545.5 5550.0 5605.8 1234.0 1254.4 1255.9 1308.5 1337.2 836.6 860.2 861.3 863.8 866.2 4579.9 4706.6 5158.4 5193.7 5203.4 5622.7 5638.7 5654.0 5666.6 5677.7 4769.0 4973.4 5177.2 5264.1 5300.9 2862.4 2960.0 2988.0 2999.7 3008.7 5152.2 5314.8 5540.6 5848.6 5922.9 4927.3 5774.8 5787.0 5796.4 5847.3 4781.0 5474.8 5833.8 5886.9 5925.0 5275.5 5652.9 5683.5 5690.5 5721.0 5171.5 5282.4 5318.6 5594.4 5606.9 5478.8 5807.6 5855.9 5879.8 5888.3 3765.2 3767.6 3771.8 3778.7 3805.7 5652.1 5670.9 5693.7 5768.5 5819.0 4990.5 5152.0 5391.8 5419.7 5590.7 5229.2 5566.7 5608.9 5610.6 5629.6 5347.3 5500.5 5510.5 5543.4 5568.1 4752.4 5366.5 5588.8 5624.4 5739.6 4668.7 5028.4 5132.4 5516.0 5541.0 05:38:49 INFO - PROCESS | 1651 | 05:38:49 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:24592.42 Median:20602.14 stddev:39509.45 (191.8%) stddev-sans-first:39579.80 05:38:49 INFO - PROCESS | 1651 | Values: 771.7 793.8 796.1 818.8 821.7 15000.4 15875.6 16526.1 16568.8 16632.7 14783.5 15203.5 15210.5 15215.6 15290.2 678.1 837.6 864.4 866.6 867.9 691.7 845.9 862.8 875.9 876.1 887.4 889.3 889.3 892.3 892.4 707.2 884.5 886.0 886.2 888.2 536.6 539.3 540.1 655.5 675.6 15250.5 15257.9 15287.9 15288.9 15301.1 13752.2 13949.6 14165.8 14181.4 14394.9 10974.0 11535.5 11658.8 11823.2 11928.1 4546.6 4585.9 4588.6 4612.6 4792.0 105299.0 105608.9 106673.5 107782.0 110696.0 10536.8 10630.3 10747.3 10762.6 11081.7 20403.7 20534.7 20588.4 20593.8 20610.5 7760.4 7831.8 7836.3 7848.6 8022.5 4018.9 4420.1 4473.5 4475.9 4570.8 3457.5 3588.8 3590.7 3592.7 3594.7 553.2 667.7 675.7 675.8 676.9 482.0 584.9 585.7 591.1 603.3 8530.8 8967.3 9174.7 9204.4 9278.0 468.3 613.4 626.6 641.4 642.8 4150.5 4581.7 4619.3 4628.5 4662.3 149620.8 150872.0 155552.4 157731.0 163770.0 116980.0 117034.7 120015.4 123014.8 147587.5 110130.4 113327.9 115202.0 115678.0 117948.8 8933.9 9507.9 9571.9 10083.2 10096.7 46760.5 59620.0 61006.4 62782.0 62782.1 46720.0 79190.0 83941.6 90367.0 94029.6 12737.7 13068.7 13111.7 13700.5 13811.7 14901.9 15018.7 15055.9 15192.2 15217.2 13535.4 13705.0 13915.3 14197.4 14298.2 11417.1 13731.9 13754.4 13960.5 14165.6 13264.3 13300.9 13436.6 13455.8 13752.7 11059.4 11212.8 11374.2 11609.0 11906.9 11184.6 11422.5 11439.3 11617.9 11623.2 05:38:49 INFO - PROCESS | 1651 | -------- Summary: end -------- 05:38:49 INFO - PROCESS | 1651 | 05:38:50 INFO - TEST-INFO | 1651: exit 0 05:38:50 INFO - TEST-OK | dromaeo_css | took 1117212ms 05:38:50 INFO - TEST-START | kraken 05:38:50 INFO - operating with platform_type : mac_ 05:38:50 INFO - Initialising browser for kraken test... 05:38:50 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpHIxQrH/profile http://localhost:49273/getInfo.html) 05:38:52 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 05:38:52 INFO - PROCESS | 1662 | colorDepth:24 05:38:52 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 05:38:52 INFO - PROCESS | 1662 | __metrics 05:38:52 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:38:52 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:38:53 INFO - TEST-INFO | 1662: exit 0 05:38:53 INFO - Browser initialized. 05:38:53 INFO - Running cycle 1/1 for kraken test... 05:38:53 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpHIxQrH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:05 INFO - PROCESS | 1663 | RSS: Main: 232562688 05:39:05 INFO - PROCESS | 1663 | 05:39:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 05:39:09 INFO - PROCESS | 1663 | RSS: Main: 291172352 05:39:09 INFO - PROCESS | 1663 | 05:39:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 05:39:12 INFO - PROCESS | 1663 | RSS: Main: 287391744 05:39:12 INFO - PROCESS | 1663 | 05:39:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 05:39:16 INFO - PROCESS | 1663 | RSS: Main: 375648256 05:39:16 INFO - PROCESS | 1663 | 05:39:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 05:39:19 INFO - PROCESS | 1663 | RSS: Main: 279052288 05:39:19 INFO - PROCESS | 1663 | 05:39:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:39:21 INFO - PROCESS | 1663 | RSS: Main: 283521024 05:39:21 INFO - PROCESS | 1663 | 05:39:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 05:39:25 INFO - PROCESS | 1663 | RSS: Main: 321007616 05:39:25 INFO - PROCESS | 1663 | 05:39:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 05:39:28 INFO - PROCESS | 1663 | RSS: Main: 321425408 05:39:28 INFO - PROCESS | 1663 | 05:39:31 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 05:39:32 INFO - PROCESS | 1663 | RSS: Main: 318930944 05:39:32 INFO - PROCESS | 1663 | 05:39:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:39:34 INFO - PROCESS | 1663 | RSS: Main: 296816640 05:39:34 INFO - PROCESS | 1663 | 05:39:36 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:39:36 INFO - PROCESS | 1663 | RSS: Main: 302604288 05:39:36 INFO - PROCESS | 1663 | 05:39:39 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:39:39 INFO - PROCESS | 1663 | RSS: Main: 303144960 05:39:39 INFO - PROCESS | 1663 | 05:39:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:39:43 INFO - PROCESS | 1663 | RSS: Main: 319918080 05:39:43 INFO - PROCESS | 1663 | 05:39:46 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:39:47 INFO - PROCESS | 1663 | RSS: Main: 315961344 05:39:47 INFO - PROCESS | 1663 | 05:39:48 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 05:39:48 INFO - PROCESS | 1663 | RSS: Main: 359837696 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | __start_tp_report 05:39:49 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 05:39:49 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 05:39:49 INFO - PROCESS | 1663 | |i|pagename|runs| 05:39:49 INFO - PROCESS | 1663 | |0;ai-astar;113;111;116;113;112;114;111;113;111;124 05:39:49 INFO - PROCESS | 1663 | |1;audio-beat-detection;147;110;134;163;106;129;128;107;159;106 05:39:49 INFO - PROCESS | 1663 | |2;audio-dft;185;184;187;183;183;182;187;184;178;183 05:39:49 INFO - PROCESS | 1663 | |3;audio-fft;80;76;92;190;80;82;57;63;148;81 05:39:49 INFO - PROCESS | 1663 | |4;audio-oscillator;83;85;134;68;71;83;119;69;70;118 05:39:49 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;88;89;134;117;88;84;89;85;90;91 05:39:49 INFO - PROCESS | 1663 | |6;imaging-darkroom;95;107;138;98;97;97;99;97;96;97 05:39:49 INFO - PROCESS | 1663 | |7;imaging-desaturate;85;87;86;85;85;87;84;86;86;85 05:39:49 INFO - PROCESS | 1663 | |8;json-parse-financial;54;56;55;54;54;54;53;55;51;53 05:39:49 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;65;68;70;73;72;77;72;70;71;70 05:39:49 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;85;86;84;86;84;87;81;87;90;90 05:39:49 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;138;136;136;137;135;141;139;137;185;145 05:39:49 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;229;168;170;239;202;169;167;167;229;209 05:39:49 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;66;66;68;67;67;67;67;68;67;69 05:39:49 INFO - PROCESS | 1663 | __end_tp_report 05:39:49 INFO - PROCESS | 1663 | __start_cc_report 05:39:49 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2026 05:39:49 INFO - PROCESS | 1663 | __end_cc_report 05:39:49 INFO - PROCESS | 1663 | __startTimestamp1473338389000__endTimestamp 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | ------- Summary: start ------- 05:39:49 INFO - PROCESS | 1663 | Number of tests: 14 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.00 stddev:3.91 (3.5%) stddev-sans-first:4.14 05:39:49 INFO - PROCESS | 1663 | Values: 113.0 111.0 116.0 113.0 112.0 114.0 111.0 113.0 111.0 124.0 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:131.50 stddev:21.88 (16.6%) stddev-sans-first:22.21 05:39:49 INFO - PROCESS | 1663 | Values: 147.0 110.0 134.0 163.0 106.0 129.0 128.0 107.0 159.0 106.0 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:2.59 (1.4%) stddev-sans-first:2.70 05:39:49 INFO - PROCESS | 1663 | Values: 185.0 184.0 187.0 183.0 183.0 182.0 187.0 184.0 178.0 183.0 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:94.90 Median:80.00 stddev:41.48 (51.9%) stddev-sans-first:43.65 05:39:49 INFO - PROCESS | 1663 | Values: 80.0 76.0 92.0 190.0 80.0 82.0 57.0 63.0 148.0 81.0 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:70.50 stddev:24.43 (34.6%) stddev-sans-first:25.78 05:39:49 INFO - PROCESS | 1663 | Values: 83.0 85.0 134.0 68.0 71.0 83.0 119.0 69.0 70.0 118.0 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:95.50 Median:88.50 stddev:16.45 (18.6%) stddev-sans-first:17.22 05:39:49 INFO - PROCESS | 1663 | Values: 88.0 89.0 134.0 117.0 88.0 84.0 89.0 85.0 90.0 91.0 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:102.10 Median:97.00 stddev:13.04 (13.4%) stddev-sans-first:13.58 05:39:49 INFO - PROCESS | 1663 | Values: 95.0 107.0 138.0 98.0 97.0 97.0 99.0 97.0 96.0 97.0 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:0.97 (1.1%) stddev-sans-first:1.00 05:39:49 INFO - PROCESS | 1663 | Values: 85.0 87.0 86.0 85.0 85.0 87.0 84.0 86.0 86.0 85.0 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.37 (2.5%) stddev-sans-first:1.45 05:39:49 INFO - PROCESS | 1663 | Values: 54.0 56.0 55.0 54.0 54.0 54.0 53.0 55.0 51.0 53.0 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.50 stddev:3.16 (4.4%) stddev-sans-first:2.55 05:39:49 INFO - PROCESS | 1663 | Values: 65.0 68.0 70.0 73.0 72.0 77.0 72.0 70.0 71.0 70.0 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.50 stddev:2.75 (3.2%) stddev-sans-first:2.89 05:39:49 INFO - PROCESS | 1663 | Values: 85.0 86.0 84.0 86.0 84.0 87.0 81.0 87.0 90.0 90.0 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:138.50 stddev:15.08 (10.9%) stddev-sans-first:15.89 05:39:49 INFO - PROCESS | 1663 | Values: 138.0 136.0 136.0 137.0 135.0 141.0 139.0 137.0 185.0 145.0 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.90 Median:205.50 stddev:29.98 (14.6%) stddev-sans-first:29.15 05:39:49 INFO - PROCESS | 1663 | Values: 229.0 168.0 170.0 239.0 202.0 169.0 167.0 167.0 229.0 209.0 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 05:39:49 INFO - PROCESS | 1663 | Values: 66.0 66.0 68.0 67.0 67.0 67.0 67.0 68.0 67.0 69.0 05:39:49 INFO - PROCESS | 1663 | -------- Summary: end -------- 05:39:49 INFO - PROCESS | 1663 | 05:39:49 INFO - TEST-INFO | 1663: exit 0 05:39:49 INFO - TEST-OK | kraken | took 59695ms 05:39:49 INFO - SUITE-END | took 1176s 05:39:50 INFO - Completed test suite (00:19:37) 05:39:50 INFO - javascript benchmark 05:39:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2842.8436435996023, 3306.553615261939, 3350.162459385155, 3381.695647391737, 3419.2990436960426, 4039.697022723293, 5537.473939975706, 5672.631278966869, 5781.306243250805, 5787.334456537495, 5696.174054762057, 5734.713264336777, 5734.885302293952, 5747.741351639176, 5760.4815566599, 5159.226116082589, 5180.404253510838, 5195.6622819516615, 5230.633855630107, 5265.473452654742, 5211.088059589576, 5288.365396152467, 5289.153735402337, 5289.2859463972445, 5299.867503312409, 5149.562287205592, 5189.792408303663, 5211.218317252405, 5223.608229382792, 5292.126799078167, 5276.630635855492, 5286.762095705702, 5293.417724050351, 5300.549453296474, 5332.733363331818, 5084.059449001947, 5102.668326558799, 5135.666181698178, 5181.5077567631015, 5204.843854684365, 5727.599068065237, 5760.654360738327, 5778.942210577925, 5827.0, 5859.531237501033, 6209.0, 6215.906761398583, 6216.720247588869, 6230.408111229426, 6241.21984751906, 6073.399325508986, 6128.105930682418, 6205.162303089115, 6222.3466536013975, 6229.688515574248, 5935.465808077251, 5936.347001829795, 5987.9101813472835, 5988.580799344091, 5990.7903223386975, 6221.96889015552, 6288.371162883675, 6295.685215739195, 6307.590006649553, 6311.147995020705, 5996.400359963969, 6087.66517841523, 6095.61970315344, 6191.442770150618, 6203.7828675997025, 5171.81898633546, 5201.635885487979, 6223.502119830403, 6229.470495007885, 6236.407541283571, 6215.502759779207, 6218.347073557211, 6224.0, 6228.906566401508, 6240.157578726905, 6094.8943112006145, 6112.807455516588, 6145.924463218918, 6227.283862355796, 6276.843078923063, 4974.626902982291, 4980.726060066731, 4983.800647974041, 4999.225120106389, 5000.299958005882, 4417.0, 4441.511433742286, 4460.30865215892, 4465.173942820588, 4514.142312960527, 5731.340895797037, 5770.13447982806, 5774.68239246837, 5778.0, 5780.971095144498, 6145.354737752472, 6212.285587157445, 6281.403266689657, 6286.5599408041, 6293.056041593706, 5644.068728659725, 5728.312602487728, 5732.77068917247, 5740.339860915965, 5745.91381129275, 4579.9542004579525, 5467.343918729778, 5472.425395333512, 5472.644278121909, 5472.781088756406, 6185.474234690102, 6189.04069869171, 6224.408681175371, 6244.937550624436, 6252.374762523802, 6301.40136687014, 6303.684815759102, 6307.05394190875, 6309.90535141964, 6328.588641738273, 5325.97337013328, 6296.0, 6301.527385446018, 6330.050492426173, 6332.145160403471, 6116.305337586134, 6119.959572021022, 6123.693815309128, 6232.283287422005, 6255.56211065221, 6110.969445152746, 6184.196054513064, 6238.064290356483, 6287.119803227461, 6309.33751956038, 6174.104754810617, 6183.227096612924, 6187.721552530057, 6197.876042479215, 6218.284897236876, 6038.577299589162, 6152.538559607958, 6191.7523299069335, 6195.938040619536, 6210.0, 5904.173415721888, 5979.103134529855, 5996.914674268573, 6021.969890150521, 6055.757769689163, 6139.109829074849, 6162.22972128484, 6173.629582225081, 6188.3502232266765, 6195.411435913581, 6003.249593800775, 6008.8798224036145, 6009.609375390585, 6048.909266361096, 6094.39056094387], "value": 5693.704167149934, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.264231011173, 491.48394186104593, 521.9556337711294, 522.0029743190507, 528.9418164001959, 26549.734502654966, 32365.67634323653, 40137.1972560549, 41248.968775780544, 41511.58488415115, 42095.158096838044, 42388.57611423885, 42427.78786106065, 42431.0, 42662.93342666435, 9758.902410975907, 9950.800983980316, 9954.800903981915, 9957.302988790787, 9962.352447090952, 7468.3278504934815, 11956.342401167933, 12183.08626852985, 12216.144869859114, 12345.753084938297, 12146.33195174265, 12195.207311524768, 12252.387380630977, 12253.387330633434, 12257.632271031884, 8779.64881404743, 12190.024798016137, 12270.693232669166, 12279.447424865903, 12294.385280735973, 11747.882521174764, 12016.339101349422, 12048.819267710991, 12230.14388992771, 12258.26450412978, 40366.0, 40647.39028914569, 40701.79649101765, 40712.185756285005, 40771.1845763086, 3343.36476069546, 3364.2934983653463, 3457.6715212054814, 3458.9308213835584, 4136.296829538986, 29650.258743531584, 30713.38573228523, 31132.688673113207, 31133.221669458217, 31137.844310778302, 3148.480500717379, 3168.30297334586, 3312.188513814107, 3336.7831090979007, 3386.153461634591, 502373.0, 503707.0, 505833.0, 507817.92182078445, 508002.9999999963, 57124.71437642868, 57581.0, 57638.7118064407, 57694.0, 57756.71121644365, 60652.0, 60749.08876366858, 60795.0, 60866.391336086956, 60879.0, 16028.519144425685, 16268.918655406647, 16303.592410189603, 16309.51071467858, 16336.346546138022, 11468.0, 11692.47383867728, 12755.553555625509, 12826.55107071248, 12827.102102852898, 15570.0, 15890.602734931488, 15966.0, 16133.757993630104, 16170.595735106717, 7109.8933515997305, 7114.928850711427, 7118.786436406813, 7155.0, 7235.710571577078, 841.9326453883674, 929.3587424676952, 971.7619183299995, 998.8701468809008, 1061.442742560162, 28578.142655720363, 29601.555976660366, 29793.0, 30332.0, 30410.0, 964.6864768950119, 1017.5980487707462, 1077.6928575355985, 1158.7450760832603, 1228.705110773408, 13244.20534767917, 14026.018178727596, 14789.926050369895, 15272.389104435699, 15724.842751572567, 641743.0, 647992.0, 648299.0, 649167.7541612262, 649529.0, 56346.0, 56675.0, 56682.43317566771, 56734.0, 56813.43186568164, 1199.8080307150815, 1214.5020541578087, 1299.6555912682957, 1346.0913883128849, 1360.5646193218274, 29971.958046842825, 30693.846530767205, 30998.535021975138, 31100.377992440477, 31605.36789264248, 47709.0, 48347.516524834304, 48380.27429588488, 48499.75750121368, 48544.514554854, 536540.0, 539684.0, 540671.0, 540745.0, 541012.0, 25546.616800748376, 26275.868620656773, 26280.34299142537, 26931.192064238105, 38403.0, 46427.303590445496, 46723.29915051345, 46765.76617116893, 47113.764431177624, 47837.0, 38096.0, 38185.85442436732, 38493.230135396574, 38541.80729096336, 39706.80146599249, 32893.50659740154, 38539.6146038536, 38803.80598097105, 38889.41665874958, 39081.80459097686, 36630.63369366379, 37548.6245137556, 37845.810770945965, 37894.431583525715, 38148.04629884275, 31162.0, 32237.0, 33171.00973941571, 33429.997100087036, 33623.0, 20600.27899023527, 24189.032438702256, 24563.263102106965, 25027.0, 25377.0], "value": 20134.587268064166, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.7200853313085, 362.2573723866074, 370.46097927515484, 373.2069352625671, 398.6671129606778, 15331.0, 16467.917660411713, 19959.501012474695, 20635.484112897186, 20729.99999999998, 19792.208311667553, 20073.498162545944, 20450.07974641141, 20454.590908181828, 20808.895955520202, 5290.550303224211, 5894.145348924414, 6109.389061093877, 6150.1082343060225, 6150.1082343060225, 4243.830246790125, 4447.377367168583, 6037.094435834638, 6121.081837724332, 6552.082708420801, 6762.492813039017, 6848.1097457330725, 6870.553414028072, 6873.725050997979, 6880.6215658139035, 6538.1827271591055, 6720.428763555079, 6813.693383797691, 6821.113255276832, 6826.965865170692, 5248.71132087735, 5720.771169153229, 5790.449907258803, 5886.70566471679, 5903.468687818074, 25055.62416563753, 26108.086216982316, 26155.476890462083, 26248.60627090595, 26524.336891577674, 2201.4936564590075, 2269.341890851651, 2397.2209032064648, 2509.560826855293, 2953.8523073846436, 13997.790033149511, 15604.453844115515, 15637.921810390875, 15848.92075539615, 16459.25933333003, 1851.7129844873932, 1876.8873867567854, 1879.6898511745546, 1915.7126431035317, 1923.1249781349452, 108976.4551177239, 111812.4409377956, 112038.0, 112513.87486125116, 114357.0, 10264.332818366931, 10467.214958878114, 10532.736681583021, 10722.0, 10897.782044359226, 13315.06794524374, 13328.0, 13350.532731354357, 13363.331833408485, 13377.331133443484, 8292.668293268322, 8560.914390856136, 8584.227419532272, 8688.218060374596, 8750.781230469162, 8692.174243446863, 8695.217430431165, 8714.69498567547, 8835.0, 8884.37809353339, 5809.506191973645, 6275.905861412082, 6421.486281097595, 6542.378474044958, 6574.112494813235, 1650.2161473300087, 1757.1829099468807, 1759.876808623384, 1774.97337539937, 1802.4682718598044, 893.9471704130322, 924.8890133184061, 937.8593211018265, 938.0150841616276, 992.8014397120605, 21397.0, 22885.656715149285, 23434.64848027281, 23552.882235588713, 23606.527869442514, 916.6654171227455, 973.1047436358567, 980.9558569864373, 988.4316518002178, 1016.898310168992, 11668.591599294154, 11809.645710628694, 12062.276263424223, 12075.0, 12448.62654120378, 490670.5466472645, 495749.0, 498690.0, 583640.0, 586740.0, 122013.0, 128001.0, 133174.0, 141984.0, 144705.0, 936.134075979716, 939.5865819039601, 982.7101005203482, 996.1781530237583, 998.930074894765, 18403.0, 18909.0, 19106.522336941132, 19183.80816191876, 19207.711884322027, 54427.0, 55474.44525554854, 56354.43645563656, 57042.7147864258, 57848.71075644595, 81900.0, 82080.0, 83492.0777772775, 86276.56861715902, 86650.56674716838, 6503.447206987459, 7428.702851885864, 7858.0, 7965.4822436541435, 8220.958895205486, 10639.616849809476, 12727.0, 13081.803772943604, 13405.324334458193, 13427.26150061756, 7638.885416718865, 8229.464930408489, 8325.000999880052, 8431.95784021076, 11092.611758588411, 11158.218924675195, 11255.943720281346, 11375.658730237776, 11722.824157637471, 11826.58606948787, 10456.63401780934, 10892.455377231265, 11524.193306468467, 11529.711757206136, 11798.174127810971, 6709.295523969913, 8186.8771968421715, 8235.83528329418, 8251.876221856797, 8418.905542279464, 8280.875786863322, 9555.665551705657, 9827.361221520578, 11034.889651103707, 11771.529138834694], "value": 9752.285062980889, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.8385585657647, 1528.9311980960856, 1721.8794684372092, 1825.4067428085875, 1903.448000079976, 8520.446170998888, 9067.455952642846, 9073.954630226855, 9083.636654533828, 9088.772780680478, 7984.92015079849, 8199.0, 8666.0, 8852.77868053299, 8920.241779448756, 2385.8926348314367, 2422.8304018718695, 2424.1394305021727, 2426.4904370082304, 2429.0283886445477, 2042.213747707136, 2393.772591603795, 2396.664466974625, 2413.8431001984814, 2414.6498757680124, 1944.6596845552042, 2256.4697296135396, 2370.8577485350847, 2384.3681424422543, 2399.8200134989947, 2358.7995020423286, 2372.3120295114395, 2384.010635586238, 2384.71383433989, 2391.796697280733, 1973.7236786849853, 2368.5973384524673, 2370.6207006878817, 2373.6202207646693, 2375.1212051541042, 8792.0, 8921.01868794432, 8925.107489251088, 8928.73213803587, 9021.097890210927, 5244.580433565306, 5273.815416460406, 5415.214793854909, 5446.373667028302, 5453.863653408696, 3559.2169722660974, 3612.4581312803025, 3699.667029967316, 3706.166112624665, 3738.4018557030745, 1034.3897100710617, 1071.7320669832543, 1073.940933248671, 1088.8149014667526, 1089.1939964426347, 11822.704432389173, 11907.047436205083, 11924.046076313874, 11932.343721095336, 11953.641390758377, 4562.817487300471, 4691.46048204454, 4847.466778654345, 4860.4896485869185, 4861.683990540603, 10017.0, 10043.19654427644, 10046.899531004743, 10052.0, 10069.496525173858, 5431.131019036935, 5437.918431223535, 5440.863978400493, 5465.043617366945, 5467.988422141916, 4435.290353543418, 4574.908501829945, 4834.20235661112, 4940.456549779521, 4949.529794669501, 3406.0, 3842.442845787345, 3903.2193561287854, 3976.9602303977167, 4002.2595819773437, 1280.238258236348, 1287.7488889666424, 1288.1176394170025, 1298.5260379961246, 1300.5058077930514, 833.6707000734676, 854.6666799948025, 898.573177740568, 908.4957848394073, 949.4350861237552, 5721.828345149652, 5815.621984570989, 6013.128096426081, 6021.066734656135, 6130.295016073209, 936.5832204668993, 937.7514958535993, 938.5776400619749, 945.4988855906381, 997.4065431068502, 3868.9226215476097, 3933.901652458654, 3962.8612998544913, 4076.5923407658997, 4084.1627466369323, 10626.840597391045, 10991.725206869733, 11028.22802403824, 11028.2280240384, 11043.950824671643, 10299.794004119876, 10686.625968091079, 10689.518971646294, 10947.397893115796, 10965.56137754481, 8033.995750531183, 8259.876101858477, 8263.256306932284, 8269.04905935825, 8269.545175015312, 5820.912686309794, 5865.94134058654, 5897.852553686193, 6091.086337049301, 6263.843403914939, 9658.855117173107, 9795.118439340493, 10213.08082272599, 10227.335223210468, 10277.126444252322, 10193.0316619921, 10301.227407944583, 10337.586496540054, 10337.84493232587, 10345.793084138124, 7029.121359830021, 7046.859062818818, 7427.294407031323, 7502.474826762293, 7604.2395760423515, 8302.916970830456, 8546.35902307317, 8547.444416112932, 8547.786305342168, 8562.186592273723, 6275.748970041147, 7470.178280389261, 7521.811954701177, 7551.320381165721, 7647.19704431049, 7358.77923662291, 7365.968764372885, 7377.889331660137, 7415.406767458482, 7417.851642967218, 6898.827529311808, 7062.646867656494, 7066.328698773608, 7070.186928503288, 7073.82315442118, 4290.50659174199, 5046.0, 5064.164412871983, 5112.795488180431, 5213.270142180174, 4919.581835544019, 5020.673656212334, 5113.284140220298, 5154.175331946871, 5258.474152584711], "value": 4623.891076086328, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [252.835656823065, 267.2770156726056, 308.1909986285999, 308.9320349523104, 311.0357890539327, 4464.709793863397, 5267.947320526793, 5315.813946511868, 5323.7338133093335, 5336.212368856428, 5012.949870501294, 5051.080589376032, 5195.19474481456, 5259.289995850559, 5283.996040752264, 3938.1926705025403, 4072.8778136655947, 4130.979345103286, 4134.276501612221, 4139.565345638703, 3578.320119177348, 4105.835766569334, 4129.834806607747, 4159.708820382574, 4206.284931561642, 3738.1962877981227, 3778.9418962690493, 3987.322155233617, 4042.5957404259634, 4053.1893621275863, 3175.4601717707815, 3790.65884070435, 3823.8661646842365, 3968.861089861841, 4021.698372622065, 3200.9039728808175, 3319.751018673609, 3492.2840817632323, 3504.704418605792, 3509.6665816747623, 4423.938254818852, 5015.5736762375245, 5091.032703786306, 5183.377994640629, 5216.843494695166, 3814.9427758583643, 4239.788010599457, 4482.462104547442, 4562.543745625444, 4563.498015218323, 5522.514868309237, 5530.446955304477, 5538.6122971392015, 5547.639403438804, 5567.2762540869835, 3253.886113986023, 3805.315043292206, 3807.9238415231816, 3827.789471579062, 3847.153626202231, 5582.246396736429, 5725.599208055396, 5744.454276843693, 5763.6541807491685, 5857.326407463153, 3796.9430458543143, 3803.6006219347123, 3806.7335286530233, 3811.4092315691114, 3823.5794062653085, 3858.5176852893387, 3880.4567360569545, 3909.6872250219913, 3915.2169566086895, 3929.4695216146024, 4278.935815962763, 4427.955720442818, 4481.865544033684, 4498.437695288089, 4554.590086892195, 5539.612227144142, 5544.390117087117, 5545.530434434878, 5550.00299838091, 5605.80379686709, 1233.9814902776466, 1254.4417734108417, 1255.8681338459512, 1308.5158491358068, 1337.197681391177, 836.6151570277618, 860.2300940658076, 861.2636196052285, 863.8099618084011, 866.2247288676599, 4579.931301030487, 4706.623470122382, 5158.38099428071, 5193.662411943212, 5203.427622961472, 5622.662640241599, 5638.718064096779, 5653.971730141405, 5666.631668941505, 5677.716114194273, 4768.974670445871, 4973.403191616957, 5177.249298851645, 5264.13123341216, 5300.92048619271, 2862.441823844372, 2959.9852000739857, 2987.970120298769, 2999.710124646423, 3008.736330741094, 5152.213123354331, 5314.813981510706, 5540.556755459554, 5848.619839710405, 5922.92697555852, 4927.28554359623, 5774.797882074107, 5786.971065144648, 5796.3913789052385, 5847.3275573308765, 4781.0, 5474.808381706621, 5833.766649333979, 5886.852828679317, 5924.999999999914, 5275.472452754694, 5652.886942261214, 5683.545316374597, 5690.487856092972, 5721.0, 5171.50870667286, 5282.445343238905, 5318.601104917069, 5594.440555944373, 5606.887862242814, 5478.808241711521, 5807.593468457168, 5855.882882342415, 5879.823605291677, 5888.293404791452, 3765.246950609834, 3767.6232376762105, 3771.811409429463, 3778.7354885157774, 3805.6765174959332, 5652.095664693794, 5670.886582268414, 5693.686847223443, 5768.509676677361, 5819.0, 4990.451050384528, 5152.0, 5391.818826892152, 5419.701916394636, 5590.748416321357, 5229.2285088902945, 5566.693831839126, 5608.915866262091, 5610.607257491936, 5629.577781666309, 5347.315595587377, 5500.45987123606, 5510.504054635102, 5543.390227074938, 5568.132411807841, 4752.382190315237, 5366.517013468807, 5588.842304098172, 5624.381318055092, 5739.62692424991, 4668.696534725232, 5028.449253425656, 5132.43543210254, 5516.0, 5540.97491963988], "value": 4062.4741276317627, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.6643260181821, 793.8015496125969, 796.1123347467575, 818.840326136403, 821.6935073233558, 15000.39998400064, 15875.603109922258, 16526.091064991422, 16568.83431165688, 16632.66734665306, 14783.482578109768, 15203.54389368318, 15210.490269105612, 15215.619609509768, 15290.235488225571, 678.1082876018045, 837.623069618671, 864.3992425264444, 866.6013633728493, 867.9045305016443, 691.6576294734114, 845.8984921809391, 862.7756783236372, 875.916787905148, 876.0801158783283, 887.4409122252972, 889.2663552569124, 889.2885691446817, 892.3485855325616, 892.4199270474179, 707.1796715809636, 884.4516399832081, 886.0165216609558, 886.1847100667402, 888.1695614600337, 536.6136381805094, 539.3420027566362, 540.0522083743045, 655.4690700532584, 675.6081472745796, 15250.466233681878, 15257.923710381488, 15287.923560382238, 15288.923555382153, 15301.08193508393, 13752.243626600533, 13949.574811303817, 14165.78751318731, 14181.36183871718, 14394.928025359806, 10974.0, 11535.480903359368, 11658.825117623242, 11823.231489953125, 11928.105392095627, 4546.590806827401, 4585.885352866172, 4588.564086411786, 4612.561806628399, 4791.976040119777, 105299.0, 105608.94391056144, 106673.46663266711, 107782.0, 110696.0, 10536.841947370796, 10630.255882088335, 10747.301425407324, 10762.56949722018, 11081.722956926142, 20403.693944590843, 20534.69197962032, 20588.38234852957, 20593.794062059187, 20610.484737881674, 7760.436543141297, 7831.804204894809, 7836.255555722198, 7848.646810893523, 8022.478538894953, 4018.9397159042637, 4420.115976804587, 4473.530279320625, 4475.910481790346, 4570.771461426915, 3457.5159477673146, 3588.784672919633, 3590.6947909427467, 3592.694620957248, 3594.730395220369, 553.1895772693024, 667.6594936582378, 675.6756756756785, 675.7736158386996, 676.9458443324522, 481.971081735097, 584.8830233953141, 585.6808039618418, 591.1103788797832, 603.3483837455537, 8530.829383412298, 8967.272438064141, 9174.724758257264, 9204.447733136034, 9278.0, 468.33028768860856, 613.362103412455, 626.6115008694638, 641.3842710997401, 642.7686033028106, 4150.543440221573, 4581.65637577183, 4619.260918253063, 4628.481198663044, 4662.300654901792, 149620.75568866477, 150872.0, 155552.44447555378, 157731.0, 163770.0, 116979.9812011282, 117034.68927626846, 120015.39992299983, 123014.76985230212, 147587.5241247595, 110130.44934775274, 113327.86672133338, 115202.0, 115678.0, 117948.8205117955, 8933.910660893307, 9507.857382139135, 9571.856422153534, 10083.193344532567, 10096.67451588223, 46760.53239467562, 59620.0, 61006.38993610007, 62782.0, 62782.058269126916, 46720.0, 79190.0, 83941.58029209815, 90367.0, 94029.58955615535, 12737.681557961125, 13068.660016633323, 13111.737765244832, 13700.520481783089, 13811.723765524432, 14901.850981490046, 15018.699626007201, 15055.924720376328, 15192.240387980777, 15217.173939127375, 13535.390907409386, 13705.0, 13915.304234788018, 14197.432102715775, 14298.213598252196, 11417.123199140746, 13731.931340343634, 13754.449822007007, 13960.511382101578, 14165.645858853612, 13264.33678316061, 13300.933495332461, 13436.596902092953, 13455.798163027759, 13752.724945500833, 11059.391733454737, 11212.83180752273, 11374.20380573352, 11609.0, 11906.91628964945, 11184.552617895193, 11422.519308973366, 11439.313641181556, 11617.941910290394, 11623.244489108181], "value": 7781.03858597309, "unit": "score"}], "name": "dromaeo_css", "value": 7394.141057728688, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 116.0, 113.0, 112.0, 114.0, 111.0, 113.0, 111.0, 124.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 110.0, 134.0, 163.0, 106.0, 129.0, 128.0, 107.0, 159.0, 106.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 187.0, 183.0, 183.0, 182.0, 187.0, 184.0, 178.0, 183.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 92.0, 190.0, 80.0, 82.0, 57.0, 63.0, 148.0, 81.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 134.0, 68.0, 71.0, 83.0, 119.0, 69.0, 70.0, 118.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 134.0, 117.0, 88.0, 84.0, 89.0, 85.0, 90.0, 91.0], "value": 95.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 107.0, 138.0, 98.0, 97.0, 97.0, 99.0, 97.0, 96.0, 97.0], "value": 102.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 86.0, 85.0, 85.0, 87.0, 84.0, 86.0, 86.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 55.0, 54.0, 54.0, 54.0, 53.0, 55.0, 51.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 70.0, 73.0, 72.0, 77.0, 72.0, 70.0, 71.0, 70.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 86.0, 84.0, 87.0, 81.0, 87.0, 90.0, 90.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 136.0, 137.0, 135.0, 141.0, 139.0, 137.0, 185.0, 145.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [229.0, 168.0, 170.0, 239.0, 202.0, 169.0, 167.0, 167.0, 229.0, 209.0], "value": 194.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 69.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1510.1000000000001, "alertThreshold": 2.0}]} 05:39:50 INFO - Return code: 0 05:39:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:39:50 INFO - # TBPL SUCCESS # 05:39:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:39:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:39:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:39:50 INFO - 2016-09-08 05:39:50.311 screenresolution[1667:10192] starting screenresolution argv=screenresolution get 05:39:50 INFO - 2016-09-08 05:39:50.314 screenresolution[1667:10192] Display 0: 1600x1200x32@60 05:39:50 INFO - 2016-09-08 05:39:50.320 screenresolution[1668:10195] starting screenresolution argv=screenresolution list 05:39:50 INFO - Available Modes on Display 0 05:39:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:39:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:39:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:39:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:39:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:39:50 INFO - Intel Iris: 05:39:50 INFO - Chipset Model: Intel Iris 05:39:50 INFO - Type: GPU 05:39:50 INFO - Bus: Built-In 05:39:50 INFO - VRAM (Dynamic, Max): 1536 MB 05:39:50 INFO - Vendor: Intel (0x8086) 05:39:50 INFO - Device ID: 0x0a2e 05:39:50 INFO - Revision ID: 0x0009 05:39:50 INFO - Displays: 05:39:50 INFO - Display: 05:39:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:39:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:39:50 INFO - Display Serial Number: 1600x1200 60 05:39:50 INFO - Main Display: Yes 05:39:50 INFO - Mirror: Off 05:39:50 INFO - Online: Yes 05:39:50 INFO - Rotation: Supported 05:39:50 INFO - Return code: 0 05:39:50 INFO - Running post-action listener: _resource_record_post_action 05:39:50 INFO - [mozharness: 2016-09-08 12:39:50.553885Z] Finished run-tests step (success) 05:39:50 INFO - Running post-run listener: _resource_record_post_run 05:39:50 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37299200; Write bytes: 703447552; Read time: 241; Write time: 1980 05:39:50 INFO - TinderboxPrint: CPU usage
53.6% 05:39:50 INFO - TinderboxPrint: I/O read bytes / time
37,299,200 / 241 05:39:50 INFO - TinderboxPrint: I/O write bytes / time
703,447,552 / 1,980 05:39:50 INFO - TinderboxPrint: CPU idle
2,252.2 (46.4%) 05:39:50 INFO - TinderboxPrint: CPU system
968.8 (20.0%) 05:39:50 INFO - TinderboxPrint: CPU user
1,628.7 (33.6%) 05:39:50 INFO - TinderboxPrint: Swap in / out
442,793,984 / 0 05:39:50 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 406561280; Write bytes: 408901632; Read time: 30488; Write time: 877 05:39:50 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 34477056; Write bytes: 293063168; Read time: 216; Write time: 1094 05:39:51 INFO - Running post-run listener: _upload_blobber_files 05:39:51 INFO - Blob upload gear active. 05:39:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:39:51 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 05:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:39:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:39:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:39:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:39:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:39:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:39:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:39:52 INFO - (blobuploader) - INFO - Done attempting. 05:39:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:39:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:39:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:39:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:39:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:39:53 INFO - (blobuploader) - INFO - Done attempting. 05:39:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:39:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:39:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:39:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:39:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:39:56 INFO - (blobuploader) - INFO - Done attempting. 05:39:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:39:56 INFO - Return code: 0 05:39:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:39:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:39:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d47392ac8f9102052019757376d01971704d0b28ec9b7cfc204abc9ebaf716df555cbb8d331d81a861e9f68d69033ff0ddd0790b37a01ed9498739b3ff9f893", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43be1232e9234f8811afb9a91d4d8b6de1dcfe6187632d00fad9373d4fe4e65109cbe93d13ca6d1acab9dc4aa648f53bab41acb08193efbcfe12f62b777626fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f445ba9039e2bf748d159b05a8ca6ff5ea8d7fe3a4a0420816f2d9884dec274975ef12a16cd23dc8102baf69eb1c9289d4742c8c36f2021668197d1121d6046a"} 05:39:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:39:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:39:56 INFO - Contents: 05:39:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d47392ac8f9102052019757376d01971704d0b28ec9b7cfc204abc9ebaf716df555cbb8d331d81a861e9f68d69033ff0ddd0790b37a01ed9498739b3ff9f893", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43be1232e9234f8811afb9a91d4d8b6de1dcfe6187632d00fad9373d4fe4e65109cbe93d13ca6d1acab9dc4aa648f53bab41acb08193efbcfe12f62b777626fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f445ba9039e2bf748d159b05a8ca6ff5ea8d7fe3a4a0420816f2d9884dec274975ef12a16cd23dc8102baf69eb1c9289d4742c8c36f2021668197d1121d6046a"} 05:39:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:39:56 INFO - Copying logs to upload dir... 05:39:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:39:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.379943 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-08 05:39:56.745916) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-08 05:39:56.749841) ========= 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.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d47392ac8f9102052019757376d01971704d0b28ec9b7cfc204abc9ebaf716df555cbb8d331d81a861e9f68d69033ff0ddd0790b37a01ed9498739b3ff9f893", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43be1232e9234f8811afb9a91d4d8b6de1dcfe6187632d00fad9373d4fe4e65109cbe93d13ca6d1acab9dc4aa648f53bab41acb08193efbcfe12f62b777626fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f445ba9039e2bf748d159b05a8ca6ff5ea8d7fe3a4a0420816f2d9884dec274975ef12a16cd23dc8102baf69eb1c9289d4742c8c36f2021668197d1121d6046a"} build_url:https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/d9SGfqZ9TF2laRjs7rAAEA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d47392ac8f9102052019757376d01971704d0b28ec9b7cfc204abc9ebaf716df555cbb8d331d81a861e9f68d69033ff0ddd0790b37a01ed9498739b3ff9f893", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43be1232e9234f8811afb9a91d4d8b6de1dcfe6187632d00fad9373d4fe4e65109cbe93d13ca6d1acab9dc4aa648f53bab41acb08193efbcfe12f62b777626fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f445ba9039e2bf748d159b05a8ca6ff5ea8d7fe3a4a0420816f2d9884dec274975ef12a16cd23dc8102baf69eb1c9289d4742c8c36f2021668197d1121d6046a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-08 05:39:56.787726) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 05:39:56.788618) ========= 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.6SjP1c8GFV/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.Nw6hy5kQpJ/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005141 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 05:39:56.843227) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-08 05:39:56.843933) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-08 05:39:56.844696) ========= ========= Total master_lag: 0.20 =========