builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0171 starttime: 1473380469.21 results: success (0) buildid: 20160908152324 builduid: 2265503967234389bb7ca064c5344b6b revision: 176aff980979bf588baed78c2824571a6a7f2b96 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 17:21:09.212536) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 17:21:09.213357) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 17:21:09.213629) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 17:21:09.237144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 17:21:09.237499) ========= 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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 17:21:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.2M=0.001s 2016-09-08 17:21:09 (16.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149362 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 17:21:09.415923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 17:21:09.416200) ========= 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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.027939 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 17:21:09.464553) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-08 17:21:09.464907) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 176aff980979bf588baed78c2824571a6a7f2b96 --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 176aff980979bf588baed78c2824571a6a7f2b96 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yjLwqbs2WS/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.xyWPS6H5sg/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 17:21:09,533 truncating revision to first 12 chars 2016-09-08 17:21:09,533 Setting DEBUG logging. 2016-09-08 17:21:09,534 attempt 1/10 2016-09-08 17:21:09,534 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/176aff980979?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-08 17:21:10,727 unpacking tar archive at: mozilla-central-176aff980979/testing/mozharness/ program finished with exit code 0 elapsedTime=1.439179 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-08 17:21:10.927716) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 17:21:10.928335) ========= script_repo_revision: 176aff980979bf588baed78c2824571a6a7f2b96 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 17:21:10.928848) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 17:21:10.929208) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 17:21:10.948706) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-09-08 17:21:10.949437) ========= /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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:21:11 INFO - MultiFileLogger online at 20160908 17:21:11 in /builds/slave/test 17:21:11 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 17:21:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:21:11 INFO - {'append_to_log': False, 17:21:11 INFO - 'base_work_dir': '/builds/slave/test', 17:21:11 INFO - 'blob_upload_branch': 'Firefox', 17:21:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:21:11 INFO - 'branch': 'Firefox', 17:21:11 INFO - 'buildbot_json_path': 'buildprops.json', 17:21:11 INFO - 'config_files': ('talos/mac_config.py',), 17:21:11 INFO - 'default_actions': ('clobber', 17:21:11 INFO - 'read-buildbot-config', 17:21:11 INFO - 'download-and-extract', 17:21:11 INFO - 'populate-webroot', 17:21:11 INFO - 'create-virtualenv', 17:21:11 INFO - 'install', 17:21:11 INFO - 'run-tests'), 17:21:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:21:11 INFO - 'download_minidump_stackwalk': True, 17:21:11 INFO - 'download_symbols': 'ondemand', 17:21:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:21:11 INFO - 'tooltool.py': '/tools/tooltool.py', 17:21:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:21:11 INFO - '/tools/misc-python/virtualenv.py')}, 17:21:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:21:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:21:11 INFO - 'installer_path': 'installer.exe', 17:21:11 INFO - 'log_level': 'info', 17:21:11 INFO - 'log_name': 'talos', 17:21:11 INFO - 'log_to_console': True, 17:21:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:21:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:21:11 INFO - 'opt_config_files': (), 17:21:11 INFO - 'pip_index': False, 17:21:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:21:11 INFO - 'cmd': ('bash', 17:21:11 INFO - '-c', 17:21:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:21:11 INFO - 'enabled': True, 17:21:11 INFO - 'halt_on_failure': False, 17:21:11 INFO - 'name': 'check_screen_resolution'},), 17:21:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:21:11 INFO - 'cmd': ('bash', 17:21:11 INFO - '-c', 17:21:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:21:11 INFO - 'enabled': True, 17:21:11 INFO - 'halt_on_failure': False, 17:21:11 INFO - 'name': 'check_screen_resolution'},), 17:21:11 INFO - 'run_cmd_checks_enabled': True, 17:21:11 INFO - 'sps_profile': False, 17:21:11 INFO - 'sps_profile_interval': 0, 17:21:11 INFO - 'suite': 'dromaeojs', 17:21:11 INFO - 'system_bits': '32', 17:21:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:21:11 INFO - 'title': 't-yosemite-r7-0171', 17:21:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:21:11 INFO - 'use_talos_json': True, 17:21:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:21:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:21:11 INFO - 'work_dir': 'build'} 17:21:11 INFO - [mozharness: 2016-09-09 00:21:11.142225Z] Running clobber step. 17:21:11 INFO - Running pre-action listener: _resource_record_pre_action 17:21:11 INFO - Running main action method: clobber 17:21:11 INFO - rmtree: /builds/slave/test/build 17:21:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:21:13 INFO - Running post-action listener: _resource_record_post_action 17:21:13 INFO - [mozharness: 2016-09-09 00:21:13.472044Z] Finished clobber step (success) 17:21:13 INFO - [mozharness: 2016-09-09 00:21:13.472185Z] Running read-buildbot-config step. 17:21:13 INFO - Running pre-action listener: _resource_record_pre_action 17:21:13 INFO - Running main action method: read_buildbot_config 17:21:13 INFO - Using buildbot properties: 17:21:13 INFO - { 17:21:13 INFO - "project": "", 17:21:13 INFO - "product": "firefox", 17:21:13 INFO - "script_repo_revision": "production", 17:21:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:21:13 INFO - "repository": "", 17:21:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:21:13 INFO - "buildid": "20160908152324", 17:21:13 INFO - "pgo_build": "False", 17:21:13 INFO - "basedir": "/builds/slave/test", 17:21:13 INFO - "buildnumber": 47, 17:21:13 INFO - "slavename": "t-yosemite-r7-0171", 17:21:13 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:21:13 INFO - "platform": "yosemite_r7", 17:21:13 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:21:13 INFO - "branch": "mozilla-central", 17:21:13 INFO - "repo_path": "mozilla-central", 17:21:13 INFO - "revision": "176aff980979bf588baed78c2824571a6a7f2b96", 17:21:13 INFO - "stage_platform": "macosx64", 17:21:13 INFO - "builduid": "2265503967234389bb7ca064c5344b6b", 17:21:13 INFO - "slavebuilddir": "test" 17:21:13 INFO - } 17:21:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/KKQ3fEwCRkalfUWP1rxE5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 17:21:13 INFO - Running post-action listener: _resource_record_post_action 17:21:13 INFO - [mozharness: 2016-09-09 00:21:13.477757Z] Finished read-buildbot-config step (success) 17:21:13 INFO - [mozharness: 2016-09-09 00:21:13.477971Z] Running download-and-extract step. 17:21:13 INFO - Running pre-action listener: _resource_record_pre_action 17:21:13 INFO - Running main action method: download_and_extract 17:21:13 INFO - mkdir: /builds/slave/test/build/tests 17:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:13 INFO - trying https://queue.taskcluster.net/v1/task/KKQ3fEwCRkalfUWP1rxE5A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 17:21:13 INFO - Downloading https://queue.taskcluster.net/v1/task/KKQ3fEwCRkalfUWP1rxE5A/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 17:21:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KKQ3fEwCRkalfUWP1rxE5A/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 17:21:14 INFO - Downloaded 1199 bytes. 17:21:14 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:21:14 INFO - Using the following test package requirements: 17:21:14 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:21:14 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:21:14 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 17:21:14 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:21:14 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 17:21:14 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:21:14 INFO - u'jsshell-mac.zip'], 17:21:14 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:21:14 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 17:21:14 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:21:14 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:21:14 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 17:21:14 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:21:14 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 17:21:14 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:21:14 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 17:21:14 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:21:14 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 17:21:14 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:21:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KKQ3fEwCRkalfUWP1rxE5A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:21:15 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 17:21:22 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 17:21:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KKQ3fEwCRkalfUWP1rxE5A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:21:23 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 17:21:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KKQ3fEwCRkalfUWP1rxE5A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:21:30 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 17:21: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')]} 17:21:31 INFO - trying https://queue.taskcluster.net/v1/task/KKQ3fEwCRkalfUWP1rxE5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:21:31 INFO - Downloading https://queue.taskcluster.net/v1/task/KKQ3fEwCRkalfUWP1rxE5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 17:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KKQ3fEwCRkalfUWP1rxE5A/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 17:21:35 INFO - Downloaded 111528138 bytes. 17:21:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KKQ3fEwCRkalfUWP1rxE5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:21:35 INFO - mkdir: /builds/slave/test/properties 17:21:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:21:35 INFO - Writing to file /builds/slave/test/properties/build_url 17:21:35 INFO - Contents: 17:21:35 INFO - build_url:https://queue.taskcluster.net/v1/task/KKQ3fEwCRkalfUWP1rxE5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:21:36 INFO - Running post-action listener: _resource_record_post_action 17:21:36 INFO - Running post-action listener: set_extra_try_arguments 17:21:36 INFO - [mozharness: 2016-09-09 00:21:36.694302Z] Finished download-and-extract step (success) 17:21:36 INFO - [mozharness: 2016-09-09 00:21:36.694457Z] Running populate-webroot step. 17:21:36 INFO - Running pre-action listener: _resource_record_pre_action 17:21:36 INFO - Running main action method: populate_webroot 17:21:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:21:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:21:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:21:36 INFO - '--tppagecycles', 17:21:36 INFO - '7'], 17:21:36 INFO - 'tests': ['tsvgm']}}, 17:21:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:21:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:21:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:21:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:21:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:21:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:21:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:36 INFO - 'talos_options': ['--disable-e10s'], 17:21:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:36 INFO - 'talos_options': ['--disable-e10s'], 17:21:36 INFO - 'tests': ['damp', 'tps']}, 17:21:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:36 INFO - 'tests': ['damp', 'tps']}, 17:21:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:21:36 INFO - 'tests': ['dromaeo_dom']}, 17:21:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:21:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:21:36 INFO - 'tests': ['basic_compositor_video']}, 17:21:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:21:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:21:36 INFO - 'tests': ['a11yr', 17:21:36 INFO - 'ts_paint', 17:21:36 INFO - 'tpaint', 17:21:36 INFO - 'sessionrestore', 17:21:36 INFO - 'sessionrestore_no_auto_restore', 17:21:36 INFO - 'tabpaint']}, 17:21:36 INFO - 'other-e10s': {'tests': ['a11yr', 17:21:36 INFO - 'ts_paint', 17:21:36 INFO - 'tpaint', 17:21:36 INFO - 'sessionrestore', 17:21:36 INFO - 'sessionrestore_no_auto_restore', 17:21:36 INFO - 'tabpaint']}, 17:21:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:21:36 INFO - 'ts_paint', 17:21:36 INFO - 'tpaint', 17:21:36 INFO - 'sessionrestore', 17:21:36 INFO - 'sessionrestore_no_auto_restore', 17:21:36 INFO - 'tabpaint']}, 17:21:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:21:36 INFO - 'ts_paint', 17:21:36 INFO - 'tpaint', 17:21:36 INFO - 'sessionrestore', 17:21:36 INFO - 'sessionrestore_no_auto_restore', 17:21:36 INFO - 'tabpaint']}, 17:21:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:21:36 INFO - 'tests': ['a11yr', 17:21:36 INFO - 'ts_paint', 17:21:36 INFO - 'tpaint', 17:21:36 INFO - 'sessionrestore', 17:21:36 INFO - 'sessionrestore_no_auto_restore', 17:21:36 INFO - 'tabpaint']}, 17:21:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:21:36 INFO - 'tests': ['a11yr', 17:21:36 INFO - 'ts_paint', 17:21:36 INFO - 'tpaint', 17:21:36 INFO - 'sessionrestore', 17:21:36 INFO - 'sessionrestore_no_auto_restore', 17:21:36 INFO - 'tabpaint']}, 17:21:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:21:36 INFO - 'tests': ['tsvgx', 17:21:36 INFO - 'tsvgr_opacity', 17:21:36 INFO - 'tart', 17:21:36 INFO - 'tscrollx', 17:21:36 INFO - 'cart']}, 17:21:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:21:36 INFO - 'tsvgr_opacity', 17:21:36 INFO - 'tart', 17:21:36 INFO - 'tscrollx', 17:21:36 INFO - 'cart']}, 17:21:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:36 INFO - 'talos_options': ['--disable-e10s'], 17:21:36 INFO - 'tests': ['tp5o']}, 17:21:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:36 INFO - 'tests': ['tp5o']}, 17:21:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:36 INFO - 'talos_options': ['--disable-e10s', 17:21:36 INFO - '--xperf_path', 17:21:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:36 INFO - 'tests': ['tp5n']}, 17:21:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:36 INFO - 'talos_options': ['--xperf_path', 17:21:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:36 INFO - 'tests': ['tp5n']}}, 17:21:36 INFO - 'talos.zip': {'path': '', 17:21:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:21:36 INFO - Running post-action listener: _resource_record_post_action 17:21:36 INFO - [mozharness: 2016-09-09 00:21:36.713497Z] Finished populate-webroot step (success) 17:21:36 INFO - [mozharness: 2016-09-09 00:21:36.713634Z] Running create-virtualenv step. 17:21:36 INFO - Running pre-action listener: _resource_record_pre_action 17:21:36 INFO - Running main action method: create_virtualenv 17:21:36 INFO - Creating virtualenv /builds/slave/test/build/venv 17:21:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:21:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:21:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:21:36 INFO - Using real prefix '/tools/python27' 17:21:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:21:37 INFO - Installing distribute.............................................................................................................................................................................................done. 17:21:40 INFO - Installing pip.................done. 17:21:40 INFO - Return code: 0 17:21:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:40 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 0x10d421a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4b6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a0ca26a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d385d30>, '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 0x10d0eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37db20>, '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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:21:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:21:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yjLwqbs2WS/Render', 17:21:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:40 INFO - 'HOME': '/Users/cltbld', 17:21:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:40 INFO - 'LOGNAME': 'cltbld', 17:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:40 INFO - 'MOZ_NO_REMOTE': '1', 17:21:40 INFO - 'NO_EM_RESTART': '1', 17:21:40 INFO - 'PAGER': '/bin/cat', 17:21:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:40 INFO - 'PWD': '/builds/slave/test', 17:21:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:40 INFO - 'SHELL': '/bin/bash', 17:21:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyWPS6H5sg/Listeners', 17:21:40 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:21:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:40 INFO - 'USER': 'cltbld', 17:21:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:40 INFO - 'XPC_FLAGS': '0x0', 17:21:40 INFO - 'XPC_SERVICE_NAME': '0', 17:21:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:21:40 INFO - Cleaning up... 17:21:40 INFO - Return code: 0 17:21:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:40 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 0x10d421a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4b6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a0ca26a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d385d30>, '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 0x10d0eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37db20>, '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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:21:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:21:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yjLwqbs2WS/Render', 17:21:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:40 INFO - 'HOME': '/Users/cltbld', 17:21:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:40 INFO - 'LOGNAME': 'cltbld', 17:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:40 INFO - 'MOZ_NO_REMOTE': '1', 17:21:40 INFO - 'NO_EM_RESTART': '1', 17:21:40 INFO - 'PAGER': '/bin/cat', 17:21:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:40 INFO - 'PWD': '/builds/slave/test', 17:21:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:40 INFO - 'SHELL': '/bin/bash', 17:21:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyWPS6H5sg/Listeners', 17:21:40 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:21:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:40 INFO - 'USER': 'cltbld', 17:21:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:40 INFO - 'XPC_FLAGS': '0x0', 17:21:40 INFO - 'XPC_SERVICE_NAME': '0', 17:21:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:40 INFO - Downloading/unpacking psutil>=3.1.1 17:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:21:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:21:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:21:44 INFO - Installing collected packages: psutil 17:21:44 INFO - Running setup.py install for psutil 17:21:45 INFO - building 'psutil._psutil_osx' extension 17:21:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:21:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:21:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:21:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:21:45 INFO - building 'psutil._psutil_posix' extension 17:21:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:21:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:21:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:21:45 INFO - ^ 17:21:46 INFO - 1 warning generated. 17:21:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:21:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:21:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:21:46 INFO - Successfully installed psutil 17:21:46 INFO - Cleaning up... 17:21:46 INFO - Return code: 0 17:21:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:46 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 0x10d421a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4b6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a0ca26a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d385d30>, '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 0x10d0eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37db20>, '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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:21:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:21:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yjLwqbs2WS/Render', 17:21:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:46 INFO - 'HOME': '/Users/cltbld', 17:21:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:46 INFO - 'LOGNAME': 'cltbld', 17:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:46 INFO - 'MOZ_NO_REMOTE': '1', 17:21:46 INFO - 'NO_EM_RESTART': '1', 17:21:46 INFO - 'PAGER': '/bin/cat', 17:21:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:46 INFO - 'PWD': '/builds/slave/test', 17:21:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:46 INFO - 'SHELL': '/bin/bash', 17:21:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyWPS6H5sg/Listeners', 17:21:46 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:21:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:46 INFO - 'USER': 'cltbld', 17:21:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:46 INFO - 'XPC_FLAGS': '0x0', 17:21:46 INFO - 'XPC_SERVICE_NAME': '0', 17:21:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:21:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:21:49 INFO - Installing collected packages: mozsystemmonitor 17:21:49 INFO - Running setup.py install for mozsystemmonitor 17:21:49 INFO - Successfully installed mozsystemmonitor 17:21:49 INFO - Cleaning up... 17:21:49 INFO - Return code: 0 17:21:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:49 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 0x10d421a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4b6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a0ca26a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d385d30>, '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 0x10d0eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37db20>, '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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:21:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:21:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yjLwqbs2WS/Render', 17:21:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:49 INFO - 'HOME': '/Users/cltbld', 17:21:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:49 INFO - 'LOGNAME': 'cltbld', 17:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:49 INFO - 'MOZ_NO_REMOTE': '1', 17:21:49 INFO - 'NO_EM_RESTART': '1', 17:21:49 INFO - 'PAGER': '/bin/cat', 17:21:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:49 INFO - 'PWD': '/builds/slave/test', 17:21:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:49 INFO - 'SHELL': '/bin/bash', 17:21:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyWPS6H5sg/Listeners', 17:21:49 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:21:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:49 INFO - 'USER': 'cltbld', 17:21:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:49 INFO - 'XPC_FLAGS': '0x0', 17:21:49 INFO - 'XPC_SERVICE_NAME': '0', 17:21:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:49 INFO - Downloading/unpacking jsonschema==2.5.1 17:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:21:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:52 INFO - Downloading functools32-3.2.3-2.tar.gz 17:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:21:52 INFO - warning: no files found matching '*.txt' 17:21:52 INFO - no previously-included directories found matching 'build' 17:21:52 INFO - no previously-included directories found matching 'dist' 17:21:52 INFO - no previously-included directories found matching '.git*' 17:21:52 INFO - Installing collected packages: jsonschema, functools32 17:21:52 INFO - Running setup.py install for functools32 17:21:52 INFO - warning: no files found matching '*.txt' 17:21:52 INFO - no previously-included directories found matching 'build' 17:21:52 INFO - no previously-included directories found matching 'dist' 17:21:52 INFO - no previously-included directories found matching '.git*' 17:21:52 INFO - Successfully installed jsonschema functools32 17:21:52 INFO - Cleaning up... 17:21:52 INFO - Return code: 0 17:21:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:52 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 0x10d421a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4b6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a0ca26a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d385d30>, '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 0x10d0eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37db20>, '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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:21:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:21:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yjLwqbs2WS/Render', 17:21:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:52 INFO - 'HOME': '/Users/cltbld', 17:21:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:52 INFO - 'LOGNAME': 'cltbld', 17:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:52 INFO - 'MOZ_NO_REMOTE': '1', 17:21:52 INFO - 'NO_EM_RESTART': '1', 17:21:52 INFO - 'PAGER': '/bin/cat', 17:21:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:52 INFO - 'PWD': '/builds/slave/test', 17:21:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:52 INFO - 'SHELL': '/bin/bash', 17:21:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyWPS6H5sg/Listeners', 17:21:52 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:21:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:52 INFO - 'USER': 'cltbld', 17:21:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:52 INFO - 'XPC_FLAGS': '0x0', 17:21:52 INFO - 'XPC_SERVICE_NAME': '0', 17:21:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:21:53 INFO - Cleaning up... 17:21:53 INFO - Return code: 0 17:21:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:53 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 0x10d421a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4b6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a0ca26a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d385d30>, '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 0x10d0eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37db20>, '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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:21:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:21:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yjLwqbs2WS/Render', 17:21:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:53 INFO - 'HOME': '/Users/cltbld', 17:21:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:53 INFO - 'LOGNAME': 'cltbld', 17:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:53 INFO - 'MOZ_NO_REMOTE': '1', 17:21:53 INFO - 'NO_EM_RESTART': '1', 17:21:53 INFO - 'PAGER': '/bin/cat', 17:21:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:53 INFO - 'PWD': '/builds/slave/test', 17:21:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:53 INFO - 'SHELL': '/bin/bash', 17:21:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyWPS6H5sg/Listeners', 17:21:53 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:21:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:53 INFO - 'USER': 'cltbld', 17:21:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:53 INFO - 'XPC_FLAGS': '0x0', 17:21:53 INFO - 'XPC_SERVICE_NAME': '0', 17:21:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:53 INFO - Downloading/unpacking blobuploader==1.2.4 17:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:55 INFO - Downloading blobuploader-1.2.4.tar.gz 17:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:21:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:21:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:56 INFO - Downloading docopt-0.6.1.tar.gz 17:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:21:57 INFO - Installing collected packages: blobuploader, requests, docopt 17:21:57 INFO - Running setup.py install for blobuploader 17:21:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:21:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:21:57 INFO - Running setup.py install for requests 17:21:57 INFO - Running setup.py install for docopt 17:21:57 INFO - Successfully installed blobuploader requests docopt 17:21:57 INFO - Cleaning up... 17:21:57 INFO - Return code: 0 17:21:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:57 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 0x10d421a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4b6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a0ca26a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d385d30>, '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 0x10d0eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37db20>, '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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:21:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yjLwqbs2WS/Render', 17:21:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:57 INFO - 'HOME': '/Users/cltbld', 17:21:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:57 INFO - 'LOGNAME': 'cltbld', 17:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:57 INFO - 'MOZ_NO_REMOTE': '1', 17:21:57 INFO - 'NO_EM_RESTART': '1', 17:21:57 INFO - 'PAGER': '/bin/cat', 17:21:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:57 INFO - 'PWD': '/builds/slave/test', 17:21:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:57 INFO - 'SHELL': '/bin/bash', 17:21:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyWPS6H5sg/Listeners', 17:21:57 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:21:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:57 INFO - 'USER': 'cltbld', 17:21:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:57 INFO - 'XPC_FLAGS': '0x0', 17:21:57 INFO - 'XPC_SERVICE_NAME': '0', 17:21:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:21:58 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-PeN9m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:21:58 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-sc2DBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:21:58 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-x5JuCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:21:58 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-E2PVdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:21:58 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-QZyuZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:21:58 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-ITlxZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:21:58 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-EfJsj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:21:58 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-7nIBi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:21:59 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-LXRcZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:21:59 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-oRDl7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:21:59 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-8uka4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:21:59 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-mHy3wK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:21:59 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-aGDKyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:21:59 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-1WlRaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:59 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-nVtUFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:21:59 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-q9CNF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:21:59 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-CkcuF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:21:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:21:59 INFO - Running setup.py install for manifestparser 17:22:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:22:00 INFO - Running setup.py install for mozcrash 17:22:00 INFO - Running setup.py install for mozdebug 17:22:00 INFO - Running setup.py install for mozdevice 17:22:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:22:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:22:00 INFO - Running setup.py install for mozfile 17:22:00 INFO - Running setup.py install for mozhttpd 17:22:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:22:00 INFO - Running setup.py install for mozinfo 17:22:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:22:00 INFO - Running setup.py install for mozInstall 17:22:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:22:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:22:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:22:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:22:01 INFO - Running setup.py install for mozleak 17:22:01 INFO - Running setup.py install for mozlog 17:22:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:22:01 INFO - Running setup.py install for moznetwork 17:22:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:22:01 INFO - Running setup.py install for mozprocess 17:22:01 INFO - Running setup.py install for mozprofile 17:22:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:22:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:22:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:22:01 INFO - Running setup.py install for mozrunner 17:22:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:22:02 INFO - Running setup.py install for mozscreenshot 17:22:02 INFO - Running setup.py install for moztest 17:22:02 INFO - Running setup.py install for mozversion 17:22:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:22:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:22:02 INFO - Cleaning up... 17:22:02 INFO - Return code: 0 17:22:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22: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')]} 17:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:02 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 0x10d421a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4b6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a0ca26a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d385d30>, '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 0x10d0eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37db20>, '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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:22:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:22:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yjLwqbs2WS/Render', 17:22:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:02 INFO - 'HOME': '/Users/cltbld', 17:22:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:02 INFO - 'LOGNAME': 'cltbld', 17:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:02 INFO - 'MOZ_NO_REMOTE': '1', 17:22:02 INFO - 'NO_EM_RESTART': '1', 17:22:02 INFO - 'PAGER': '/bin/cat', 17:22:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:02 INFO - 'PWD': '/builds/slave/test', 17:22:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:02 INFO - 'SHELL': '/bin/bash', 17:22:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyWPS6H5sg/Listeners', 17:22:02 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:22:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:02 INFO - 'USER': 'cltbld', 17:22:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:02 INFO - 'XPC_FLAGS': '0x0', 17:22:02 INFO - 'XPC_SERVICE_NAME': '0', 17:22:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:22:02 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-0HQDey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:22:02 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-wg4r1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:22:03 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)) 17:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:22:03 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-RgKHho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:22:03 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-OIyewI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:22:03 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-jcmxeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:22:03 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-B_lDdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:22:03 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-MgBq_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:22:03 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-7uKe83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:22:03 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Q0lwRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:22:03 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-LBd_Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:22:03 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)) 17:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:22:03 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-R1QzMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:22:03 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-zSi_6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:22:04 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-2sOgQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:22:04 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-obSSEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:22:04 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)) 17:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:04 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-E6lJ3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:22:04 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Mh4V6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:22:04 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-uhBnKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:22:04 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)) 17:22:04 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)) 17:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:22:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:07 INFO - Downloading blessings-1.6.tar.gz 17:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:22:07 INFO - Installing collected packages: blessings 17:22:07 INFO - Running setup.py install for blessings 17:22:07 INFO - Successfully installed blessings 17:22:07 INFO - Cleaning up... 17:22:07 INFO - Return code: 0 17:22:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:22:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:22:07 INFO - Reading from file tmpfile_stdout 17:22:07 INFO - Current package versions: 17:22:07 INFO - blessings == 1.6 17:22:07 INFO - blobuploader == 1.2.4 17:22:07 INFO - docopt == 0.6.1 17:22:07 INFO - functools32 == 3.2.3-2 17:22:07 INFO - jsonschema == 2.5.1 17:22:07 INFO - manifestparser == 1.1 17:22:07 INFO - mozInstall == 1.12 17:22:07 INFO - mozcrash == 0.17 17:22:07 INFO - mozdebug == 0.1 17:22:07 INFO - mozdevice == 0.48 17:22:07 INFO - mozfile == 1.2 17:22:07 INFO - mozhttpd == 0.7 17:22:07 INFO - mozinfo == 0.9 17:22:07 INFO - mozleak == 0.1 17:22:07 INFO - mozlog == 3.3 17:22:07 INFO - moznetwork == 0.27 17:22:07 INFO - mozprocess == 0.23 17:22:07 INFO - mozprofile == 0.28 17:22:07 INFO - mozrunner == 6.12 17:22:07 INFO - mozscreenshot == 0.1 17:22:07 INFO - mozsystemmonitor == 0.3 17:22:07 INFO - moztest == 0.7 17:22:07 INFO - mozversion == 1.4 17:22:07 INFO - psutil == 3.1.1 17:22:07 INFO - requests == 1.2.3 17:22:07 INFO - wsgiref == 0.1.2 17:22:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:07 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 0x10d421a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4b6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a0ca26a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d385d30>, '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 0x10d0eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37db20>, '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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:22:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:22:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yjLwqbs2WS/Render', 17:22:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:07 INFO - 'HOME': '/Users/cltbld', 17:22:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:07 INFO - 'LOGNAME': 'cltbld', 17:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:07 INFO - 'MOZ_NO_REMOTE': '1', 17:22:07 INFO - 'NO_EM_RESTART': '1', 17:22:07 INFO - 'PAGER': '/bin/cat', 17:22:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:07 INFO - 'PWD': '/builds/slave/test', 17:22:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:07 INFO - 'SHELL': '/bin/bash', 17:22:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyWPS6H5sg/Listeners', 17:22:07 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:22:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:07 INFO - 'USER': 'cltbld', 17:22:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:07 INFO - 'XPC_FLAGS': '0x0', 17:22:07 INFO - 'XPC_SERVICE_NAME': '0', 17:22:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:22:07 INFO - Cleaning up... 17:22:07 INFO - Return code: 0 17:22:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d421a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4b6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8a0ca26a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d385d30>, '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 0x10d0eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37db20>, '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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:22:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:22:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yjLwqbs2WS/Render', 17:22:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:08 INFO - 'HOME': '/Users/cltbld', 17:22:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:08 INFO - 'LOGNAME': 'cltbld', 17:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:08 INFO - 'MOZ_NO_REMOTE': '1', 17:22:08 INFO - 'NO_EM_RESTART': '1', 17:22:08 INFO - 'PAGER': '/bin/cat', 17:22:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:08 INFO - 'PWD': '/builds/slave/test', 17:22:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:08 INFO - 'SHELL': '/bin/bash', 17:22:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyWPS6H5sg/Listeners', 17:22:08 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:22:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:08 INFO - 'USER': 'cltbld', 17:22:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:08 INFO - 'XPC_FLAGS': '0x0', 17:22:08 INFO - 'XPC_SERVICE_NAME': '0', 17:22:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:22:08 INFO - Cleaning up... 17:22:08 INFO - Return code: 0 17:22:08 INFO - Running post-action listener: _resource_record_post_action 17:22:08 INFO - Running post-action listener: _start_resource_monitoring 17:22:08 INFO - Starting resource monitoring. 17:22:08 INFO - [mozharness: 2016-09-09 00:22:08.296948Z] Finished create-virtualenv step (success) 17:22:08 INFO - [mozharness: 2016-09-09 00:22:08.297924Z] Running install step. 17:22:08 INFO - Running pre-action listener: _resource_record_pre_action 17:22:08 INFO - Running main action method: install 17:22:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:22:08 INFO - Reading from file tmpfile_stdout 17:22:08 INFO - Detecting whether we're running mozinstall >=1.0... 17:22:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:22:08 INFO - Reading from file tmpfile_stdout 17:22:08 INFO - Output received: 17:22:08 INFO - Usage: mozinstall [options] installer 17:22:08 INFO - Options: 17:22:08 INFO - -h, --help show this help message and exit 17:22:08 INFO - -d DEST, --destination=DEST 17:22:08 INFO - Directory to install application into. [default: 17:22:08 INFO - "/builds/slave/test"] 17:22:08 INFO - --app=APP Application being installed. [default: firefox] 17:22:08 INFO - mkdir: /builds/slave/test/build/application 17:22:08 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'] 17:22:08 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 17:22:42 INFO - Reading from file tmpfile_stdout 17:22:42 INFO - Output received: 17:22:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:22:42 INFO - Running post-action listener: _resource_record_post_action 17:22:42 INFO - [mozharness: 2016-09-09 00:22:42.819848Z] Finished install step (success) 17:22:42 INFO - [mozharness: 2016-09-09 00:22:42.819981Z] Running run-tests step. 17:22:42 INFO - Running pre-action listener: _resource_record_pre_action 17:22:42 INFO - Running main action method: run_tests 17:22:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:22:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:22:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:22:42 INFO - 2016-09-08 17:22:42.834 screenresolution[1643:8518] starting screenresolution argv=screenresolution get 17:22:42 INFO - 2016-09-08 17:22:42.837 screenresolution[1643:8518] Display 0: 1600x1200x32@60 17:22:42 INFO - 2016-09-08 17:22:42.842 screenresolution[1644:8520] starting screenresolution argv=screenresolution list 17:22:42 INFO - Available Modes on Display 0 17:22:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:22:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:22:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:22:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:22:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:22:43 INFO - Intel Iris: 17:22:43 INFO - Chipset Model: Intel Iris 17:22:43 INFO - Type: GPU 17:22:43 INFO - Bus: Built-In 17:22:43 INFO - VRAM (Dynamic, Max): 1536 MB 17:22:43 INFO - Vendor: Intel (0x8086) 17:22:43 INFO - Device ID: 0x0a2e 17:22:43 INFO - Revision ID: 0x0009 17:22:43 INFO - Displays: 17:22:43 INFO - Display: 17:22:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:22:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:22:43 INFO - Display Serial Number: 1600x1200 60 17:22:43 INFO - Main Display: Yes 17:22:43 INFO - Mirror: Off 17:22:43 INFO - Online: Yes 17:22:43 INFO - Rotation: Supported 17:22:43 INFO - Return code: 0 17:22:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:22:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:22:43 INFO - Python 2.7.3 17:22:43 INFO - Return code: 0 17:22:43 INFO - grabbing minidump binary from tooltool 17:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:43 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 0x10d385d30>, '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 0x10d0eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:22:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:22:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:22:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:22:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:22:43 INFO - Return code: 0 17:22:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:22:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:22:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:22:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:22:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:22:43 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/KKQ3fEwCRkalfUWP1rxE5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:22:43 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/KKQ3fEwCRkalfUWP1rxE5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0171 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:22:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yjLwqbs2WS/Render', 17:22:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:43 INFO - 'HOME': '/Users/cltbld', 17:22:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:43 INFO - 'LOGNAME': 'cltbld', 17:22:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:22:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:43 INFO - 'MOZ_NO_REMOTE': '1', 17:22:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:22:43 INFO - 'NO_EM_RESTART': '1', 17:22:43 INFO - 'PAGER': '/bin/cat', 17:22:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:43 INFO - 'PWD': '/builds/slave/test', 17:22:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:22:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:43 INFO - 'SHELL': '/bin/bash', 17:22:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xyWPS6H5sg/Listeners', 17:22:43 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 17:22:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:43 INFO - 'USER': 'cltbld', 17:22:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:43 INFO - 'XPC_FLAGS': '0x0', 17:22:43 INFO - 'XPC_SERVICE_NAME': '0', 17:22:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:43 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/KKQ3fEwCRkalfUWP1rxE5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:22:43 INFO - mozversion application_buildid: 20160908152324 17:22:43 INFO - mozversion application_changeset: 176aff980979bf588baed78c2824571a6a7f2b96 17:22:43 INFO - mozversion application_display_name: Nightly 17:22:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:22:43 INFO - mozversion application_name: Firefox 17:22:43 INFO - mozversion application_remotingname: firefox 17:22:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:22:43 INFO - mozversion application_vendor: Mozilla 17:22:43 INFO - mozversion application_version: 51.0a1 17:22:43 INFO - mozversion platform_buildid: 20160908152324 17:22:43 INFO - mozversion platform_changeset: 176aff980979bf588baed78c2824571a6a7f2b96 17:22:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:22:43 INFO - mozversion platform_version: 51.0a1 17:22:43 INFO - using testdate: 1473380563 17:22:43 INFO - actual date: 1473380563 17:22:43 INFO - starting webserver on 'localhost:49271' 17:22:43 INFO - SUITE-START | Running 2 tests 17:22:43 INFO - TEST-START | dromaeo_css 17:22:43 INFO - operating with platform_type : mac_ 17:22:43 INFO - Initialising browser for dromaeo_css test... 17:22:43 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmplGagK9/profile http://localhost:49271/getInfo.html) 17:22:45 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 17:22:45 INFO - PROCESS | 1654 | colorDepth:24 17:22:45 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 17:22:45 INFO - PROCESS | 1654 | __metrics 17:22:45 INFO - PROCESS | 1654 | 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" 17:22:45 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:22:46 INFO - TEST-INFO | 1654: exit 0 17:22:46 INFO - Browser initialized. 17:22:46 INFO - Running cycle 1/1 for dromaeo_css test... 17:22:46 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmplGagK9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:22:58 INFO - PROCESS | 1657 | RSS: Main: 232427520 17:22:58 INFO - PROCESS | 1657 | 17:23:49 INFO - PROCESS | 1657 | 1473380629914 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:26:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 17:26:03 INFO - PROCESS | 1657 | RSS: Main: 397467648 17:26:03 INFO - PROCESS | 1657 | 17:29:06 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 17:29:07 INFO - PROCESS | 1657 | RSS: Main: 381329408 17:29:07 INFO - PROCESS | 1657 | 17:32:09 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 17:32:10 INFO - PROCESS | 1657 | RSS: Main: 328404992 17:32:10 INFO - PROCESS | 1657 | 17:35:12 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 17:35:13 INFO - PROCESS | 1657 | RSS: Main: 345366528 17:35:13 INFO - PROCESS | 1657 | 17:38:16 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 17:38:17 INFO - PROCESS | 1657 | RSS: Main: 327012352 17:38:17 INFO - PROCESS | 1657 | 17:41:20 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 17:41:20 INFO - PROCESS | 1657 | RSS: Main: 370765824 17:41:20 INFO - PROCESS | 1657 | 17:41:20 INFO - PROCESS | 1657 | __start_tp_report 17:41:20 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 17:41:20 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 17:41:20 INFO - PROCESS | 1657 | |i|pagename|runs| 17:41:20 INFO - PROCESS | 1657 | |0;dojo.html;2989.4021195760847;3304.3721692878353;3336.9989003299006;3341.097903566039;3401.7958922464654;5573.916391254124;5676.829695109148;5726.0552008918585;5746.683932383722;5749.310082790061;5682.573806964473;5723.399043100467;5791.942080579193;5812.854678633036;5833.824985250439;5116.232565115244;5189.221616757479;5198;5213.973930130363;5280.762365693534;5301.284326615915;5312.07038768214;5315.335583052119;5318.228856815759;5358.035553600351;3952.565217826037;5110.28456016158;5175.378954525443;5190.740462976836;5254.973725131388;5210.817621383233;5222.00781851447;5223.869403264911;5227.3465816772905;5230.843074707765;5139.383274007143;5167.48325167484;5169.069567477853;5175.922361164586;5190.480951904817;5726.169705392736;5733.827985160452;5734;5735.1970724098655;5739.368669446358;6118.253719382623;6138.877222455526;6197.0704394340755;6214.161088253119;6218.595791273553;6055.122007308915;6204.193454850841;6206.565540412173;6221.564490485668;6222.81331560054;5694.174344719992;5874.0014197586515;5888.823335299948;5895.911561326584;5896.616719913192;6201.596896201732;6219.222597175353;6250.4374606285655;6319.304876463585;6321.905171422432;6171.444569988723;6173.506119510428;6182.443580077725;6184.752609895554;6196.225471816023;5607.915881261784;5851.093080572433;6132.386102851662;6208.689565521796;6234.096056071844;6101.633901965896;6118.223266370627;6129.175413489909;6146.170267013896;6149.677819268879;6190.535709821781;6297.4962003039645;6302.747890084345;6314.242290925118;6321.65230912295;4937.901241975141;4954.801807927643;4996.125678006334;5002.549770520671;5044.823431179964;4439.556044395535;4444.377787109807;4484.506704262529;4496.595306422438;4507.977460112678;5675.77296908119;5704.058830293038;5736.196932429463;5741.425857414225;5797.739101740432;6262.3111457739615;6308.810735677937;6312.24253089623;6325.557210995186;6326.2724786649205;5587.944120558824;5669.348024977098;5686.715664216773;5715.48560629537;5747.39652336507;4535.523770004102;5429.158480435539;5432.782688692408;5451.318585176853;5517.944820551824;6315.336889626615;6331.96834015827;6339.270983836917;6339.683015849281;6357.237131544244;6129.389354848233;6266.279377871603;6309.873802523832;6321.0834429008455;6331.3352098029045;6223.906641400473;6234.3453937337745;6251.218597675291;6321.209848768904;6344.333844946214;6207.379262073757;6216.564840461305;6221.129041934223;6230.314665386713;6243.96878015607;6138.572327483795;6243.094751260951;6261.217347831521;6322.3045464997895;6338.080978258219;6071.696415179312;6080.969595152173;6137.815865524041;6157.84605384869;6187.659678717714;6152.569320147726;6161.383861613803;6164.599301045418;6167.537434692326;6187.938120618736;5143.919776846755;5643.35101463337;5970.611910225822;5986.593150609516;6055.697215139314;4928.2607608857525;6028.0355143176885;6045.727942242697;6103.481204097701;6112.144299797943;5938.970305148447;5972.58191926561;5976.97011514957;6001.7599296027665;6026.337102918587 17:41:20 INFO - PROCESS | 1657 | |1;ext.html;482.6886658105522;508.9567386772124;509.7833420796163;518.8443466959911;537.1942086869695;30745.538816917764;32310.86911958082;32450.837745811295;32519.349613007755;40729.796351018274;41056;43398.56601433985;43433.43948885369;43483.34774978378;43545.12909741803;9799.755006124833;9967.800643987115;9977.401355918668;9979.550920208572;9981.401115933031;8799.428037177562;9764.462954537497;9886.851697224547;9890.456024918627;11909.40452977352;12000.699982500464;12331.07516936229;12337.938310308436;12340.938295308555;12354.444050017726;12184.086193535475;12251.142420030601;12258.754824903452;12264.938675306566;12267.325297108655;11939.582114626033;12005.759884802343;12022.218555793845;12024.278543287342;12031.879681203163;40127.59872401268;40301.39547906784;40365.19269614621;40387.39418908719;40578;2934.5891575179494;3526.2242306692488;3953.717429586204;4010.6590939770153;4129.215449064668;31503.527447088312;31626.841865790753;31693.52459713106;31734.841325793455;31756.841215794004;3209.8876539321245;3270.689284517967;3365.1923538350866;3386.458166693342;3393.7624366294367;465839.9999999966;468505;469187;469211;472663;58458.415415846146;58800.7059964706;58803.70598146982;58810;58842;63210.68394657997;63328.68335658292;63454;63547.36452635507;63614.09402683628;15494.767578486331;15859.700343450366;15995.600109997344;16097.356105755873;16103.516894493185;12256.816147757612;12314;12328.013758899266;12335;12345.629631111082;14960.70078598422;15339.0796552205;16732.916335418246;17086.658266834842;17134.742978855327;6752.291009444036;7104.609246491493;7120.750773722998;7195.640217989079;7243.674034668453;873.7291439653727;878;1005.6731562242301;1095.3044816541553;1118.4743170709753;28265;29239.415211695647;29328.26679333034;29725.256868578457;29913.401731965238;1021.1473419694489;1047.4448542272607;1050.5430137890041;1131.7283851875654;1185.4494994548415;12602.432890519949;14594.489192878198;14718.926405367905;15321.625148102063;15342.232888355538;576975;580077;580374;581792;587601;48756.26865597019;48891.75554122207;56496.87006259934;56929.430705693245;57277.42722572721;1060.7030031591166;1334.1994803118052;1353.5803900790786;1376.6283103562182;1378.0835744230176;30359.696403035687;30995.535066974466;31179.37641247117;31953.840230798698;32402.51396229011;50830.983380332924;51389.48610513847;51403.22895156501;51424;51442.228366573785;395367;401125.9943700263;403069;537539;539994.5004124627;22754.86225688742;24678.753212468364;25379.111731089324;25693.329933554258;25717.228483145536;46003.76998114988;46475.535244648476;46749;48105;49487;38645;39541.2091758169;39577;39945.60190393439;41086.58913410947;35979.82010089933;36505.81747091247;38768.418473722355;39135.6086439132;40694.1861162781;37655.24689506249;38318.80840595891;38635.42046869243;38708;38748;26047;26721.465570688088;28329.008484702936;34502.65497344994;35146.47280290747;22946.426339340982;24029.158979435637;25260.62109068402;26013.959441622123;26084.217473475826 17:41:20 INFO - PROCESS | 1657 | |2;jquery.html;349.9965000349996;369.8502106646808;372.48038985615085;382.7741632436862;404.2763453418381;15039.624009399757;15919.920400397996;20151;20287.289944851935;20397.08213130411;20002.899840508766;20089.29687460939;20288.594228115428;20374.89812550939;20988.790112098875;5895.233619629453;5897.764089436418;6158.168647232634;6190.78332258371;6199.4110559497;5985.1022346647915;6151.477124444427;6155.446009859112;6163.537734669895;6164.291106522763;4152.231837110129;6513.609183448984;6880.655967201645;6917.584944903322;6925;6613.801585952429;6873.381395674363;6891.241963384024;6896.862062758767;6942.861142777167;6010.78962236324;6014.338422773491;6015.218021657201;6020.307664618581;6031.276246850362;26227.344316392053;26863;26948;27416.177514674393;27431.86284068587;2237.161064600775;2360.6931098957198;2418.7823095921453;2507.7868381187623;2600.9739902600923;15233.61915952099;15420.614484637861;15571.458472456094;16452.259648315856;16720.581985450463;1851.592649617082;1873.7657792775904;1880.6520793653217;1893.867429279951;1924.1822225554083;94042;96849.09452716359;118744.40627796893;119243.807561925;128938.35530822474;10888.346699198073;10956.068734157687;11065.336079835235;11254.831177532344;11342.489587968561;14037.526059763783;14054.929725351309;14074.648133796532;14074.648133796736;14100.506482273071;8486.533240671699;8645.265152461985;8671.826563468696;8675.175858293453;8830.690925817566;8644.394892357475;8648.922737350795;8653.913460865437;8793.252573531194;8793.780155496164;5776.971115144482;6756.966215168893;6854.177498700088;6880.69036893341;7104.68028938699;1810.2849374497;1856.5544269375523;1859.191251805469;1866.3561071430336;1868.7103498957683;365.64532403568495;844.9493030418072;858.9184027517376;859.2352806002663;891.460666296894;9876.703698889045;11384.715382115513;11900.107491938139;11951.581694640647;11957.521699131938;420.73283464999946;421.66266986411364;428.5885549872158;438.74772006096623;441.3071477779855;5313.335833020872;5824.359320474744;5991.64050156992;6005.489533389624;6162.568620196633;547030;549103;554007;554924;561477;117703;120166;120673;123365;125838;454.06236122407125;459.8827299038657;460.4267686729976;461.06634066016585;461.9376384188159;11116.722081947693;11200.716400089615;11299;11315.547378105113;11361.37512436824;52327;52885.20672189997;52940.205896910804;53594.19608705951;54201;58940;66390.66804666139;78697;78766.27402355877;78873;5514.476124768141;7874.409419293462;8180.877286840821;8239.011318641802;8514.659413623385;12258.26450412978;12748.68128296763;13060.281684507443;13450.932745336211;13570.86429135696;11436.428178591204;11578.305301681927;11732.589359372723;11916.880831191924;11959.641210763692;11363.431828408711;11518.769624607628;11529.250598711056;11866.288022718665;12014.879851201726;11545.076393888638;11569.247998880046;11781.882181178422;11889.881101189223;11920.821187682019;6883.346082122191;8148.714794982147;8348.37387195975;8449.197326253996;8536.829263414573;11318.830217546909;11691.532338706696;11977.580784672495;12001.519939202333;12008.339541324962 17:41:20 INFO - PROCESS | 1657 | |3;mootools.html;1335.265603917845;1485.82912965009;1524.5578782153173;1713.9657206855863;1897.8197071278223;7711;8555.443896146746;8764.035956044845;8768.430052046613;8940.374173807835;8678;8763.824723505542;8769.429987050837;8774.60514276859;8776;2377.667126602277;2412.3969007748065;2413.046846495642;2414.4567472318677;2414.794742446894;2340.6372012338115;2384.618461046233;2386.0455817672982;2386.427257458206;2387.2599494156866;2348.7886090251873;2368.14746691191;2381.5832229359794;2384.892679829412;2389.0443822471066;2325.8953347099423;2362.4566349739484;2363.397333679909;2363.7045369328835;2367.490989437279;1942.2716481319505;2344.3787396339985;2344.6717459555675;2350.118705485443;2350.635651474024;8600.440971336842;8730.607122679494;8740.21338079576;8818.206361427503;8830.735077947671;5156.716380599066;5364.773618948132;5375.946240537583;5379.892402151935;5389.514943655051;3080.2761351082477;3506.2636846262317;3529.4705794130828;3584.1039740064984;3606.6934310583633;1044.8746150461918;1079.6922876980102;1463.5097242423801;1827.7349784281337;1862.8416584590327;11241.381724005176;11692;11707.180497365187;11719.824202636968;11720.765584688344;4685.835995740201;4704.176769065469;4849.587785038311;4867.634927380461;4900.975495122501;9137.725868223964;9209.125133112477;9218.539073046455;9220.677276295297;9229.815403691888;5244.160934250502;5260.579153667697;5261.342332208474;5265.368155821326;5268.762905669254;4043.696722745806;4411.051623900877;4450.221211288012;4799.3760811094335;4916.434610019822;3748;3809.2383022308604;3817.84728610858;3873.4189871519498;3886.902827429337;1168.339887963315;1182.1193211057816;1188.4473719720372;1192.1416580062514;1199.9760004799855;724.4421795217653;850.927671147947;884.6063501741663;904.7466709321401;946.7680418297562;5719.885602287931;5769.249997500298;5918.585699001114;5996.970015149896;6133.938660613426;896.1620884473039;938.3572253006712;950.6482601437374;967.1585720423277;1003.8996100389902;3391.016605184469;3813.8855834325013;3825.1967086911504;3922.3135951208424;3989.566364517642;9100.226480749077;10309.123724483503;10763.3541987481;10768.030877221088;10814.459277036116;10719.571217151382;10732.195085368628;10736.94631526853;10739.892601074045;10743.570257189782;7722.768316950388;8135.064467586185;8253.13342099083;8261.710840120568;8296.751097467086;5858.238429004202;6001.639901605743;6023.789167379296;6113.358097399709;6160.476359509492;9417.952910235404;9745.853812192965;10007.399556026661;10037.749056273651;10133.64532241368;9269.44383337002;10014.549345279625;10190.235732319958;10278.280520363503;10384.01351871571;6959.8956015660815;7866.292033716993;8182.590870456573;8247.257746802576;8265.752027439186;8167.224113709188;8235.052968908412;8288.129746376544;8290.751277461686;8366.581670916308;6625.972974189009;7235.782926512213;7453.440991925519;7559.319661230295;7575.280348366897;7174.497785154989;7315.341619254293;7324.304191101837;7381.151167615578;7393.667284972082;6552.24649165333;6785.762498312535;6941.34057264559;6951.374376306157;6960.4779641526075;3996.480457540501;4872.9269060964825;4931.778069986787;4957.529034741694;5084.9745751271;4750.263709125091;4782.569568738831;4825.541573550507;4846.733429661403;5133.870548479328 17:41:20 INFO - PROCESS | 1657 | |4;prototype.html;276.3533332003112;290.6541215953016;303.35991058865795;305.4349453511005;305.68972492919676;5221.242919776635;5257.815976440826;5259.52664260217;5269.07791136551;5283.841484755454;3971.602839716027;4130.586941305868;4948.703077815325;5237.10969135247;5251.86870328242;3599.8200089995526;3727.3477141500266;3966.3653815389616;3971.4837071180705;4019.1358857845557;3719.925601487969;3975.801209939506;4002.879913602582;4007.8797636070817;4018.4976877890263;3499.440089585667;3575.5161607932678;3587.3004764071015;3946.131850992777;4011.638952494275;3246.4156451838658;3678.988278223483;3760.492333534965;3980.9402858957137;4008.7995600220165;2906.8982585609615;3466.5493485846932;3482.564679415073;3487.7558570900046;3489;3907.355286377744;4338.349247612852;5057.064443078006;5064.480655803244;5086.669366491166;3417.1627951151877;4085.5710150434074;4461.754603496806;4507.819687212507;4549.863504094882;5139;5452.863678408032;5456.236126942231;5477.643953143033;5484.561235101222;3841.673457756094;3847.8076096195077;3853.2293541291856;3855.652991230803;3883.728139030269;5295.973520132413;5407.270018547485;5709.45760152789;5716.399778023289;5773.711314434346;3316.225819186772;3769.208466222069;3774.8112594370723;3786.981065094712;3791.976166435047;3336.566246387954;3532.8586856525967;3537.080359106599;3827.2919509890203;3846.211526637033;3465.5841299043773;3828.8468461261236;4505.594496495331;4511.841710802451;4537.160625284333;4528;4788.539495453851;4950.603951683928;5295.338082739658;5641.802536911188;1123.224974767408;1154.261272785418;1297.6893337728961;1313.9211647301192;1314.6450458376185;716.9318914703199;791.6833266693369;836.7991681996399;848.1221935296938;881.1188811188811;4206.621404073648;4454.844080457168;4804.759762011886;5049.293098966147;5135.6405051646025;5537.695426751487;5551.805686800943;5560.860023695132;5563.524231716847;5597.412271711493;4316.978415107905;4354.651627869763;4776.9761151194025;5016.54851063406;5069.8732531687;2501.0996041425074;2832.711116442014;2844.018813509336;2931.5016447204025;2957.5711521829217;4982.626303027288;5041.6470847040355;5696.344920334214;5778.27771528559;5805.303363596396;5424.647397919122;5691.459311365414;5827.271591051119;5886.999210134288;5915.438033386908;4897.534734200245;5955.76176952917;5956;5965.850853728604;5974.253218347707;4402.823887044482;5293.761780719799;5359.839204823861;5709.771609135588;5726.685032323262;5666.433356664301;5667.149927510906;5706.42935706426;5722.198892155185;5750.913736293875;5444.918326225031;5972.193753843176;5992.08253358921;6003.939960600338;6015.939840601713;3507.6667716566885;3761;3823.9235215296094;3845.1540661054523;3845.942310865283;5612.979327442199;5617.241672374177;5617.410171931889;5620.634658747168;5633.183188437735;4548.954510454853;5472.753726082256;5478.75371097848;5486.31421072366;5512.4211957743855;4550.408446901882;4715.434147902273;5470.56235501151;5474.41242039804;5510.283663123768;4652.860414187445;5360.463953604608;5361.410244872983;5370.919436208382;5398.460153984727;4518.6385089193445;5331.546818520314;5436.918446223231;5483.314585676791;5511.090670039559;5332.440093790251;5409.214959063578;5426.891462170814;5427.945720542744;5438.70087145195 17:41:20 INFO - PROCESS | 1657 | |5;yui.html;773.2267732267733;784.7331907151569;808.4502538273975;809.308041624411;819.6024927909966;14696.265186740673;15308.923455382708;15995.120268385248;15997;16016.279267432965;14371;14733.18967456792;14750.852491475081;14755.18846463444;14755.188464634468;678.9626570538618;850.107387243395;864.2999170671744;865.6018231613465;866.8309679612478;679.894616334469;845.3533047218882;859.70769938221;870.3298460185654;871.9912800871973;894.8926128864546;895.212213252337;896.2829736211038;896.9865452018225;899.1053901368115;702.7470110760122;887.5296093070683;888.8533391990314;889.9822003559925;890.2343984173606;650.5251166648326;663.7743167323085;665.3313420012856;666.1772710702279;670.0217682184017;14469.92765036168;14492.058016228912;14502.782458263135;14515.491957781533;14542.200178990151;13149.474021039146;13518.324083795771;13632.93183534076;13681.578382587133;13822.861771382259;10393.636222732244;11813.822792658117;11945.940270298594;12058.276503409736;12506.374681265901;4405.658735486431;4450.577195166454;4472.575105364985;4549.658775591844;4550.522195169526;85164.57417712871;108655.45672271588;109026;109693.90306096917;110880.33679494895;10688.625898093529;10690.09134223584;10721.517531711092;10759.246852720235;10901.945490272497;17196.31214751421;20818.063187156615;20858.895705521678;20881.791182087985;20897.37307880766;6907.171139463297;7534.794432890821;7829.491083079582;7909.604519773989;7930.762077137695;4298.118885628439;4393.6704747144095;4489.842855500042;4527.139843429738;4533.614642755337;3325.48454989477;3394.4399174135992;3434.1414646338417;3446.6553344665836;3448.0862571418593;651.8174911024921;658.1937127019363;675.9391654751096;728.2426276672307;729.5002922997763;530.4032962916718;612.5999316029189;671.452765995712;672.865426914619;689.8827199376118;8674.956625216959;8699.085806254976;9206.447613143233;9243.722688319362;9438.95280523593;678.8438659108433;679.8198477403492;680.1803826389189;682.1200651160048;687.2234375156041;4402.251617225015;4594.150082234797;4598.195315819785;4600.677952543357;4737.786799594027;75332.87000694995;153978;156468;160660;163199;126246.7375326235;135521;139951;142282.2885885564;143305.07118861141;86640.56679716561;119332.40333798276;122337;122826.15760763417;124655.99999999818;8684.913150868411;8744.387892847693;8842.690505832265;8859.734207973772;9006.414583052081;55720.72139639276;61426;65538.34461655322;66333.66833165803;66741.33258667351;87466.56266718626;97011.51494242484;103479;103588;105753;10889.237753357189;11091;11142.220044596801;11512.136589755635;11534.480948357512;12897.548585799452;14648.85351146475;14800.703985920007;14857;15036.399998014667;13128.343582821011;13470.191788492722;13969.511067112602;14222.644433889236;14280.785788212977;13086.869131308566;13541;14017.088889222168;14120.152790832582;14409.42362305496;12495.812562811747;13120.278384688552;13224.723528854383;13565.186088834702;14035.649108772363;10858.34849909008;11031.724206894893;11311.321320720783;11707.531698732297;11807.822882656596;9106.635734570544;9560.572425275708;10515.211359148247;11028.349965511683;11731.178817482694 17:41:20 INFO - PROCESS | 1657 | __end_tp_report 17:41:20 INFO - PROCESS | 1657 | __start_cc_report 17:41:20 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1602 17:41:20 INFO - PROCESS | 1657 | __end_cc_report 17:41:20 INFO - PROCESS | 1657 | __startTimestamp1473381680967__endTimestamp 17:41:20 INFO - PROCESS | 1657 | 17:41:20 INFO - PROCESS | 1657 | ------- Summary: start ------- 17:41:20 INFO - PROCESS | 1657 | Number of tests: 6 17:41:20 INFO - PROCESS | 1657 | 17:41:20 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5730.27 Median:5972.58 stddev:666.09 (11.2%) stddev-sans-first:632.48 17:41:20 INFO - PROCESS | 1657 | Values: 2989.4 3304.4 3337.0 3341.1 3401.8 5573.9 5676.8 5726.1 5746.7 5749.3 5682.6 5723.4 5791.9 5812.9 5833.8 5116.2 5189.2 5198.0 5214.0 5280.8 5301.3 5312.1 5315.3 5318.2 5358.0 3952.6 5110.3 5175.4 5190.7 5255.0 5210.8 5222.0 5223.9 5227.3 5230.8 5139.4 5167.5 5169.1 5175.9 5190.5 5726.2 5733.8 5734.0 5735.2 5739.4 6118.3 6138.9 6197.1 6214.2 6218.6 6055.1 6204.2 6206.6 6221.6 6222.8 5694.2 5874.0 5888.8 5895.9 5896.6 6201.6 6219.2 6250.4 6319.3 6321.9 6171.4 6173.5 6182.4 6184.8 6196.2 5607.9 5851.1 6132.4 6208.7 6234.1 6101.6 6118.2 6129.2 6146.2 6149.7 6190.5 6297.5 6302.7 6314.2 6321.7 4937.9 4954.8 4996.1 5002.5 5044.8 4439.6 4444.4 4484.5 4496.6 4508.0 5675.8 5704.1 5736.2 5741.4 5797.7 6262.3 6308.8 6312.2 6325.6 6326.3 5587.9 5669.3 5686.7 5715.5 5747.4 4535.5 5429.2 5432.8 5451.3 5517.9 6315.3 6332.0 6339.3 6339.7 6357.2 6129.4 6266.3 6309.9 6321.1 6331.3 6223.9 6234.3 6251.2 6321.2 6344.3 6207.4 6216.6 6221.1 6230.3 6244.0 6138.6 6243.1 6261.2 6322.3 6338.1 6071.7 6081.0 6137.8 6157.8 6187.7 6152.6 6161.4 6164.6 6167.5 6187.9 5143.9 5643.4 5970.6 5986.6 6055.7 4928.3 6028.0 6045.7 6103.5 6112.1 5939.0 5972.6 5977.0 6001.8 6026.3 17:41:20 INFO - PROCESS | 1657 | 17:41:20 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:64432.29 Median:36242.82 stddev:134915.59 (372.3%) stddev-sans-first:135208.63 17:41:20 INFO - PROCESS | 1657 | Values: 482.7 509.0 509.8 518.8 537.2 30745.5 32310.9 32450.8 32519.3 40729.8 41056.0 43398.6 43433.4 43483.3 43545.1 9799.8 9967.8 9977.4 9979.6 9981.4 8799.4 9764.5 9886.9 9890.5 11909.4 12000.7 12331.1 12337.9 12340.9 12354.4 12184.1 12251.1 12258.8 12264.9 12267.3 11939.6 12005.8 12022.2 12024.3 12031.9 40127.6 40301.4 40365.2 40387.4 40578.0 2934.6 3526.2 3953.7 4010.7 4129.2 31503.5 31626.8 31693.5 31734.8 31756.8 3209.9 3270.7 3365.2 3386.5 3393.8 465840.0 468505.0 469187.0 469211.0 472663.0 58458.4 58800.7 58803.7 58810.0 58842.0 63210.7 63328.7 63454.0 63547.4 63614.1 15494.8 15859.7 15995.6 16097.4 16103.5 12256.8 12314.0 12328.0 12335.0 12345.6 14960.7 15339.1 16732.9 17086.7 17134.7 6752.3 7104.6 7120.8 7195.6 7243.7 873.7 878.0 1005.7 1095.3 1118.5 28265.0 29239.4 29328.3 29725.3 29913.4 1021.1 1047.4 1050.5 1131.7 1185.4 12602.4 14594.5 14718.9 15321.6 15342.2 576975.0 580077.0 580374.0 581792.0 587601.0 48756.3 48891.8 56496.9 56929.4 57277.4 1060.7 1334.2 1353.6 1376.6 1378.1 30359.7 30995.5 31179.4 31953.8 32402.5 50831.0 51389.5 51403.2 51424.0 51442.2 395367.0 401126.0 403069.0 537539.0 539994.5 22754.9 24678.8 25379.1 25693.3 25717.2 46003.8 46475.5 46749.0 48105.0 49487.0 38645.0 39541.2 39577.0 39945.6 41086.6 35979.8 36505.8 38768.4 39135.6 40694.2 37655.2 38318.8 38635.4 38708.0 38748.0 26047.0 26721.5 28329.0 34502.7 35146.5 22946.4 24029.2 25260.6 26014.0 26084.2 17:41:20 INFO - PROCESS | 1657 | 17:41:20 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:32957.16 Median:377.63 stddev:92486.20 (24491.4%) stddev-sans-first:92713.24 17:41:20 INFO - PROCESS | 1657 | Values: 350.0 369.9 372.5 382.8 404.3 15039.6 15919.9 20151.0 20287.3 20397.1 20002.9 20089.3 20288.6 20374.9 20988.8 5895.2 5897.8 6158.2 6190.8 6199.4 5985.1 6151.5 6155.4 6163.5 6164.3 4152.2 6513.6 6880.7 6917.6 6925.0 6613.8 6873.4 6891.2 6896.9 6942.9 6010.8 6014.3 6015.2 6020.3 6031.3 26227.3 26863.0 26948.0 27416.2 27431.9 2237.2 2360.7 2418.8 2507.8 2601.0 15233.6 15420.6 15571.5 16452.3 16720.6 1851.6 1873.8 1880.7 1893.9 1924.2 94042.0 96849.1 118744.4 119243.8 128938.4 10888.3 10956.1 11065.3 11254.8 11342.5 14037.5 14054.9 14074.6 14074.6 14100.5 8486.5 8645.3 8671.8 8675.2 8830.7 8644.4 8648.9 8653.9 8793.3 8793.8 5777.0 6757.0 6854.2 6880.7 7104.7 1810.3 1856.6 1859.2 1866.4 1868.7 365.6 844.9 858.9 859.2 891.5 9876.7 11384.7 11900.1 11951.6 11957.5 420.7 421.7 428.6 438.7 441.3 5313.3 5824.4 5991.6 6005.5 6162.6 547030.0 549103.0 554007.0 554924.0 561477.0 117703.0 120166.0 120673.0 123365.0 125838.0 454.1 459.9 460.4 461.1 461.9 11116.7 11200.7 11299.0 11315.5 11361.4 52327.0 52885.2 52940.2 53594.2 54201.0 58940.0 66390.7 78697.0 78766.3 78873.0 5514.5 7874.4 8180.9 8239.0 8514.7 12258.3 12748.7 13060.3 13450.9 13570.9 11436.4 11578.3 11732.6 11916.9 11959.6 11363.4 11518.8 11529.3 11866.3 12014.9 11545.1 11569.2 11781.9 11889.9 11920.8 6883.3 8148.7 8348.4 8449.2 8536.8 11318.8 11691.5 11977.6 12001.5 12008.3 17:41:20 INFO - PROCESS | 1657 | 17:41:20 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5666.62 Median:4886.95 stddev:3154.79 (64.6%) stddev-sans-first:3146.85 17:41:20 INFO - PROCESS | 1657 | Values: 1335.3 1485.8 1524.6 1714.0 1897.8 7711.0 8555.4 8764.0 8768.4 8940.4 8678.0 8763.8 8769.4 8774.6 8776.0 2377.7 2412.4 2413.0 2414.5 2414.8 2340.6 2384.6 2386.0 2386.4 2387.3 2348.8 2368.1 2381.6 2384.9 2389.0 2325.9 2362.5 2363.4 2363.7 2367.5 1942.3 2344.4 2344.7 2350.1 2350.6 8600.4 8730.6 8740.2 8818.2 8830.7 5156.7 5364.8 5375.9 5379.9 5389.5 3080.3 3506.3 3529.5 3584.1 3606.7 1044.9 1079.7 1463.5 1827.7 1862.8 11241.4 11692.0 11707.2 11719.8 11720.8 4685.8 4704.2 4849.6 4867.6 4901.0 9137.7 9209.1 9218.5 9220.7 9229.8 5244.2 5260.6 5261.3 5265.4 5268.8 4043.7 4411.1 4450.2 4799.4 4916.4 3748.0 3809.2 3817.8 3873.4 3886.9 1168.3 1182.1 1188.4 1192.1 1200.0 724.4 850.9 884.6 904.7 946.8 5719.9 5769.2 5918.6 5997.0 6133.9 896.2 938.4 950.6 967.2 1003.9 3391.0 3813.9 3825.2 3922.3 3989.6 9100.2 10309.1 10763.4 10768.0 10814.5 10719.6 10732.2 10736.9 10739.9 10743.6 7722.8 8135.1 8253.1 8261.7 8296.8 5858.2 6001.6 6023.8 6113.4 6160.5 9418.0 9745.9 10007.4 10037.7 10133.6 9269.4 10014.5 10190.2 10278.3 10384.0 6959.9 7866.3 8182.6 8247.3 8265.8 8167.2 8235.1 8288.1 8290.8 8366.6 6626.0 7235.8 7453.4 7559.3 7575.3 7174.5 7315.3 7324.3 7381.2 7393.7 6552.2 6785.8 6941.3 6951.4 6960.5 3996.5 4872.9 4931.8 4957.5 5085.0 4750.3 4782.6 4825.5 4846.7 5133.9 17:41:20 INFO - PROCESS | 1657 | 17:41:20 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4404.65 Median:4966.62 stddev:1393.19 (28.1%) stddev-sans-first:1362.20 17:41:20 INFO - PROCESS | 1657 | Values: 276.4 290.7 303.4 305.4 305.7 5221.2 5257.8 5259.5 5269.1 5283.8 3971.6 4130.6 4948.7 5237.1 5251.9 3599.8 3727.3 3966.4 3971.5 4019.1 3719.9 3975.8 4002.9 4007.9 4018.5 3499.4 3575.5 3587.3 3946.1 4011.6 3246.4 3679.0 3760.5 3980.9 4008.8 2906.9 3466.5 3482.6 3487.8 3489.0 3907.4 4338.3 5057.1 5064.5 5086.7 3417.2 4085.6 4461.8 4507.8 4549.9 5139.0 5452.9 5456.2 5477.6 5484.6 3841.7 3847.8 3853.2 3855.7 3883.7 5296.0 5407.3 5709.5 5716.4 5773.7 3316.2 3769.2 3774.8 3787.0 3792.0 3336.6 3532.9 3537.1 3827.3 3846.2 3465.6 3828.8 4505.6 4511.8 4537.2 4528.0 4788.5 4950.6 5295.3 5641.8 1123.2 1154.3 1297.7 1313.9 1314.6 716.9 791.7 836.8 848.1 881.1 4206.6 4454.8 4804.8 5049.3 5135.6 5537.7 5551.8 5560.9 5563.5 5597.4 4317.0 4354.7 4777.0 5016.5 5069.9 2501.1 2832.7 2844.0 2931.5 2957.6 4982.6 5041.6 5696.3 5778.3 5805.3 5424.6 5691.5 5827.3 5887.0 5915.4 4897.5 5955.8 5956.0 5965.9 5974.3 4402.8 5293.8 5359.8 5709.8 5726.7 5666.4 5667.1 5706.4 5722.2 5750.9 5444.9 5972.2 5992.1 6003.9 6015.9 3507.7 3761.0 3823.9 3845.2 3845.9 5613.0 5617.2 5617.4 5620.6 5633.2 4549.0 5472.8 5478.8 5486.3 5512.4 4550.4 4715.4 5470.6 5474.4 5510.3 4652.9 5360.5 5361.4 5370.9 5398.5 4518.6 5331.5 5436.9 5483.3 5511.1 5332.4 5409.2 5426.9 5427.9 5438.7 17:41:20 INFO - PROCESS | 1657 | 17:41:20 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:25012.84 Median:3440.40 stddev:40624.26 (1180.8%) stddev-sans-first:40697.45 17:41:20 INFO - PROCESS | 1657 | Values: 773.2 784.7 808.5 809.3 819.6 14696.3 15308.9 15995.1 15997.0 16016.3 14371.0 14733.2 14750.9 14755.2 14755.2 679.0 850.1 864.3 865.6 866.8 679.9 845.4 859.7 870.3 872.0 894.9 895.2 896.3 897.0 899.1 702.7 887.5 888.9 890.0 890.2 650.5 663.8 665.3 666.2 670.0 14469.9 14492.1 14502.8 14515.5 14542.2 13149.5 13518.3 13632.9 13681.6 13822.9 10393.6 11813.8 11945.9 12058.3 12506.4 4405.7 4450.6 4472.6 4549.7 4550.5 85164.6 108655.5 109026.0 109693.9 110880.3 10688.6 10690.1 10721.5 10759.2 10901.9 17196.3 20818.1 20858.9 20881.8 20897.4 6907.2 7534.8 7829.5 7909.6 7930.8 4298.1 4393.7 4489.8 4527.1 4533.6 3325.5 3394.4 3434.1 3446.7 3448.1 651.8 658.2 675.9 728.2 729.5 530.4 612.6 671.5 672.9 689.9 8675.0 8699.1 9206.4 9243.7 9439.0 678.8 679.8 680.2 682.1 687.2 4402.3 4594.2 4598.2 4600.7 4737.8 75332.9 153978.0 156468.0 160660.0 163199.0 126246.7 135521.0 139951.0 142282.3 143305.1 86640.6 119332.4 122337.0 122826.2 124656.0 8684.9 8744.4 8842.7 8859.7 9006.4 55720.7 61426.0 65538.3 66333.7 66741.3 87466.6 97011.5 103479.0 103588.0 105753.0 10889.2 11091.0 11142.2 11512.1 11534.5 12897.5 14648.9 14800.7 14857.0 15036.4 13128.3 13470.2 13969.5 14222.6 14280.8 13086.9 13541.0 14017.1 14120.2 14409.4 12495.8 13120.3 13224.7 13565.2 14035.6 10858.3 11031.7 11311.3 11707.5 11807.8 9106.6 9560.6 10515.2 11028.3 11731.2 17:41:20 INFO - PROCESS | 1657 | -------- Summary: end -------- 17:41:20 INFO - PROCESS | 1657 | 17:41:21 INFO - TEST-INFO | 1657: exit 0 17:41:21 INFO - TEST-OK | dromaeo_css | took 1118162ms 17:41:21 INFO - TEST-START | kraken 17:41:21 INFO - operating with platform_type : mac_ 17:41:21 INFO - Initialising browser for kraken test... 17:41:21 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpcWKS40/profile http://localhost:49271/getInfo.html) 17:41:23 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 17:41:23 INFO - PROCESS | 1665 | colorDepth:24 17:41:23 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 17:41:23 INFO - PROCESS | 1665 | __metrics 17:41:23 INFO - PROCESS | 1665 | 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" 17:41:23 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:41:24 INFO - TEST-INFO | 1665: exit 0 17:41:24 INFO - Browser initialized. 17:41:24 INFO - Running cycle 1/1 for kraken test... 17:41:24 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpcWKS40/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:41:36 INFO - PROCESS | 1666 | RSS: Main: 232808448 17:41:36 INFO - PROCESS | 1666 | 17:41:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 17:41:40 INFO - PROCESS | 1666 | RSS: Main: 291909632 17:41:40 INFO - PROCESS | 1666 | 17:41:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 17:41:43 INFO - PROCESS | 1666 | RSS: Main: 287477760 17:41:43 INFO - PROCESS | 1666 | 17:41:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 17:41:47 INFO - PROCESS | 1666 | RSS: Main: 374644736 17:41:47 INFO - PROCESS | 1666 | 17:41:49 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 17:41:50 INFO - PROCESS | 1666 | RSS: Main: 279973888 17:41:50 INFO - PROCESS | 1666 | 17:41:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:41:52 INFO - PROCESS | 1666 | RSS: Main: 284491776 17:41:52 INFO - PROCESS | 1666 | 17:41:55 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 17:41:56 INFO - PROCESS | 1666 | RSS: Main: 322564096 17:41:56 INFO - PROCESS | 1666 | 17:41:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 17:41:59 INFO - PROCESS | 1666 | RSS: Main: 323350528 17:41:59 INFO - PROCESS | 1666 | 17:42:02 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 17:42:03 INFO - PROCESS | 1666 | RSS: Main: 323055616 17:42:03 INFO - PROCESS | 1666 | 17:42:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:42:05 INFO - PROCESS | 1666 | RSS: Main: 298987520 17:42:05 INFO - PROCESS | 1666 | 17:42:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:42:07 INFO - PROCESS | 1666 | RSS: Main: 304508928 17:42:07 INFO - PROCESS | 1666 | 17:42:09 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:42:10 INFO - PROCESS | 1666 | RSS: Main: 301621248 17:42:10 INFO - PROCESS | 1666 | 17:42:13 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:42:14 INFO - PROCESS | 1666 | RSS: Main: 319082496 17:42:14 INFO - PROCESS | 1666 | 17:42:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:42:17 INFO - PROCESS | 1666 | RSS: Main: 315432960 17:42:17 INFO - PROCESS | 1666 | 17:42:19 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 17:42:20 INFO - PROCESS | 1666 | RSS: Main: 358752256 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | __start_tp_report 17:42:20 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 17:42:20 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 17:42:20 INFO - PROCESS | 1666 | |i|pagename|runs| 17:42:20 INFO - PROCESS | 1666 | |0;ai-astar;112;112;116;112;111;111;111;111;111;124 17:42:20 INFO - PROCESS | 1666 | |1;audio-beat-detection;143;114;127;159;106;129;129;106;159;106 17:42:20 INFO - PROCESS | 1666 | |2;audio-dft;185;186;185;183;182;185;184;181;180;181 17:42:20 INFO - PROCESS | 1666 | |3;audio-fft;74;82;73;154;58;57;57;62;136;62 17:42:20 INFO - PROCESS | 1666 | |4;audio-oscillator;83;84;137;72;71;86;119;68;72;118 17:42:20 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;89;86;90;87;89;86;89;86;88;86 17:42:20 INFO - PROCESS | 1666 | |6;imaging-darkroom;95;94;94;95;94;94;92;95;95;95 17:42:20 INFO - PROCESS | 1666 | |7;imaging-desaturate;86;84;85;84;86;86;85;84;87;84 17:42:20 INFO - PROCESS | 1666 | |8;json-parse-financial;55;54;56;54;53;54;57;54;57;57 17:42:20 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;67;64;69;77;70;75;72;67;69;68 17:42:20 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;88;85;86;86;84;86;84;84;85;86 17:42:20 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;139;139;135;142;113;144;147;149;192;126 17:42:20 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;168;226;158;212;235;166;169;170;169;198 17:42:20 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;58;84;92;67;66;76;89;69;58;82 17:42:20 INFO - PROCESS | 1666 | __end_tp_report 17:42:20 INFO - PROCESS | 1666 | __start_cc_report 17:42:20 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,2043 17:42:20 INFO - PROCESS | 1666 | __end_cc_report 17:42:20 INFO - PROCESS | 1666 | __startTimestamp1473381740033__endTimestamp 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | ------- Summary: start ------- 17:42:20 INFO - PROCESS | 1666 | Number of tests: 14 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:113.10 Median:112.00 stddev:4.12 (3.7%) stddev-sans-first:4.35 17:42:20 INFO - PROCESS | 1666 | Values: 112.0 112.0 116.0 112.0 111.0 111.0 111.0 111.0 111.0 124.0 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:129.00 stddev:20.54 (15.9%) stddev-sans-first:21.04 17:42:20 INFO - PROCESS | 1666 | Values: 143.0 114.0 127.0 159.0 106.0 129.0 129.0 106.0 159.0 106.0 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:183.20 Median:184.50 stddev:2.10 (1.1%) stddev-sans-first:2.12 17:42:20 INFO - PROCESS | 1666 | Values: 185.0 186.0 185.0 183.0 182.0 185.0 184.0 181.0 180.0 181.0 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:81.50 Median:62.00 stddev:34.75 (56.0%) stddev-sans-first:36.75 17:42:20 INFO - PROCESS | 1666 | Values: 74.0 82.0 73.0 154.0 58.0 57.0 57.0 62.0 136.0 62.0 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:72.00 stddev:24.54 (34.1%) stddev-sans-first:25.85 17:42:20 INFO - PROCESS | 1666 | Values: 83.0 84.0 137.0 72.0 71.0 86.0 119.0 68.0 72.0 118.0 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:1.58 (1.8%) stddev-sans-first:1.59 17:42:20 INFO - PROCESS | 1666 | Values: 89.0 86.0 90.0 87.0 89.0 86.0 89.0 86.0 88.0 86.0 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:95.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 17:42:20 INFO - PROCESS | 1666 | Values: 95.0 94.0 94.0 95.0 94.0 94.0 92.0 95.0 95.0 95.0 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.50 stddev:1.10 (1.3%) stddev-sans-first:1.12 17:42:20 INFO - PROCESS | 1666 | Values: 86.0 84.0 85.0 84.0 86.0 86.0 85.0 84.0 87.0 84.0 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:1.52 (2.7%) stddev-sans-first:1.62 17:42:20 INFO - PROCESS | 1666 | Values: 55.0 54.0 56.0 54.0 53.0 54.0 57.0 54.0 57.0 57.0 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:69.50 stddev:3.91 (5.6%) stddev-sans-first:4.01 17:42:20 INFO - PROCESS | 1666 | Values: 67.0 64.0 69.0 77.0 70.0 75.0 72.0 67.0 69.0 68.0 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:86.00 stddev:1.26 (1.5%) stddev-sans-first:0.93 17:42:20 INFO - PROCESS | 1666 | Values: 88.0 85.0 86.0 86.0 84.0 86.0 84.0 84.0 85.0 86.0 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:143.00 stddev:20.38 (14.3%) stddev-sans-first:21.58 17:42:20 INFO - PROCESS | 1666 | Values: 139.0 139.0 135.0 142.0 113.0 144.0 147.0 149.0 192.0 126.0 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.10 Median:184.00 stddev:28.19 (15.3%) stddev-sans-first:29.04 17:42:20 INFO - PROCESS | 1666 | Values: 168.0 226.0 158.0 212.0 235.0 166.0 169.0 170.0 169.0 198.0 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:79.00 stddev:12.32 (15.6%) stddev-sans-first:11.61 17:42:20 INFO - PROCESS | 1666 | Values: 58.0 84.0 92.0 67.0 66.0 76.0 89.0 69.0 58.0 82.0 17:42:20 INFO - PROCESS | 1666 | -------- Summary: end -------- 17:42:20 INFO - PROCESS | 1666 | 17:42:20 INFO - TEST-INFO | 1666: exit 0 17:42:20 INFO - TEST-OK | kraken | took 59343ms 17:42:20 INFO - SUITE-END | took 1177s 17:42:21 INFO - Completed test suite (00:19:37) 17:42:21 INFO - javascript benchmark 17:42:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2989.4021195760847, 3304.3721692878353, 3336.9989003299006, 3341.097903566039, 3401.7958922464654, 5573.916391254124, 5676.829695109148, 5726.0552008918585, 5746.683932383722, 5749.310082790061, 5682.573806964473, 5723.399043100467, 5791.942080579193, 5812.854678633036, 5833.824985250439, 5116.232565115244, 5189.221616757479, 5198.0, 5213.973930130363, 5280.762365693534, 5301.284326615915, 5312.07038768214, 5315.335583052119, 5318.228856815759, 5358.035553600351, 3952.565217826037, 5110.28456016158, 5175.378954525443, 5190.740462976836, 5254.973725131388, 5210.817621383233, 5222.00781851447, 5223.869403264911, 5227.3465816772905, 5230.843074707765, 5139.383274007143, 5167.48325167484, 5169.069567477853, 5175.922361164586, 5190.480951904817, 5726.169705392736, 5733.827985160452, 5734.0, 5735.1970724098655, 5739.368669446358, 6118.253719382623, 6138.877222455526, 6197.0704394340755, 6214.161088253119, 6218.595791273553, 6055.122007308915, 6204.193454850841, 6206.565540412173, 6221.564490485668, 6222.81331560054, 5694.174344719992, 5874.0014197586515, 5888.823335299948, 5895.911561326584, 5896.616719913192, 6201.596896201732, 6219.222597175353, 6250.4374606285655, 6319.304876463585, 6321.905171422432, 6171.444569988723, 6173.506119510428, 6182.443580077725, 6184.752609895554, 6196.225471816023, 5607.915881261784, 5851.093080572433, 6132.386102851662, 6208.689565521796, 6234.096056071844, 6101.633901965896, 6118.223266370627, 6129.175413489909, 6146.170267013896, 6149.677819268879, 6190.535709821781, 6297.4962003039645, 6302.747890084345, 6314.242290925118, 6321.65230912295, 4937.901241975141, 4954.801807927643, 4996.125678006334, 5002.549770520671, 5044.823431179964, 4439.556044395535, 4444.377787109807, 4484.506704262529, 4496.595306422438, 4507.977460112678, 5675.77296908119, 5704.058830293038, 5736.196932429463, 5741.425857414225, 5797.739101740432, 6262.3111457739615, 6308.810735677937, 6312.24253089623, 6325.557210995186, 6326.2724786649205, 5587.944120558824, 5669.348024977098, 5686.715664216773, 5715.48560629537, 5747.39652336507, 4535.523770004102, 5429.158480435539, 5432.782688692408, 5451.318585176853, 5517.944820551824, 6315.336889626615, 6331.96834015827, 6339.270983836917, 6339.683015849281, 6357.237131544244, 6129.389354848233, 6266.279377871603, 6309.873802523832, 6321.0834429008455, 6331.3352098029045, 6223.906641400473, 6234.3453937337745, 6251.218597675291, 6321.209848768904, 6344.333844946214, 6207.379262073757, 6216.564840461305, 6221.129041934223, 6230.314665386713, 6243.96878015607, 6138.572327483795, 6243.094751260951, 6261.217347831521, 6322.3045464997895, 6338.080978258219, 6071.696415179312, 6080.969595152173, 6137.815865524041, 6157.84605384869, 6187.659678717714, 6152.569320147726, 6161.383861613803, 6164.599301045418, 6167.537434692326, 6187.938120618736, 5143.919776846755, 5643.35101463337, 5970.611910225822, 5986.593150609516, 6055.697215139314, 4928.2607608857525, 6028.0355143176885, 6045.727942242697, 6103.481204097701, 6112.144299797943, 5938.970305148447, 5972.58191926561, 5976.97011514957, 6001.7599296027665, 6026.337102918587], "value": 5686.662639356132, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.6886658105522, 508.9567386772124, 509.7833420796163, 518.8443466959911, 537.1942086869695, 30745.538816917764, 32310.86911958082, 32450.837745811295, 32519.349613007755, 40729.796351018274, 41056.0, 43398.56601433985, 43433.43948885369, 43483.34774978378, 43545.12909741803, 9799.755006124833, 9967.800643987115, 9977.401355918668, 9979.550920208572, 9981.401115933031, 8799.428037177562, 9764.462954537497, 9886.851697224547, 9890.456024918627, 11909.40452977352, 12000.699982500464, 12331.07516936229, 12337.938310308436, 12340.938295308555, 12354.444050017726, 12184.086193535475, 12251.142420030601, 12258.754824903452, 12264.938675306566, 12267.325297108655, 11939.582114626033, 12005.759884802343, 12022.218555793845, 12024.278543287342, 12031.879681203163, 40127.59872401268, 40301.39547906784, 40365.19269614621, 40387.39418908719, 40578.0, 2934.5891575179494, 3526.2242306692488, 3953.717429586204, 4010.6590939770153, 4129.215449064668, 31503.527447088312, 31626.841865790753, 31693.52459713106, 31734.841325793455, 31756.841215794004, 3209.8876539321245, 3270.689284517967, 3365.1923538350866, 3386.458166693342, 3393.7624366294367, 465839.9999999966, 468505.0, 469187.0, 469211.0, 472663.0, 58458.415415846146, 58800.7059964706, 58803.70598146982, 58810.0, 58842.0, 63210.68394657997, 63328.68335658292, 63454.0, 63547.36452635507, 63614.09402683628, 15494.767578486331, 15859.700343450366, 15995.600109997344, 16097.356105755873, 16103.516894493185, 12256.816147757612, 12314.0, 12328.013758899266, 12335.0, 12345.629631111082, 14960.70078598422, 15339.0796552205, 16732.916335418246, 17086.658266834842, 17134.742978855327, 6752.291009444036, 7104.609246491493, 7120.750773722998, 7195.640217989079, 7243.674034668453, 873.7291439653727, 878.0, 1005.6731562242301, 1095.3044816541553, 1118.4743170709753, 28265.0, 29239.415211695647, 29328.26679333034, 29725.256868578457, 29913.401731965238, 1021.1473419694489, 1047.4448542272607, 1050.5430137890041, 1131.7283851875654, 1185.4494994548415, 12602.432890519949, 14594.489192878198, 14718.926405367905, 15321.625148102063, 15342.232888355538, 576975.0, 580077.0, 580374.0, 581792.0, 587601.0, 48756.26865597019, 48891.75554122207, 56496.87006259934, 56929.430705693245, 57277.42722572721, 1060.7030031591166, 1334.1994803118052, 1353.5803900790786, 1376.6283103562182, 1378.0835744230176, 30359.696403035687, 30995.535066974466, 31179.37641247117, 31953.840230798698, 32402.51396229011, 50830.983380332924, 51389.48610513847, 51403.22895156501, 51424.0, 51442.228366573785, 395367.0, 401125.9943700263, 403069.0, 537539.0, 539994.5004124627, 22754.86225688742, 24678.753212468364, 25379.111731089324, 25693.329933554258, 25717.228483145536, 46003.76998114988, 46475.535244648476, 46749.0, 48105.0, 49487.0, 38645.0, 39541.2091758169, 39577.0, 39945.60190393439, 41086.58913410947, 35979.82010089933, 36505.81747091247, 38768.418473722355, 39135.6086439132, 40694.1861162781, 37655.24689506249, 38318.80840595891, 38635.42046869243, 38708.0, 38748.0, 26047.0, 26721.465570688088, 28329.008484702936, 34502.65497344994, 35146.47280290747, 22946.426339340982, 24029.158979435637, 25260.62109068402, 26013.959441622123, 26084.217473475826], "value": 19913.767974413884, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.9965000349996, 369.8502106646808, 372.48038985615085, 382.7741632436862, 404.2763453418381, 15039.624009399757, 15919.920400397996, 20151.0, 20287.289944851935, 20397.08213130411, 20002.899840508766, 20089.29687460939, 20288.594228115428, 20374.89812550939, 20988.790112098875, 5895.233619629453, 5897.764089436418, 6158.168647232634, 6190.78332258371, 6199.4110559497, 5985.1022346647915, 6151.477124444427, 6155.446009859112, 6163.537734669895, 6164.291106522763, 4152.231837110129, 6513.609183448984, 6880.655967201645, 6917.584944903322, 6925.0, 6613.801585952429, 6873.381395674363, 6891.241963384024, 6896.862062758767, 6942.861142777167, 6010.78962236324, 6014.338422773491, 6015.218021657201, 6020.307664618581, 6031.276246850362, 26227.344316392053, 26863.0, 26948.0, 27416.177514674393, 27431.86284068587, 2237.161064600775, 2360.6931098957198, 2418.7823095921453, 2507.7868381187623, 2600.9739902600923, 15233.61915952099, 15420.614484637861, 15571.458472456094, 16452.259648315856, 16720.581985450463, 1851.592649617082, 1873.7657792775904, 1880.6520793653217, 1893.867429279951, 1924.1822225554083, 94042.0, 96849.09452716359, 118744.40627796893, 119243.807561925, 128938.35530822474, 10888.346699198073, 10956.068734157687, 11065.336079835235, 11254.831177532344, 11342.489587968561, 14037.526059763783, 14054.929725351309, 14074.648133796532, 14074.648133796736, 14100.506482273071, 8486.533240671699, 8645.265152461985, 8671.826563468696, 8675.175858293453, 8830.690925817566, 8644.394892357475, 8648.922737350795, 8653.913460865437, 8793.252573531194, 8793.780155496164, 5776.971115144482, 6756.966215168893, 6854.177498700088, 6880.69036893341, 7104.68028938699, 1810.2849374497, 1856.5544269375523, 1859.191251805469, 1866.3561071430336, 1868.7103498957683, 365.64532403568495, 844.9493030418072, 858.9184027517376, 859.2352806002663, 891.460666296894, 9876.703698889045, 11384.715382115513, 11900.107491938139, 11951.581694640647, 11957.521699131938, 420.73283464999946, 421.66266986411364, 428.5885549872158, 438.74772006096623, 441.3071477779855, 5313.335833020872, 5824.359320474744, 5991.64050156992, 6005.489533389624, 6162.568620196633, 547030.0, 549103.0, 554007.0, 554924.0, 561477.0, 117703.0, 120166.0, 120673.0, 123365.0, 125838.0, 454.06236122407125, 459.8827299038657, 460.4267686729976, 461.06634066016585, 461.9376384188159, 11116.722081947693, 11200.716400089615, 11299.0, 11315.547378105113, 11361.37512436824, 52327.0, 52885.20672189997, 52940.205896910804, 53594.19608705951, 54201.0, 58940.0, 66390.66804666139, 78697.0, 78766.27402355877, 78873.0, 5514.476124768141, 7874.409419293462, 8180.877286840821, 8239.011318641802, 8514.659413623385, 12258.26450412978, 12748.68128296763, 13060.281684507443, 13450.932745336211, 13570.86429135696, 11436.428178591204, 11578.305301681927, 11732.589359372723, 11916.880831191924, 11959.641210763692, 11363.431828408711, 11518.769624607628, 11529.250598711056, 11866.288022718665, 12014.879851201726, 11545.076393888638, 11569.247998880046, 11781.882181178422, 11889.881101189223, 11920.821187682019, 6883.346082122191, 8148.714794982147, 8348.37387195975, 8449.197326253996, 8536.829263414573, 11318.830217546909, 11691.532338706696, 11977.580784672495, 12001.519939202333, 12008.339541324962], "value": 8963.125852581468, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.265603917845, 1485.82912965009, 1524.5578782153173, 1713.9657206855863, 1897.8197071278223, 7711.0, 8555.443896146746, 8764.035956044845, 8768.430052046613, 8940.374173807835, 8678.0, 8763.824723505542, 8769.429987050837, 8774.60514276859, 8776.0, 2377.667126602277, 2412.3969007748065, 2413.046846495642, 2414.4567472318677, 2414.794742446894, 2340.6372012338115, 2384.618461046233, 2386.0455817672982, 2386.427257458206, 2387.2599494156866, 2348.7886090251873, 2368.14746691191, 2381.5832229359794, 2384.892679829412, 2389.0443822471066, 2325.8953347099423, 2362.4566349739484, 2363.397333679909, 2363.7045369328835, 2367.490989437279, 1942.2716481319505, 2344.3787396339985, 2344.6717459555675, 2350.118705485443, 2350.635651474024, 8600.440971336842, 8730.607122679494, 8740.21338079576, 8818.206361427503, 8830.735077947671, 5156.716380599066, 5364.773618948132, 5375.946240537583, 5379.892402151935, 5389.514943655051, 3080.2761351082477, 3506.2636846262317, 3529.4705794130828, 3584.1039740064984, 3606.6934310583633, 1044.8746150461918, 1079.6922876980102, 1463.5097242423801, 1827.7349784281337, 1862.8416584590327, 11241.381724005176, 11692.0, 11707.180497365187, 11719.824202636968, 11720.765584688344, 4685.835995740201, 4704.176769065469, 4849.587785038311, 4867.634927380461, 4900.975495122501, 9137.725868223964, 9209.125133112477, 9218.539073046455, 9220.677276295297, 9229.815403691888, 5244.160934250502, 5260.579153667697, 5261.342332208474, 5265.368155821326, 5268.762905669254, 4043.696722745806, 4411.051623900877, 4450.221211288012, 4799.3760811094335, 4916.434610019822, 3748.0, 3809.2383022308604, 3817.84728610858, 3873.4189871519498, 3886.902827429337, 1168.339887963315, 1182.1193211057816, 1188.4473719720372, 1192.1416580062514, 1199.9760004799855, 724.4421795217653, 850.927671147947, 884.6063501741663, 904.7466709321401, 946.7680418297562, 5719.885602287931, 5769.249997500298, 5918.585699001114, 5996.970015149896, 6133.938660613426, 896.1620884473039, 938.3572253006712, 950.6482601437374, 967.1585720423277, 1003.8996100389902, 3391.016605184469, 3813.8855834325013, 3825.1967086911504, 3922.3135951208424, 3989.566364517642, 9100.226480749077, 10309.123724483503, 10763.3541987481, 10768.030877221088, 10814.459277036116, 10719.571217151382, 10732.195085368628, 10736.94631526853, 10739.892601074045, 10743.570257189782, 7722.768316950388, 8135.064467586185, 8253.13342099083, 8261.710840120568, 8296.751097467086, 5858.238429004202, 6001.639901605743, 6023.789167379296, 6113.358097399709, 6160.476359509492, 9417.952910235404, 9745.853812192965, 10007.399556026661, 10037.749056273651, 10133.64532241368, 9269.44383337002, 10014.549345279625, 10190.235732319958, 10278.280520363503, 10384.01351871571, 6959.8956015660815, 7866.292033716993, 8182.590870456573, 8247.257746802576, 8265.752027439186, 8167.224113709188, 8235.052968908412, 8288.129746376544, 8290.751277461686, 8366.581670916308, 6625.972974189009, 7235.782926512213, 7453.440991925519, 7559.319661230295, 7575.280348366897, 7174.497785154989, 7315.341619254293, 7324.304191101837, 7381.151167615578, 7393.667284972082, 6552.24649165333, 6785.762498312535, 6941.34057264559, 6951.374376306157, 6960.4779641526075, 3996.480457540501, 4872.9269060964825, 4931.778069986787, 4957.529034741694, 5084.9745751271, 4750.263709125091, 4782.569568738831, 4825.541573550507, 4846.733429661403, 5133.870548479328], "value": 4580.083814459882, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.3533332003112, 290.6541215953016, 303.35991058865795, 305.4349453511005, 305.68972492919676, 5221.242919776635, 5257.815976440826, 5259.52664260217, 5269.07791136551, 5283.841484755454, 3971.602839716027, 4130.586941305868, 4948.703077815325, 5237.10969135247, 5251.86870328242, 3599.8200089995526, 3727.3477141500266, 3966.3653815389616, 3971.4837071180705, 4019.1358857845557, 3719.925601487969, 3975.801209939506, 4002.879913602582, 4007.8797636070817, 4018.4976877890263, 3499.440089585667, 3575.5161607932678, 3587.3004764071015, 3946.131850992777, 4011.638952494275, 3246.4156451838658, 3678.988278223483, 3760.492333534965, 3980.9402858957137, 4008.7995600220165, 2906.8982585609615, 3466.5493485846932, 3482.564679415073, 3487.7558570900046, 3489.0, 3907.355286377744, 4338.349247612852, 5057.064443078006, 5064.480655803244, 5086.669366491166, 3417.1627951151877, 4085.5710150434074, 4461.754603496806, 4507.819687212507, 4549.863504094882, 5139.0, 5452.863678408032, 5456.236126942231, 5477.643953143033, 5484.561235101222, 3841.673457756094, 3847.8076096195077, 3853.2293541291856, 3855.652991230803, 3883.728139030269, 5295.973520132413, 5407.270018547485, 5709.45760152789, 5716.399778023289, 5773.711314434346, 3316.225819186772, 3769.208466222069, 3774.8112594370723, 3786.981065094712, 3791.976166435047, 3336.566246387954, 3532.8586856525967, 3537.080359106599, 3827.2919509890203, 3846.211526637033, 3465.5841299043773, 3828.8468461261236, 4505.594496495331, 4511.841710802451, 4537.160625284333, 4528.0, 4788.539495453851, 4950.603951683928, 5295.338082739658, 5641.802536911188, 1123.224974767408, 1154.261272785418, 1297.6893337728961, 1313.9211647301192, 1314.6450458376185, 716.9318914703199, 791.6833266693369, 836.7991681996399, 848.1221935296938, 881.1188811188811, 4206.621404073648, 4454.844080457168, 4804.759762011886, 5049.293098966147, 5135.6405051646025, 5537.695426751487, 5551.805686800943, 5560.860023695132, 5563.524231716847, 5597.412271711493, 4316.978415107905, 4354.651627869763, 4776.9761151194025, 5016.54851063406, 5069.8732531687, 2501.0996041425074, 2832.711116442014, 2844.018813509336, 2931.5016447204025, 2957.5711521829217, 4982.626303027288, 5041.6470847040355, 5696.344920334214, 5778.27771528559, 5805.303363596396, 5424.647397919122, 5691.459311365414, 5827.271591051119, 5886.999210134288, 5915.438033386908, 4897.534734200245, 5955.76176952917, 5956.0, 5965.850853728604, 5974.253218347707, 4402.823887044482, 5293.761780719799, 5359.839204823861, 5709.771609135588, 5726.685032323262, 5666.433356664301, 5667.149927510906, 5706.42935706426, 5722.198892155185, 5750.913736293875, 5444.918326225031, 5972.193753843176, 5992.08253358921, 6003.939960600338, 6015.939840601713, 3507.6667716566885, 3761.0, 3823.9235215296094, 3845.1540661054523, 3845.942310865283, 5612.979327442199, 5617.241672374177, 5617.410171931889, 5620.634658747168, 5633.183188437735, 4548.954510454853, 5472.753726082256, 5478.75371097848, 5486.31421072366, 5512.4211957743855, 4550.408446901882, 4715.434147902273, 5470.56235501151, 5474.41242039804, 5510.283663123768, 4652.860414187445, 5360.463953604608, 5361.410244872983, 5370.919436208382, 5398.460153984727, 4518.6385089193445, 5331.546818520314, 5436.918446223231, 5483.314585676791, 5511.090670039559, 5332.440093790251, 5409.214959063578, 5426.891462170814, 5427.945720542744, 5438.70087145195], "value": 3959.078652146015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.2267732267733, 784.7331907151569, 808.4502538273975, 809.308041624411, 819.6024927909966, 14696.265186740673, 15308.923455382708, 15995.120268385248, 15997.0, 16016.279267432965, 14371.0, 14733.18967456792, 14750.852491475081, 14755.18846463444, 14755.188464634468, 678.9626570538618, 850.107387243395, 864.2999170671744, 865.6018231613465, 866.8309679612478, 679.894616334469, 845.3533047218882, 859.70769938221, 870.3298460185654, 871.9912800871973, 894.8926128864546, 895.212213252337, 896.2829736211038, 896.9865452018225, 899.1053901368115, 702.7470110760122, 887.5296093070683, 888.8533391990314, 889.9822003559925, 890.2343984173606, 650.5251166648326, 663.7743167323085, 665.3313420012856, 666.1772710702279, 670.0217682184017, 14469.92765036168, 14492.058016228912, 14502.782458263135, 14515.491957781533, 14542.200178990151, 13149.474021039146, 13518.324083795771, 13632.93183534076, 13681.578382587133, 13822.861771382259, 10393.636222732244, 11813.822792658117, 11945.940270298594, 12058.276503409736, 12506.374681265901, 4405.658735486431, 4450.577195166454, 4472.575105364985, 4549.658775591844, 4550.522195169526, 85164.57417712871, 108655.45672271588, 109026.0, 109693.90306096917, 110880.33679494895, 10688.625898093529, 10690.09134223584, 10721.517531711092, 10759.246852720235, 10901.945490272497, 17196.31214751421, 20818.063187156615, 20858.895705521678, 20881.791182087985, 20897.37307880766, 6907.171139463297, 7534.794432890821, 7829.491083079582, 7909.604519773989, 7930.762077137695, 4298.118885628439, 4393.6704747144095, 4489.842855500042, 4527.139843429738, 4533.614642755337, 3325.48454989477, 3394.4399174135992, 3434.1414646338417, 3446.6553344665836, 3448.0862571418593, 651.8174911024921, 658.1937127019363, 675.9391654751096, 728.2426276672307, 729.5002922997763, 530.4032962916718, 612.5999316029189, 671.452765995712, 672.865426914619, 689.8827199376118, 8674.956625216959, 8699.085806254976, 9206.447613143233, 9243.722688319362, 9438.95280523593, 678.8438659108433, 679.8198477403492, 680.1803826389189, 682.1200651160048, 687.2234375156041, 4402.251617225015, 4594.150082234797, 4598.195315819785, 4600.677952543357, 4737.786799594027, 75332.87000694995, 153978.0, 156468.0, 160660.0, 163199.0, 126246.7375326235, 135521.0, 139951.0, 142282.2885885564, 143305.07118861141, 86640.56679716561, 119332.40333798276, 122337.0, 122826.15760763417, 124655.99999999818, 8684.913150868411, 8744.387892847693, 8842.690505832265, 8859.734207973772, 9006.414583052081, 55720.72139639276, 61426.0, 65538.34461655322, 66333.66833165803, 66741.33258667351, 87466.56266718626, 97011.51494242484, 103479.0, 103588.0, 105753.0, 10889.237753357189, 11091.0, 11142.220044596801, 11512.136589755635, 11534.480948357512, 12897.548585799452, 14648.85351146475, 14800.703985920007, 14857.0, 15036.399998014667, 13128.343582821011, 13470.191788492722, 13969.511067112602, 14222.644433889236, 14280.785788212977, 13086.869131308566, 13541.0, 14017.088889222168, 14120.152790832582, 14409.42362305496, 12495.812562811747, 13120.278384688552, 13224.723528854383, 13565.186088834702, 14035.649108772363, 10858.34849909008, 11031.724206894893, 11311.321320720783, 11707.531698732297, 11807.822882656596, 9106.635734570544, 9560.572425275708, 10515.211359148247, 11028.349965511683, 11731.178817482694], "value": 7798.698486772139, "unit": "score"}], "name": "dromaeo_css", "value": 7236.042916570196, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 116.0, 112.0, 111.0, 111.0, 111.0, 111.0, 111.0, 124.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 114.0, 127.0, 159.0, 106.0, 129.0, 129.0, 106.0, 159.0, 106.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 185.0, 183.0, 182.0, 185.0, 184.0, 181.0, 180.0, 181.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 82.0, 73.0, 154.0, 58.0, 57.0, 57.0, 62.0, 136.0, 62.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 137.0, 72.0, 71.0, 86.0, 119.0, 68.0, 72.0, 118.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 87.0, 89.0, 86.0, 89.0, 86.0, 88.0, 86.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 92.0, 95.0, 95.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 84.0, 86.0, 86.0, 85.0, 84.0, 87.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 56.0, 54.0, 53.0, 54.0, 57.0, 54.0, 57.0, 57.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 69.0, 77.0, 70.0, 75.0, 72.0, 67.0, 69.0, 68.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 86.0, 86.0, 84.0, 86.0, 84.0, 84.0, 85.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 135.0, 142.0, 113.0, 144.0, 147.0, 149.0, 192.0, 126.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 226.0, 158.0, 212.0, 235.0, 166.0, 169.0, 170.0, 169.0, 198.0], "value": 187.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 84.0, 92.0, 67.0, 66.0, 76.0, 89.0, 69.0, 58.0, 82.0], "value": 74.1, "unit": "score"}], "name": "kraken", "value": 1477.6999999999996, "alertThreshold": 2.0}]} 17:42:21 INFO - Return code: 0 17:42:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:42:21 INFO - # TBPL SUCCESS # 17:42:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:42:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:42:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:42:21 INFO - 2016-09-08 17:42:21.346 screenresolution[1670:10753] starting screenresolution argv=screenresolution get 17:42:21 INFO - 2016-09-08 17:42:21.351 screenresolution[1670:10753] Display 0: 1600x1200x32@60 17:42:21 INFO - 2016-09-08 17:42:21.357 screenresolution[1671:10756] starting screenresolution argv=screenresolution list 17:42:21 INFO - Available Modes on Display 0 17:42:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:42:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:42:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:42:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:42:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:42:21 INFO - Intel Iris: 17:42:21 INFO - Chipset Model: Intel Iris 17:42:21 INFO - Type: GPU 17:42:21 INFO - Bus: Built-In 17:42:21 INFO - VRAM (Dynamic, Max): 1536 MB 17:42:21 INFO - Vendor: Intel (0x8086) 17:42:21 INFO - Device ID: 0x0a2e 17:42:21 INFO - Revision ID: 0x0009 17:42:21 INFO - Displays: 17:42:21 INFO - Display: 17:42:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:42:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:42:21 INFO - Display Serial Number: 1600x1200 60 17:42:21 INFO - Main Display: Yes 17:42:21 INFO - Mirror: Off 17:42:21 INFO - Online: Yes 17:42:21 INFO - Rotation: Supported 17:42:21 INFO - Return code: 0 17:42:21 INFO - Running post-action listener: _resource_record_post_action 17:42:21 INFO - [mozharness: 2016-09-09 00:42:21.592505Z] Finished run-tests step (success) 17:42:21 INFO - Running post-run listener: _resource_record_post_run 17:42:21 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 32996352; Write bytes: 704803840; Read time: 314; Write time: 1983 17:42:21 INFO - TinderboxPrint: CPU usage
53.4% 17:42:21 INFO - TinderboxPrint: I/O read bytes / time
32,996,352 / 314 17:42:21 INFO - TinderboxPrint: I/O write bytes / time
704,803,840 / 1,983 17:42:21 INFO - TinderboxPrint: CPU idle
2,261.4 (46.6%) 17:42:21 INFO - TinderboxPrint: CPU system
968.6 (20.0%) 17:42:21 INFO - TinderboxPrint: CPU user
1,619.7 (33.4%) 17:42:21 INFO - TinderboxPrint: Swap in / out
435,445,760 / 0 17:42:21 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 396409344; Write bytes: 390268416; Read time: 29511; Write time: 733 17:42:21 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 31013888; Write bytes: 295857664; Read time: 293; Write time: 1209 17:42:22 INFO - Running post-run listener: _upload_blobber_files 17:42:22 INFO - Blob upload gear active. 17:42:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:42:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:42:22 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'] 17:42:22 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 17:42:22 INFO - (blobuploader) - INFO - Open directory for files ... 17:42:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:42:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:42:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:23 INFO - (blobuploader) - INFO - Done attempting. 17:42:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:42:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:42:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:24 INFO - (blobuploader) - INFO - Done attempting. 17:42:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:42:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:42:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:27 INFO - (blobuploader) - INFO - Done attempting. 17:42:27 INFO - (blobuploader) - INFO - Iteration through files over. 17:42:27 INFO - Return code: 0 17:42:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:42:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:42:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bffec87405ee19187f383c4d9c766ab4936314d954135d5f281026468ec28feebaf3d86159711e9ca7d5c1809ed2cc802d960ae35069df57331c0b3eba832f8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d01f020d89c1993505cca5d987fa5190a56b6e585cdeb034867ab7bc1ea14697f4bdbd4d41567df52b0265123f1eda8ff92a8566ab5c2ed34bd1b2ae3d5a3c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/879d82c4e00e5e42286c86312f315090ed14fc4bfad5a45f73f5d43c046656241b5a4eccc8063c3bf73ada5ebf0382adc1e07fcc2059fabd1ea3274878c57055"} 17:42:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:42:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:42:27 INFO - Contents: 17:42:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bffec87405ee19187f383c4d9c766ab4936314d954135d5f281026468ec28feebaf3d86159711e9ca7d5c1809ed2cc802d960ae35069df57331c0b3eba832f8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d01f020d89c1993505cca5d987fa5190a56b6e585cdeb034867ab7bc1ea14697f4bdbd4d41567df52b0265123f1eda8ff92a8566ab5c2ed34bd1b2ae3d5a3c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/879d82c4e00e5e42286c86312f315090ed14fc4bfad5a45f73f5d43c046656241b5a4eccc8063c3bf73ada5ebf0382adc1e07fcc2059fabd1ea3274878c57055"} 17:42:27 INFO - Running post-run listener: copy_logs_to_upload_dir 17:42:27 INFO - Copying logs to upload dir... 17:42:27 INFO - mkdir: /builds/slave/test/build/upload/logs 17:42:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.444138 ========= master_lag: 1.96 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-09-08 17:42:29.354787) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-08 17:42:29.358896) ========= 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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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/bffec87405ee19187f383c4d9c766ab4936314d954135d5f281026468ec28feebaf3d86159711e9ca7d5c1809ed2cc802d960ae35069df57331c0b3eba832f8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d01f020d89c1993505cca5d987fa5190a56b6e585cdeb034867ab7bc1ea14697f4bdbd4d41567df52b0265123f1eda8ff92a8566ab5c2ed34bd1b2ae3d5a3c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/879d82c4e00e5e42286c86312f315090ed14fc4bfad5a45f73f5d43c046656241b5a4eccc8063c3bf73ada5ebf0382adc1e07fcc2059fabd1ea3274878c57055"} build_url:https://queue.taskcluster.net/v1/task/KKQ3fEwCRkalfUWP1rxE5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011098 build_url: 'https://queue.taskcluster.net/v1/task/KKQ3fEwCRkalfUWP1rxE5A/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/bffec87405ee19187f383c4d9c766ab4936314d954135d5f281026468ec28feebaf3d86159711e9ca7d5c1809ed2cc802d960ae35069df57331c0b3eba832f8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d01f020d89c1993505cca5d987fa5190a56b6e585cdeb034867ab7bc1ea14697f4bdbd4d41567df52b0265123f1eda8ff92a8566ab5c2ed34bd1b2ae3d5a3c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/879d82c4e00e5e42286c86312f315090ed14fc4bfad5a45f73f5d43c046656241b5a4eccc8063c3bf73ada5ebf0382adc1e07fcc2059fabd1ea3274878c57055"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-08 17:42:29.400109) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 17:42:29.400523) ========= 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.yjLwqbs2WS/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.xyWPS6H5sg/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.005279 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 17:42:29.450371) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-08 17:42:29.450831) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-08 17:42:29.451379) ========= ========= Total master_lag: 2.11 =========