builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0176 starttime: 1473653666.78 results: success (0) buildid: 20160911193116 builduid: cd089d2021594127aa3bef575a469672 revision: cfdb7af3af2e92e95f71ca2f1672bf5433beeb89 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-11 21:14:26.780440) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-11 21:14:26.780939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-11 21:14:26.781218) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-11 21:14:26.963599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 21:14:26.963914) ========= 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.WPzFWAVNv6/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.LNnagFHf3L/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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-11 21:14:26-- 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% 31.4M=0s 2016-09-11 21:14:27 (31.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158573 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 21:14:27.191740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 21:14:27.192023) ========= 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.WPzFWAVNv6/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.LNnagFHf3L/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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.027892 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 21:14:27.260670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-11 21:14:27.260988) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cfdb7af3af2e92e95f71ca2f1672bf5433beeb89 --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 cfdb7af3af2e92e95f71ca2f1672bf5433beeb89 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WPzFWAVNv6/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.LNnagFHf3L/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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-11 21:14:27,339 truncating revision to first 12 chars 2016-09-11 21:14:27,339 Setting DEBUG logging. 2016-09-11 21:14:27,339 attempt 1/10 2016-09-11 21:14:27,339 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cfdb7af3af2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-11 21:14:28,437 unpacking tar archive at: mozilla-central-cfdb7af3af2e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.365833 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-11 21:14:28.652241) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-11 21:14:28.652885) ========= script_repo_revision: cfdb7af3af2e92e95f71ca2f1672bf5433beeb89 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-11 21:14:28.653754) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-11 21:14:28.654083) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-11 21:14:28.673717) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-09-11 21:14:28.674392) ========= /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.WPzFWAVNv6/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.LNnagFHf3L/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 21:14:28 INFO - MultiFileLogger online at 20160911 21:14:28 in /builds/slave/test 21:14:28 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 21:14:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:14:28 INFO - {'append_to_log': False, 21:14:28 INFO - 'base_work_dir': '/builds/slave/test', 21:14:28 INFO - 'blob_upload_branch': 'Firefox', 21:14:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:14:28 INFO - 'branch': 'Firefox', 21:14:28 INFO - 'buildbot_json_path': 'buildprops.json', 21:14:28 INFO - 'config_files': ('talos/mac_config.py',), 21:14:28 INFO - 'default_actions': ('clobber', 21:14:28 INFO - 'read-buildbot-config', 21:14:28 INFO - 'download-and-extract', 21:14:28 INFO - 'populate-webroot', 21:14:28 INFO - 'create-virtualenv', 21:14:28 INFO - 'install', 21:14:28 INFO - 'run-tests'), 21:14:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:14:28 INFO - 'download_minidump_stackwalk': True, 21:14:28 INFO - 'download_symbols': 'ondemand', 21:14:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:14:28 INFO - 'tooltool.py': '/tools/tooltool.py', 21:14:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:14:28 INFO - '/tools/misc-python/virtualenv.py')}, 21:14:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:14:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:14:28 INFO - 'installer_path': 'installer.exe', 21:14:28 INFO - 'log_level': 'info', 21:14:28 INFO - 'log_name': 'talos', 21:14:28 INFO - 'log_to_console': True, 21:14:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:14:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:14:28 INFO - 'opt_config_files': (), 21:14:28 INFO - 'pip_index': False, 21:14:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:14:28 INFO - 'cmd': ('bash', 21:14:28 INFO - '-c', 21:14:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:14:28 INFO - 'enabled': True, 21:14:28 INFO - 'halt_on_failure': False, 21:14:28 INFO - 'name': 'check_screen_resolution'},), 21:14:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:14:28 INFO - 'cmd': ('bash', 21:14:28 INFO - '-c', 21:14:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:14:28 INFO - 'enabled': True, 21:14:28 INFO - 'halt_on_failure': False, 21:14:28 INFO - 'name': 'check_screen_resolution'},), 21:14:28 INFO - 'run_cmd_checks_enabled': True, 21:14:28 INFO - 'sps_profile': False, 21:14:28 INFO - 'sps_profile_interval': 0, 21:14:28 INFO - 'suite': 'dromaeojs', 21:14:28 INFO - 'system_bits': '32', 21:14:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:14:28 INFO - 'title': 't-yosemite-r7-0176', 21:14:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:14:28 INFO - 'use_talos_json': True, 21:14:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:14:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:14:28 INFO - 'work_dir': 'build'} 21:14:28 INFO - [mozharness: 2016-09-12 04:14:28.897830Z] Running clobber step. 21:14:28 INFO - Running pre-action listener: _resource_record_pre_action 21:14:28 INFO - Running main action method: clobber 21:14:28 INFO - rmtree: /builds/slave/test/build 21:14:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:14:31 INFO - Running post-action listener: _resource_record_post_action 21:14:31 INFO - [mozharness: 2016-09-12 04:14:31.388677Z] Finished clobber step (success) 21:14:31 INFO - [mozharness: 2016-09-12 04:14:31.388807Z] Running read-buildbot-config step. 21:14:31 INFO - Running pre-action listener: _resource_record_pre_action 21:14:31 INFO - Running main action method: read_buildbot_config 21:14:31 INFO - Using buildbot properties: 21:14:31 INFO - { 21:14:31 INFO - "project": "", 21:14:31 INFO - "product": "firefox", 21:14:31 INFO - "script_repo_revision": "production", 21:14:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:14:31 INFO - "repository": "", 21:14:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:14:31 INFO - "buildid": "20160911193116", 21:14:31 INFO - "pgo_build": "False", 21:14:31 INFO - "basedir": "/builds/slave/test", 21:14:31 INFO - "buildnumber": 29, 21:14:31 INFO - "slavename": "t-yosemite-r7-0176", 21:14:31 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 21:14:31 INFO - "platform": "yosemite_r7", 21:14:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:14:31 INFO - "branch": "mozilla-central", 21:14:31 INFO - "repo_path": "mozilla-central", 21:14:31 INFO - "revision": "cfdb7af3af2e92e95f71ca2f1672bf5433beeb89", 21:14:31 INFO - "stage_platform": "macosx64", 21:14:31 INFO - "builduid": "cd089d2021594127aa3bef575a469672", 21:14:31 INFO - "slavebuilddir": "test" 21:14:31 INFO - } 21:14:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/GnTncIIyQRemOTl5FZav9w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 21:14:31 INFO - Running post-action listener: _resource_record_post_action 21:14:31 INFO - [mozharness: 2016-09-12 04:14:31.392030Z] Finished read-buildbot-config step (success) 21:14:31 INFO - [mozharness: 2016-09-12 04:14:31.392138Z] Running download-and-extract step. 21:14:31 INFO - Running pre-action listener: _resource_record_pre_action 21:14:31 INFO - Running main action method: download_and_extract 21:14:31 INFO - mkdir: /builds/slave/test/build/tests 21:14: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')]} 21:14:31 INFO - trying https://queue.taskcluster.net/v1/task/GnTncIIyQRemOTl5FZav9w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 21:14:31 INFO - Downloading https://queue.taskcluster.net/v1/task/GnTncIIyQRemOTl5FZav9w/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 21:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GnTncIIyQRemOTl5FZav9w/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 21:14:31 INFO - Downloaded 1199 bytes. 21:14:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 21:14:31 INFO - Using the following test package requirements: 21:14:31 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:14:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:31 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 21:14:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:31 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 21:14:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:31 INFO - u'jsshell-mac.zip'], 21:14:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:31 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 21:14:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:14:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:31 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 21:14:31 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:31 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 21:14:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:31 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 21:14:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:31 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 21:14:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:14:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnTncIIyQRemOTl5FZav9w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:14:32 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 21:14:39 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 21:14:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnTncIIyQRemOTl5FZav9w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:14:40 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 21:14:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnTncIIyQRemOTl5FZav9w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 21:14:47 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 21:14:47 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')]} 21:14:47 INFO - trying https://queue.taskcluster.net/v1/task/GnTncIIyQRemOTl5FZav9w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:14:47 INFO - Downloading https://queue.taskcluster.net/v1/task/GnTncIIyQRemOTl5FZav9w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 21:14:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GnTncIIyQRemOTl5FZav9w/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 21:14:50 INFO - Downloaded 111647509 bytes. 21:14:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GnTncIIyQRemOTl5FZav9w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:14:50 INFO - mkdir: /builds/slave/test/properties 21:14:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:14:50 INFO - Writing to file /builds/slave/test/properties/build_url 21:14:50 INFO - Contents: 21:14:50 INFO - build_url:https://queue.taskcluster.net/v1/task/GnTncIIyQRemOTl5FZav9w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:14:51 INFO - Running post-action listener: _resource_record_post_action 21:14:51 INFO - Running post-action listener: set_extra_try_arguments 21:14:51 INFO - [mozharness: 2016-09-12 04:14:51.131757Z] Finished download-and-extract step (success) 21:14:51 INFO - [mozharness: 2016-09-12 04:14:51.131882Z] Running populate-webroot step. 21:14:51 INFO - Running pre-action listener: _resource_record_pre_action 21:14:51 INFO - Running main action method: populate_webroot 21:14:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:14:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:14:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:14:51 INFO - '--tppagecycles', 21:14:51 INFO - '7'], 21:14:51 INFO - 'tests': ['tsvgm']}}, 21:14:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:14:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:14:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:14:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:14:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:14:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:14:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:51 INFO - 'talos_options': ['--disable-e10s'], 21:14:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:14:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:14:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:51 INFO - 'talos_options': ['--disable-e10s'], 21:14:51 INFO - 'tests': ['damp', 'tps']}, 21:14:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:51 INFO - 'tests': ['damp', 'tps']}, 21:14:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:14:51 INFO - 'tests': ['dromaeo_dom']}, 21:14:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:14:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:14:51 INFO - 'tests': ['basic_compositor_video']}, 21:14:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:14:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:14:51 INFO - 'tests': ['a11yr', 21:14:51 INFO - 'ts_paint', 21:14:51 INFO - 'tpaint', 21:14:51 INFO - 'sessionrestore', 21:14:51 INFO - 'sessionrestore_no_auto_restore', 21:14:51 INFO - 'tabpaint']}, 21:14:51 INFO - 'other-e10s': {'tests': ['a11yr', 21:14:51 INFO - 'ts_paint', 21:14:51 INFO - 'tpaint', 21:14:51 INFO - 'sessionrestore', 21:14:51 INFO - 'sessionrestore_no_auto_restore', 21:14:51 INFO - 'tabpaint']}, 21:14:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:14:51 INFO - 'ts_paint', 21:14:51 INFO - 'tpaint', 21:14:51 INFO - 'sessionrestore', 21:14:51 INFO - 'sessionrestore_no_auto_restore', 21:14:51 INFO - 'tabpaint']}, 21:14:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:14:51 INFO - 'ts_paint', 21:14:51 INFO - 'tpaint', 21:14:51 INFO - 'sessionrestore', 21:14:51 INFO - 'sessionrestore_no_auto_restore', 21:14:51 INFO - 'tabpaint']}, 21:14:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:14:51 INFO - 'tests': ['a11yr', 21:14:51 INFO - 'ts_paint', 21:14:51 INFO - 'tpaint', 21:14:51 INFO - 'sessionrestore', 21:14:51 INFO - 'sessionrestore_no_auto_restore', 21:14:51 INFO - 'tabpaint']}, 21:14:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:14:51 INFO - 'tests': ['a11yr', 21:14:51 INFO - 'ts_paint', 21:14:51 INFO - 'tpaint', 21:14:51 INFO - 'sessionrestore', 21:14:51 INFO - 'sessionrestore_no_auto_restore', 21:14:51 INFO - 'tabpaint']}, 21:14:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:14:51 INFO - 'tests': ['tsvgx', 21:14:51 INFO - 'tsvgr_opacity', 21:14:51 INFO - 'tart', 21:14:51 INFO - 'tscrollx', 21:14:51 INFO - 'cart']}, 21:14:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:14:51 INFO - 'tsvgr_opacity', 21:14:51 INFO - 'tart', 21:14:51 INFO - 'tscrollx', 21:14:51 INFO - 'cart']}, 21:14:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:51 INFO - 'talos_options': ['--disable-e10s'], 21:14:51 INFO - 'tests': ['tp5o']}, 21:14:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:51 INFO - 'tests': ['tp5o']}, 21:14:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:51 INFO - 'talos_options': ['--disable-e10s', 21:14:51 INFO - '--xperf_path', 21:14:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:14:51 INFO - 'tests': ['tp5n']}, 21:14:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:51 INFO - 'talos_options': ['--xperf_path', 21:14:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:14:51 INFO - 'tests': ['tp5n']}}, 21:14:51 INFO - 'talos.zip': {'path': '', 21:14:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:14:51 INFO - Running post-action listener: _resource_record_post_action 21:14:51 INFO - [mozharness: 2016-09-12 04:14:51.151343Z] Finished populate-webroot step (success) 21:14:51 INFO - [mozharness: 2016-09-12 04:14:51.151482Z] Running create-virtualenv step. 21:14:51 INFO - Running pre-action listener: _resource_record_pre_action 21:14:51 INFO - Running main action method: create_virtualenv 21:14:51 INFO - Creating virtualenv /builds/slave/test/build/venv 21:14:51 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 21:14:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:14:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:14:51 INFO - Using real prefix '/tools/python27' 21:14:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:14:52 INFO - Installing distribute.............................................................................................................................................................................................done. 21:14:54 INFO - Installing pip.................done. 21:14:54 INFO - Return code: 0 21:14:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:14:54 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')]} 21:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:54 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')]} 21:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:54 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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ead98cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10631bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.WPzFWAVNv6/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.LNnagFHf3L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 21:14:54 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 21:14:54 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 21:14:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WPzFWAVNv6/Render', 21:14:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:54 INFO - 'HOME': '/Users/cltbld', 21:14:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:54 INFO - 'LOGNAME': 'cltbld', 21:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:54 INFO - 'MOZ_NO_REMOTE': '1', 21:14:54 INFO - 'NO_EM_RESTART': '1', 21:14:54 INFO - 'PAGER': '/bin/cat', 21:14:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:54 INFO - 'PWD': '/builds/slave/test', 21:14:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:54 INFO - 'SHELL': '/bin/bash', 21:14:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LNnagFHf3L/Listeners', 21:14:54 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 21:14:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:54 INFO - 'USER': 'cltbld', 21:14:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:54 INFO - 'XPC_FLAGS': '0x0', 21:14:54 INFO - 'XPC_SERVICE_NAME': '0', 21:14:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:55 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 21:14:55 INFO - Cleaning up... 21:14:55 INFO - Return code: 0 21:14:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ead98cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10631bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.WPzFWAVNv6/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.LNnagFHf3L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 21:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:14:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WPzFWAVNv6/Render', 21:14:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:55 INFO - 'HOME': '/Users/cltbld', 21:14:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:55 INFO - 'LOGNAME': 'cltbld', 21:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:55 INFO - 'MOZ_NO_REMOTE': '1', 21:14:55 INFO - 'NO_EM_RESTART': '1', 21:14:55 INFO - 'PAGER': '/bin/cat', 21:14:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:55 INFO - 'PWD': '/builds/slave/test', 21:14:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:55 INFO - 'SHELL': '/bin/bash', 21:14:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LNnagFHf3L/Listeners', 21:14:55 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 21:14:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:55 INFO - 'USER': 'cltbld', 21:14:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:55 INFO - 'XPC_FLAGS': '0x0', 21:14:55 INFO - 'XPC_SERVICE_NAME': '0', 21:14:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:55 INFO - Downloading/unpacking psutil>=3.1.1 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:14:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:14:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:14:58 INFO - Installing collected packages: psutil 21:14:58 INFO - Running setup.py install for psutil 21:14:58 INFO - building 'psutil._psutil_osx' extension 21:14:58 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 21:14:59 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 21:14:59 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 21:14:59 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 21:14:59 INFO - building 'psutil._psutil_posix' extension 21:14:59 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 21:14:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:14:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:14:59 INFO - ^ 21:14:59 INFO - 1 warning generated. 21:14:59 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 21:14:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:14:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:14:59 INFO - Successfully installed psutil 21:14:59 INFO - Cleaning up... 21:14:59 INFO - Return code: 0 21:14:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:14:59 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')]} 21:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:59 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')]} 21:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:59 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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ead98cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10631bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.WPzFWAVNv6/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.LNnagFHf3L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 21:14:59 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 21:14:59 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 21:14:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WPzFWAVNv6/Render', 21:14:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:59 INFO - 'HOME': '/Users/cltbld', 21:14:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:59 INFO - 'LOGNAME': 'cltbld', 21:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:59 INFO - 'MOZ_NO_REMOTE': '1', 21:14:59 INFO - 'NO_EM_RESTART': '1', 21:14:59 INFO - 'PAGER': '/bin/cat', 21:14:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:59 INFO - 'PWD': '/builds/slave/test', 21:14:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:59 INFO - 'SHELL': '/bin/bash', 21:14:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LNnagFHf3L/Listeners', 21:14:59 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 21:14:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:59 INFO - 'USER': 'cltbld', 21:14:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:59 INFO - 'XPC_FLAGS': '0x0', 21:14:59 INFO - 'XPC_SERVICE_NAME': '0', 21:14:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:15:00 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 21:15:00 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 21:15:00 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 21:15:00 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 21:15:00 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 21:15:00 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 21:15:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:15:02 INFO - Installing collected packages: mozsystemmonitor 21:15:02 INFO - Running setup.py install for mozsystemmonitor 21:15:02 INFO - Successfully installed mozsystemmonitor 21:15:02 INFO - Cleaning up... 21:15:02 INFO - Return code: 0 21:15:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:15: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')]} 21:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15: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')]} 21:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ead98cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10631bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.WPzFWAVNv6/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.LNnagFHf3L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 21:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:15:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WPzFWAVNv6/Render', 21:15:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:02 INFO - 'HOME': '/Users/cltbld', 21:15:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:02 INFO - 'LOGNAME': 'cltbld', 21:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:02 INFO - 'MOZ_NO_REMOTE': '1', 21:15:02 INFO - 'NO_EM_RESTART': '1', 21:15:02 INFO - 'PAGER': '/bin/cat', 21:15:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:02 INFO - 'PWD': '/builds/slave/test', 21:15:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:02 INFO - 'SHELL': '/bin/bash', 21:15:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LNnagFHf3L/Listeners', 21:15:02 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 21:15:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:02 INFO - 'USER': 'cltbld', 21:15:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:02 INFO - 'XPC_FLAGS': '0x0', 21:15:02 INFO - 'XPC_SERVICE_NAME': '0', 21:15:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:03 INFO - Downloading/unpacking jsonschema==2.5.1 21:15:03 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 21:15:03 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 21:15:03 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 21:15:03 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 21:15:03 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 21:15:03 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 21:15:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:15:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:05 INFO - Downloading functools32-3.2.3-2.tar.gz 21:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:15:06 INFO - warning: no files found matching '*.txt' 21:15:06 INFO - no previously-included directories found matching 'build' 21:15:06 INFO - no previously-included directories found matching 'dist' 21:15:06 INFO - no previously-included directories found matching '.git*' 21:15:06 INFO - Installing collected packages: jsonschema, functools32 21:15:06 INFO - Running setup.py install for functools32 21:15:06 INFO - warning: no files found matching '*.txt' 21:15:06 INFO - no previously-included directories found matching 'build' 21:15:06 INFO - no previously-included directories found matching 'dist' 21:15:06 INFO - no previously-included directories found matching '.git*' 21:15:06 INFO - Successfully installed jsonschema functools32 21:15:06 INFO - Cleaning up... 21:15:06 INFO - Return code: 0 21:15:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ead98cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10631bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.WPzFWAVNv6/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.LNnagFHf3L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 21:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:15:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WPzFWAVNv6/Render', 21:15:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:06 INFO - 'HOME': '/Users/cltbld', 21:15:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:06 INFO - 'LOGNAME': 'cltbld', 21:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:06 INFO - 'MOZ_NO_REMOTE': '1', 21:15:06 INFO - 'NO_EM_RESTART': '1', 21:15:06 INFO - 'PAGER': '/bin/cat', 21:15:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:06 INFO - 'PWD': '/builds/slave/test', 21:15:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:06 INFO - 'SHELL': '/bin/bash', 21:15:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LNnagFHf3L/Listeners', 21:15:06 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 21:15:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:06 INFO - 'USER': 'cltbld', 21:15:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:06 INFO - 'XPC_FLAGS': '0x0', 21:15:06 INFO - 'XPC_SERVICE_NAME': '0', 21:15:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:15:06 INFO - Cleaning up... 21:15:06 INFO - Return code: 0 21:15:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ead98cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10631bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.WPzFWAVNv6/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.LNnagFHf3L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 21:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:15:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WPzFWAVNv6/Render', 21:15:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:06 INFO - 'HOME': '/Users/cltbld', 21:15:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:06 INFO - 'LOGNAME': 'cltbld', 21:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:06 INFO - 'MOZ_NO_REMOTE': '1', 21:15:06 INFO - 'NO_EM_RESTART': '1', 21:15:06 INFO - 'PAGER': '/bin/cat', 21:15:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:06 INFO - 'PWD': '/builds/slave/test', 21:15:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:06 INFO - 'SHELL': '/bin/bash', 21:15:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LNnagFHf3L/Listeners', 21:15:06 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 21:15:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:06 INFO - 'USER': 'cltbld', 21:15:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:06 INFO - 'XPC_FLAGS': '0x0', 21:15:06 INFO - 'XPC_SERVICE_NAME': '0', 21:15:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:06 INFO - Downloading/unpacking blobuploader==1.2.4 21:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:09 INFO - Downloading blobuploader-1.2.4.tar.gz 21:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:15:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:15:09 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 21:15:09 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 21:15:09 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 21:15:09 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 21:15:09 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 21:15:09 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 21:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:15:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:10 INFO - Downloading docopt-0.6.1.tar.gz 21:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:15:10 INFO - Installing collected packages: blobuploader, requests, docopt 21:15:10 INFO - Running setup.py install for blobuploader 21:15:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:15:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:15:10 INFO - Running setup.py install for requests 21:15:11 INFO - Running setup.py install for docopt 21:15:11 INFO - Successfully installed blobuploader requests docopt 21:15:11 INFO - Cleaning up... 21:15:11 INFO - Return code: 0 21:15:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:11 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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ead98cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10631bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.WPzFWAVNv6/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.LNnagFHf3L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 21:15:11 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 21:15:11 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 21:15:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WPzFWAVNv6/Render', 21:15:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:11 INFO - 'HOME': '/Users/cltbld', 21:15:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:11 INFO - 'LOGNAME': 'cltbld', 21:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:11 INFO - 'MOZ_NO_REMOTE': '1', 21:15:11 INFO - 'NO_EM_RESTART': '1', 21:15:11 INFO - 'PAGER': '/bin/cat', 21:15:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:11 INFO - 'PWD': '/builds/slave/test', 21:15:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:11 INFO - 'SHELL': '/bin/bash', 21:15:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LNnagFHf3L/Listeners', 21:15:11 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 21:15:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:11 INFO - 'USER': 'cltbld', 21:15:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:11 INFO - 'XPC_FLAGS': '0x0', 21:15:11 INFO - 'XPC_SERVICE_NAME': '0', 21:15:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:15:11 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-oPmhFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:15:11 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-_za8hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:15:11 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-sxaVJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:15:12 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-3nNVC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:15:12 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-c0lREp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:15:12 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-cXreFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:15:12 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-0c16m6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:15:12 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-EutdxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:15:12 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-SIVA9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:15:12 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-YFqxt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:15:12 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-b_ugQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:15:12 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-SjHkKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:15:13 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-aeCwuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:15:13 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-cAH1gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:15:13 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-zZoiRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:15:13 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-31k70W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:15:13 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-Qw0Jb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:15:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:15:13 INFO - Running setup.py install for manifestparser 21:15:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:15:13 INFO - Running setup.py install for mozcrash 21:15:13 INFO - Running setup.py install for mozdebug 21:15:14 INFO - Running setup.py install for mozdevice 21:15:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:15:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:15:14 INFO - Running setup.py install for mozfile 21:15:14 INFO - Running setup.py install for mozhttpd 21:15:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:15:14 INFO - Running setup.py install for mozinfo 21:15:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:15:14 INFO - Running setup.py install for mozInstall 21:15:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:15:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:15:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:15:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:15:14 INFO - Running setup.py install for mozleak 21:15:14 INFO - Running setup.py install for mozlog 21:15:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:15:15 INFO - Running setup.py install for moznetwork 21:15:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:15:15 INFO - Running setup.py install for mozprocess 21:15:15 INFO - Running setup.py install for mozprofile 21:15:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:15:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:15:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:15:15 INFO - Running setup.py install for mozrunner 21:15:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:15:15 INFO - Running setup.py install for mozscreenshot 21:15:15 INFO - Running setup.py install for moztest 21:15:16 INFO - Running setup.py install for mozversion 21:15:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:15:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:15:16 INFO - Cleaning up... 21:15:16 INFO - Return code: 0 21:15:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:15:16 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')]} 21:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:16 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')]} 21:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:16 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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ead98cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10631bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.WPzFWAVNv6/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.LNnagFHf3L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 21:15:16 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 21:15:16 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 21:15:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WPzFWAVNv6/Render', 21:15:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:16 INFO - 'HOME': '/Users/cltbld', 21:15:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:16 INFO - 'LOGNAME': 'cltbld', 21:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:16 INFO - 'MOZ_NO_REMOTE': '1', 21:15:16 INFO - 'NO_EM_RESTART': '1', 21:15:16 INFO - 'PAGER': '/bin/cat', 21:15:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:16 INFO - 'PWD': '/builds/slave/test', 21:15:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:16 INFO - 'SHELL': '/bin/bash', 21:15:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LNnagFHf3L/Listeners', 21:15:16 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 21:15:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:16 INFO - 'USER': 'cltbld', 21:15:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:16 INFO - 'XPC_FLAGS': '0x0', 21:15:16 INFO - 'XPC_SERVICE_NAME': '0', 21:15:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:15:16 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-YmMpns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:15:16 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)) 21:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:15:16 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-HLmDXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:15:16 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)) 21:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:15:16 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-v1yR8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:15:16 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)) 21:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:15:16 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-HjiVQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:15:16 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)) 21:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:15:16 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-LyFyUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:15:17 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)) 21:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:15:17 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-Sj9hQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:15:17 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)) 21:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:15:17 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-dTcV_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:15:17 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)) 21:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:15:17 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-LHHN1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:15:17 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)) 21:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:15:17 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-2ZQIGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:15:17 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)) 21:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:15:17 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-ByGKnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:15:17 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)) 21:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:15:17 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-ytZbDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:15:17 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)) 21:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:15:17 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-FSD5MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:15:17 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)) 21:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:15:17 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-ttd7nP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:15:17 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)) 21:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:15:17 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-oAPKkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:15:17 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)) 21:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:15:17 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-vwcZVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:15:18 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)) 21:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:15:18 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-yDhVVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:15:18 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)) 21:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:15:18 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-xUhsMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:15:18 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)) 21:15:18 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)) 21:15:18 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)) 21:15:18 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)) 21:15:18 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)) 21:15:18 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)) 21:15:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:15:18 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 21:15:18 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 21:15:18 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 21:15:18 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 21:15:18 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 21:15:18 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 21:15:20 INFO - Downloading blessings-1.6.tar.gz 21:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:15:20 INFO - Installing collected packages: blessings 21:15:20 INFO - Running setup.py install for blessings 21:15:21 INFO - Successfully installed blessings 21:15:21 INFO - Cleaning up... 21:15:21 INFO - Return code: 0 21:15:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:15:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:15:21 INFO - Reading from file tmpfile_stdout 21:15:21 INFO - Current package versions: 21:15:21 INFO - blessings == 1.6 21:15:21 INFO - blobuploader == 1.2.4 21:15:21 INFO - docopt == 0.6.1 21:15:21 INFO - functools32 == 3.2.3-2 21:15:21 INFO - jsonschema == 2.5.1 21:15:21 INFO - manifestparser == 1.1 21:15:21 INFO - mozInstall == 1.12 21:15:21 INFO - mozcrash == 0.17 21:15:21 INFO - mozdebug == 0.1 21:15:21 INFO - mozdevice == 0.48 21:15:21 INFO - mozfile == 1.2 21:15:21 INFO - mozhttpd == 0.7 21:15:21 INFO - mozinfo == 0.9 21:15:21 INFO - mozleak == 0.1 21:15:21 INFO - mozlog == 3.3 21:15:21 INFO - moznetwork == 0.27 21:15:21 INFO - mozprocess == 0.23 21:15:21 INFO - mozprofile == 0.28 21:15:21 INFO - mozrunner == 6.12 21:15:21 INFO - mozscreenshot == 0.1 21:15:21 INFO - mozsystemmonitor == 0.3 21:15:21 INFO - moztest == 0.7 21:15:21 INFO - mozversion == 1.4 21:15:21 INFO - psutil == 3.1.1 21:15:21 INFO - requests == 1.2.3 21:15:21 INFO - wsgiref == 0.1.2 21:15:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:21 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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ead98cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10631bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.WPzFWAVNv6/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.LNnagFHf3L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 21:15:21 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 21:15:21 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 21:15:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WPzFWAVNv6/Render', 21:15:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:21 INFO - 'HOME': '/Users/cltbld', 21:15:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:21 INFO - 'LOGNAME': 'cltbld', 21:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:21 INFO - 'MOZ_NO_REMOTE': '1', 21:15:21 INFO - 'NO_EM_RESTART': '1', 21:15:21 INFO - 'PAGER': '/bin/cat', 21:15:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:21 INFO - 'PWD': '/builds/slave/test', 21:15:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:21 INFO - 'SHELL': '/bin/bash', 21:15:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LNnagFHf3L/Listeners', 21:15:21 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 21:15:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:21 INFO - 'USER': 'cltbld', 21:15:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:21 INFO - 'XPC_FLAGS': '0x0', 21:15:21 INFO - 'XPC_SERVICE_NAME': '0', 21:15:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:21 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)) 21:15:21 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)) 21:15:21 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)) 21:15:21 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)) 21:15:21 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)) 21:15:21 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)) 21:15:21 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)) 21:15:21 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)) 21:15:21 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)) 21:15:21 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)) 21:15:21 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)) 21:15:21 INFO - Cleaning up... 21:15:21 INFO - Return code: 0 21:15:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ead98cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10631bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.WPzFWAVNv6/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.LNnagFHf3L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 21:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:15:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WPzFWAVNv6/Render', 21:15:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:21 INFO - 'HOME': '/Users/cltbld', 21:15:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:21 INFO - 'LOGNAME': 'cltbld', 21:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:21 INFO - 'MOZ_NO_REMOTE': '1', 21:15:21 INFO - 'NO_EM_RESTART': '1', 21:15:21 INFO - 'PAGER': '/bin/cat', 21:15:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:21 INFO - 'PWD': '/builds/slave/test', 21:15:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:21 INFO - 'SHELL': '/bin/bash', 21:15:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LNnagFHf3L/Listeners', 21:15:21 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 21:15:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:21 INFO - 'USER': 'cltbld', 21:15:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:21 INFO - 'XPC_FLAGS': '0x0', 21:15:21 INFO - 'XPC_SERVICE_NAME': '0', 21:15:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:15:22 INFO - Cleaning up... 21:15:22 INFO - Return code: 0 21:15:22 INFO - Running post-action listener: _resource_record_post_action 21:15:22 INFO - Running post-action listener: _start_resource_monitoring 21:15:22 INFO - Starting resource monitoring. 21:15:22 INFO - [mozharness: 2016-09-12 04:15:22.048792Z] Finished create-virtualenv step (success) 21:15:22 INFO - [mozharness: 2016-09-12 04:15:22.049773Z] Running install step. 21:15:22 INFO - Running pre-action listener: _resource_record_pre_action 21:15:22 INFO - Running main action method: install 21:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:15:22 INFO - Reading from file tmpfile_stdout 21:15:22 INFO - Detecting whether we're running mozinstall >=1.0... 21:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:15:22 INFO - Reading from file tmpfile_stdout 21:15:22 INFO - Output received: 21:15:22 INFO - Usage: mozinstall [options] installer 21:15:22 INFO - Options: 21:15:22 INFO - -h, --help show this help message and exit 21:15:22 INFO - -d DEST, --destination=DEST 21:15:22 INFO - Directory to install application into. [default: 21:15:22 INFO - "/builds/slave/test"] 21:15:22 INFO - --app=APP Application being installed. [default: firefox] 21:15:22 INFO - mkdir: /builds/slave/test/build/application 21:15:22 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'] 21:15:22 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 21:15:56 INFO - Reading from file tmpfile_stdout 21:15:56 INFO - Output received: 21:15:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:15:56 INFO - Running post-action listener: _resource_record_post_action 21:15:56 INFO - [mozharness: 2016-09-12 04:15:56.242205Z] Finished install step (success) 21:15:56 INFO - [mozharness: 2016-09-12 04:15:56.242348Z] Running run-tests step. 21:15:56 INFO - Running pre-action listener: _resource_record_pre_action 21:15:56 INFO - Running main action method: run_tests 21:15:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:15:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:15:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:15:56 INFO - 2016-09-11 21:15:56.256 screenresolution[1666:17355] starting screenresolution argv=screenresolution get 21:15:56 INFO - 2016-09-11 21:15:56.259 screenresolution[1666:17355] Display 0: 1600x1200x32@60 21:15:56 INFO - 2016-09-11 21:15:56.265 screenresolution[1667:17359] starting screenresolution argv=screenresolution list 21:15:56 INFO - Available Modes on Display 0 21:15:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:15:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:15:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:15:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:15:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:15:56 INFO - Intel Iris: 21:15:56 INFO - Chipset Model: Intel Iris 21:15:56 INFO - Type: GPU 21:15:56 INFO - Bus: Built-In 21:15:56 INFO - VRAM (Dynamic, Max): 1536 MB 21:15:56 INFO - Vendor: Intel (0x8086) 21:15:56 INFO - Device ID: 0x0a2e 21:15:56 INFO - Revision ID: 0x0009 21:15:56 INFO - Displays: 21:15:56 INFO - Display: 21:15:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:15:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:15:56 INFO - Display Serial Number: 1600x1200 60 21:15:56 INFO - Main Display: Yes 21:15:56 INFO - Mirror: Off 21:15:56 INFO - Online: Yes 21:15:56 INFO - Rotation: Supported 21:15:56 INFO - Return code: 0 21:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:15:56 INFO - Python 2.7.3 21:15:56 INFO - Return code: 0 21:15:56 INFO - grabbing minidump binary from tooltool 21:15:56 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')]} 21:15:56 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 0x1064f5d30>, '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 0x10631bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:15:56 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 21:15:56 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 21:15:56 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 21:15:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:15:56 INFO - Return code: 0 21:15:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:15:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:15:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:15:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:15:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:15:56 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/GnTncIIyQRemOTl5FZav9w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0176', '--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 21:15:56 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/GnTncIIyQRemOTl5FZav9w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0176 --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 21:15:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WPzFWAVNv6/Render', 21:15:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:56 INFO - 'HOME': '/Users/cltbld', 21:15:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:56 INFO - 'LOGNAME': 'cltbld', 21:15:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:15:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:56 INFO - 'MOZ_NO_REMOTE': '1', 21:15:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:15:56 INFO - 'NO_EM_RESTART': '1', 21:15:56 INFO - 'PAGER': '/bin/cat', 21:15:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:56 INFO - 'PWD': '/builds/slave/test', 21:15:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:15:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:56 INFO - 'SHELL': '/bin/bash', 21:15:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LNnagFHf3L/Listeners', 21:15:56 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 21:15:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:56 INFO - 'USER': 'cltbld', 21:15:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:56 INFO - 'XPC_FLAGS': '0x0', 21:15:56 INFO - 'XPC_SERVICE_NAME': '0', 21:15:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:56 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/GnTncIIyQRemOTl5FZav9w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0176', '--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 21:15:56 INFO - mozversion application_buildid: 20160911193116 21:15:56 INFO - mozversion application_changeset: cfdb7af3af2e92e95f71ca2f1672bf5433beeb89 21:15:56 INFO - mozversion application_display_name: Nightly 21:15:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:15:56 INFO - mozversion application_name: Firefox 21:15:56 INFO - mozversion application_remotingname: firefox 21:15:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:15:56 INFO - mozversion application_vendor: Mozilla 21:15:56 INFO - mozversion application_version: 51.0a1 21:15:56 INFO - mozversion platform_buildid: 20160911193116 21:15:56 INFO - mozversion platform_changeset: cfdb7af3af2e92e95f71ca2f1672bf5433beeb89 21:15:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:15:56 INFO - mozversion platform_version: 51.0a1 21:15:56 INFO - using testdate: 1473653756 21:15:56 INFO - actual date: 1473653756 21:15:56 INFO - starting webserver on 'localhost:49275' 21:15:56 INFO - SUITE-START | Running 2 tests 21:15:56 INFO - TEST-START | dromaeo_css 21:15:56 INFO - operating with platform_type : mac_ 21:15:56 INFO - Initialising browser for dromaeo_css test... 21:15:56 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpjgBFSJ/profile http://localhost:49275/getInfo.html) 21:15:59 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 21:15:59 INFO - PROCESS | 1677 | colorDepth:24 21:15:59 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 21:15:59 INFO - PROCESS | 1677 | __metrics 21:15:59 INFO - PROCESS | 1677 | 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" 21:15:59 INFO - PROCESS | 1677 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:16:00 INFO - TEST-INFO | 1677: exit 0 21:16:00 INFO - Browser initialized. 21:16:00 INFO - Running cycle 1/1 for dromaeo_css test... 21:16:00 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpjgBFSJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:16:12 INFO - PROCESS | 1680 | RSS: Main: 232435712 21:16:12 INFO - PROCESS | 1680 | 21:17:03 INFO - PROCESS | 1680 | 1473653823218 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] 21:19:15 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 21:19:17 INFO - PROCESS | 1680 | RSS: Main: 384860160 21:19:17 INFO - PROCESS | 1680 | 21:22:20 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 21:22:21 INFO - PROCESS | 1680 | RSS: Main: 370061312 21:22:21 INFO - PROCESS | 1680 | 21:25:23 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 21:25:24 INFO - PROCESS | 1680 | RSS: Main: 348884992 21:25:24 INFO - PROCESS | 1680 | 21:28:26 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 21:28:27 INFO - PROCESS | 1680 | RSS: Main: 346185728 21:28:27 INFO - PROCESS | 1680 | 21:31:30 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 21:31:31 INFO - PROCESS | 1680 | RSS: Main: 331005952 21:31:31 INFO - PROCESS | 1680 | 21:34:34 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 21:34:34 INFO - PROCESS | 1680 | RSS: Main: 396484608 21:34:34 INFO - PROCESS | 1680 | 21:34:34 INFO - PROCESS | 1680 | __start_tp_report 21:34:34 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 21:34:34 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 21:34:34 INFO - PROCESS | 1680 | |i|pagename|runs| 21:34:34 INFO - PROCESS | 1680 | |0;dojo.html;3360.5967283925934;3361.7814842035273;3366.8148251846155;3383.0865666270092;3446.707029902458;5694.259746232984;5750.71246437678;5780.884382312352;5798.39116892726;5815.418458154182;5741.684207368593;5759.942400575993;5790.536757059435;5833.445822646841;5863.560232982532;5192.480751924796;5209.192575150839;5237.423883372826;5273.1826566882;5324.840254792343;5368.731563421833;5379.784808607651;5389.73051347433;5392.892142157174;5405.783768649249;5256.9474305256845;5335.626506144571;5339.973300133474;5387.78448862045;5399.757010934517;5249;5258.316418865561;5308.840734777963;5311.49540793624;5335.146376579729;5255.159174532095;5280.630355875091;5286.207068939651;5299.814506492293;5360.892782144335;5763.971180144114;5774.133879918004;5798.623089499211;5806.506446952014;5835.416458354173;6125.693326622233;6183.227096612924;6210.813675589739;6263;6326.430621244064;6301.936980630181;6349.52378571609;6369.808905732835;6378.681065946684;6385.744570217185;5793.971030144822;5844.357120716718;5863.882722345529;5879.470847623735;5894.675792831393;6269.279032911182;6287.1826662534495;6326.841828954313;6332.651704156316;6333.366663333722;6071.293738947235;6190.50475961922;6258.968705156445;6260.311365749764;6273.12176295319;6305.4009869062365;6310.211223597051;6311.652859092702;6318.368163183737;6335.778247761306;6123.25211838015;6156.907646385308;6222.502199824004;6284.560080794392;6299.937000629935;6217.595856269328;6218.689065546704;6228.22147231596;6248.250209974832;6265.937340626535;4923.458419573844;4953.504649535018;4960.429550601655;4983.053219888209;4991.176455884738;4416;4470.776461176928;4483.19302525542;4493.662975276868;4515.503294637587;5605.607607467438;5708.885822283531;5757.453041961091;5759.424057594207;5767.769289228384;6294.339094395114;6296.622202667854;6316.936830631635;6319.431251187415;6358.459530939922;4840.29815676732;5781.88436231273;5784.82645520635;5800.709964501758;5810.738516766755;5396.811111611075;5430.049741295257;5446.2375267462585;5482.122860342406;5486.1222204447095;6440.19497562814;6461.450776683847;6469.935300646934;6478.740850366121;6490.578112422678;6348.93651063502;6352.205974253218;6352.936470635419;6354.23749150105;6358.713857876314;6265;6291.622502649856;6294.0558916162945;6322.873542529215;6397.392247736458;6244.781432649836;6285.59143655661;6287.46556542699;6297.905531416941;6322.399372059647;6322.0200868865395;6324.209473815773;6328.114064030948;6336.651484168415;6361.14124593174;5835.533157347487;6044.002739547926;6123.877522449437;6134.202553667995;6185.257769067741;6107.633541987495;6121.84695382619;6190.845228869134;6197.349278325711;6197.752089916353;5014.5737612303365;6029;6032.521778863873;6034.939650603438;6043.909341359795;6043.818685439268;6055.909161362495;6111.327753947151;6116.42707509198;6170.475509581735;6087.0815627276625;6110.226820533157;6111.266648002268;6116.606841479004;6131.294901086432 21:34:34 INFO - PROCESS | 1680 | |1;ext.html;518.7795187045506;522.1906045629274;530.0485628297206;533.3945971322551;551.1017042221179;25976.74023259767;41377;42561.99999999996;42725.931851703644;42847.78576107123;44078.779606101925;44343.77828110855;44522.777386113106;44542.55457445425;44567;9807.754806129851;9988.101070903616;9989.700308990741;9995.850062249072;10047.547860346302;8777.868331974994;8947.77630559238;12045.879541204564;12196.63410097694;12202.694932626711;12029.398530073506;12086.818697719542;12089.637310880687;12095.637130886087;12112.394380280995;8799.296056315543;12180.634580962542;12269.509219631203;12279.631611051684;12300.753984920297;8613;11747.060235181165;11811.704707382298;12037.759244815055;12055.095867809949;36619.08452288687;42396.78801605972;42418;42508.149837003395;42536.14927701429;3086.6450358208867;3306.8511916963794;3532.5760908690863;3995.580464051262;4146.859613606252;27574.724252757416;30923.446278741765;32200.516992245135;32251.032469025966;32511;2589.7151313355516;3230.07942736319;3316.7014968652697;3358.1940334319834;3384.3569721752788;517754.41122794524;519379;520707;523726;524903;62640;62898.685506572176;62935.741285174954;62985;63070.36929630737;66507;66809;66885.6655716728;66918.66540667362;66995.66502167458;16637.417690381022;16879;16896.155192240585;16933.238004289837;16939.745903811454;11730.824037639442;12096.697582560506;12963.15739476931;13032.478700852049;13065.216087034618;18737.969411682217;19237.903810480857;19295;19648.508787280432;19787.703184452246;6744.752220839062;7092.751753688596;7437.070366204224;7704.691812327556;7713.614319284014;853.2363534636465;932.883389576303;983.2281658897731;995.66147509847;1020.1583693452783;30220.934516164503;30221;30263.848680756895;30590.388192236474;31121.68878311233;963.7735132243918;1015.1827778638267;1016.7813920007234;1026.4457193115784;1028.8919663435381;13344.532941347006;15625.765613515807;15633.218339083;15697.607559810867;16025.839741602667;193872.0306398459;194546.05453945562;194806;194853;194907.0254648746;58571.70714146402;58954.41045589489;58977.70511147417;59108;59198.70400647969;1229.4528934624007;1262.059765474727;1267;1383.633337165652;1406.5147524104168;30154.793808247425;30733.69266307308;31793.523097154022;32891.671083288864;33372.499412509314;56809.431905680416;57302.7134864323;57403.42596573981;57513.71243143925;57609.13586296125;535752;598636;609573;617068;617714;26460.8676956614;27031.324216893947;27079.864600676872;27421.862890685417;27558.311042224104;47707.76146119247;48052.03895922132;48129.75935120302;48880.51119488902;49281.75359123181;38956;39532.60467395404;40261.39607905942;40727.83045175617;41304;39171.608283916794;39608.00979975409;39663.80168099141;40873.795631021654;41097.38353924753;38863.222735544565;39470.60529394784;39512;39727;39784.403233950936;32835.83582082074;34084.488732668535;34922.47616285809;35103.12242193965;35379.82310088433;19859.900700496404;24577.262682119566;25065.122720704687;25493.3626659335;27591.724082758916 21:34:34 INFO - PROCESS | 1680 | |2;jquery.html;352.2092901436276;371.1611757428211;371.8085186129143;381.5631102387765;402.64164893245;14778.704425911475;15594.532164035083;15656.608584785386;20179.495512612193;20651.380458586227;19511.317103901365;20056.899715501437;20647.070881810316;20668.966551672394;20917.581648367024;5452.127659574468;5849.795257166;6115.052166914135;6118.969405152968;6130.540209484284;5816;6031.577789554733;6086.17836592061;6090.147379366892;6090.878182436349;5739.770409183628;5930;6055.273367195942;6055.909161362583;6061.242344706911;5976.760929562813;5993.250843644544;6027;6027.909581356261;6041.365656606037;5056.64603477753;5070.2141168119;5222.138347172712;5227.3988491323225;5230.450802665741;25109.62335564968;25154;25239.49521009588;25307.86114624828;25447.491050179076;2386.5465561543424;2392.928212153638;2807.1999480148265;3033.8179709217297;3161.6206055273283;12816.487340506368;14808.333624986793;14967.775483367759;16183.19084045793;16293.348266069343;1848.2422206895108;1917.9616407671908;1923.384516954575;1934.430974851397;1941.4466876940146;115532;120384.39807800905;126037.36981315126;126434;133946.33026834804;9158.496282704382;9573.664921727706;9676;9800.95099524512;9892.415781652002;12289.324087175113;12379.62861114168;12380.380980950917;12401.94583460398;12409.44157512896;7929.960350198212;8086.070101938235;8089.797755056171;8175.509469431853;8193.426460147852;8234.588270586446;8327.876391520123;8444.957775211085;8544.530050847263;8726.607302671267;3792.7345085843726;3860.4209368594934;3862.7682339059747;3925.803709814498;3928.1161738608585;1870.8587761465494;1904.6190761847686;1908.6659834528903;1908.885466871992;1940.1366391955444;803.501828866095;866.4627930683017;870.6996086350199;935.3584459273931;982.7985263021063;20544.28095016667;21282.530668559466;21357.359279221648;21375;21419.678704819442;737.5869513072589;888.7822483491586;913.3104506097853;930.1767935377239;972.6790159247431;10637.149028077734;11262.297048708415;11296.322220666787;11303.9826415623;11321.641403031688;587345;593540;594574;616338;617343.9132804397;83204.58397707973;111866;128779;135672;143540;907.6278725722422;956.3544607389983;972.3339512434005;972.3728195314125;973.5473005052685;18749.53126171802;19109;19240.326588569333;19290.324838631142;19291.324803632368;54594.72702636461;55163.72418138044;55883.72058139683;57178;57274.14088788588;75653.48693026218;77708.01176864353;79510.80733789114;80808;81544.77682834644;7498.38074834325;7707.537547747153;7918.049834019724;8083.3533317333295;8092.352611791161;9034.45793252407;11194.552217911192;11353.829692554453;11873.52505899789;12116.697082573006;10853.837192442277;10860.185486088418;10967.067799237155;11028.28316159447;11031.779364412827;8184.8772268417215;8458.619362128842;10848.945755271174;10852.945735271272;10988.505517251582;10939.991502336603;11258.437078146224;11258.66224013281;11267.661970140582;11276.097912166842;7868.685252589832;7889.408294377829;8002;8143.83712325762;8173.182681732017;10035.448050357301;10648.361098334124;10957.726056848642;11076.224664273423;11084.667459976214 21:34:34 INFO - PROCESS | 1680 | |3;mootools.html;1489.8510148985104;1524.1007805394818;1703.33569907736;1835.6145209506003;1882.303547687355;8430.873536896945;8976.147266009719;8981.281497480202;8987.325950553719;8992.280617550588;7881.408894332933;8079.272865442109;8080.91919080809;8466.238038576526;8733.563321833915;2392.2583998960336;2427.817913656474;2430.6961629796274;2434.1480481831304;2444.8655323957173;2381.297517232412;2409.9879500602474;2418.0811291709124;2419.5402873454077;2429.647701083342;2403.267003563912;2410.18053861687;2413.81896357773;2420.4674971506242;2422.527607116613;2163.632182528966;2169.642009068502;2169.6873391598015;2171.4245724882917;2176.3144609447972;2318.8724620145886;2406.602910519762;2413.408714864852;2414.987925060381;2416.9758302417104;8789.165029322205;8906.688265910661;8913.420627659181;8917.33120015995;8931.821363572757;5215.165573508259;5374.462553744634;5376.086065368897;5380.273663055476;5381.946180538183;2975.598294230273;3425.9486107708403;3446.1212390840424;3582.176099497104;3677.5770786359644;1098.0611577101542;1101.8512500812367;1104.9116070714324;1130.22014809781;1131.8472006279212;11657.883421165765;11807.350595717233;11844.526218951232;11853.940730296294;11856.932876041112;4595.563421474954;4638.536146385334;4803.375561177025;4811.518848115161;4821.421429428491;8953.194212520904;10010.699679009642;10011.49942502872;10012.098911098035;10016.64941727036;5060.51925067118;5364.7317634118135;5366.9873797326;5368.516833485005;5370.248165256867;4709.434867815816;4862.07620552094;4916.360873086476;4930.8767280818265;4942.827001054946;3764.698824094066;3771.698264138862;3837.5394952605866;3853.6917046636763;3855.4409610606303;1173.5540494612164;1175.629676651852;1182.2433642468827;1182.9940850295693;1185.6324539392815;843.5739951324542;859.7592674051151;903.6475774447971;912.6896855069308;938.4275591888942;5710.172025056427;5753.798617048383;5986.311574169026;6062.090686397076;6164.753409863555;898.9146031127033;925.5418567808978;951.5147274889856;993.1310103659298;997.680742162501;3905.511811023622;3936.8622098226424;3943.2310699413338;4062.207869465485;4091.754494730326;10507.422091784872;10963.958423949713;10972.725681857857;10982.505787239434;10986.230963832455;10926.453677316102;10940.781184376427;10951.233413661126;10952.123830093573;10954.3427394355;8180.672773089129;8208.425410221347;8320.084790673021;8323.542205178774;8369.665213391396;4920.901581968412;5745.3105627324985;5903.498202652822;5932.614380065282;5973.163757073926;10120.79758404813;10182.083612474913;10224;10228.64199753005;10288;9867.16129129032;10388.792224155626;10481;10481.056704896597;10494.055535001886;6585.670716464253;6784.6946887389195;6928.896066559107;7036.612986285803;7169.4981351304905;8537.18896704812;8544;8610.397272190887;8626.051134375088;8649.783755406164;7336.669849856876;7410.5183163094225;7440.218777028334;7536.849263014599;7618.771436856903;7366.484346095722;7390.29792169743;7430.591317477374;7444.776656700091;7511.51175173612;6903.344182302673;6932.8560787469505;7028.894566581607;7032.402245809163;7047.154341479055;4217.557156498524;4924.359833221658;5023.146065168857;5071.695698257969;5147.790269286789;4974.626902982219;5007.198848184273;5152.124138896322;5184.870378240575;5276.788928442819 21:34:34 INFO - PROCESS | 1680 | |4;prototype.html;236.637943945763;297.4007375139095;307.2411144473151;309.0820263816464;310.84302427274224;4466.553344665532;5375.408705042442;5383.420025682921;5430.511253987141;5462.399136095037;4928.802847886089;5070.340855688764;5085.677723791813;5157.375426740574;5357.678539287645;3689.8524059037604;4019.3970904364432;4049.574794646564;4081.7755023473696;4096.730013695749;3515.084279067914;3747.5128233329765;4051.1897620476025;4080.81636326366;4116.259073366793;3870.845166193349;4022.9798851005703;4040.939385909199;4076.429299898017;4089.325261331877;3347.815870127142;4049.967258349102;4058.857939972116;4059.776712280823;4094.9934532079214;3525.6121826599056;3525.982370088133;3530.646935306449;3550.6449355064547;3557.3063252665743;4192.958070419288;4429.202743506167;4859.222524396079;5092.414372347191;5192.350956130484;4000.4799376081214;4540.524329592896;4570.7257564546235;4578.45058592971;4616.584507394317;4707.152712511746;4838.975805120952;5274.393444753826;5555.500004999529;5592.5805564582415;3376.480583737328;3615.385384484644;3792.355299599075;3817.7592282508017;3847.461355410245;5473.644213126134;5812.476877080999;5837.781642975685;5920.111983202511;5941.821745347646;3767.698584113264;3780.9980355205894;3793.5205269944745;3793.5827059023486;3804.391297392404;3879.515060617423;3880.320943834874;3885;3900.64894159527;3918.45141680165;3910.081130934228;4083.652889504366;4206.284931561642;4339.631131353807;4541;4869.586085182728;5437;5608;5629.408912064257;5640.561656777495;1048.2295512798087;1287.9503204888174;1316.835395575553;1321.8479874814327;1323.3912400295972;765.5521519910803;825.2449009156675;868.5179725252545;896.9192772650492;903.6927444668713;5145.408278048072;5155.61332900034;5177.611679124081;5221.843344699665;5278.023565640369;4623.583877451046;4832.710037397767;5697.515711164515;5762.423757624204;5789.913151302734;5050.925788184488;5118.797082685566;5149.330587023663;5151.562117220078;5184.766685499161;2960.41617734511;2972.212363723615;2977.764227845463;2983.209449495885;2998.7151220634005;4496.752678602708;4915.205949828287;5552.333719953551;5883.529317654663;5963.373845746134;5699.629524080921;5712.714639206145;5925.792597259161;5950.137230101611;5953.553483488756;5987.15610085206;6011.458968692838;6023.096535519707;6057.182845146526;6073.908891366721;4596.448426188878;5436.40199578054;5722.513586345207;5760.740766665594;5800.56495762811;4502.4371953505815;5239.825472428899;5398.568114550905;5700.3444603871085;5705.857353566194;5664.37691853904;6006.489448396936;6024.277086749618;6027.186329845415;6037;3891.747036442622;3960.7623542587535;3988.766290877118;3996.2407142642805;3999.5600483947323;5710.600257981901;5724.311328158286;5742.19609254713;5742.19609254713;5743.874766336482;5082.745862706924;5204.661696989683;5264.447233040476;5623.493885550321;5642.2665053544415;4443.577860103285;4938.604911606991;5556.972215138899;5621.7189140542;5650.689212093374;4918.680285781413;5101.260317253903;5233.293505376878;5280.498352656491;5499.285092938053;5135.6918584885025;5166.4242406065005;5459.945400546103;5522.66863988162;5592.245046918614;5466.453354664502;5467.945320546903;5488.012157811632;5502.394736578893;5528.75120619565 21:34:34 INFO - PROCESS | 1680 | |5;yui.html;721.3976329764646;729.5294535024909;739.6708464733192;779.2207792207794;803.5178892664405;15496.22518874056;16420.34318627255;16428.8927768058;16429.753553696704;16503.587410314747;14685.92657036716;14820.481283155092;14828.925855370708;14855.702885942275;14883.627909302273;688.3288793426419;708.1183926012122;833.295864994079;838.8070743728946;851.5061264466594;866.1295398124876;872.9039805621377;873.388627960427;873.9038705742363;874.152072489684;914.401067300919;923.6628630549834;929.8744669469636;932.1470854168427;935.9906400936005;922.5940586142076;925.2597921662643;925.421611492817;925.4771054354268;926.2219735422277;532.0874699889707;556.2351766321308;657.5725778244132;691.5055735149342;694.5728377048079;15018.549443516711;15212.261792877278;15213.771793423108;15222.314995825214;15271.465498707492;13843.30783460833;14105.78841317381;14216;14243.78634320486;14429.494967676186;12248.571300004458;12617.369131543477;12639.684007899876;12671.809922851164;13023.348832558335;4524.660650451229;4649.372334734801;4657.417822772153;4664.463586687507;4690;117353.99999999914;120262;120353.39823300915;120426;120617.39691301488;10723.731906702238;10929.781404371868;11146.888531114586;11432.428378581038;11469.88530114705;18032.459026229233;21998.89000555019;22009.009594568284;22009.559808804053;22037.449063773212;7828.334591559667;7976.521408715495;8029.478083924526;8030.638621262057;8070.515769053875;4188.497380314321;4382.364557139261;4426.822927082881;4467.6649251305635;4514.932276015862;3407.914802129917;3525.7531972761662;3527.3827080260853;3529.4705794131087;3539.433690609542;546.1861825879411;637.2384999925138;653.8692261547709;654.3979538824293;654.8886689262837;600.8407771940439;608.6044071353656;615.4614712126889;638.1894993358502;641.9215717594486;8905.287576993825;8983.955080224558;9007.453825199333;9024.187823095821;9061.864072038925;506.9923951140736;550.8182299841043;625.562106525434;625.9515311852629;650.9186351706037;3408.727301815849;4323.654107671442;4367.432233809584;4447.599716025573;4477.507474177838;92323.53838230901;123417.68038118802;133052.66947330596;134074.98887516695;139477.3026134883;79401.42693578803;115997.4200128994;118136;120933;126511;72363.6381818098;103667;109260.453697731;109524.90475095306;110175.44912275548;9365.297602679962;9515.619375224913;9517.809643807224;9553.04469553039;9556.331056825955;61244;61867;63428;63734.36265637284;65206.347936520026;87293;90497.54751226201;96946;97927;99625.50187249017;13062.673433164247;13115.540956066492;13177.47290108385;13292.800607991081;13598.320083995563;14850.40598376053;14877.404903803726;14877.702445950805;15260.160691161649;15406.845931540542;11133.387663678252;13667.453301867814;13915.443382265;14325.928370358082;14395.352209150404;13483.393247303698;13693.657658558615;13699.383527741475;13825;13834.65413364674;13453.46186152543;13463.730725385632;13538.59384218475;14100.435982560582;14319.713605728035;11086.42357487731;11197.272177308449;11453.141014423785;11705.590304339306;11750.764984700087;10734.302270352402;10865.891341086488;11338.60314888975;11408.771824563628;11594.072474202212 21:34:34 INFO - PROCESS | 1680 | __end_tp_report 21:34:34 INFO - PROCESS | 1680 | __start_cc_report 21:34:34 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1478 21:34:34 INFO - PROCESS | 1680 | __end_cc_report 21:34:34 INFO - PROCESS | 1680 | __startTimestamp1473654874580__endTimestamp 21:34:34 INFO - PROCESS | 1680 | 21:34:34 INFO - PROCESS | 1680 | ------- Summary: start ------- 21:34:34 INFO - PROCESS | 1680 | Number of tests: 6 21:34:34 INFO - PROCESS | 1680 | 21:34:34 INFO - PROCESS | 1680 | [#0] dojo.html Cycles:165 Average:5805.82 Median:6044.00 stddev:648.11 (10.7%) stddev-sans-first:621.06 21:34:34 INFO - PROCESS | 1680 | Values: 3360.6 3361.8 3366.8 3383.1 3446.7 5694.3 5750.7 5780.9 5798.4 5815.4 5741.7 5759.9 5790.5 5833.4 5863.6 5192.5 5209.2 5237.4 5273.2 5324.8 5368.7 5379.8 5389.7 5392.9 5405.8 5256.9 5335.6 5340.0 5387.8 5399.8 5249.0 5258.3 5308.8 5311.5 5335.1 5255.2 5280.6 5286.2 5299.8 5360.9 5764.0 5774.1 5798.6 5806.5 5835.4 6125.7 6183.2 6210.8 6263.0 6326.4 6301.9 6349.5 6369.8 6378.7 6385.7 5794.0 5844.4 5863.9 5879.5 5894.7 6269.3 6287.2 6326.8 6332.7 6333.4 6071.3 6190.5 6259.0 6260.3 6273.1 6305.4 6310.2 6311.7 6318.4 6335.8 6123.3 6156.9 6222.5 6284.6 6299.9 6217.6 6218.7 6228.2 6248.3 6265.9 4923.5 4953.5 4960.4 4983.1 4991.2 4416.0 4470.8 4483.2 4493.7 4515.5 5605.6 5708.9 5757.5 5759.4 5767.8 6294.3 6296.6 6316.9 6319.4 6358.5 4840.3 5781.9 5784.8 5800.7 5810.7 5396.8 5430.0 5446.2 5482.1 5486.1 6440.2 6461.5 6469.9 6478.7 6490.6 6348.9 6352.2 6352.9 6354.2 6358.7 6265.0 6291.6 6294.1 6322.9 6397.4 6244.8 6285.6 6287.5 6297.9 6322.4 6322.0 6324.2 6328.1 6336.7 6361.1 5835.5 6044.0 6123.9 6134.2 6185.3 6107.6 6121.8 6190.8 6197.3 6197.8 5014.6 6029.0 6032.5 6034.9 6043.9 6043.8 6055.9 6111.3 6116.4 6170.5 6087.1 6110.2 6111.3 6116.6 6131.3 21:34:34 INFO - PROCESS | 1680 | 21:34:34 INFO - PROCESS | 1680 | [#1] ext.html Cycles:180 Average:60214.48 Median:35999.45 stddev:126151.20 (350.4%) stddev-sans-first:126425.46 21:34:34 INFO - PROCESS | 1680 | Values: 518.8 522.2 530.0 533.4 551.1 25976.7 41377.0 42562.0 42725.9 42847.8 44078.8 44343.8 44522.8 44542.6 44567.0 9807.8 9988.1 9989.7 9995.9 10047.5 8777.9 8947.8 12045.9 12196.6 12202.7 12029.4 12086.8 12089.6 12095.6 12112.4 8799.3 12180.6 12269.5 12279.6 12300.8 8613.0 11747.1 11811.7 12037.8 12055.1 36619.1 42396.8 42418.0 42508.1 42536.1 3086.6 3306.9 3532.6 3995.6 4146.9 27574.7 30923.4 32200.5 32251.0 32511.0 2589.7 3230.1 3316.7 3358.2 3384.4 517754.4 519379.0 520707.0 523726.0 524903.0 62640.0 62898.7 62935.7 62985.0 63070.4 66507.0 66809.0 66885.7 66918.7 66995.7 16637.4 16879.0 16896.2 16933.2 16939.7 11730.8 12096.7 12963.2 13032.5 13065.2 18738.0 19237.9 19295.0 19648.5 19787.7 6744.8 7092.8 7437.1 7704.7 7713.6 853.2 932.9 983.2 995.7 1020.2 30220.9 30221.0 30263.8 30590.4 31121.7 963.8 1015.2 1016.8 1026.4 1028.9 13344.5 15625.8 15633.2 15697.6 16025.8 193872.0 194546.1 194806.0 194853.0 194907.0 58571.7 58954.4 58977.7 59108.0 59198.7 1229.5 1262.1 1267.0 1383.6 1406.5 30154.8 30733.7 31793.5 32891.7 33372.5 56809.4 57302.7 57403.4 57513.7 57609.1 535752.0 598636.0 609573.0 617068.0 617714.0 26460.9 27031.3 27079.9 27421.9 27558.3 47707.8 48052.0 48129.8 48880.5 49281.8 38956.0 39532.6 40261.4 40727.8 41304.0 39171.6 39608.0 39663.8 40873.8 41097.4 38863.2 39470.6 39512.0 39727.0 39784.4 32835.8 34084.5 34922.5 35103.1 35379.8 19859.9 24577.3 25065.1 25493.4 27591.7 21:34:34 INFO - PROCESS | 1680 | 21:34:34 INFO - PROCESS | 1680 | [#2] jquery.html Cycles:180 Average:35067.67 Median:2120.99 stddev:100534.33 (4740.0%) stddev-sans-first:100782.57 21:34:34 INFO - PROCESS | 1680 | Values: 352.2 371.2 371.8 381.6 402.6 14778.7 15594.5 15656.6 20179.5 20651.4 19511.3 20056.9 20647.1 20669.0 20917.6 5452.1 5849.8 6115.1 6119.0 6130.5 5816.0 6031.6 6086.2 6090.1 6090.9 5739.8 5930.0 6055.3 6055.9 6061.2 5976.8 5993.3 6027.0 6027.9 6041.4 5056.6 5070.2 5222.1 5227.4 5230.5 25109.6 25154.0 25239.5 25307.9 25447.5 2386.5 2392.9 2807.2 3033.8 3161.6 12816.5 14808.3 14967.8 16183.2 16293.3 1848.2 1918.0 1923.4 1934.4 1941.4 115532.0 120384.4 126037.4 126434.0 133946.3 9158.5 9573.7 9676.0 9801.0 9892.4 12289.3 12379.6 12380.4 12401.9 12409.4 7930.0 8086.1 8089.8 8175.5 8193.4 8234.6 8327.9 8445.0 8544.5 8726.6 3792.7 3860.4 3862.8 3925.8 3928.1 1870.9 1904.6 1908.7 1908.9 1940.1 803.5 866.5 870.7 935.4 982.8 20544.3 21282.5 21357.4 21375.0 21419.7 737.6 888.8 913.3 930.2 972.7 10637.1 11262.3 11296.3 11304.0 11321.6 587345.0 593540.0 594574.0 616338.0 617343.9 83204.6 111866.0 128779.0 135672.0 143540.0 907.6 956.4 972.3 972.4 973.5 18749.5 19109.0 19240.3 19290.3 19291.3 54594.7 55163.7 55883.7 57178.0 57274.1 75653.5 77708.0 79510.8 80808.0 81544.8 7498.4 7707.5 7918.0 8083.4 8092.4 9034.5 11194.6 11353.8 11873.5 12116.7 10853.8 10860.2 10967.1 11028.3 11031.8 8184.9 8458.6 10848.9 10852.9 10988.5 10940.0 11258.4 11258.7 11267.7 11276.1 7868.7 7889.4 8002.0 8143.8 8173.2 10035.4 10648.4 10957.7 11076.2 11084.7 21:34:34 INFO - PROCESS | 1680 | 21:34:34 INFO - PROCESS | 1680 | [#3] mootools.html Cycles:180 Average:5733.63 Median:4889.22 stddev:3239.97 (66.3%) stddev-sans-first:3233.36 21:34:34 INFO - PROCESS | 1680 | Values: 1489.9 1524.1 1703.3 1835.6 1882.3 8430.9 8976.1 8981.3 8987.3 8992.3 7881.4 8079.3 8080.9 8466.2 8733.6 2392.3 2427.8 2430.7 2434.1 2444.9 2381.3 2410.0 2418.1 2419.5 2429.6 2403.3 2410.2 2413.8 2420.5 2422.5 2163.6 2169.6 2169.7 2171.4 2176.3 2318.9 2406.6 2413.4 2415.0 2417.0 8789.2 8906.7 8913.4 8917.3 8931.8 5215.2 5374.5 5376.1 5380.3 5381.9 2975.6 3425.9 3446.1 3582.2 3677.6 1098.1 1101.9 1104.9 1130.2 1131.8 11657.9 11807.4 11844.5 11853.9 11856.9 4595.6 4638.5 4803.4 4811.5 4821.4 8953.2 10010.7 10011.5 10012.1 10016.6 5060.5 5364.7 5367.0 5368.5 5370.2 4709.4 4862.1 4916.4 4930.9 4942.8 3764.7 3771.7 3837.5 3853.7 3855.4 1173.6 1175.6 1182.2 1183.0 1185.6 843.6 859.8 903.6 912.7 938.4 5710.2 5753.8 5986.3 6062.1 6164.8 898.9 925.5 951.5 993.1 997.7 3905.5 3936.9 3943.2 4062.2 4091.8 10507.4 10964.0 10972.7 10982.5 10986.2 10926.5 10940.8 10951.2 10952.1 10954.3 8180.7 8208.4 8320.1 8323.5 8369.7 4920.9 5745.3 5903.5 5932.6 5973.2 10120.8 10182.1 10224.0 10228.6 10288.0 9867.2 10388.8 10481.0 10481.1 10494.1 6585.7 6784.7 6928.9 7036.6 7169.5 8537.2 8544.0 8610.4 8626.1 8649.8 7336.7 7410.5 7440.2 7536.8 7618.8 7366.5 7390.3 7430.6 7444.8 7511.5 6903.3 6932.9 7028.9 7032.4 7047.2 4217.6 4924.4 5023.1 5071.7 5147.8 4974.6 5007.2 5152.1 5184.9 5276.8 21:34:34 INFO - PROCESS | 1680 | 21:34:34 INFO - PROCESS | 1680 | [#4] prototype.html Cycles:180 Average:4509.38 Median:5089.05 stddev:1391.70 (27.3%) stddev-sans-first:1358.15 21:34:34 INFO - PROCESS | 1680 | Values: 236.6 297.4 307.2 309.1 310.8 4466.6 5375.4 5383.4 5430.5 5462.4 4928.8 5070.3 5085.7 5157.4 5357.7 3689.9 4019.4 4049.6 4081.8 4096.7 3515.1 3747.5 4051.2 4080.8 4116.3 3870.8 4023.0 4040.9 4076.4 4089.3 3347.8 4050.0 4058.9 4059.8 4095.0 3525.6 3526.0 3530.6 3550.6 3557.3 4193.0 4429.2 4859.2 5092.4 5192.4 4000.5 4540.5 4570.7 4578.5 4616.6 4707.2 4839.0 5274.4 5555.5 5592.6 3376.5 3615.4 3792.4 3817.8 3847.5 5473.6 5812.5 5837.8 5920.1 5941.8 3767.7 3781.0 3793.5 3793.6 3804.4 3879.5 3880.3 3885.0 3900.6 3918.5 3910.1 4083.7 4206.3 4339.6 4541.0 4869.6 5437.0 5608.0 5629.4 5640.6 1048.2 1288.0 1316.8 1321.8 1323.4 765.6 825.2 868.5 896.9 903.7 5145.4 5155.6 5177.6 5221.8 5278.0 4623.6 4832.7 5697.5 5762.4 5789.9 5050.9 5118.8 5149.3 5151.6 5184.8 2960.4 2972.2 2977.8 2983.2 2998.7 4496.8 4915.2 5552.3 5883.5 5963.4 5699.6 5712.7 5925.8 5950.1 5953.6 5987.2 6011.5 6023.1 6057.2 6073.9 4596.4 5436.4 5722.5 5760.7 5800.6 4502.4 5239.8 5398.6 5700.3 5705.9 5664.4 6006.5 6024.3 6027.2 6037.0 3891.7 3960.8 3988.8 3996.2 3999.6 5710.6 5724.3 5742.2 5742.2 5743.9 5082.7 5204.7 5264.4 5623.5 5642.3 4443.6 4938.6 5557.0 5621.7 5650.7 4918.7 5101.3 5233.3 5280.5 5499.3 5135.7 5166.4 5459.9 5522.7 5592.2 5466.5 5467.9 5488.0 5502.4 5528.8 21:34:34 INFO - PROCESS | 1680 | 21:34:34 INFO - PROCESS | 1680 | [#5] yui.html Cycles:180 Average:23952.94 Median:3528.43 stddev:36946.31 (1047.1%) stddev-sans-first:37008.78 21:34:34 INFO - PROCESS | 1680 | Values: 721.4 729.5 739.7 779.2 803.5 15496.2 16420.3 16428.9 16429.8 16503.6 14685.9 14820.5 14828.9 14855.7 14883.6 688.3 708.1 833.3 838.8 851.5 866.1 872.9 873.4 873.9 874.2 914.4 923.7 929.9 932.1 936.0 922.6 925.3 925.4 925.5 926.2 532.1 556.2 657.6 691.5 694.6 15018.5 15212.3 15213.8 15222.3 15271.5 13843.3 14105.8 14216.0 14243.8 14429.5 12248.6 12617.4 12639.7 12671.8 13023.3 4524.7 4649.4 4657.4 4664.5 4690.0 117354.0 120262.0 120353.4 120426.0 120617.4 10723.7 10929.8 11146.9 11432.4 11469.9 18032.5 21998.9 22009.0 22009.6 22037.4 7828.3 7976.5 8029.5 8030.6 8070.5 4188.5 4382.4 4426.8 4467.7 4514.9 3407.9 3525.8 3527.4 3529.5 3539.4 546.2 637.2 653.9 654.4 654.9 600.8 608.6 615.5 638.2 641.9 8905.3 8984.0 9007.5 9024.2 9061.9 507.0 550.8 625.6 626.0 650.9 3408.7 4323.7 4367.4 4447.6 4477.5 92323.5 123417.7 133052.7 134075.0 139477.3 79401.4 115997.4 118136.0 120933.0 126511.0 72363.6 103667.0 109260.5 109524.9 110175.4 9365.3 9515.6 9517.8 9553.0 9556.3 61244.0 61867.0 63428.0 63734.4 65206.3 87293.0 90497.5 96946.0 97927.0 99625.5 13062.7 13115.5 13177.5 13292.8 13598.3 14850.4 14877.4 14877.7 15260.2 15406.8 11133.4 13667.5 13915.4 14325.9 14395.4 13483.4 13693.7 13699.4 13825.0 13834.7 13453.5 13463.7 13538.6 14100.4 14319.7 11086.4 11197.3 11453.1 11705.6 11750.8 10734.3 10865.9 11338.6 11408.8 11594.1 21:34:34 INFO - PROCESS | 1680 | -------- Summary: end -------- 21:34:34 INFO - PROCESS | 1680 | 21:34:35 INFO - TEST-INFO | 1680: exit 0 21:34:35 INFO - TEST-OK | dromaeo_css | took 1118418ms 21:34:35 INFO - TEST-START | kraken 21:34:35 INFO - operating with platform_type : mac_ 21:34:35 INFO - Initialising browser for kraken test... 21:34:35 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpuaL2Ht/profile http://localhost:49275/getInfo.html) 21:34:37 INFO - PROCESS | 1686 | __metrics Screen width/height:1600/1200 21:34:37 INFO - PROCESS | 1686 | colorDepth:24 21:34:37 INFO - PROCESS | 1686 | Browser inner width/height: 1024/689 21:34:37 INFO - PROCESS | 1686 | __metrics 21:34:37 INFO - PROCESS | 1686 | 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" 21:34:37 INFO - PROCESS | 1686 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:34:38 INFO - TEST-INFO | 1686: exit 0 21:34:38 INFO - Browser initialized. 21:34:38 INFO - Running cycle 1/1 for kraken test... 21:34:38 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpuaL2Ht/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:34:50 INFO - PROCESS | 1687 | RSS: Main: 232468480 21:34:50 INFO - PROCESS | 1687 | 21:34:52 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 21:34:53 INFO - PROCESS | 1687 | RSS: Main: 292016128 21:34:53 INFO - PROCESS | 1687 | 21:34:56 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 21:34:57 INFO - PROCESS | 1687 | RSS: Main: 288116736 21:34:57 INFO - PROCESS | 1687 | 21:35:00 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 21:35:01 INFO - PROCESS | 1687 | RSS: Main: 377606144 21:35:01 INFO - PROCESS | 1687 | 21:35:03 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 21:35:04 INFO - PROCESS | 1687 | RSS: Main: 277463040 21:35:04 INFO - PROCESS | 1687 | 21:35:06 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:35:06 INFO - PROCESS | 1687 | RSS: Main: 283275264 21:35:06 INFO - PROCESS | 1687 | 21:35:09 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 21:35:10 INFO - PROCESS | 1687 | RSS: Main: 321585152 21:35:10 INFO - PROCESS | 1687 | 21:35:12 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 21:35:13 INFO - PROCESS | 1687 | RSS: Main: 322179072 21:35:13 INFO - PROCESS | 1687 | 21:35:16 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 21:35:16 INFO - PROCESS | 1687 | RSS: Main: 321908736 21:35:16 INFO - PROCESS | 1687 | 21:35:18 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:35:19 INFO - PROCESS | 1687 | RSS: Main: 298590208 21:35:19 INFO - PROCESS | 1687 | 21:35:20 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:35:21 INFO - PROCESS | 1687 | RSS: Main: 302972928 21:35:21 INFO - PROCESS | 1687 | 21:35:23 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:35:24 INFO - PROCESS | 1687 | RSS: Main: 309460992 21:35:24 INFO - PROCESS | 1687 | 21:35:27 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:35:28 INFO - PROCESS | 1687 | RSS: Main: 311828480 21:35:28 INFO - PROCESS | 1687 | 21:35:30 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:35:31 INFO - PROCESS | 1687 | RSS: Main: 313368576 21:35:31 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 21:35:33 INFO - PROCESS | 1687 | RSS: Main: 358096896 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | __start_tp_report 21:35:33 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 21:35:33 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 21:35:33 INFO - PROCESS | 1687 | |i|pagename|runs| 21:35:33 INFO - PROCESS | 1687 | |0;ai-astar;113;114;116;113;114;113;111;112;113;123 21:35:33 INFO - PROCESS | 1687 | |1;audio-beat-detection;148;114;129;163;110;129;127;108;175;107 21:35:33 INFO - PROCESS | 1687 | |2;audio-dft;186;185;186;186;184;184;182;259;207;181 21:35:33 INFO - PROCESS | 1687 | |3;audio-fft;74;75;78;150;58;56;57;64;136;81 21:35:33 INFO - PROCESS | 1687 | |4;audio-oscillator;82;83;135;71;72;94;116;69;70;117 21:35:33 INFO - PROCESS | 1687 | |5;imaging-gaussian-blur;86;84;86;84;86;83;87;84;87;83 21:35:33 INFO - PROCESS | 1687 | |6;imaging-darkroom;95;95;96;95;95;95;95;96;95;95 21:35:33 INFO - PROCESS | 1687 | |7;imaging-desaturate;86;84;84;84;84;85;85;86;84;84 21:35:33 INFO - PROCESS | 1687 | |8;json-parse-financial;53;51;52;52;53;53;55;53;53;52 21:35:33 INFO - PROCESS | 1687 | |9;json-stringify-tinderbox;63;64;69;70;70;73;69;67;70;69 21:35:33 INFO - PROCESS | 1687 | |10;stanford-crypto-aes;89;85;89;85;87;84;88;90;89;113 21:35:33 INFO - PROCESS | 1687 | |11;stanford-crypto-ccm;135;139;138;138;137;133;143;153;186;150 21:35:33 INFO - PROCESS | 1687 | |12;stanford-crypto-pbkdf2;166;170;168;168;166;167;165;168;170;169 21:35:33 INFO - PROCESS | 1687 | |13;stanford-crypto-sha256-iterative;69;67;67;67;81;87;88;66;68;67 21:35:33 INFO - PROCESS | 1687 | __end_tp_report 21:35:33 INFO - PROCESS | 1687 | __start_cc_report 21:35:33 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,2049 21:35:33 INFO - PROCESS | 1687 | __end_cc_report 21:35:33 INFO - PROCESS | 1687 | __startTimestamp1473654933560__endTimestamp 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | ------- Summary: start ------- 21:35:33 INFO - PROCESS | 1687 | Number of tests: 14 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | [#0] ai-astar Cycles:10 Average:114.20 Median:113.50 stddev:3.36 (3.0%) stddev-sans-first:3.54 21:35:33 INFO - PROCESS | 1687 | Values: 113.0 114.0 116.0 113.0 114.0 113.0 111.0 112.0 113.0 123.0 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:129.00 stddev:23.82 (18.5%) stddev-sans-first:24.46 21:35:33 INFO - PROCESS | 1687 | Values: 148.0 114.0 129.0 163.0 110.0 129.0 127.0 108.0 175.0 107.0 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | [#2] audio-dft Cycles:10 Average:194.00 Median:186.00 stddev:23.99 (12.9%) stddev-sans-first:25.27 21:35:33 INFO - PROCESS | 1687 | Values: 186.0 185.0 186.0 186.0 184.0 184.0 182.0 259.0 207.0 181.0 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | [#3] audio-fft Cycles:10 Average:82.90 Median:69.00 stddev:33.10 (48.0%) stddev-sans-first:34.96 21:35:33 INFO - PROCESS | 1687 | Values: 74.0 75.0 78.0 150.0 58.0 56.0 57.0 64.0 136.0 81.0 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:71.50 stddev:23.75 (33.2%) stddev-sans-first:24.97 21:35:33 INFO - PROCESS | 1687 | Values: 82.0 83.0 135.0 71.0 72.0 94.0 116.0 69.0 70.0 117.0 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:85.00 Median:86.00 stddev:1.56 (1.8%) stddev-sans-first:1.62 21:35:33 INFO - PROCESS | 1687 | Values: 86.0 84.0 86.0 84.0 86.0 83.0 87.0 84.0 87.0 83.0 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:35:33 INFO - PROCESS | 1687 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:84.50 stddev:0.84 (1.0%) stddev-sans-first:0.73 21:35:33 INFO - PROCESS | 1687 | Values: 86.0 84.0 84.0 84.0 84.0 85.0 85.0 86.0 84.0 84.0 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:1.06 (2.0%) stddev-sans-first:1.12 21:35:33 INFO - PROCESS | 1687 | Values: 53.0 51.0 52.0 52.0 53.0 53.0 55.0 53.0 53.0 52.0 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.50 stddev:2.99 (4.3%) stddev-sans-first:2.45 21:35:33 INFO - PROCESS | 1687 | Values: 63.0 64.0 69.0 70.0 70.0 73.0 69.0 67.0 70.0 69.0 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:88.50 stddev:8.37 (9.5%) stddev-sans-first:8.87 21:35:33 INFO - PROCESS | 1687 | Values: 89.0 85.0 89.0 85.0 87.0 84.0 88.0 90.0 89.0 113.0 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:141.00 stddev:15.69 (11.1%) stddev-sans-first:16.20 21:35:33 INFO - PROCESS | 1687 | Values: 135.0 139.0 138.0 138.0 137.0 133.0 143.0 153.0 186.0 150.0 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:168.00 stddev:1.70 (1.0%) stddev-sans-first:1.69 21:35:33 INFO - PROCESS | 1687 | Values: 166.0 170.0 168.0 168.0 166.0 167.0 165.0 168.0 170.0 169.0 21:35:33 INFO - PROCESS | 1687 | 21:35:33 INFO - PROCESS | 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:68.50 stddev:8.93 (13.0%) stddev-sans-first:9.37 21:35:33 INFO - PROCESS | 1687 | Values: 69.0 67.0 67.0 67.0 81.0 87.0 88.0 66.0 68.0 67.0 21:35:33 INFO - PROCESS | 1687 | -------- Summary: end -------- 21:35:33 INFO - PROCESS | 1687 | 21:35:34 INFO - TEST-INFO | 1687: exit 0 21:35:34 INFO - TEST-OK | kraken | took 59203ms 21:35:34 INFO - SUITE-END | took 1177s 21:35:34 INFO - Completed test suite (00:19:37) 21:35:34 INFO - javascript benchmark 21:35:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.5967283925934, 3361.7814842035273, 3366.8148251846155, 3383.0865666270092, 3446.707029902458, 5694.259746232984, 5750.71246437678, 5780.884382312352, 5798.39116892726, 5815.418458154182, 5741.684207368593, 5759.942400575993, 5790.536757059435, 5833.445822646841, 5863.560232982532, 5192.480751924796, 5209.192575150839, 5237.423883372826, 5273.1826566882, 5324.840254792343, 5368.731563421833, 5379.784808607651, 5389.73051347433, 5392.892142157174, 5405.783768649249, 5256.9474305256845, 5335.626506144571, 5339.973300133474, 5387.78448862045, 5399.757010934517, 5249.0, 5258.316418865561, 5308.840734777963, 5311.49540793624, 5335.146376579729, 5255.159174532095, 5280.630355875091, 5286.207068939651, 5299.814506492293, 5360.892782144335, 5763.971180144114, 5774.133879918004, 5798.623089499211, 5806.506446952014, 5835.416458354173, 6125.693326622233, 6183.227096612924, 6210.813675589739, 6263.0, 6326.430621244064, 6301.936980630181, 6349.52378571609, 6369.808905732835, 6378.681065946684, 6385.744570217185, 5793.971030144822, 5844.357120716718, 5863.882722345529, 5879.470847623735, 5894.675792831393, 6269.279032911182, 6287.1826662534495, 6326.841828954313, 6332.651704156316, 6333.366663333722, 6071.293738947235, 6190.50475961922, 6258.968705156445, 6260.311365749764, 6273.12176295319, 6305.4009869062365, 6310.211223597051, 6311.652859092702, 6318.368163183737, 6335.778247761306, 6123.25211838015, 6156.907646385308, 6222.502199824004, 6284.560080794392, 6299.937000629935, 6217.595856269328, 6218.689065546704, 6228.22147231596, 6248.250209974832, 6265.937340626535, 4923.458419573844, 4953.504649535018, 4960.429550601655, 4983.053219888209, 4991.176455884738, 4416.0, 4470.776461176928, 4483.19302525542, 4493.662975276868, 4515.503294637587, 5605.607607467438, 5708.885822283531, 5757.453041961091, 5759.424057594207, 5767.769289228384, 6294.339094395114, 6296.622202667854, 6316.936830631635, 6319.431251187415, 6358.459530939922, 4840.29815676732, 5781.88436231273, 5784.82645520635, 5800.709964501758, 5810.738516766755, 5396.811111611075, 5430.049741295257, 5446.2375267462585, 5482.122860342406, 5486.1222204447095, 6440.19497562814, 6461.450776683847, 6469.935300646934, 6478.740850366121, 6490.578112422678, 6348.93651063502, 6352.205974253218, 6352.936470635419, 6354.23749150105, 6358.713857876314, 6265.0, 6291.622502649856, 6294.0558916162945, 6322.873542529215, 6397.392247736458, 6244.781432649836, 6285.59143655661, 6287.46556542699, 6297.905531416941, 6322.399372059647, 6322.0200868865395, 6324.209473815773, 6328.114064030948, 6336.651484168415, 6361.14124593174, 5835.533157347487, 6044.002739547926, 6123.877522449437, 6134.202553667995, 6185.257769067741, 6107.633541987495, 6121.84695382619, 6190.845228869134, 6197.349278325711, 6197.752089916353, 5014.5737612303365, 6029.0, 6032.521778863873, 6034.939650603438, 6043.909341359795, 6043.818685439268, 6055.909161362495, 6111.327753947151, 6116.42707509198, 6170.475509581735, 6087.0815627276625, 6110.226820533157, 6111.266648002268, 6116.606841479004, 6131.294901086432], "value": 5763.963354317768, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.7795187045506, 522.1906045629274, 530.0485628297206, 533.3945971322551, 551.1017042221179, 25976.74023259767, 41377.0, 42561.99999999996, 42725.931851703644, 42847.78576107123, 44078.779606101925, 44343.77828110855, 44522.777386113106, 44542.55457445425, 44567.0, 9807.754806129851, 9988.101070903616, 9989.700308990741, 9995.850062249072, 10047.547860346302, 8777.868331974994, 8947.77630559238, 12045.879541204564, 12196.63410097694, 12202.694932626711, 12029.398530073506, 12086.818697719542, 12089.637310880687, 12095.637130886087, 12112.394380280995, 8799.296056315543, 12180.634580962542, 12269.509219631203, 12279.631611051684, 12300.753984920297, 8613.0, 11747.060235181165, 11811.704707382298, 12037.759244815055, 12055.095867809949, 36619.08452288687, 42396.78801605972, 42418.0, 42508.149837003395, 42536.14927701429, 3086.6450358208867, 3306.8511916963794, 3532.5760908690863, 3995.580464051262, 4146.859613606252, 27574.724252757416, 30923.446278741765, 32200.516992245135, 32251.032469025966, 32511.0, 2589.7151313355516, 3230.07942736319, 3316.7014968652697, 3358.1940334319834, 3384.3569721752788, 517754.41122794524, 519379.0, 520707.0, 523726.0, 524903.0, 62640.0, 62898.685506572176, 62935.741285174954, 62985.0, 63070.36929630737, 66507.0, 66809.0, 66885.6655716728, 66918.66540667362, 66995.66502167458, 16637.417690381022, 16879.0, 16896.155192240585, 16933.238004289837, 16939.745903811454, 11730.824037639442, 12096.697582560506, 12963.15739476931, 13032.478700852049, 13065.216087034618, 18737.969411682217, 19237.903810480857, 19295.0, 19648.508787280432, 19787.703184452246, 6744.752220839062, 7092.751753688596, 7437.070366204224, 7704.691812327556, 7713.614319284014, 853.2363534636465, 932.883389576303, 983.2281658897731, 995.66147509847, 1020.1583693452783, 30220.934516164503, 30221.0, 30263.848680756895, 30590.388192236474, 31121.68878311233, 963.7735132243918, 1015.1827778638267, 1016.7813920007234, 1026.4457193115784, 1028.8919663435381, 13344.532941347006, 15625.765613515807, 15633.218339083, 15697.607559810867, 16025.839741602667, 193872.0306398459, 194546.05453945562, 194806.0, 194853.0, 194907.0254648746, 58571.70714146402, 58954.41045589489, 58977.70511147417, 59108.0, 59198.70400647969, 1229.4528934624007, 1262.059765474727, 1267.0, 1383.633337165652, 1406.5147524104168, 30154.793808247425, 30733.69266307308, 31793.523097154022, 32891.671083288864, 33372.499412509314, 56809.431905680416, 57302.7134864323, 57403.42596573981, 57513.71243143925, 57609.13586296125, 535752.0, 598636.0, 609573.0, 617068.0, 617714.0, 26460.8676956614, 27031.324216893947, 27079.864600676872, 27421.862890685417, 27558.311042224104, 47707.76146119247, 48052.03895922132, 48129.75935120302, 48880.51119488902, 49281.75359123181, 38956.0, 39532.60467395404, 40261.39607905942, 40727.83045175617, 41304.0, 39171.608283916794, 39608.00979975409, 39663.80168099141, 40873.795631021654, 41097.38353924753, 38863.222735544565, 39470.60529394784, 39512.0, 39727.0, 39784.403233950936, 32835.83582082074, 34084.488732668535, 34922.47616285809, 35103.12242193965, 35379.82310088433, 19859.900700496404, 24577.262682119566, 25065.122720704687, 25493.3626659335, 27591.724082758916], "value": 20078.08384199037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.2092901436276, 371.1611757428211, 371.8085186129143, 381.5631102387765, 402.64164893245, 14778.704425911475, 15594.532164035083, 15656.608584785386, 20179.495512612193, 20651.380458586227, 19511.317103901365, 20056.899715501437, 20647.070881810316, 20668.966551672394, 20917.581648367024, 5452.127659574468, 5849.795257166, 6115.052166914135, 6118.969405152968, 6130.540209484284, 5816.0, 6031.577789554733, 6086.17836592061, 6090.147379366892, 6090.878182436349, 5739.770409183628, 5930.0, 6055.273367195942, 6055.909161362583, 6061.242344706911, 5976.760929562813, 5993.250843644544, 6027.0, 6027.909581356261, 6041.365656606037, 5056.64603477753, 5070.2141168119, 5222.138347172712, 5227.3988491323225, 5230.450802665741, 25109.62335564968, 25154.0, 25239.49521009588, 25307.86114624828, 25447.491050179076, 2386.5465561543424, 2392.928212153638, 2807.1999480148265, 3033.8179709217297, 3161.6206055273283, 12816.487340506368, 14808.333624986793, 14967.775483367759, 16183.19084045793, 16293.348266069343, 1848.2422206895108, 1917.9616407671908, 1923.384516954575, 1934.430974851397, 1941.4466876940146, 115532.0, 120384.39807800905, 126037.36981315126, 126434.0, 133946.33026834804, 9158.496282704382, 9573.664921727706, 9676.0, 9800.95099524512, 9892.415781652002, 12289.324087175113, 12379.62861114168, 12380.380980950917, 12401.94583460398, 12409.44157512896, 7929.960350198212, 8086.070101938235, 8089.797755056171, 8175.509469431853, 8193.426460147852, 8234.588270586446, 8327.876391520123, 8444.957775211085, 8544.530050847263, 8726.607302671267, 3792.7345085843726, 3860.4209368594934, 3862.7682339059747, 3925.803709814498, 3928.1161738608585, 1870.8587761465494, 1904.6190761847686, 1908.6659834528903, 1908.885466871992, 1940.1366391955444, 803.501828866095, 866.4627930683017, 870.6996086350199, 935.3584459273931, 982.7985263021063, 20544.28095016667, 21282.530668559466, 21357.359279221648, 21375.0, 21419.678704819442, 737.5869513072589, 888.7822483491586, 913.3104506097853, 930.1767935377239, 972.6790159247431, 10637.149028077734, 11262.297048708415, 11296.322220666787, 11303.9826415623, 11321.641403031688, 587345.0, 593540.0, 594574.0, 616338.0, 617343.9132804397, 83204.58397707973, 111866.0, 128779.0, 135672.0, 143540.0, 907.6278725722422, 956.3544607389983, 972.3339512434005, 972.3728195314125, 973.5473005052685, 18749.53126171802, 19109.0, 19240.326588569333, 19290.324838631142, 19291.324803632368, 54594.72702636461, 55163.72418138044, 55883.72058139683, 57178.0, 57274.14088788588, 75653.48693026218, 77708.01176864353, 79510.80733789114, 80808.0, 81544.77682834644, 7498.38074834325, 7707.537547747153, 7918.049834019724, 8083.3533317333295, 8092.352611791161, 9034.45793252407, 11194.552217911192, 11353.829692554453, 11873.52505899789, 12116.697082573006, 10853.837192442277, 10860.185486088418, 10967.067799237155, 11028.28316159447, 11031.779364412827, 8184.8772268417215, 8458.619362128842, 10848.945755271174, 10852.945735271272, 10988.505517251582, 10939.991502336603, 11258.437078146224, 11258.66224013281, 11267.661970140582, 11276.097912166842, 7868.685252589832, 7889.408294377829, 8002.0, 8143.83712325762, 8173.182681732017, 10035.448050357301, 10648.361098334124, 10957.726056848642, 11076.224664273423, 11084.667459976214], "value": 9455.703898320688, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.8510148985104, 1524.1007805394818, 1703.33569907736, 1835.6145209506003, 1882.303547687355, 8430.873536896945, 8976.147266009719, 8981.281497480202, 8987.325950553719, 8992.280617550588, 7881.408894332933, 8079.272865442109, 8080.91919080809, 8466.238038576526, 8733.563321833915, 2392.2583998960336, 2427.817913656474, 2430.6961629796274, 2434.1480481831304, 2444.8655323957173, 2381.297517232412, 2409.9879500602474, 2418.0811291709124, 2419.5402873454077, 2429.647701083342, 2403.267003563912, 2410.18053861687, 2413.81896357773, 2420.4674971506242, 2422.527607116613, 2163.632182528966, 2169.642009068502, 2169.6873391598015, 2171.4245724882917, 2176.3144609447972, 2318.8724620145886, 2406.602910519762, 2413.408714864852, 2414.987925060381, 2416.9758302417104, 8789.165029322205, 8906.688265910661, 8913.420627659181, 8917.33120015995, 8931.821363572757, 5215.165573508259, 5374.462553744634, 5376.086065368897, 5380.273663055476, 5381.946180538183, 2975.598294230273, 3425.9486107708403, 3446.1212390840424, 3582.176099497104, 3677.5770786359644, 1098.0611577101542, 1101.8512500812367, 1104.9116070714324, 1130.22014809781, 1131.8472006279212, 11657.883421165765, 11807.350595717233, 11844.526218951232, 11853.940730296294, 11856.932876041112, 4595.563421474954, 4638.536146385334, 4803.375561177025, 4811.518848115161, 4821.421429428491, 8953.194212520904, 10010.699679009642, 10011.49942502872, 10012.098911098035, 10016.64941727036, 5060.51925067118, 5364.7317634118135, 5366.9873797326, 5368.516833485005, 5370.248165256867, 4709.434867815816, 4862.07620552094, 4916.360873086476, 4930.8767280818265, 4942.827001054946, 3764.698824094066, 3771.698264138862, 3837.5394952605866, 3853.6917046636763, 3855.4409610606303, 1173.5540494612164, 1175.629676651852, 1182.2433642468827, 1182.9940850295693, 1185.6324539392815, 843.5739951324542, 859.7592674051151, 903.6475774447971, 912.6896855069308, 938.4275591888942, 5710.172025056427, 5753.798617048383, 5986.311574169026, 6062.090686397076, 6164.753409863555, 898.9146031127033, 925.5418567808978, 951.5147274889856, 993.1310103659298, 997.680742162501, 3905.511811023622, 3936.8622098226424, 3943.2310699413338, 4062.207869465485, 4091.754494730326, 10507.422091784872, 10963.958423949713, 10972.725681857857, 10982.505787239434, 10986.230963832455, 10926.453677316102, 10940.781184376427, 10951.233413661126, 10952.123830093573, 10954.3427394355, 8180.672773089129, 8208.425410221347, 8320.084790673021, 8323.542205178774, 8369.665213391396, 4920.901581968412, 5745.3105627324985, 5903.498202652822, 5932.614380065282, 5973.163757073926, 10120.79758404813, 10182.083612474913, 10224.0, 10228.64199753005, 10288.0, 9867.16129129032, 10388.792224155626, 10481.0, 10481.056704896597, 10494.055535001886, 6585.670716464253, 6784.6946887389195, 6928.896066559107, 7036.612986285803, 7169.4981351304905, 8537.18896704812, 8544.0, 8610.397272190887, 8626.051134375088, 8649.783755406164, 7336.669849856876, 7410.5183163094225, 7440.218777028334, 7536.849263014599, 7618.771436856903, 7366.484346095722, 7390.29792169743, 7430.591317477374, 7444.776656700091, 7511.51175173612, 6903.344182302673, 6932.8560787469505, 7028.894566581607, 7032.402245809163, 7047.154341479055, 4217.557156498524, 4924.359833221658, 5023.146065168857, 5071.695698257969, 5147.790269286789, 4974.626902982219, 5007.198848184273, 5152.124138896322, 5184.870378240575, 5276.788928442819], "value": 4599.209037276312, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [236.637943945763, 297.4007375139095, 307.2411144473151, 309.0820263816464, 310.84302427274224, 4466.553344665532, 5375.408705042442, 5383.420025682921, 5430.511253987141, 5462.399136095037, 4928.802847886089, 5070.340855688764, 5085.677723791813, 5157.375426740574, 5357.678539287645, 3689.8524059037604, 4019.3970904364432, 4049.574794646564, 4081.7755023473696, 4096.730013695749, 3515.084279067914, 3747.5128233329765, 4051.1897620476025, 4080.81636326366, 4116.259073366793, 3870.845166193349, 4022.9798851005703, 4040.939385909199, 4076.429299898017, 4089.325261331877, 3347.815870127142, 4049.967258349102, 4058.857939972116, 4059.776712280823, 4094.9934532079214, 3525.6121826599056, 3525.982370088133, 3530.646935306449, 3550.6449355064547, 3557.3063252665743, 4192.958070419288, 4429.202743506167, 4859.222524396079, 5092.414372347191, 5192.350956130484, 4000.4799376081214, 4540.524329592896, 4570.7257564546235, 4578.45058592971, 4616.584507394317, 4707.152712511746, 4838.975805120952, 5274.393444753826, 5555.500004999529, 5592.5805564582415, 3376.480583737328, 3615.385384484644, 3792.355299599075, 3817.7592282508017, 3847.461355410245, 5473.644213126134, 5812.476877080999, 5837.781642975685, 5920.111983202511, 5941.821745347646, 3767.698584113264, 3780.9980355205894, 3793.5205269944745, 3793.5827059023486, 3804.391297392404, 3879.515060617423, 3880.320943834874, 3885.0, 3900.64894159527, 3918.45141680165, 3910.081130934228, 4083.652889504366, 4206.284931561642, 4339.631131353807, 4541.0, 4869.586085182728, 5437.0, 5608.0, 5629.408912064257, 5640.561656777495, 1048.2295512798087, 1287.9503204888174, 1316.835395575553, 1321.8479874814327, 1323.3912400295972, 765.5521519910803, 825.2449009156675, 868.5179725252545, 896.9192772650492, 903.6927444668713, 5145.408278048072, 5155.61332900034, 5177.611679124081, 5221.843344699665, 5278.023565640369, 4623.583877451046, 4832.710037397767, 5697.515711164515, 5762.423757624204, 5789.913151302734, 5050.925788184488, 5118.797082685566, 5149.330587023663, 5151.562117220078, 5184.766685499161, 2960.41617734511, 2972.212363723615, 2977.764227845463, 2983.209449495885, 2998.7151220634005, 4496.752678602708, 4915.205949828287, 5552.333719953551, 5883.529317654663, 5963.373845746134, 5699.629524080921, 5712.714639206145, 5925.792597259161, 5950.137230101611, 5953.553483488756, 5987.15610085206, 6011.458968692838, 6023.096535519707, 6057.182845146526, 6073.908891366721, 4596.448426188878, 5436.40199578054, 5722.513586345207, 5760.740766665594, 5800.56495762811, 4502.4371953505815, 5239.825472428899, 5398.568114550905, 5700.3444603871085, 5705.857353566194, 5664.37691853904, 6006.489448396936, 6024.277086749618, 6027.186329845415, 6037.0, 3891.747036442622, 3960.7623542587535, 3988.766290877118, 3996.2407142642805, 3999.5600483947323, 5710.600257981901, 5724.311328158286, 5742.19609254713, 5742.19609254713, 5743.874766336482, 5082.745862706924, 5204.661696989683, 5264.447233040476, 5623.493885550321, 5642.2665053544415, 4443.577860103285, 4938.604911606991, 5556.972215138899, 5621.7189140542, 5650.689212093374, 4918.680285781413, 5101.260317253903, 5233.293505376878, 5280.498352656491, 5499.285092938053, 5135.6918584885025, 5166.4242406065005, 5459.945400546103, 5522.66863988162, 5592.245046918614, 5466.453354664502, 5467.945320546903, 5488.012157811632, 5502.394736578893, 5528.75120619565], "value": 4057.8511806250044, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.3976329764646, 729.5294535024909, 739.6708464733192, 779.2207792207794, 803.5178892664405, 15496.22518874056, 16420.34318627255, 16428.8927768058, 16429.753553696704, 16503.587410314747, 14685.92657036716, 14820.481283155092, 14828.925855370708, 14855.702885942275, 14883.627909302273, 688.3288793426419, 708.1183926012122, 833.295864994079, 838.8070743728946, 851.5061264466594, 866.1295398124876, 872.9039805621377, 873.388627960427, 873.9038705742363, 874.152072489684, 914.401067300919, 923.6628630549834, 929.8744669469636, 932.1470854168427, 935.9906400936005, 922.5940586142076, 925.2597921662643, 925.421611492817, 925.4771054354268, 926.2219735422277, 532.0874699889707, 556.2351766321308, 657.5725778244132, 691.5055735149342, 694.5728377048079, 15018.549443516711, 15212.261792877278, 15213.771793423108, 15222.314995825214, 15271.465498707492, 13843.30783460833, 14105.78841317381, 14216.0, 14243.78634320486, 14429.494967676186, 12248.571300004458, 12617.369131543477, 12639.684007899876, 12671.809922851164, 13023.348832558335, 4524.660650451229, 4649.372334734801, 4657.417822772153, 4664.463586687507, 4690.0, 117353.99999999914, 120262.0, 120353.39823300915, 120426.0, 120617.39691301488, 10723.731906702238, 10929.781404371868, 11146.888531114586, 11432.428378581038, 11469.88530114705, 18032.459026229233, 21998.89000555019, 22009.009594568284, 22009.559808804053, 22037.449063773212, 7828.334591559667, 7976.521408715495, 8029.478083924526, 8030.638621262057, 8070.515769053875, 4188.497380314321, 4382.364557139261, 4426.822927082881, 4467.6649251305635, 4514.932276015862, 3407.914802129917, 3525.7531972761662, 3527.3827080260853, 3529.4705794131087, 3539.433690609542, 546.1861825879411, 637.2384999925138, 653.8692261547709, 654.3979538824293, 654.8886689262837, 600.8407771940439, 608.6044071353656, 615.4614712126889, 638.1894993358502, 641.9215717594486, 8905.287576993825, 8983.955080224558, 9007.453825199333, 9024.187823095821, 9061.864072038925, 506.9923951140736, 550.8182299841043, 625.562106525434, 625.9515311852629, 650.9186351706037, 3408.727301815849, 4323.654107671442, 4367.432233809584, 4447.599716025573, 4477.507474177838, 92323.53838230901, 123417.68038118802, 133052.66947330596, 134074.98887516695, 139477.3026134883, 79401.42693578803, 115997.4200128994, 118136.0, 120933.0, 126511.0, 72363.6381818098, 103667.0, 109260.453697731, 109524.90475095306, 110175.44912275548, 9365.297602679962, 9515.619375224913, 9517.809643807224, 9553.04469553039, 9556.331056825955, 61244.0, 61867.0, 63428.0, 63734.36265637284, 65206.347936520026, 87293.0, 90497.54751226201, 96946.0, 97927.0, 99625.50187249017, 13062.673433164247, 13115.540956066492, 13177.47290108385, 13292.800607991081, 13598.320083995563, 14850.40598376053, 14877.404903803726, 14877.702445950805, 15260.160691161649, 15406.845931540542, 11133.387663678252, 13667.453301867814, 13915.443382265, 14325.928370358082, 14395.352209150404, 13483.393247303698, 13693.657658558615, 13699.383527741475, 13825.0, 13834.65413364674, 13453.46186152543, 13463.730725385632, 13538.59384218475, 14100.435982560582, 14319.713605728035, 11086.42357487731, 11197.272177308449, 11453.141014423785, 11705.590304339306, 11750.764984700087, 10734.302270352402, 10865.891341086488, 11338.60314888975, 11408.771824563628, 11594.072474202212], "value": 7807.07728795472, "unit": "score"}], "name": "dromaeo_css", "value": 7363.911042812086, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 116.0, 113.0, 114.0, 113.0, 111.0, 112.0, 113.0, 123.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 114.0, 129.0, 163.0, 110.0, 129.0, 127.0, 108.0, 175.0, 107.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 186.0, 186.0, 184.0, 184.0, 182.0, 259.0, 207.0, 181.0], "value": 194.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 78.0, 150.0, 58.0, 56.0, 57.0, 64.0, 136.0, 81.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 135.0, 71.0, 72.0, 94.0, 116.0, 69.0, 70.0, 117.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 84.0, 86.0, 83.0, 87.0, 84.0, 87.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 86.0, 84.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 52.0, 53.0, 53.0, 55.0, 53.0, 53.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 69.0, 70.0, 70.0, 73.0, 69.0, 67.0, 70.0, 69.0], "value": 68.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 85.0, 87.0, 84.0, 88.0, 90.0, 89.0, 113.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 138.0, 138.0, 137.0, 133.0, 143.0, 153.0, 186.0, 150.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 168.0, 168.0, 166.0, 167.0, 165.0, 168.0, 170.0, 169.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 67.0, 81.0, 87.0, 88.0, 66.0, 68.0, 67.0], "value": 72.7, "unit": "score"}], "name": "kraken", "value": 1474.4000000000003, "alertThreshold": 2.0}]} 21:35:34 INFO - Return code: 0 21:35:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:35:34 INFO - # TBPL SUCCESS # 21:35:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:35:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:35:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:35:34 INFO - 2016-09-11 21:35:34.873 screenresolution[1691:19545] starting screenresolution argv=screenresolution get 21:35:34 INFO - 2016-09-11 21:35:34.875 screenresolution[1691:19545] Display 0: 1600x1200x32@60 21:35:34 INFO - 2016-09-11 21:35:34.881 screenresolution[1692:19548] starting screenresolution argv=screenresolution list 21:35:34 INFO - Available Modes on Display 0 21:35:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:35:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:35:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:35:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:35:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:35:35 INFO - Intel Iris: 21:35:35 INFO - Chipset Model: Intel Iris 21:35:35 INFO - Type: GPU 21:35:35 INFO - Bus: Built-In 21:35:35 INFO - VRAM (Dynamic, Max): 1536 MB 21:35:35 INFO - Vendor: Intel (0x8086) 21:35:35 INFO - Device ID: 0x0a2e 21:35:35 INFO - Revision ID: 0x0009 21:35:35 INFO - Displays: 21:35:35 INFO - Display: 21:35:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:35:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:35:35 INFO - Display Serial Number: 1600x1200 60 21:35:35 INFO - Main Display: Yes 21:35:35 INFO - Mirror: Off 21:35:35 INFO - Online: Yes 21:35:35 INFO - Rotation: Supported 21:35:35 INFO - Return code: 0 21:35:35 INFO - Running post-action listener: _resource_record_post_action 21:35:35 INFO - [mozharness: 2016-09-12 04:35:35.115557Z] Finished run-tests step (success) 21:35:35 INFO - Running post-run listener: _resource_record_post_run 21:35:35 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 32791552; Write bytes: 705903616; Read time: 308; Write time: 1897 21:35:35 INFO - TinderboxPrint: CPU usage
53.5% 21:35:35 INFO - TinderboxPrint: I/O read bytes / time
32,791,552 / 308 21:35:35 INFO - TinderboxPrint: I/O write bytes / time
705,903,616 / 1,897 21:35:35 INFO - TinderboxPrint: CPU idle
2,254.8 (46.5%) 21:35:35 INFO - TinderboxPrint: CPU system
967.8 (20.0%) 21:35:35 INFO - TinderboxPrint: CPU user
1,627.0 (33.5%) 21:35:35 INFO - TinderboxPrint: Swap in / out
434,368,512 / 0 21:35:35 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404935168; Write bytes: 401200128; Read time: 29626; Write time: 784 21:35:35 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 29080576; Write bytes: 293935104; Read time: 276; Write time: 1080 21:35:35 INFO - Running post-run listener: _upload_blobber_files 21:35:35 INFO - Blob upload gear active. 21:35:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:35:35 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 21:35:35 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'] 21:35:35 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 21:35:36 INFO - (blobuploader) - INFO - Open directory for files ... 21:35:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:35:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:35:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:35:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:35:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:35:36 INFO - (blobuploader) - INFO - Done attempting. 21:35:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:35:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:35:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:35:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:35:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:35:37 INFO - (blobuploader) - INFO - Done attempting. 21:35:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:35:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:35:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:35:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:35:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:35:40 INFO - (blobuploader) - INFO - Done attempting. 21:35:40 INFO - (blobuploader) - INFO - Iteration through files over. 21:35:40 INFO - Return code: 0 21:35:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:35:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:35:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3208baa38ac4482155a44b31b9fa0eaa65fb78d15ac2443b9a0ac8ab17df73174820cac636e7d1071600de46116c17027b0dc4e51707a20477e7d889b2a8d0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a425ad2bc2aa207004810f499710ed2b655bec3b216e7365b222ecd6d6d37e8e4f9ab19fa2149a9f18d0b24dea866ba0bb9c1fb3300c6093a453eab960e333c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/141669d66b3bf308b3de635335e61445f8515edc1de05ee58ad2e3379f44592d21de97aae350f2d0667d2ef636d35b1382776f0fd66d491afb155e3b27530c74"} 21:35:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:35:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:35:40 INFO - Contents: 21:35:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3208baa38ac4482155a44b31b9fa0eaa65fb78d15ac2443b9a0ac8ab17df73174820cac636e7d1071600de46116c17027b0dc4e51707a20477e7d889b2a8d0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a425ad2bc2aa207004810f499710ed2b655bec3b216e7365b222ecd6d6d37e8e4f9ab19fa2149a9f18d0b24dea866ba0bb9c1fb3300c6093a453eab960e333c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/141669d66b3bf308b3de635335e61445f8515edc1de05ee58ad2e3379f44592d21de97aae350f2d0667d2ef636d35b1382776f0fd66d491afb155e3b27530c74"} 21:35:40 INFO - Running post-run listener: copy_logs_to_upload_dir 21:35:40 INFO - Copying logs to upload dir... 21:35:40 INFO - mkdir: /builds/slave/test/build/upload/logs 21:35:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.639749 ========= master_lag: 6.94 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-09-11 21:35:47.249655) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-11 21:35:47.254447) ========= 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.WPzFWAVNv6/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.LNnagFHf3L/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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/a3208baa38ac4482155a44b31b9fa0eaa65fb78d15ac2443b9a0ac8ab17df73174820cac636e7d1071600de46116c17027b0dc4e51707a20477e7d889b2a8d0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a425ad2bc2aa207004810f499710ed2b655bec3b216e7365b222ecd6d6d37e8e4f9ab19fa2149a9f18d0b24dea866ba0bb9c1fb3300c6093a453eab960e333c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/141669d66b3bf308b3de635335e61445f8515edc1de05ee58ad2e3379f44592d21de97aae350f2d0667d2ef636d35b1382776f0fd66d491afb155e3b27530c74"} build_url:https://queue.taskcluster.net/v1/task/GnTncIIyQRemOTl5FZav9w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011129 build_url: 'https://queue.taskcluster.net/v1/task/GnTncIIyQRemOTl5FZav9w/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/a3208baa38ac4482155a44b31b9fa0eaa65fb78d15ac2443b9a0ac8ab17df73174820cac636e7d1071600de46116c17027b0dc4e51707a20477e7d889b2a8d0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a425ad2bc2aa207004810f499710ed2b655bec3b216e7365b222ecd6d6d37e8e4f9ab19fa2149a9f18d0b24dea866ba0bb9c1fb3300c6093a453eab960e333c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/141669d66b3bf308b3de635335e61445f8515edc1de05ee58ad2e3379f44592d21de97aae350f2d0667d2ef636d35b1382776f0fd66d491afb155e3b27530c74"}' ========= master_lag: 0.46 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-11 21:35:47.722526) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 21:35:47.722869) ========= 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.WPzFWAVNv6/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.LNnagFHf3L/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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.005133 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 21:35:47.749802) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-11 21:35:47.750175) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-11 21:35:47.750499) ========= ========= Total master_lag: 7.55 =========