builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0292 starttime: 1473448314.82 results: success (0) buildid: 20160909104831 builduid: 891c649be1cc4009a26af2d8daa3efce revision: 644b3de5d7a18b101d44a003bc27d50853dee4c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-09 12:11:54.817794) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-09 12:11:54.818352) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-09 12:11:54.818698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-09 12:11:54.843977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 12:11:54.844278) ========= 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.fDdLc1n042/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.jlS9uS0cNI/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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-09 12:11:54-- 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% 26.6M=0s 2016-09-09 12:11:54 (26.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106683 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 12:11:54.976197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 12:11:54.976950) ========= 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.fDdLc1n042/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.jlS9uS0cNI/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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.025748 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 12:11:55.026562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-09 12:11:55.026967) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 644b3de5d7a18b101d44a003bc27d50853dee4c9 --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 644b3de5d7a18b101d44a003bc27d50853dee4c9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fDdLc1n042/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.jlS9uS0cNI/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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-09 12:11:55,109 truncating revision to first 12 chars 2016-09-09 12:11:55,109 Setting DEBUG logging. 2016-09-09 12:11:55,109 attempt 1/10 2016-09-09 12:11:55,109 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/644b3de5d7a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-09 12:11:56,136 unpacking tar archive at: mozilla-central-644b3de5d7a1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.322019 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-09 12:11:56.371594) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-09 12:11:56.371963) ========= script_repo_revision: 644b3de5d7a18b101d44a003bc27d50853dee4c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-09 12:11:56.372402) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-09 12:11:56.372721) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-09 12:11:56.471321) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-09 12:11:56.471761) ========= /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.fDdLc1n042/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.jlS9uS0cNI/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 12:11:56 INFO - MultiFileLogger online at 20160909 12:11:56 in /builds/slave/test 12:11:56 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 12:11:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:11:56 INFO - {'append_to_log': False, 12:11:56 INFO - 'base_work_dir': '/builds/slave/test', 12:11:56 INFO - 'blob_upload_branch': 'Firefox', 12:11:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:11:56 INFO - 'branch': 'Firefox', 12:11:56 INFO - 'buildbot_json_path': 'buildprops.json', 12:11:56 INFO - 'config_files': ('talos/mac_config.py',), 12:11:56 INFO - 'default_actions': ('clobber', 12:11:56 INFO - 'read-buildbot-config', 12:11:56 INFO - 'download-and-extract', 12:11:56 INFO - 'populate-webroot', 12:11:56 INFO - 'create-virtualenv', 12:11:56 INFO - 'install', 12:11:56 INFO - 'run-tests'), 12:11:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:11:56 INFO - 'download_minidump_stackwalk': True, 12:11:56 INFO - 'download_symbols': 'ondemand', 12:11:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:11:56 INFO - 'tooltool.py': '/tools/tooltool.py', 12:11:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:11:56 INFO - '/tools/misc-python/virtualenv.py')}, 12:11:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:11:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:11:56 INFO - 'installer_path': 'installer.exe', 12:11:56 INFO - 'log_level': 'info', 12:11:56 INFO - 'log_name': 'talos', 12:11:56 INFO - 'log_to_console': True, 12:11:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:11:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:11:56 INFO - 'opt_config_files': (), 12:11:56 INFO - 'pip_index': False, 12:11:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:11:56 INFO - 'cmd': ('bash', 12:11:56 INFO - '-c', 12:11:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:11:56 INFO - 'enabled': True, 12:11:56 INFO - 'halt_on_failure': False, 12:11:56 INFO - 'name': 'check_screen_resolution'},), 12:11:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:11:56 INFO - 'cmd': ('bash', 12:11:56 INFO - '-c', 12:11:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:11:56 INFO - 'enabled': True, 12:11:56 INFO - 'halt_on_failure': False, 12:11:56 INFO - 'name': 'check_screen_resolution'},), 12:11:56 INFO - 'run_cmd_checks_enabled': True, 12:11:56 INFO - 'sps_profile': False, 12:11:56 INFO - 'sps_profile_interval': 0, 12:11:56 INFO - 'suite': 'dromaeojs', 12:11:56 INFO - 'system_bits': '32', 12:11:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:11:56 INFO - 'title': 't-yosemite-r7-0292', 12:11:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:11:56 INFO - 'use_talos_json': True, 12:11:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:11:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:11:56 INFO - 'work_dir': 'build'} 12:11:56 INFO - [mozharness: 2016-09-09 19:11:56.665078Z] Running clobber step. 12:11:56 INFO - Running pre-action listener: _resource_record_pre_action 12:11:56 INFO - Running main action method: clobber 12:11:56 INFO - rmtree: /builds/slave/test/build 12:11:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:11:58 INFO - Running post-action listener: _resource_record_post_action 12:11:58 INFO - [mozharness: 2016-09-09 19:11:58.807322Z] Finished clobber step (success) 12:11:58 INFO - [mozharness: 2016-09-09 19:11:58.807610Z] Running read-buildbot-config step. 12:11:58 INFO - Running pre-action listener: _resource_record_pre_action 12:11:58 INFO - Running main action method: read_buildbot_config 12:11:58 INFO - Using buildbot properties: 12:11:58 INFO - { 12:11:58 INFO - "project": "", 12:11:58 INFO - "product": "firefox", 12:11:58 INFO - "script_repo_revision": "production", 12:11:58 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 12:11:58 INFO - "repository": "", 12:11:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 12:11:58 INFO - "buildid": "20160909104831", 12:11:58 INFO - "stage_platform": "macosx64", 12:11:58 INFO - "basedir": "/builds/slave/test", 12:11:58 INFO - "nightly_build": "True", 12:11:58 INFO - "buildnumber": 5, 12:11:58 INFO - "slavename": "t-yosemite-r7-0292", 12:11:58 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:11:58 INFO - "platform": "yosemite_r7", 12:11:58 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:11:58 INFO - "branch": "mozilla-central", 12:11:58 INFO - "repo_path": "mozilla-central", 12:11:58 INFO - "revision": "644b3de5d7a18b101d44a003bc27d50853dee4c9", 12:11:58 INFO - "pgo_build": "False", 12:11:58 INFO - "builduid": "891c649be1cc4009a26af2d8daa3efce", 12:11:58 INFO - "slavebuilddir": "test" 12:11:58 INFO - } 12:11:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 12:11:58 INFO - Running post-action listener: _resource_record_post_action 12:11:58 INFO - [mozharness: 2016-09-09 19:11:58.813422Z] Finished read-buildbot-config step (success) 12:11:58 INFO - [mozharness: 2016-09-09 19:11:58.813605Z] Running download-and-extract step. 12:11:58 INFO - Running pre-action listener: _resource_record_pre_action 12:11:58 INFO - Running main action method: download_and_extract 12:11:58 INFO - mkdir: /builds/slave/test/build/tests 12:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:11:58 INFO - trying https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 12:11:58 INFO - Downloading https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/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 12:11:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/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 12:11:59 INFO - Downloaded 1199 bytes. 12:11:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 12:11:59 INFO - Using the following test package requirements: 12:11:59 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 12:11:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:11:59 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 12:11:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:11:59 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 12:11:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:11:59 INFO - u'jsshell-mac.zip'], 12:11:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:11:59 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 12:11:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 12:11:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:11:59 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 12:11:59 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:11:59 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 12:11:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:11:59 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 12:11:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:11:59 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 12:11:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:12:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 12:12:00 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 12:12:07 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 12:12:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 12:12:07 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 12:12:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 12:12:15 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 12:12: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')]} 12:12:16 INFO - trying https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:12:16 INFO - Downloading https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 12:12:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/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 12:12:19 INFO - Downloaded 111720733 bytes. 12:12:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:12:19 INFO - mkdir: /builds/slave/test/properties 12:12:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:12:19 INFO - Writing to file /builds/slave/test/properties/build_url 12:12:19 INFO - Contents: 12:12:19 INFO - build_url:https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:12:19 INFO - Running post-action listener: _resource_record_post_action 12:12:19 INFO - Running post-action listener: set_extra_try_arguments 12:12:19 INFO - [mozharness: 2016-09-09 19:12:19.998422Z] Finished download-and-extract step (success) 12:12:19 INFO - [mozharness: 2016-09-09 19:12:19.998548Z] Running populate-webroot step. 12:12:19 INFO - Running pre-action listener: _resource_record_pre_action 12:12:19 INFO - Running main action method: populate_webroot 12:12:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:12:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:12:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:12:20 INFO - '--tppagecycles', 12:12:20 INFO - '7'], 12:12:20 INFO - 'tests': ['tsvgm']}}, 12:12:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:12:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:12:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:12:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:12:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:12:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:12:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:20 INFO - 'talos_options': ['--disable-e10s'], 12:12:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:12:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:12:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:20 INFO - 'talos_options': ['--disable-e10s'], 12:12:20 INFO - 'tests': ['damp', 'tps']}, 12:12:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:20 INFO - 'tests': ['damp', 'tps']}, 12:12:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:12:20 INFO - 'tests': ['dromaeo_dom']}, 12:12:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:12:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:12:20 INFO - 'tests': ['basic_compositor_video']}, 12:12:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:12:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:12:20 INFO - 'tests': ['a11yr', 12:12:20 INFO - 'ts_paint', 12:12:20 INFO - 'tpaint', 12:12:20 INFO - 'sessionrestore', 12:12:20 INFO - 'sessionrestore_no_auto_restore', 12:12:20 INFO - 'tabpaint']}, 12:12:20 INFO - 'other-e10s': {'tests': ['a11yr', 12:12:20 INFO - 'ts_paint', 12:12:20 INFO - 'tpaint', 12:12:20 INFO - 'sessionrestore', 12:12:20 INFO - 'sessionrestore_no_auto_restore', 12:12:20 INFO - 'tabpaint']}, 12:12:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:12:20 INFO - 'ts_paint', 12:12:20 INFO - 'tpaint', 12:12:20 INFO - 'sessionrestore', 12:12:20 INFO - 'sessionrestore_no_auto_restore', 12:12:20 INFO - 'tabpaint']}, 12:12:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:12:20 INFO - 'ts_paint', 12:12:20 INFO - 'tpaint', 12:12:20 INFO - 'sessionrestore', 12:12:20 INFO - 'sessionrestore_no_auto_restore', 12:12:20 INFO - 'tabpaint']}, 12:12:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:12:20 INFO - 'tests': ['a11yr', 12:12:20 INFO - 'ts_paint', 12:12:20 INFO - 'tpaint', 12:12:20 INFO - 'sessionrestore', 12:12:20 INFO - 'sessionrestore_no_auto_restore', 12:12:20 INFO - 'tabpaint']}, 12:12:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:12:20 INFO - 'tests': ['a11yr', 12:12:20 INFO - 'ts_paint', 12:12:20 INFO - 'tpaint', 12:12:20 INFO - 'sessionrestore', 12:12:20 INFO - 'sessionrestore_no_auto_restore', 12:12:20 INFO - 'tabpaint']}, 12:12:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:12:20 INFO - 'tests': ['tsvgx', 12:12:20 INFO - 'tsvgr_opacity', 12:12:20 INFO - 'tart', 12:12:20 INFO - 'tscrollx', 12:12:20 INFO - 'cart']}, 12:12:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:12:20 INFO - 'tsvgr_opacity', 12:12:20 INFO - 'tart', 12:12:20 INFO - 'tscrollx', 12:12:20 INFO - 'cart']}, 12:12:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:20 INFO - 'talos_options': ['--disable-e10s'], 12:12:20 INFO - 'tests': ['tp5o']}, 12:12:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:20 INFO - 'tests': ['tp5o']}, 12:12:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:20 INFO - 'talos_options': ['--disable-e10s', 12:12:20 INFO - '--xperf_path', 12:12:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:12:20 INFO - 'tests': ['tp5n']}, 12:12:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:12:20 INFO - 'talos_options': ['--xperf_path', 12:12:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:12:20 INFO - 'tests': ['tp5n']}}, 12:12:20 INFO - 'talos.zip': {'path': '', 12:12:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:12:20 INFO - Running post-action listener: _resource_record_post_action 12:12:20 INFO - [mozharness: 2016-09-09 19:12:20.017311Z] Finished populate-webroot step (success) 12:12:20 INFO - [mozharness: 2016-09-09 19:12:20.017450Z] Running create-virtualenv step. 12:12:20 INFO - Running pre-action listener: _resource_record_pre_action 12:12:20 INFO - Running main action method: create_virtualenv 12:12:20 INFO - Creating virtualenv /builds/slave/test/build/venv 12:12:20 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 12:12:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:12:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:12:20 INFO - Using real prefix '/tools/python27' 12:12:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:12:20 INFO - Installing distribute.............................................................................................................................................................................................done. 12:12:23 INFO - Installing pip.................done. 12:12:23 INFO - Return code: 0 12:12:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102034618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe142c754a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f03d30>, '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 0x101c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101efbb20>, '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.fDdLc1n042/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.jlS9uS0cNI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 12:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:12:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fDdLc1n042/Render', 12:12:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:23 INFO - 'HOME': '/Users/cltbld', 12:12:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:23 INFO - 'LOGNAME': 'cltbld', 12:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:23 INFO - 'MOZ_NO_REMOTE': '1', 12:12:23 INFO - 'NO_EM_RESTART': '1', 12:12:23 INFO - 'PAGER': '/bin/cat', 12:12:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:23 INFO - 'PWD': '/builds/slave/test', 12:12:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:23 INFO - 'SHELL': '/bin/bash', 12:12:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlS9uS0cNI/Listeners', 12:12:23 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 12:12:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:23 INFO - 'USER': 'cltbld', 12:12:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:23 INFO - 'XPC_FLAGS': '0x0', 12:12:23 INFO - 'XPC_SERVICE_NAME': '0', 12:12:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:12:23 INFO - Cleaning up... 12:12:23 INFO - Return code: 0 12:12:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102034618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe142c754a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f03d30>, '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 0x101c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101efbb20>, '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.fDdLc1n042/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.jlS9uS0cNI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 12:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:12:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fDdLc1n042/Render', 12:12:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:23 INFO - 'HOME': '/Users/cltbld', 12:12:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:23 INFO - 'LOGNAME': 'cltbld', 12:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:23 INFO - 'MOZ_NO_REMOTE': '1', 12:12:23 INFO - 'NO_EM_RESTART': '1', 12:12:23 INFO - 'PAGER': '/bin/cat', 12:12:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:23 INFO - 'PWD': '/builds/slave/test', 12:12:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:23 INFO - 'SHELL': '/bin/bash', 12:12:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlS9uS0cNI/Listeners', 12:12:23 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 12:12:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:23 INFO - 'USER': 'cltbld', 12:12:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:23 INFO - 'XPC_FLAGS': '0x0', 12:12:23 INFO - 'XPC_SERVICE_NAME': '0', 12:12:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:24 INFO - Downloading/unpacking psutil>=3.1.1 12:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:12:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:12:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:12:27 INFO - Installing collected packages: psutil 12:12:27 INFO - Running setup.py install for psutil 12:12:27 INFO - building 'psutil._psutil_osx' extension 12:12:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:12:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:12:28 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 12:12:28 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 12:12:28 INFO - building 'psutil._psutil_posix' extension 12:12:28 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 12:12:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:12:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:12:28 INFO - ^ 12:12:28 INFO - 1 warning generated. 12:12:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:12:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:12:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:12:28 INFO - Successfully installed psutil 12:12:28 INFO - Cleaning up... 12:12:28 INFO - Return code: 0 12:12:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102034618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe142c754a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f03d30>, '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 0x101c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101efbb20>, '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.fDdLc1n042/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.jlS9uS0cNI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 12:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:12:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fDdLc1n042/Render', 12:12:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:28 INFO - 'HOME': '/Users/cltbld', 12:12:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:28 INFO - 'LOGNAME': 'cltbld', 12:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:28 INFO - 'MOZ_NO_REMOTE': '1', 12:12:28 INFO - 'NO_EM_RESTART': '1', 12:12:28 INFO - 'PAGER': '/bin/cat', 12:12:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:28 INFO - 'PWD': '/builds/slave/test', 12:12:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:28 INFO - 'SHELL': '/bin/bash', 12:12:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlS9uS0cNI/Listeners', 12:12:28 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 12:12:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:28 INFO - 'USER': 'cltbld', 12:12:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:28 INFO - 'XPC_FLAGS': '0x0', 12:12:28 INFO - 'XPC_SERVICE_NAME': '0', 12:12:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:12:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:12:31 INFO - Installing collected packages: mozsystemmonitor 12:12:31 INFO - Running setup.py install for mozsystemmonitor 12:12:31 INFO - Successfully installed mozsystemmonitor 12:12:31 INFO - Cleaning up... 12:12:31 INFO - Return code: 0 12:12:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:12: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')]} 12:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12: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')]} 12:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102034618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe142c754a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f03d30>, '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 0x101c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101efbb20>, '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.fDdLc1n042/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.jlS9uS0cNI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 12:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:12:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fDdLc1n042/Render', 12:12:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:31 INFO - 'HOME': '/Users/cltbld', 12:12:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:31 INFO - 'LOGNAME': 'cltbld', 12:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:31 INFO - 'MOZ_NO_REMOTE': '1', 12:12:31 INFO - 'NO_EM_RESTART': '1', 12:12:31 INFO - 'PAGER': '/bin/cat', 12:12:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:31 INFO - 'PWD': '/builds/slave/test', 12:12:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:31 INFO - 'SHELL': '/bin/bash', 12:12:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlS9uS0cNI/Listeners', 12:12:31 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 12:12:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:31 INFO - 'USER': 'cltbld', 12:12:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:31 INFO - 'XPC_FLAGS': '0x0', 12:12:31 INFO - 'XPC_SERVICE_NAME': '0', 12:12:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:31 INFO - Downloading/unpacking jsonschema==2.5.1 12:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:12:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:34 INFO - Downloading functools32-3.2.3-2.tar.gz 12:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:12:34 INFO - warning: no files found matching '*.txt' 12:12:34 INFO - no previously-included directories found matching 'build' 12:12:34 INFO - no previously-included directories found matching 'dist' 12:12:34 INFO - no previously-included directories found matching '.git*' 12:12:34 INFO - Installing collected packages: jsonschema, functools32 12:12:34 INFO - Running setup.py install for functools32 12:12:34 INFO - warning: no files found matching '*.txt' 12:12:34 INFO - no previously-included directories found matching 'build' 12:12:34 INFO - no previously-included directories found matching 'dist' 12:12:34 INFO - no previously-included directories found matching '.git*' 12:12:34 INFO - Successfully installed jsonschema functools32 12:12:34 INFO - Cleaning up... 12:12:35 INFO - Return code: 0 12:12:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102034618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe142c754a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f03d30>, '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 0x101c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101efbb20>, '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.fDdLc1n042/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.jlS9uS0cNI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 12:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:12:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fDdLc1n042/Render', 12:12:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:35 INFO - 'HOME': '/Users/cltbld', 12:12:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:35 INFO - 'LOGNAME': 'cltbld', 12:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:35 INFO - 'MOZ_NO_REMOTE': '1', 12:12:35 INFO - 'NO_EM_RESTART': '1', 12:12:35 INFO - 'PAGER': '/bin/cat', 12:12:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:35 INFO - 'PWD': '/builds/slave/test', 12:12:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:35 INFO - 'SHELL': '/bin/bash', 12:12:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlS9uS0cNI/Listeners', 12:12:35 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 12:12:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:35 INFO - 'USER': 'cltbld', 12:12:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:35 INFO - 'XPC_FLAGS': '0x0', 12:12:35 INFO - 'XPC_SERVICE_NAME': '0', 12:12:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:12:35 INFO - Cleaning up... 12:12:35 INFO - Return code: 0 12:12:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102034618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe142c754a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f03d30>, '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 0x101c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101efbb20>, '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.fDdLc1n042/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.jlS9uS0cNI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 12:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:12:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fDdLc1n042/Render', 12:12:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:35 INFO - 'HOME': '/Users/cltbld', 12:12:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:35 INFO - 'LOGNAME': 'cltbld', 12:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:35 INFO - 'MOZ_NO_REMOTE': '1', 12:12:35 INFO - 'NO_EM_RESTART': '1', 12:12:35 INFO - 'PAGER': '/bin/cat', 12:12:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:35 INFO - 'PWD': '/builds/slave/test', 12:12:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:35 INFO - 'SHELL': '/bin/bash', 12:12:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlS9uS0cNI/Listeners', 12:12:35 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 12:12:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:35 INFO - 'USER': 'cltbld', 12:12:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:35 INFO - 'XPC_FLAGS': '0x0', 12:12:35 INFO - 'XPC_SERVICE_NAME': '0', 12:12:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:35 INFO - Downloading/unpacking blobuploader==1.2.4 12:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:38 INFO - Downloading blobuploader-1.2.4.tar.gz 12:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:12:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:12:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:39 INFO - Downloading docopt-0.6.1.tar.gz 12:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:12:39 INFO - Installing collected packages: blobuploader, requests, docopt 12:12:39 INFO - Running setup.py install for blobuploader 12:12:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:12:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:12:39 INFO - Running setup.py install for requests 12:12:40 INFO - Running setup.py install for docopt 12:12:40 INFO - Successfully installed blobuploader requests docopt 12:12:40 INFO - Cleaning up... 12:12:40 INFO - Return code: 0 12:12:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102034618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe142c754a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f03d30>, '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 0x101c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101efbb20>, '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.fDdLc1n042/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.jlS9uS0cNI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 12:12:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:12:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fDdLc1n042/Render', 12:12:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:40 INFO - 'HOME': '/Users/cltbld', 12:12:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:40 INFO - 'LOGNAME': 'cltbld', 12:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:40 INFO - 'MOZ_NO_REMOTE': '1', 12:12:40 INFO - 'NO_EM_RESTART': '1', 12:12:40 INFO - 'PAGER': '/bin/cat', 12:12:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:40 INFO - 'PWD': '/builds/slave/test', 12:12:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:40 INFO - 'SHELL': '/bin/bash', 12:12:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlS9uS0cNI/Listeners', 12:12:40 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 12:12:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:40 INFO - 'USER': 'cltbld', 12:12:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:40 INFO - 'XPC_FLAGS': '0x0', 12:12:40 INFO - 'XPC_SERVICE_NAME': '0', 12:12:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:12:40 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-GXsBVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:12:40 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-o6GkMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:12:40 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-FFRVgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:12:40 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-n96G0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:12:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-6o2Bbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:12:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-kRW4ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:12:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-z7I8J5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:12:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-HIRa0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:12:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Hpv5Xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:12:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-unF_YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:12:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-scSQpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:12:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-eZHsOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:12:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-OxatJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:12:41 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Zapcw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:12:42 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-643971-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:12:42 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Nh94OB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:12:42 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-19QPkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:12:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:12:42 INFO - Running setup.py install for manifestparser 12:12:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:12:42 INFO - Running setup.py install for mozcrash 12:12:42 INFO - Running setup.py install for mozdebug 12:12:42 INFO - Running setup.py install for mozdevice 12:12:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:12:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:12:42 INFO - Running setup.py install for mozfile 12:12:43 INFO - Running setup.py install for mozhttpd 12:12:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:12:43 INFO - Running setup.py install for mozinfo 12:12:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:12:43 INFO - Running setup.py install for mozInstall 12:12:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:12:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:12:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:12:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:12:43 INFO - Running setup.py install for mozleak 12:12:43 INFO - Running setup.py install for mozlog 12:12:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:12:43 INFO - Running setup.py install for moznetwork 12:12:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:12:44 INFO - Running setup.py install for mozprocess 12:12:44 INFO - Running setup.py install for mozprofile 12:12:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:12:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:12:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:12:44 INFO - Running setup.py install for mozrunner 12:12:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:12:44 INFO - Running setup.py install for mozscreenshot 12:12:44 INFO - Running setup.py install for moztest 12:12:44 INFO - Running setup.py install for mozversion 12:12:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:12:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:12:44 INFO - Cleaning up... 12:12:44 INFO - Return code: 0 12:12:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:12:44 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')]} 12:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:44 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')]} 12:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:44 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 0x101f9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102034618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe142c754a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f03d30>, '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 0x101c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101efbb20>, '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.fDdLc1n042/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.jlS9uS0cNI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 12:12:44 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 12:12:44 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 12:12:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fDdLc1n042/Render', 12:12:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:44 INFO - 'HOME': '/Users/cltbld', 12:12:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:44 INFO - 'LOGNAME': 'cltbld', 12:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:44 INFO - 'MOZ_NO_REMOTE': '1', 12:12:44 INFO - 'NO_EM_RESTART': '1', 12:12:44 INFO - 'PAGER': '/bin/cat', 12:12:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:44 INFO - 'PWD': '/builds/slave/test', 12:12:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:44 INFO - 'SHELL': '/bin/bash', 12:12:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlS9uS0cNI/Listeners', 12:12:44 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 12:12:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:44 INFO - 'USER': 'cltbld', 12:12:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:44 INFO - 'XPC_FLAGS': '0x0', 12:12:44 INFO - 'XPC_SERVICE_NAME': '0', 12:12:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:12:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-11X01S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:12:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-yB0ZcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:12:45 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)) 12:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:12:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-5MR_qV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:12:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-y1rIoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:12:45 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)) 12:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:12:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-WVXAzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:12:45 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)) 12:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:12:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-gwnyfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:12:45 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)) 12:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:12:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-oiom6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:12:45 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)) 12:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:12:45 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-_6xKpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:12:46 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-BUZjjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:12:46 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-bTyRNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:12:46 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)) 12:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:12:46 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-f_kVph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:12:46 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-fCLnsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:12:46 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-CHYDKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:12:46 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)) 12:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:12:46 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-sfiaa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:12:46 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)) 12:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:12:46 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-lfdCtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:12:46 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)) 12:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:12:46 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-1ZYomW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:12:46 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)) 12:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:12:46 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-0Ms3m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:12:46 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)) 12:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:12:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:12:49 INFO - Downloading blessings-1.6.tar.gz 12:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:12:49 INFO - Installing collected packages: blessings 12:12:49 INFO - Running setup.py install for blessings 12:12:49 INFO - Successfully installed blessings 12:12:49 INFO - Cleaning up... 12:12:49 INFO - Return code: 0 12:12:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:12:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:12:50 INFO - Reading from file tmpfile_stdout 12:12:50 INFO - Current package versions: 12:12:50 INFO - blessings == 1.6 12:12:50 INFO - blobuploader == 1.2.4 12:12:50 INFO - docopt == 0.6.1 12:12:50 INFO - functools32 == 3.2.3-2 12:12:50 INFO - jsonschema == 2.5.1 12:12:50 INFO - manifestparser == 1.1 12:12:50 INFO - mozInstall == 1.12 12:12:50 INFO - mozcrash == 0.17 12:12:50 INFO - mozdebug == 0.1 12:12:50 INFO - mozdevice == 0.48 12:12:50 INFO - mozfile == 1.2 12:12:50 INFO - mozhttpd == 0.7 12:12:50 INFO - mozinfo == 0.9 12:12:50 INFO - mozleak == 0.1 12:12:50 INFO - mozlog == 3.3 12:12:50 INFO - moznetwork == 0.27 12:12:50 INFO - mozprocess == 0.23 12:12:50 INFO - mozprofile == 0.28 12:12:50 INFO - mozrunner == 6.12 12:12:50 INFO - mozscreenshot == 0.1 12:12:50 INFO - mozsystemmonitor == 0.3 12:12:50 INFO - moztest == 0.7 12:12:50 INFO - mozversion == 1.4 12:12:50 INFO - psutil == 3.1.1 12:12:50 INFO - requests == 1.2.3 12:12:50 INFO - wsgiref == 0.1.2 12:12:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:50 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 0x101f9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102034618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe142c754a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f03d30>, '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 0x101c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101efbb20>, '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.fDdLc1n042/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.jlS9uS0cNI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 12:12:50 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 12:12:50 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 12:12:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fDdLc1n042/Render', 12:12:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:50 INFO - 'HOME': '/Users/cltbld', 12:12:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:50 INFO - 'LOGNAME': 'cltbld', 12:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:50 INFO - 'MOZ_NO_REMOTE': '1', 12:12:50 INFO - 'NO_EM_RESTART': '1', 12:12:50 INFO - 'PAGER': '/bin/cat', 12:12:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:50 INFO - 'PWD': '/builds/slave/test', 12:12:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:50 INFO - 'SHELL': '/bin/bash', 12:12:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlS9uS0cNI/Listeners', 12:12:50 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 12:12:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:50 INFO - 'USER': 'cltbld', 12:12:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:50 INFO - 'XPC_FLAGS': '0x0', 12:12:50 INFO - 'XPC_SERVICE_NAME': '0', 12:12:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:50 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)) 12:12:50 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)) 12:12:50 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)) 12:12:50 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)) 12:12:50 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)) 12:12:50 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)) 12:12:50 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)) 12:12:50 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)) 12:12:50 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)) 12:12:50 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)) 12:12:50 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)) 12:12:50 INFO - Cleaning up... 12:12:50 INFO - Return code: 0 12:12:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102034618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe142c754a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f03d30>, '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 0x101c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101efbb20>, '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.fDdLc1n042/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.jlS9uS0cNI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 12:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:12:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fDdLc1n042/Render', 12:12:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:12:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:12:50 INFO - 'HOME': '/Users/cltbld', 12:12:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:12:50 INFO - 'LOGNAME': 'cltbld', 12:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:50 INFO - 'MOZ_NO_REMOTE': '1', 12:12:50 INFO - 'NO_EM_RESTART': '1', 12:12:50 INFO - 'PAGER': '/bin/cat', 12:12:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:50 INFO - 'PWD': '/builds/slave/test', 12:12:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:12:50 INFO - 'SHELL': '/bin/bash', 12:12:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlS9uS0cNI/Listeners', 12:12:50 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 12:12:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:12:50 INFO - 'USER': 'cltbld', 12:12:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:12:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:50 INFO - 'XPC_FLAGS': '0x0', 12:12:50 INFO - 'XPC_SERVICE_NAME': '0', 12:12:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:12:50 INFO - Cleaning up... 12:12:50 INFO - Return code: 0 12:12:50 INFO - Running post-action listener: _resource_record_post_action 12:12:50 INFO - Running post-action listener: _start_resource_monitoring 12:12:50 INFO - Starting resource monitoring. 12:12:50 INFO - [mozharness: 2016-09-09 19:12:50.653931Z] Finished create-virtualenv step (success) 12:12:50 INFO - [mozharness: 2016-09-09 19:12:50.654974Z] Running install step. 12:12:50 INFO - Running pre-action listener: _resource_record_pre_action 12:12:50 INFO - Running main action method: install 12:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:12:50 INFO - Reading from file tmpfile_stdout 12:12:50 INFO - Detecting whether we're running mozinstall >=1.0... 12:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:12:51 INFO - Reading from file tmpfile_stdout 12:12:51 INFO - Output received: 12:12:51 INFO - Usage: mozinstall [options] installer 12:12:51 INFO - Options: 12:12:51 INFO - -h, --help show this help message and exit 12:12:51 INFO - -d DEST, --destination=DEST 12:12:51 INFO - Directory to install application into. [default: 12:12:51 INFO - "/builds/slave/test"] 12:12:51 INFO - --app=APP Application being installed. [default: firefox] 12:12:51 INFO - mkdir: /builds/slave/test/build/application 12:12:51 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'] 12:12:51 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 12:13:25 INFO - Reading from file tmpfile_stdout 12:13:25 INFO - Output received: 12:13:25 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 12:13:25 INFO - Running post-action listener: _resource_record_post_action 12:13:25 INFO - [mozharness: 2016-09-09 19:13:25.067775Z] Finished install step (success) 12:13:25 INFO - [mozharness: 2016-09-09 19:13:25.067950Z] Running run-tests step. 12:13:25 INFO - Running pre-action listener: _resource_record_pre_action 12:13:25 INFO - Running main action method: run_tests 12:13:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:13:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:13:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:13:25 INFO - 2016-09-09 12:13:25.082 screenresolution[1643:8150] starting screenresolution argv=screenresolution get 12:13:25 INFO - 2016-09-09 12:13:25.085 screenresolution[1643:8150] Display 0: 1600x1200x32@60 12:13:25 INFO - 2016-09-09 12:13:25.090 screenresolution[1644:8152] starting screenresolution argv=screenresolution list 12:13:25 INFO - Available Modes on Display 0 12:13:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:13:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:13:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:13:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:13:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:13:25 INFO - Intel Iris: 12:13:25 INFO - Chipset Model: Intel Iris 12:13:25 INFO - Type: GPU 12:13:25 INFO - Bus: Built-In 12:13:25 INFO - VRAM (Dynamic, Max): 1536 MB 12:13:25 INFO - Vendor: Intel (0x8086) 12:13:25 INFO - Device ID: 0x0a2e 12:13:25 INFO - Revision ID: 0x0009 12:13:25 INFO - Displays: 12:13:25 INFO - Display: 12:13:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:13:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:13:25 INFO - Display Serial Number: 1600x1200 60 12:13:25 INFO - Main Display: Yes 12:13:25 INFO - Mirror: Off 12:13:25 INFO - Online: Yes 12:13:25 INFO - Rotation: Supported 12:13:25 INFO - Return code: 0 12:13:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:13:25 INFO - Python 2.7.3 12:13:25 INFO - Return code: 0 12:13:25 INFO - grabbing minidump binary from tooltool 12:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:13:25 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 0x101f03d30>, '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 0x101c68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101efbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:13:25 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 12:13:25 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 12:13:25 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 12:13:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:13:25 INFO - Return code: 0 12:13:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:13:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:13:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:13:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:13:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:13:25 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0292', '--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 12:13:25 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0292 --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 12:13:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fDdLc1n042/Render', 12:13:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:13:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:13:25 INFO - 'HOME': '/Users/cltbld', 12:13:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:13:25 INFO - 'LOGNAME': 'cltbld', 12:13:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:13:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:25 INFO - 'MOZ_NO_REMOTE': '1', 12:13:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:13:25 INFO - 'NO_EM_RESTART': '1', 12:13:25 INFO - 'PAGER': '/bin/cat', 12:13:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:25 INFO - 'PWD': '/builds/slave/test', 12:13:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:13:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:13:25 INFO - 'SHELL': '/bin/bash', 12:13:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlS9uS0cNI/Listeners', 12:13:25 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 12:13:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:13:25 INFO - 'USER': 'cltbld', 12:13:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:13:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:25 INFO - 'XPC_FLAGS': '0x0', 12:13:25 INFO - 'XPC_SERVICE_NAME': '0', 12:13:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:13:25 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0292', '--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 12:13:25 INFO - mozversion application_buildid: 20160909104831 12:13:25 INFO - mozversion application_changeset: 644b3de5d7a18b101d44a003bc27d50853dee4c9 12:13:25 INFO - mozversion application_display_name: Nightly 12:13:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:13:25 INFO - mozversion application_name: Firefox 12:13:25 INFO - mozversion application_remotingname: firefox 12:13:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:13:25 INFO - mozversion application_vendor: Mozilla 12:13:25 INFO - mozversion application_version: 51.0a1 12:13:25 INFO - mozversion platform_buildid: 20160909104831 12:13:25 INFO - mozversion platform_changeset: 644b3de5d7a18b101d44a003bc27d50853dee4c9 12:13:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:13:25 INFO - mozversion platform_version: 51.0a1 12:13:25 INFO - using testdate: 1473448405 12:13:25 INFO - actual date: 1473448405 12:13:25 INFO - starting webserver on 'localhost:49274' 12:13:25 INFO - SUITE-START | Running 2 tests 12:13:25 INFO - TEST-START | dromaeo_css 12:13:25 INFO - operating with platform_type : mac_ 12:13:25 INFO - Initialising browser for dromaeo_css test... 12:13:25 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmp2zMRMg/profile http://localhost:49274/getInfo.html) 12:13:28 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 12:13:28 INFO - PROCESS | 1654 | colorDepth:24 12:13:28 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 12:13:28 INFO - PROCESS | 1654 | __metrics 12:13:28 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:13:28 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:13:29 INFO - TEST-INFO | 1654: exit 0 12:13:29 INFO - Browser initialized. 12:13:29 INFO - Running cycle 1/1 for dromaeo_css test... 12:13:29 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmp2zMRMg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:13:40 INFO - PROCESS | 1659 | RSS: Main: 232378368 12:13:40 INFO - PROCESS | 1659 | 12:14:32 INFO - PROCESS | 1659 | 1473448472644 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] 12:16:44 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 12:16:45 INFO - PROCESS | 1659 | RSS: Main: 411324416 12:16:45 INFO - PROCESS | 1659 | 12:19:48 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 12:19:49 INFO - PROCESS | 1659 | RSS: Main: 369049600 12:19:49 INFO - PROCESS | 1659 | 12:22:51 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 12:22:52 INFO - PROCESS | 1659 | RSS: Main: 340688896 12:22:52 INFO - PROCESS | 1659 | 12:25:54 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 12:25:55 INFO - PROCESS | 1659 | RSS: Main: 345436160 12:25:55 INFO - PROCESS | 1659 | 12:28:58 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 12:28:59 INFO - PROCESS | 1659 | RSS: Main: 330297344 12:28:59 INFO - PROCESS | 1659 | 12:32:02 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 12:32:02 INFO - PROCESS | 1659 | RSS: Main: 440266752 12:32:02 INFO - PROCESS | 1659 | 12:32:02 INFO - PROCESS | 1659 | __start_tp_report 12:32:02 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 12:32:02 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 12:32:02 INFO - PROCESS | 1659 | |i|pagename|runs| 12:32:02 INFO - PROCESS | 1659 | |0;dojo.html;3304.58692663417;3308.3052558962618;3335.5663763710727;3368.9157771055707;3386.932261354773;5512.33851937767;5581.386047534768;5615.719214039297;5671.943280567193;5690.032694441945;5641.069223578115;5641.661500309984;5685.459881311269;5718.685472299022;5777.971110144444;5030.723310217936;5052.317937078484;5056.367954005749;5121.257417674435;5175.741212939357;5231.816886408977;5271.4201437842;5273.551748101416;5281.498257665535;5331.733413329337;5074.188129899236;5208.192730126836;5212.244224587452;5270.262163297141;5276.182191760283;4209.473815773028;5091.567216786578;5163.993021360836;5166.586673066184;5172.379314482248;5077.086124497589;5134.897302053975;5140.460251673558;5145.51117643827;5159.638825282232;5660.150977353389;5663.093904975184;5676.403977582336;5713;5717.428257174291;6174.197354343906;6217.098520714516;6230.5638605297645;6237.594556353868;6242.500599951993;6098.14625952367;6144.109104179914;6278.30938596754;6306.905396419012;6310.2427708674795;5700.40145784695;5739.3973632768375;5767.423257674199;5804.477597016289;5860.355360910296;6228.408301211378;6302;6314.958031924681;6321.051842223703;6340.7463701451425;5934.228550288435;6145.631262124287;6148.6925653717135;6159.722812473449;6161.630302181794;6120.294761999531;6127.816165515042;6159.907601385983;6161.199044124235;6166.81499555014;6146.754129834757;6166.660833654102;6226.128342032119;6240.812775616739;6256.968715156395;6184.907226391608;6231.376862313823;6232;6235;6257.186565746424;4841.419029716457;4860.392450943632;4883.658143929962;4929.802807887644;4931.3589233399425;4372.584604462571;4395.099004704028;4409.5149533551285;4420.359047938031;4430.357598148251;5694.572907031989;5700.429957004267;5703.857403564861;5713;5757.942420575824;6129.295131059986;6143.757528502065;6254.968725156436;6271.592346497463;6273.905891411632;5616.269884914935;5661.773529058792;5662.688552129673;5689.687067211343;5741.368449470555;5375.650582712189;5379.596530260246;5386.622936394415;5387.030334539742;5424.186372044146;6234.189555357774;6287.245530536365;6310.684465776784;6316.968415157895;6320.462760665395;6083.026715725463;6087.117367981707;6133.049377346519;6193.349698281616;6251.624902505864;6273.3099359071375;6274.717637706405;6288.276848162337;6295.779647712308;6317.6209427434505;6168.25980882297;6174.629522228681;6177.444030037318;6190;6206.410391012847;5969.343372228965;6108.450239478469;6127.509799215963;6239.469645080219;6263.592866463665;6024.90962635552;6034.064719968412;6044.879102418015;6050.092486127116;6057.969710151598;6004.0693692477735;6060.363661815446;6094.451499365078;6114.785982490592;6120.387961203844;5895.115732640138;5946.256717910262;5948.048312270016;5956.642601443928;5966.582339236385;5945.197398351167;6103.084537319438;6104.725287361991;6117.816465506042;6122.357152498924;5732.799352022826;5741.569382296261;5769.711514424346;5774.48029677331;5871.266091738533 12:32:02 INFO - PROCESS | 1659 | |1;ext.html;476.749706404138;499.14645955416216;527.7282199667171;531.2907268796157;535.5929493584877;30427.543586846186;40610.59389406105;41363.79318103409;41483;43723;43141;43214.13571728564;43343.13313733731;43470.56529434705;43496.347554786706;9719.222462203043;9934.50327483623;9935.652252171176;9940.254480913924;9964.153046991014;9786.510674466284;9907.356021858555;9912.90087099127;9916.305858589902;9916.603335866557;9884.950575247114;9901.603935842557;9923.950380248089;9944.552495137736;9965.451900145488;9851.556679949384;9918.206543476505;9922.652707155252;9938.403695778277;9951.154151897097;9737.610495580238;9787.804243915081;9792.902070979342;9804.215662746963;9815.214782817358;41387.37918931218;41759;41759.582404175875;41775.7911210442;41818.1636367274;3304.8843290484956;3572.8928132156075;3807.9428808567895;4015.678745700337;4167.937480937789;25710.10014649497;31170.064898053093;31608;31617.683823161933;31689.890853820005;3003.9098827035223;3114.875404983798;3140.277736120682;3181.904542863718;3181.96818031819;468265.317346829;469730;470767;473313.6334318306;474952;60848.78302433927;61202.38797612056;61280.69359653263;61328;61373.693131534055;64576;64580.70838583296;64661.03008454877;64668;64815;16337.428190013292;16539.83460165383;16579.088150151616;16584.08787516674;16607.91696041536;12742.98056155524;12826.871731282754;12839.55061572859;12839.679008024686;12893.35533223335;16834;17436.564085897953;17450.865693729866;17462.738058929128;17512.912435437996;5715.371309155989;6742.865142697118;6877.793666189922;6881.827954301082;6997.475189360818;838.3419016072354;956.1872408452898;957.5020989085637;971.577363846729;1037.5071840875676;29694.109176724734;30235.69764302329;30805.84597077045;31039.689603104132;31244.843775780977;998.8451789972421;1006.3609607899036;1012.1548506996741;1033.7777377863645;1109.3732041396586;14930.178840163895;15540.533783986499;15543.378264869505;15669.336212843617;15965.962212456154;641663.7916810386;677793;678810.6059469671;678876;679463;56477.15284270739;56693.43306566964;56763.43236567664;56845;56866.86266274734;1051.2693677893944;1257.9622611321493;1260.086437332963;1368.8699573540498;1392.3664732546667;23813.34999851212;32324.83837580797;32452.35095298128;32653;33111.17222069467;56607.43392566022;57390;57490.137647934476;57496.712516437154;57642.7117864408;616232;622279;622442;623454;624276;25345.112921047676;26051.609225862005;26181.821818017856;26205.606915895896;26208.73791262063;46704.7664761674;47248.85764850547;47336.28995565138;47714.04571908612;48582;38776.806115970365;38785.418218726176;38906.4164037534;39437.408438874016;40323;31607.683923160475;35426.82286588551;38907;39594.60405395909;39808.60191398165;37098.258034839695;37357;38210.617893821815;38381.61618383892;38385.4242186373;32817.83591082029;33628.831855840566;34524.654753452145;34857.302853942274;34932.236181029846;25197.874010630563;25319;25337.98648054057;25579.48841023132;26114.73885261123 12:32:02 INFO - PROCESS | 1659 | |2;jquery.html;299.7571966706969;365.5047410758422;371.489202346773;381.88925211688604;402.24779662032006;15024.624384390396;15114.244287785608;16444.424445144406;20925.581488370222;20978.26576069834;18617.069146542653;20418.7748735076;20909;21188;21422.678659820114;5551.417101204376;5975.880482390349;6246.937530624704;6249.312575616678;6263.592866463665;5928.614640048383;6151.384861513835;6226.097215903691;6226.501879849624;6227.252729672446;5819.185314056035;6074;6190.566660333779;6211.47202487789;6214.440700336969;6062.939370606282;6100.5119590433105;6107.908381374283;6110.511159107261;6116.204893363834;5030.84907452777;5240.8689782755355;5303.337082864642;5304.761285742151;5306.70813105279;19026.809731902642;24070.546948814525;24110.156144534856;24575.754242457704;24575.894084766227;2188.4310079379316;2497.113524698742;2611.8041146914056;2711.2544050386105;2793.4273473937997;15467.922660386626;15512.819871926227;15548.689026219412;15877.20613969297;16000.919995400065;1512.6974605078917;1525.85504377084;1812.954676133094;1822.1071674879347;1866.2441711107024;78543.60728196379;87234.56382718046;114628.42685786601;114709;115735;10653.201009924287;10957.83563246552;11058.281211721212;11152.386618735885;11308.208425410143;13948.232847193502;13951.441942322397;13958.651033724034;13959.441622334993;13968.860311396958;8496.830063398698;8664.61009254585;8670.176333248332;8684.218420342073;8841.248493878093;8723.040465548911;8728.825423491495;8742.388032837767;8922.152395522415;8924.464532128093;6009.45914867664;6295.622262664255;6744.145360025934;6773;6777.322267773183;1476.3282706368577;1810.1763697517597;1810.3030333321503;1812.3236006693755;1815.0924537731134;869.4739682492128;887.6981826179001;888.3648191543077;981.2983716642492;994.2841154368842;21166.894165529073;21728.565428691338;21731.23940662069;21788.782112178676;21884.781152188592;905.3752910491739;908.42315129893;937.3625934364561;939.8721534159037;942.783159873233;8618.698345557876;9099.81257488304;10754.870738572494;11455.656330310105;11788.115891308185;574804;580057;593801;596506;598820;109552.4522377383;112653.87346126598;115081;116120;118628;1001.6344034427382;1007;1008.2589296866797;1011.2112552209288;1020.6733845169474;18827;19007.438214828617;19207.51981200481;19255.422337329903;19363.4190974271;47377.76311118422;47708;47961;48310.27534586914;48486.75756621194;47142.764286178346;63467;63520.411989700624;64876;65935.68128637497;7816.687332506636;7850.725224617111;8103.432759706764;8141.185881411811;8300.833983320179;12666.176698514568;12869.935650321688;12954.870451295366;13296.335183240994;13349.733005339645;11270.985611295022;11349.886501135214;11364.590622813288;11627.59303424376;11639.59261425846;10979.615713449992;11148.498317575566;11340.20618556693;11635.01102406305;11655.88344116548;11440.42797860087;11575.073994080285;11625.709357266136;11628.418579071182;11820.349880756641;6676.232233293234;7341.6329183541675;7437.107547094383;8054.3556515479795;8338.458000229966;7375.483716139819;10848.728781780203;10878.619248326271;11232.157588181082;11337.829932550854 12:32:02 INFO - PROCESS | 1659 | |3;mootools.html;1288.5876519513756;1332.380443093961;1348.514534767484;1460.3647413375186;1881.5954569767498;7604;7709.614519274035;8237.176282371767;8251.257386835183;8824.735257942271;8655;8752.256058235058;8757.386982911199;8761.649534018648;8764.342674299438;1960.4902725291456;1983.7321961535224;1985.930492432765;1986.5133042404632;1989.1943762776027;2362.991730523466;2394.832361734679;2407.57867373209;2407.6027455469825;2408.8795560222006;2167.967480487794;2240.2943072932057;2361.2680069178523;2389.545986262613;2403.8557686538775;2350.764923507653;2370.2059809963685;2378.286514045788;2379.6430535419654;2383.9165629202894;2355.3169580821714;2359.858408495496;2360.775726305998;2369.478714682767;2373.4185124644573;8682.6092825823;8764.73705788821;8800.779980500474;8824.338174636863;8828.69099581518;4995.800167993276;5182.093133701587;5187.740612969336;5228.503292187236;5230.973845130788;3474;3676.3198808220563;3689.631036896316;3712.2946640138557;3722.7021838252876;1040.4537617750666;1076.8761592416815;1082.8629938564475;1085.696005118568;1094.3762055628295;11617.012553932926;11642.24325418845;11754.47104880274;11759.412029398496;11768.2939023658;4356.5187836135865;4538.863834084983;4651.139539185261;4666.136764698542;4671.556202160789;9161.358704890594;9165.220956218664;9181.908180918239;9190.264778817678;9196.816063678823;5247.790088396498;5253.684778913277;5253.973730131325;5261.789788348625;5275.525202731773;4076.470058892325;4394.494633117169;4562.931556026662;4911.435184953704;4947.579455746302;3732.402815549499;3797.9620203798163;3853.9229215415535;3866.5940076291586;3866.941995870064;1174.3130268792681;1174.682835634374;1177.7821103095955;1192.66605350502;1196.4376742930808;746.3693179263514;875.2166810704384;892.6607889002138;893.4907102951255;909.6406919266985;5583.69289689071;5712.514436272963;5756.758508267765;5885.967497789414;5966.522678185735;440.86544667414654;440.86553601151314;449.62905602877754;452.83471532890917;454.31171774761265;3827.4067519534515;3847.9038024049623;3942.2706799242233;3945.467361906163;3973.1854969731135;10463.267571269938;10734.785304294026;10834.566617335377;10852.565897364017;10913.781724365468;10782.406967616856;10796.78406431867;10799.78400431987;10812.243142979916;10866.185036122164;7917.327027202752;8057.274845263954;8147.185281471805;8235.8352832943;8243.175682431709;5619.297587801525;5684.573656975826;5688.544916406595;5762.2221000164445;5815.273090863642;9654.613815447303;9846.08001439741;10015.599376024877;10121.03850134236;10168.135708464863;9341.766455838659;10110.292279540361;10161.593536258466;10236.744081398025;10295.279330447096;5949.6430214187285;6612.966935165294;6810.591364517946;6894.965525172543;7078.893816592652;8263.380246481418;8265.628046738031;8328.500289982621;8345.248927596545;8368.539730314891;7492.662830172764;7527.134379546423;7533.171351151478;7553.811154721176;7618.5809780462605;7313.341799238094;7367.189609142883;7369.373603243785;7424.888626670712;7512.173660897188;6659.234188068434;6932.61870597122;6974.337437943387;6984.825379365557;6996.370326670624;4857.975710121426;4974.303597496281;4985.5762260208285;5021.84934451967;5168.3539557555305;4021.91956160881;4602.861914142581;4615.907681846412;4665.576999015333;4808 12:32:02 INFO - PROCESS | 1659 | |4;prototype.html;297.84660899636685;299.3145696355346;306.45145190109696;310.51559567075367;312.87677238713013;4318.8488402905905;5267.683938963665;5281.042616134967;5315.973420132898;5321.946780532198;4331.696781225308;4882.438519570251;5046.697198168104;5055.39335279767;5245.921311180326;3030.9696903031017;3769.962300377002;3852.6725228355485;3914.725969182158;3915.804209789513;3265.4448743713624;3997.3604223324273;4031.294523458383;4033.2740106780766;4034.9394759078637;3729.4592284118785;3960.544537378195;3989.1822176453757;3990.38149086892;4001.4598029266112;3916.608339166089;3947.46709194258;3973.7615743055508;3983.521977362706;4011.618896204856;3436.1066122808;3436.381451338758;3437.7077948374417;3445.0870519312152;3451.3606037132413;5108.744562771846;5119.135053034972;5128.743562821881;5131.486851314876;5148.639595228336;3611.963880361215;3912.5304963404287;4149.647279981205;4156.39978608238;4521.660875434355;4605.355250264965;4702.3181638662545;4970.478099799541;5004.499550045003;5506.91739623906;3510.192655689206;3726.9254614907823;3753.3431649461236;3756.145329549535;3756.69946404287;4890.535399137077;4917.877053073666;5449.3188351456065;5614.045612245887;5660.801871934463;3788.9431658525145;3790.677792387678;3797.240551889633;3808.8857334280015;3812.6187381262207;3812.656860882478;3857.2478366718783;3868.5551161616213;3868.709846761504;3873;3991;4554.840580579664;4560.270356742905;4577.313402989512;4578.313253012075;4337.457817772778;4551.772411379484;5379.919301210485;5513.8345849624575;5529.253550770594;1305.2233920817098;1316.7490883660369;1319.9142055766345;1321.5837011341396;1331.5353111577188;719.3022767915114;838.4508147163617;853.5988085599759;888.3426264564305;894.1639567004871;5224.675019616234;5230.137027390514;5232.790688372498;5239.842804715865;5246.501582349671;4582.977085114553;4980.5019498049905;5393.867287869592;5620.690862002629;5704.458076482728;4787.904241915142;4982.800687972441;5071.594272458195;5137.383513978271;5176.7411629418375;2266.6713326567883;2369.419492224416;2539.996701302975;2953.556966455049;2967.4065186962694;4563.771811409416;4713.064591066498;5076.644634875597;5297.390800057966;5588.702665427418;4587.243104887723;4788.712746983387;5660.801871934545;5774.0945487988865;5808.30300363959;5829.271341082364;5863.677497737665;5865.659412035064;5870.530357571384;5876.239206907582;4628.5371462853445;4847.297141914332;4982.551570358685;5056.292119103255;5259.815906443256;5073.340465739578;5361;5583.776648933997;5599.384067752462;5619.667837847248;5052.014857102829;5807.332156802022;5867.266591676041;5871.6183448075735;5881.411858814085;3638.7270954679034;3777.9244415110993;3781.3551105269294;3809.5809460958717;3824.2733880562605;4156.210320039183;4893.559579637849;5180.963807238492;5421.241026256248;5580.014692139685;5023.09584274834;5167.777855522161;5386.461353864739;5500.4499550044675;5510.862228444321;4539.046800172001;5279.574514881037;5361.785528578813;5436.864078398072;5505.779768809363;4821;4948.455669876239;4958.6611614864505;5360.490753378423;5385.192221166856;4950.108980383421;5108;5477.643953143033;5541.861453463695;5578.497935185853;5437.10287802524;5448.858867260831;5449.6730196188355;5456.43547532659;5469.097598896137 12:32:02 INFO - PROCESS | 1659 | |5;yui.html;673.7204060314966;676.8240257533046;684.2985939412102;770.8265640230949;795.7135431244752;14931.477398291063;15766.21168941554;15884;16051.357945682174;16450.42423515177;14669.413223471074;14775.335109920052;14894.329755161016;14935.327910244037;14973.775393369107;702.9191642961074;849.7450764770575;868.891388576428;869.1525762381691;869.4044579463057;677.7221339250908;691.2085661917101;695.2873304862532;835.9498430094213;885.6014793342989;913.8949020862586;924.7040946896996;926.5969303353063;929.1126973740062;930.3069213435966;919.9862002069974;920.5995392004467;921.258386998466;922.2022950148073;923.8937522184967;432.3126229295435;539.7220431477792;540.3704684043086;683.5454422808826;686.3925425997978;12566;12611.054170937216;14393.496227631982;14802.963792534527;14921.701565968728;14340.92829535856;14738.852611473856;14793.40826366944;15027.924860375628;15215.239238038053;11934.940325298405;12007.939960300142;12056.63830085099;12070.69823254417;12122.691076061887;3807.7715337079862;3847.076701591598;3861.6331448512346;3890.0469385000574;4000.5399379071487;119400;120055;120459;123099.38450307692;123680.38159809144;11124.777504449865;11208.495617697223;11241.156913231376;11380.487878045507;11608.709782255512;20868.791312086683;23765;23766.405839854142;23774.286771396884;23806;7941.36469082472;8089.9191008089165;8111.513309201467;8152.836943261102;8230.21812927771;4198.895027624334;4391.25348690717;4427.070315233773;4556.225441674923;4602.263637817933;3463.8268086595567;3617.8914632561064;3627.437747149196;3628.9455658165148;3629.4374371972385;656.7241758461457;670.1087553553762;680.2721088435327;690.602903330587;695.8225652458591;635.1806170040596;635.4471609699499;668.6924014953177;678.9456843452512;688.7448765916129;9049.366544341832;9355.345125841126;9496;9762;9766.07222313879;641.4195153386192;655.7147640776277;672.2605134352272;673.1854456108164;683.62400679627;4360.738355698668;4421.734695918255;4561.657875659339;4593.724376537419;4764.737939413366;166439;166984;170483;172007;172076.1396193011;90685;112172;141442;142110.2894485521;144523;94411;94753;97267;123119;128810.35594822154;9115.27077833785;9859.802803943738;9912.752181195528;10060.899391005996;10068.093871551595;55940.720296398256;61185.47036324128;61440.69279653573;62883.6855815718;62985;63335;85160.57419712862;91930;92865;93883.53058234665;12762.42569084412;12877.424515097206;13382.866171338163;13495.325233738078;13537.864621354054;14730.852691473377;14833.777493337824;14900.552983410515;14913.62715932067;15456.536303910902;13676.384562694504;13677.521286754916;13706.603838957626;14153.858461415666;14280.214588197749;13499.32503374847;13727.794083088962;13762.518311859038;13770.380332884844;13792.655183620489;11069.5572177112;13357.866421336052;13423.463061477432;13522.93238533801;13559.59321220365;11012.080215025855;11495.942520287344;11567.421628918351;11655.825162622737;11659.591914282959;9801.607935682492;10428.426436546062;10705.785884282115;11563.6530904073;11583.305001699588 12:32:02 INFO - PROCESS | 1659 | __end_tp_report 12:32:02 INFO - PROCESS | 1659 | __start_cc_report 12:32:02 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1587 12:32:02 INFO - PROCESS | 1659 | __end_cc_report 12:32:02 INFO - PROCESS | 1659 | __startTimestamp1473449522817__endTimestamp 12:32:02 INFO - PROCESS | 1659 | 12:32:02 INFO - PROCESS | 1659 | ------- Summary: start ------- 12:32:02 INFO - PROCESS | 1659 | Number of tests: 6 12:32:02 INFO - PROCESS | 1659 | 12:32:02 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5711.63 Median:5945.20 stddev:647.88 (10.9%) stddev-sans-first:621.74 12:32:02 INFO - PROCESS | 1659 | Values: 3304.6 3308.3 3335.6 3368.9 3386.9 5512.3 5581.4 5615.7 5671.9 5690.0 5641.1 5641.7 5685.5 5718.7 5778.0 5030.7 5052.3 5056.4 5121.3 5175.7 5231.8 5271.4 5273.6 5281.5 5331.7 5074.2 5208.2 5212.2 5270.3 5276.2 4209.5 5091.6 5164.0 5166.6 5172.4 5077.1 5134.9 5140.5 5145.5 5159.6 5660.2 5663.1 5676.4 5713.0 5717.4 6174.2 6217.1 6230.6 6237.6 6242.5 6098.1 6144.1 6278.3 6306.9 6310.2 5700.4 5739.4 5767.4 5804.5 5860.4 6228.4 6302.0 6315.0 6321.1 6340.7 5934.2 6145.6 6148.7 6159.7 6161.6 6120.3 6127.8 6159.9 6161.2 6166.8 6146.8 6166.7 6226.1 6240.8 6257.0 6184.9 6231.4 6232.0 6235.0 6257.2 4841.4 4860.4 4883.7 4929.8 4931.4 4372.6 4395.1 4409.5 4420.4 4430.4 5694.6 5700.4 5703.9 5713.0 5757.9 6129.3 6143.8 6255.0 6271.6 6273.9 5616.3 5661.8 5662.7 5689.7 5741.4 5375.7 5379.6 5386.6 5387.0 5424.2 6234.2 6287.2 6310.7 6317.0 6320.5 6083.0 6087.1 6133.0 6193.3 6251.6 6273.3 6274.7 6288.3 6295.8 6317.6 6168.3 6174.6 6177.4 6190.0 6206.4 5969.3 6108.5 6127.5 6239.5 6263.6 6024.9 6034.1 6044.9 6050.1 6058.0 6004.1 6060.4 6094.5 6114.8 6120.4 5895.1 5946.3 5948.0 5956.6 5966.6 5945.2 6103.1 6104.7 6117.8 6122.4 5732.8 5741.6 5769.7 5774.5 5871.3 12:32:02 INFO - PROCESS | 1659 | 12:32:02 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:72141.69 Median:41759.29 stddev:159033.53 (380.8%) stddev-sans-first:159388.64 12:32:02 INFO - PROCESS | 1659 | Values: 476.7 499.1 527.7 531.3 535.6 30427.5 40610.6 41363.8 41483.0 43723.0 43141.0 43214.1 43343.1 43470.6 43496.3 9719.2 9934.5 9935.7 9940.3 9964.2 9786.5 9907.4 9912.9 9916.3 9916.6 9885.0 9901.6 9924.0 9944.6 9965.5 9851.6 9918.2 9922.7 9938.4 9951.2 9737.6 9787.8 9792.9 9804.2 9815.2 41387.4 41759.0 41759.6 41775.8 41818.2 3304.9 3572.9 3807.9 4015.7 4167.9 25710.1 31170.1 31608.0 31617.7 31689.9 3003.9 3114.9 3140.3 3181.9 3182.0 468265.3 469730.0 470767.0 473313.6 474952.0 60848.8 61202.4 61280.7 61328.0 61373.7 64576.0 64580.7 64661.0 64668.0 64815.0 16337.4 16539.8 16579.1 16584.1 16607.9 12743.0 12826.9 12839.6 12839.7 12893.4 16834.0 17436.6 17450.9 17462.7 17512.9 5715.4 6742.9 6877.8 6881.8 6997.5 838.3 956.2 957.5 971.6 1037.5 29694.1 30235.7 30805.8 31039.7 31244.8 998.8 1006.4 1012.2 1033.8 1109.4 14930.2 15540.5 15543.4 15669.3 15966.0 641663.8 677793.0 678810.6 678876.0 679463.0 56477.2 56693.4 56763.4 56845.0 56866.9 1051.3 1258.0 1260.1 1368.9 1392.4 23813.3 32324.8 32452.4 32653.0 33111.2 56607.4 57390.0 57490.1 57496.7 57642.7 616232.0 622279.0 622442.0 623454.0 624276.0 25345.1 26051.6 26181.8 26205.6 26208.7 46704.8 47248.9 47336.3 47714.0 48582.0 38776.8 38785.4 38906.4 39437.4 40323.0 31607.7 35426.8 38907.0 39594.6 39808.6 37098.3 37357.0 38210.6 38381.6 38385.4 32817.8 33628.8 34524.7 34857.3 34932.2 25197.9 25319.0 25338.0 25579.5 26114.7 12:32:02 INFO - PROCESS | 1659 | 12:32:02 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:33441.48 Median:13536.50 stddev:97504.43 (720.3%) stddev-sans-first:97746.20 12:32:02 INFO - PROCESS | 1659 | Values: 299.8 365.5 371.5 381.9 402.2 15024.6 15114.2 16444.4 20925.6 20978.3 18617.1 20418.8 20909.0 21188.0 21422.7 5551.4 5975.9 6246.9 6249.3 6263.6 5928.6 6151.4 6226.1 6226.5 6227.3 5819.2 6074.0 6190.6 6211.5 6214.4 6062.9 6100.5 6107.9 6110.5 6116.2 5030.8 5240.9 5303.3 5304.8 5306.7 19026.8 24070.5 24110.2 24575.8 24575.9 2188.4 2497.1 2611.8 2711.3 2793.4 15467.9 15512.8 15548.7 15877.2 16000.9 1512.7 1525.9 1813.0 1822.1 1866.2 78543.6 87234.6 114628.4 114709.0 115735.0 10653.2 10957.8 11058.3 11152.4 11308.2 13948.2 13951.4 13958.7 13959.4 13968.9 8496.8 8664.6 8670.2 8684.2 8841.2 8723.0 8728.8 8742.4 8922.2 8924.5 6009.5 6295.6 6744.1 6773.0 6777.3 1476.3 1810.2 1810.3 1812.3 1815.1 869.5 887.7 888.4 981.3 994.3 21166.9 21728.6 21731.2 21788.8 21884.8 905.4 908.4 937.4 939.9 942.8 8618.7 9099.8 10754.9 11455.7 11788.1 574804.0 580057.0 593801.0 596506.0 598820.0 109552.5 112653.9 115081.0 116120.0 118628.0 1001.6 1007.0 1008.3 1011.2 1020.7 18827.0 19007.4 19207.5 19255.4 19363.4 47377.8 47708.0 47961.0 48310.3 48486.8 47142.8 63467.0 63520.4 64876.0 65935.7 7816.7 7850.7 8103.4 8141.2 8300.8 12666.2 12869.9 12954.9 13296.3 13349.7 11271.0 11349.9 11364.6 11627.6 11639.6 10979.6 11148.5 11340.2 11635.0 11655.9 11440.4 11575.1 11625.7 11628.4 11820.3 6676.2 7341.6 7437.1 8054.4 8338.5 7375.5 10848.7 10878.6 11232.2 11337.8 12:32:02 INFO - PROCESS | 1659 | 12:32:02 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5597.55 Median:4658.36 stddev:3207.05 (68.8%) stddev-sans-first:3199.70 12:32:02 INFO - PROCESS | 1659 | Values: 1288.6 1332.4 1348.5 1460.4 1881.6 7604.0 7709.6 8237.2 8251.3 8824.7 8655.0 8752.3 8757.4 8761.6 8764.3 1960.5 1983.7 1985.9 1986.5 1989.2 2363.0 2394.8 2407.6 2407.6 2408.9 2168.0 2240.3 2361.3 2389.5 2403.9 2350.8 2370.2 2378.3 2379.6 2383.9 2355.3 2359.9 2360.8 2369.5 2373.4 8682.6 8764.7 8800.8 8824.3 8828.7 4995.8 5182.1 5187.7 5228.5 5231.0 3474.0 3676.3 3689.6 3712.3 3722.7 1040.5 1076.9 1082.9 1085.7 1094.4 11617.0 11642.2 11754.5 11759.4 11768.3 4356.5 4538.9 4651.1 4666.1 4671.6 9161.4 9165.2 9181.9 9190.3 9196.8 5247.8 5253.7 5254.0 5261.8 5275.5 4076.5 4394.5 4562.9 4911.4 4947.6 3732.4 3798.0 3853.9 3866.6 3866.9 1174.3 1174.7 1177.8 1192.7 1196.4 746.4 875.2 892.7 893.5 909.6 5583.7 5712.5 5756.8 5886.0 5966.5 440.9 440.9 449.6 452.8 454.3 3827.4 3847.9 3942.3 3945.5 3973.2 10463.3 10734.8 10834.6 10852.6 10913.8 10782.4 10796.8 10799.8 10812.2 10866.2 7917.3 8057.3 8147.2 8235.8 8243.2 5619.3 5684.6 5688.5 5762.2 5815.3 9654.6 9846.1 10015.6 10121.0 10168.1 9341.8 10110.3 10161.6 10236.7 10295.3 5949.6 6613.0 6810.6 6895.0 7078.9 8263.4 8265.6 8328.5 8345.2 8368.5 7492.7 7527.1 7533.2 7553.8 7618.6 7313.3 7367.2 7369.4 7424.9 7512.2 6659.2 6932.6 6974.3 6984.8 6996.4 4858.0 4974.3 4985.6 5021.8 5168.4 4021.9 4602.9 4615.9 4665.6 4808.0 12:32:02 INFO - PROCESS | 1659 | 12:32:02 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4373.00 Median:4933.17 stddev:1336.40 (27.1%) stddev-sans-first:1304.68 12:32:02 INFO - PROCESS | 1659 | Values: 297.8 299.3 306.5 310.5 312.9 4318.8 5267.7 5281.0 5316.0 5321.9 4331.7 4882.4 5046.7 5055.4 5245.9 3031.0 3770.0 3852.7 3914.7 3915.8 3265.4 3997.4 4031.3 4033.3 4034.9 3729.5 3960.5 3989.2 3990.4 4001.5 3916.6 3947.5 3973.8 3983.5 4011.6 3436.1 3436.4 3437.7 3445.1 3451.4 5108.7 5119.1 5128.7 5131.5 5148.6 3612.0 3912.5 4149.6 4156.4 4521.7 4605.4 4702.3 4970.5 5004.5 5506.9 3510.2 3726.9 3753.3 3756.1 3756.7 4890.5 4917.9 5449.3 5614.0 5660.8 3788.9 3790.7 3797.2 3808.9 3812.6 3812.7 3857.2 3868.6 3868.7 3873.0 3991.0 4554.8 4560.3 4577.3 4578.3 4337.5 4551.8 5379.9 5513.8 5529.3 1305.2 1316.7 1319.9 1321.6 1331.5 719.3 838.5 853.6 888.3 894.2 5224.7 5230.1 5232.8 5239.8 5246.5 4583.0 4980.5 5393.9 5620.7 5704.5 4787.9 4982.8 5071.6 5137.4 5176.7 2266.7 2369.4 2540.0 2953.6 2967.4 4563.8 4713.1 5076.6 5297.4 5588.7 4587.2 4788.7 5660.8 5774.1 5808.3 5829.3 5863.7 5865.7 5870.5 5876.2 4628.5 4847.3 4982.6 5056.3 5259.8 5073.3 5361.0 5583.8 5599.4 5619.7 5052.0 5807.3 5867.3 5871.6 5881.4 3638.7 3777.9 3781.4 3809.6 3824.3 4156.2 4893.6 5181.0 5421.2 5580.0 5023.1 5167.8 5386.5 5500.4 5510.9 4539.0 5279.6 5361.8 5436.9 5505.8 4821.0 4948.5 4958.7 5360.5 5385.2 4950.1 5108.0 5477.6 5541.9 5578.5 5437.1 5448.9 5449.7 5456.4 5469.1 12:32:02 INFO - PROCESS | 1659 | 12:32:02 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:25518.47 Median:3629.19 stddev:41821.96 (1152.4%) stddev-sans-first:41897.68 12:32:02 INFO - PROCESS | 1659 | Values: 673.7 676.8 684.3 770.8 795.7 14931.5 15766.2 15884.0 16051.4 16450.4 14669.4 14775.3 14894.3 14935.3 14973.8 702.9 849.7 868.9 869.2 869.4 677.7 691.2 695.3 835.9 885.6 913.9 924.7 926.6 929.1 930.3 920.0 920.6 921.3 922.2 923.9 432.3 539.7 540.4 683.5 686.4 12566.0 12611.1 14393.5 14803.0 14921.7 14340.9 14738.9 14793.4 15027.9 15215.2 11934.9 12007.9 12056.6 12070.7 12122.7 3807.8 3847.1 3861.6 3890.0 4000.5 119400.0 120055.0 120459.0 123099.4 123680.4 11124.8 11208.5 11241.2 11380.5 11608.7 20868.8 23765.0 23766.4 23774.3 23806.0 7941.4 8089.9 8111.5 8152.8 8230.2 4198.9 4391.3 4427.1 4556.2 4602.3 3463.8 3617.9 3627.4 3628.9 3629.4 656.7 670.1 680.3 690.6 695.8 635.2 635.4 668.7 678.9 688.7 9049.4 9355.3 9496.0 9762.0 9766.1 641.4 655.7 672.3 673.2 683.6 4360.7 4421.7 4561.7 4593.7 4764.7 166439.0 166984.0 170483.0 172007.0 172076.1 90685.0 112172.0 141442.0 142110.3 144523.0 94411.0 94753.0 97267.0 123119.0 128810.4 9115.3 9859.8 9912.8 10060.9 10068.1 55940.7 61185.5 61440.7 62883.7 62985.0 63335.0 85160.6 91930.0 92865.0 93883.5 12762.4 12877.4 13382.9 13495.3 13537.9 14730.9 14833.8 14900.6 14913.6 15456.5 13676.4 13677.5 13706.6 14153.9 14280.2 13499.3 13727.8 13762.5 13770.4 13792.7 11069.6 13357.9 13423.5 13522.9 13559.6 11012.1 11495.9 11567.4 11655.8 11659.6 9801.6 10428.4 10705.8 11563.7 11583.3 12:32:02 INFO - PROCESS | 1659 | -------- Summary: end -------- 12:32:02 INFO - PROCESS | 1659 | 12:32:03 INFO - TEST-INFO | 1659: exit 0 12:32:03 INFO - TEST-OK | dromaeo_css | took 1117762ms 12:32:03 INFO - TEST-START | kraken 12:32:03 INFO - operating with platform_type : mac_ 12:32:03 INFO - Initialising browser for kraken test... 12:32:03 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmp9i7_wx/profile http://localhost:49274/getInfo.html) 12:32:05 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 12:32:05 INFO - PROCESS | 1665 | colorDepth:24 12:32:05 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 12:32:05 INFO - PROCESS | 1665 | __metrics 12:32:05 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:32:05 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:32:06 INFO - TEST-INFO | 1665: exit 0 12:32:06 INFO - Browser initialized. 12:32:06 INFO - Running cycle 1/1 for kraken test... 12:32:06 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmp9i7_wx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:32:18 INFO - PROCESS | 1667 | RSS: Main: 232607744 12:32:18 INFO - PROCESS | 1667 | 12:32:21 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 12:32:22 INFO - PROCESS | 1667 | RSS: Main: 291299328 12:32:22 INFO - PROCESS | 1667 | 12:32:24 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 12:32:25 INFO - PROCESS | 1667 | RSS: Main: 289067008 12:32:25 INFO - PROCESS | 1667 | 12:32:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 12:32:29 INFO - PROCESS | 1667 | RSS: Main: 375963648 12:32:29 INFO - PROCESS | 1667 | 12:32:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 12:32:32 INFO - PROCESS | 1667 | RSS: Main: 277553152 12:32:32 INFO - PROCESS | 1667 | 12:32:34 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:32:35 INFO - PROCESS | 1667 | RSS: Main: 283189248 12:32:35 INFO - PROCESS | 1667 | 12:32:37 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 12:32:38 INFO - PROCESS | 1667 | RSS: Main: 322240512 12:32:38 INFO - PROCESS | 1667 | 12:32:41 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 12:32:42 INFO - PROCESS | 1667 | RSS: Main: 322940928 12:32:42 INFO - PROCESS | 1667 | 12:32:44 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 12:32:45 INFO - PROCESS | 1667 | RSS: Main: 321093632 12:32:45 INFO - PROCESS | 1667 | 12:32:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:32:47 INFO - PROCESS | 1667 | RSS: Main: 297664512 12:32:47 INFO - PROCESS | 1667 | 12:32:49 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:32:50 INFO - PROCESS | 1667 | RSS: Main: 303091712 12:32:50 INFO - PROCESS | 1667 | 12:32:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:32:53 INFO - PROCESS | 1667 | RSS: Main: 306249728 12:32:53 INFO - PROCESS | 1667 | 12:32:55 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:32:56 INFO - PROCESS | 1667 | RSS: Main: 319537152 12:32:56 INFO - PROCESS | 1667 | 12:32:59 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:32:59 INFO - PROCESS | 1667 | RSS: Main: 315691008 12:32:59 INFO - PROCESS | 1667 | 12:33:01 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 12:33:01 INFO - PROCESS | 1667 | RSS: Main: 359276544 12:33:01 INFO - PROCESS | 1667 | 12:33:01 INFO - PROCESS | 1667 | __start_tp_report 12:33:01 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 12:33:01 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 12:33:01 INFO - PROCESS | 1667 | |i|pagename|runs| 12:33:01 INFO - PROCESS | 1667 | |0;ai-astar;114;113;116;112;113;113;111;113;113;123 12:33:01 INFO - PROCESS | 1667 | |1;audio-beat-detection;146;108;130;159;109;141;123;89;191;139 12:33:01 INFO - PROCESS | 1667 | |2;audio-dft;184;182;185;181;181;182;180;183;233;179 12:33:01 INFO - PROCESS | 1667 | |3;audio-fft;77;79;98;190;82;57;57;60;141;56 12:33:01 INFO - PROCESS | 1667 | |4;audio-oscillator;82;84;139;71;69;81;119;69;68;118 12:33:01 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;88;85;88;84;95;129;88;83;87;83 12:33:01 INFO - PROCESS | 1667 | |6;imaging-darkroom;93;93;94;94;94;93;94;94;93;93 12:33:01 INFO - PROCESS | 1667 | |7;imaging-desaturate;86;83;86;84;84;85;86;85;85;84 12:33:01 INFO - PROCESS | 1667 | |8;json-parse-financial;55;53;57;56;54;54;54;53;54;54 12:33:01 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;65;65;75;83;72;69;72;69;70;74 12:33:01 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;88;86;85;88;84;87;84;89;85;92 12:33:01 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;139;133;136;141;150;154;144;135;180;124 12:33:01 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;172;169;168;182;169;170;170;169;169;168 12:33:01 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;68;67;67;67;67;66;65;69;68;80 12:33:01 INFO - PROCESS | 1667 | __end_tp_report 12:33:01 INFO - PROCESS | 1667 | __start_cc_report 12:33:01 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1983 12:33:01 INFO - PROCESS | 1667 | __end_cc_report 12:33:01 INFO - PROCESS | 1667 | __startTimestamp1473449581984__endTimestamp 12:33:01 INFO - PROCESS | 1667 | 12:33:01 INFO - PROCESS | 1667 | ------- Summary: start ------- 12:33:01 INFO - PROCESS | 1667 | Number of tests: 14 12:33:01 INFO - PROCESS | 1667 | 12:33:01 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:114.10 Median:113.00 stddev:3.38 (3.0%) stddev-sans-first:3.59 12:33:01 INFO - PROCESS | 1667 | Values: 114.0 113.0 116.0 112.0 113.0 113.0 111.0 113.0 113.0 123.0 12:33:01 INFO - PROCESS | 1667 | 12:33:01 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:143.50 stddev:28.97 (20.2%) stddev-sans-first:30.37 12:33:01 INFO - PROCESS | 1667 | Values: 146.0 108.0 130.0 159.0 109.0 141.0 123.0 89.0 191.0 139.0 12:33:01 INFO - PROCESS | 1667 | 12:33:01 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:187.00 Median:182.50 stddev:16.26 (8.9%) stddev-sans-first:17.21 12:33:01 INFO - PROCESS | 1667 | Values: 184.0 182.0 185.0 181.0 181.0 182.0 180.0 183.0 233.0 179.0 12:33:01 INFO - PROCESS | 1667 | 12:33:01 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:89.70 Median:68.50 stddev:43.78 (63.9%) stddev-sans-first:46.20 12:33:01 INFO - PROCESS | 1667 | Values: 77.0 79.0 98.0 190.0 82.0 57.0 57.0 60.0 141.0 56.0 12:33:01 INFO - PROCESS | 1667 | 12:33:01 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:70.00 stddev:25.68 (36.7%) stddev-sans-first:27.07 12:33:01 INFO - PROCESS | 1667 | Values: 82.0 84.0 139.0 71.0 69.0 81.0 119.0 69.0 68.0 118.0 12:33:01 INFO - PROCESS | 1667 | 12:33:01 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:87.50 stddev:13.81 (15.8%) stddev-sans-first:14.60 12:33:01 INFO - PROCESS | 1667 | Values: 88.0 85.0 88.0 84.0 95.0 129.0 88.0 83.0 87.0 83.0 12:33:01 INFO - PROCESS | 1667 | 12:33:01 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 12:33:01 INFO - PROCESS | 1667 | Values: 93.0 93.0 94.0 94.0 94.0 93.0 94.0 94.0 93.0 93.0 12:33:01 INFO - PROCESS | 1667 | 12:33:01 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.03 (1.2%) stddev-sans-first:1.00 12:33:02 INFO - PROCESS | 1667 | Values: 86.0 83.0 86.0 84.0 84.0 85.0 86.0 85.0 85.0 84.0 12:33:02 INFO - PROCESS | 1667 | 12:33:02 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:1.26 (2.3%) stddev-sans-first:1.32 12:33:02 INFO - PROCESS | 1667 | Values: 55.0 53.0 57.0 56.0 54.0 54.0 54.0 53.0 54.0 54.0 12:33:02 INFO - PROCESS | 1667 | 12:33:02 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:72.00 stddev:5.27 (7.3%) stddev-sans-first:5.06 12:33:02 INFO - PROCESS | 1667 | Values: 65.0 65.0 75.0 83.0 72.0 69.0 72.0 69.0 70.0 74.0 12:33:02 INFO - PROCESS | 1667 | 12:33:02 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.50 stddev:2.53 (2.9%) stddev-sans-first:2.65 12:33:02 INFO - PROCESS | 1667 | Values: 88.0 86.0 85.0 88.0 84.0 87.0 84.0 89.0 85.0 92.0 12:33:02 INFO - PROCESS | 1667 | 12:33:02 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:142.50 stddev:15.39 (10.8%) stddev-sans-first:16.23 12:33:02 INFO - PROCESS | 1667 | Values: 139.0 133.0 136.0 141.0 150.0 154.0 144.0 135.0 180.0 124.0 12:33:02 INFO - PROCESS | 1667 | 12:33:02 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:169.50 stddev:4.17 (2.5%) stddev-sans-first:4.39 12:33:02 INFO - PROCESS | 1667 | Values: 172.0 169.0 168.0 182.0 169.0 170.0 170.0 169.0 169.0 168.0 12:33:02 INFO - PROCESS | 1667 | 12:33:02 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:67.50 stddev:4.22 (6.3%) stddev-sans-first:4.48 12:33:02 INFO - PROCESS | 1667 | Values: 68.0 67.0 67.0 67.0 67.0 66.0 65.0 69.0 68.0 80.0 12:33:02 INFO - PROCESS | 1667 | -------- Summary: end -------- 12:33:02 INFO - PROCESS | 1667 | 12:33:02 INFO - TEST-INFO | 1667: exit 0 12:33:02 INFO - TEST-OK | kraken | took 59374ms 12:33:02 INFO - SUITE-END | took 1177s 12:33:03 INFO - Completed test suite (00:19:37) 12:33:03 INFO - javascript benchmark 12:33:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3304.58692663417, 3308.3052558962618, 3335.5663763710727, 3368.9157771055707, 3386.932261354773, 5512.33851937767, 5581.386047534768, 5615.719214039297, 5671.943280567193, 5690.032694441945, 5641.069223578115, 5641.661500309984, 5685.459881311269, 5718.685472299022, 5777.971110144444, 5030.723310217936, 5052.317937078484, 5056.367954005749, 5121.257417674435, 5175.741212939357, 5231.816886408977, 5271.4201437842, 5273.551748101416, 5281.498257665535, 5331.733413329337, 5074.188129899236, 5208.192730126836, 5212.244224587452, 5270.262163297141, 5276.182191760283, 4209.473815773028, 5091.567216786578, 5163.993021360836, 5166.586673066184, 5172.379314482248, 5077.086124497589, 5134.897302053975, 5140.460251673558, 5145.51117643827, 5159.638825282232, 5660.150977353389, 5663.093904975184, 5676.403977582336, 5713.0, 5717.428257174291, 6174.197354343906, 6217.098520714516, 6230.5638605297645, 6237.594556353868, 6242.500599951993, 6098.14625952367, 6144.109104179914, 6278.30938596754, 6306.905396419012, 6310.2427708674795, 5700.40145784695, 5739.3973632768375, 5767.423257674199, 5804.477597016289, 5860.355360910296, 6228.408301211378, 6302.0, 6314.958031924681, 6321.051842223703, 6340.7463701451425, 5934.228550288435, 6145.631262124287, 6148.6925653717135, 6159.722812473449, 6161.630302181794, 6120.294761999531, 6127.816165515042, 6159.907601385983, 6161.199044124235, 6166.81499555014, 6146.754129834757, 6166.660833654102, 6226.128342032119, 6240.812775616739, 6256.968715156395, 6184.907226391608, 6231.376862313823, 6232.0, 6235.0, 6257.186565746424, 4841.419029716457, 4860.392450943632, 4883.658143929962, 4929.802807887644, 4931.3589233399425, 4372.584604462571, 4395.099004704028, 4409.5149533551285, 4420.359047938031, 4430.357598148251, 5694.572907031989, 5700.429957004267, 5703.857403564861, 5713.0, 5757.942420575824, 6129.295131059986, 6143.757528502065, 6254.968725156436, 6271.592346497463, 6273.905891411632, 5616.269884914935, 5661.773529058792, 5662.688552129673, 5689.687067211343, 5741.368449470555, 5375.650582712189, 5379.596530260246, 5386.622936394415, 5387.030334539742, 5424.186372044146, 6234.189555357774, 6287.245530536365, 6310.684465776784, 6316.968415157895, 6320.462760665395, 6083.026715725463, 6087.117367981707, 6133.049377346519, 6193.349698281616, 6251.624902505864, 6273.3099359071375, 6274.717637706405, 6288.276848162337, 6295.779647712308, 6317.6209427434505, 6168.25980882297, 6174.629522228681, 6177.444030037318, 6190.0, 6206.410391012847, 5969.343372228965, 6108.450239478469, 6127.509799215963, 6239.469645080219, 6263.592866463665, 6024.90962635552, 6034.064719968412, 6044.879102418015, 6050.092486127116, 6057.969710151598, 6004.0693692477735, 6060.363661815446, 6094.451499365078, 6114.785982490592, 6120.387961203844, 5895.115732640138, 5946.256717910262, 5948.048312270016, 5956.642601443928, 5966.582339236385, 5945.197398351167, 6103.084537319438, 6104.725287361991, 6117.816465506042, 6122.357152498924, 5732.799352022826, 5741.569382296261, 5769.711514424346, 5774.48029677331, 5871.266091738533], "value": 5668.917628115793, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.749706404138, 499.14645955416216, 527.7282199667171, 531.2907268796157, 535.5929493584877, 30427.543586846186, 40610.59389406105, 41363.79318103409, 41483.0, 43723.0, 43141.0, 43214.13571728564, 43343.13313733731, 43470.56529434705, 43496.347554786706, 9719.222462203043, 9934.50327483623, 9935.652252171176, 9940.254480913924, 9964.153046991014, 9786.510674466284, 9907.356021858555, 9912.90087099127, 9916.305858589902, 9916.603335866557, 9884.950575247114, 9901.603935842557, 9923.950380248089, 9944.552495137736, 9965.451900145488, 9851.556679949384, 9918.206543476505, 9922.652707155252, 9938.403695778277, 9951.154151897097, 9737.610495580238, 9787.804243915081, 9792.902070979342, 9804.215662746963, 9815.214782817358, 41387.37918931218, 41759.0, 41759.582404175875, 41775.7911210442, 41818.1636367274, 3304.8843290484956, 3572.8928132156075, 3807.9428808567895, 4015.678745700337, 4167.937480937789, 25710.10014649497, 31170.064898053093, 31608.0, 31617.683823161933, 31689.890853820005, 3003.9098827035223, 3114.875404983798, 3140.277736120682, 3181.904542863718, 3181.96818031819, 468265.317346829, 469730.0, 470767.0, 473313.6334318306, 474952.0, 60848.78302433927, 61202.38797612056, 61280.69359653263, 61328.0, 61373.693131534055, 64576.0, 64580.70838583296, 64661.03008454877, 64668.0, 64815.0, 16337.428190013292, 16539.83460165383, 16579.088150151616, 16584.08787516674, 16607.91696041536, 12742.98056155524, 12826.871731282754, 12839.55061572859, 12839.679008024686, 12893.35533223335, 16834.0, 17436.564085897953, 17450.865693729866, 17462.738058929128, 17512.912435437996, 5715.371309155989, 6742.865142697118, 6877.793666189922, 6881.827954301082, 6997.475189360818, 838.3419016072354, 956.1872408452898, 957.5020989085637, 971.577363846729, 1037.5071840875676, 29694.109176724734, 30235.69764302329, 30805.84597077045, 31039.689603104132, 31244.843775780977, 998.8451789972421, 1006.3609607899036, 1012.1548506996741, 1033.7777377863645, 1109.3732041396586, 14930.178840163895, 15540.533783986499, 15543.378264869505, 15669.336212843617, 15965.962212456154, 641663.7916810386, 677793.0, 678810.6059469671, 678876.0, 679463.0, 56477.15284270739, 56693.43306566964, 56763.43236567664, 56845.0, 56866.86266274734, 1051.2693677893944, 1257.9622611321493, 1260.086437332963, 1368.8699573540498, 1392.3664732546667, 23813.34999851212, 32324.83837580797, 32452.35095298128, 32653.0, 33111.17222069467, 56607.43392566022, 57390.0, 57490.137647934476, 57496.712516437154, 57642.7117864408, 616232.0, 622279.0, 622442.0, 623454.0, 624276.0, 25345.112921047676, 26051.609225862005, 26181.821818017856, 26205.606915895896, 26208.73791262063, 46704.7664761674, 47248.85764850547, 47336.28995565138, 47714.04571908612, 48582.0, 38776.806115970365, 38785.418218726176, 38906.4164037534, 39437.408438874016, 40323.0, 31607.683923160475, 35426.82286588551, 38907.0, 39594.60405395909, 39808.60191398165, 37098.258034839695, 37357.0, 38210.617893821815, 38381.61618383892, 38385.4242186373, 32817.83591082029, 33628.831855840566, 34524.654753452145, 34857.302853942274, 34932.236181029846, 25197.874010630563, 25319.0, 25337.98648054057, 25579.48841023132, 26114.73885261123], "value": 20107.96724375966, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.7571966706969, 365.5047410758422, 371.489202346773, 381.88925211688604, 402.24779662032006, 15024.624384390396, 15114.244287785608, 16444.424445144406, 20925.581488370222, 20978.26576069834, 18617.069146542653, 20418.7748735076, 20909.0, 21188.0, 21422.678659820114, 5551.417101204376, 5975.880482390349, 6246.937530624704, 6249.312575616678, 6263.592866463665, 5928.614640048383, 6151.384861513835, 6226.097215903691, 6226.501879849624, 6227.252729672446, 5819.185314056035, 6074.0, 6190.566660333779, 6211.47202487789, 6214.440700336969, 6062.939370606282, 6100.5119590433105, 6107.908381374283, 6110.511159107261, 6116.204893363834, 5030.84907452777, 5240.8689782755355, 5303.337082864642, 5304.761285742151, 5306.70813105279, 19026.809731902642, 24070.546948814525, 24110.156144534856, 24575.754242457704, 24575.894084766227, 2188.4310079379316, 2497.113524698742, 2611.8041146914056, 2711.2544050386105, 2793.4273473937997, 15467.922660386626, 15512.819871926227, 15548.689026219412, 15877.20613969297, 16000.919995400065, 1512.6974605078917, 1525.85504377084, 1812.954676133094, 1822.1071674879347, 1866.2441711107024, 78543.60728196379, 87234.56382718046, 114628.42685786601, 114709.0, 115735.0, 10653.201009924287, 10957.83563246552, 11058.281211721212, 11152.386618735885, 11308.208425410143, 13948.232847193502, 13951.441942322397, 13958.651033724034, 13959.441622334993, 13968.860311396958, 8496.830063398698, 8664.61009254585, 8670.176333248332, 8684.218420342073, 8841.248493878093, 8723.040465548911, 8728.825423491495, 8742.388032837767, 8922.152395522415, 8924.464532128093, 6009.45914867664, 6295.622262664255, 6744.145360025934, 6773.0, 6777.322267773183, 1476.3282706368577, 1810.1763697517597, 1810.3030333321503, 1812.3236006693755, 1815.0924537731134, 869.4739682492128, 887.6981826179001, 888.3648191543077, 981.2983716642492, 994.2841154368842, 21166.894165529073, 21728.565428691338, 21731.23940662069, 21788.782112178676, 21884.781152188592, 905.3752910491739, 908.42315129893, 937.3625934364561, 939.8721534159037, 942.783159873233, 8618.698345557876, 9099.81257488304, 10754.870738572494, 11455.656330310105, 11788.115891308185, 574804.0, 580057.0, 593801.0, 596506.0, 598820.0, 109552.4522377383, 112653.87346126598, 115081.0, 116120.0, 118628.0, 1001.6344034427382, 1007.0, 1008.2589296866797, 1011.2112552209288, 1020.6733845169474, 18827.0, 19007.438214828617, 19207.51981200481, 19255.422337329903, 19363.4190974271, 47377.76311118422, 47708.0, 47961.0, 48310.27534586914, 48486.75756621194, 47142.764286178346, 63467.0, 63520.411989700624, 64876.0, 65935.68128637497, 7816.687332506636, 7850.725224617111, 8103.432759706764, 8141.185881411811, 8300.833983320179, 12666.176698514568, 12869.935650321688, 12954.870451295366, 13296.335183240994, 13349.733005339645, 11270.985611295022, 11349.886501135214, 11364.590622813288, 11627.59303424376, 11639.59261425846, 10979.615713449992, 11148.498317575566, 11340.20618556693, 11635.01102406305, 11655.88344116548, 11440.42797860087, 11575.073994080285, 11625.709357266136, 11628.418579071182, 11820.349880756641, 6676.232233293234, 7341.6329183541675, 7437.107547094383, 8054.3556515479795, 8338.458000229966, 7375.483716139819, 10848.728781780203, 10878.619248326271, 11232.157588181082, 11337.829932550854], "value": 9549.88468602395, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1288.5876519513756, 1332.380443093961, 1348.514534767484, 1460.3647413375186, 1881.5954569767498, 7604.0, 7709.614519274035, 8237.176282371767, 8251.257386835183, 8824.735257942271, 8655.0, 8752.256058235058, 8757.386982911199, 8761.649534018648, 8764.342674299438, 1960.4902725291456, 1983.7321961535224, 1985.930492432765, 1986.5133042404632, 1989.1943762776027, 2362.991730523466, 2394.832361734679, 2407.57867373209, 2407.6027455469825, 2408.8795560222006, 2167.967480487794, 2240.2943072932057, 2361.2680069178523, 2389.545986262613, 2403.8557686538775, 2350.764923507653, 2370.2059809963685, 2378.286514045788, 2379.6430535419654, 2383.9165629202894, 2355.3169580821714, 2359.858408495496, 2360.775726305998, 2369.478714682767, 2373.4185124644573, 8682.6092825823, 8764.73705788821, 8800.779980500474, 8824.338174636863, 8828.69099581518, 4995.800167993276, 5182.093133701587, 5187.740612969336, 5228.503292187236, 5230.973845130788, 3474.0, 3676.3198808220563, 3689.631036896316, 3712.2946640138557, 3722.7021838252876, 1040.4537617750666, 1076.8761592416815, 1082.8629938564475, 1085.696005118568, 1094.3762055628295, 11617.012553932926, 11642.24325418845, 11754.47104880274, 11759.412029398496, 11768.2939023658, 4356.5187836135865, 4538.863834084983, 4651.139539185261, 4666.136764698542, 4671.556202160789, 9161.358704890594, 9165.220956218664, 9181.908180918239, 9190.264778817678, 9196.816063678823, 5247.790088396498, 5253.684778913277, 5253.973730131325, 5261.789788348625, 5275.525202731773, 4076.470058892325, 4394.494633117169, 4562.931556026662, 4911.435184953704, 4947.579455746302, 3732.402815549499, 3797.9620203798163, 3853.9229215415535, 3866.5940076291586, 3866.941995870064, 1174.3130268792681, 1174.682835634374, 1177.7821103095955, 1192.66605350502, 1196.4376742930808, 746.3693179263514, 875.2166810704384, 892.6607889002138, 893.4907102951255, 909.6406919266985, 5583.69289689071, 5712.514436272963, 5756.758508267765, 5885.967497789414, 5966.522678185735, 440.86544667414654, 440.86553601151314, 449.62905602877754, 452.83471532890917, 454.31171774761265, 3827.4067519534515, 3847.9038024049623, 3942.2706799242233, 3945.467361906163, 3973.1854969731135, 10463.267571269938, 10734.785304294026, 10834.566617335377, 10852.565897364017, 10913.781724365468, 10782.406967616856, 10796.78406431867, 10799.78400431987, 10812.243142979916, 10866.185036122164, 7917.327027202752, 8057.274845263954, 8147.185281471805, 8235.8352832943, 8243.175682431709, 5619.297587801525, 5684.573656975826, 5688.544916406595, 5762.2221000164445, 5815.273090863642, 9654.613815447303, 9846.08001439741, 10015.599376024877, 10121.03850134236, 10168.135708464863, 9341.766455838659, 10110.292279540361, 10161.593536258466, 10236.744081398025, 10295.279330447096, 5949.6430214187285, 6612.966935165294, 6810.591364517946, 6894.965525172543, 7078.893816592652, 8263.380246481418, 8265.628046738031, 8328.500289982621, 8345.248927596545, 8368.539730314891, 7492.662830172764, 7527.134379546423, 7533.171351151478, 7553.811154721176, 7618.5809780462605, 7313.341799238094, 7367.189609142883, 7369.373603243785, 7424.888626670712, 7512.173660897188, 6659.234188068434, 6932.61870597122, 6974.337437943387, 6984.825379365557, 6996.370326670624, 4857.975710121426, 4974.303597496281, 4985.5762260208285, 5021.84934451967, 5168.3539557555305, 4021.91956160881, 4602.861914142581, 4615.907681846412, 4665.576999015333, 4808.0], "value": 4395.165756163594, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.84660899636685, 299.3145696355346, 306.45145190109696, 310.51559567075367, 312.87677238713013, 4318.8488402905905, 5267.683938963665, 5281.042616134967, 5315.973420132898, 5321.946780532198, 4331.696781225308, 4882.438519570251, 5046.697198168104, 5055.39335279767, 5245.921311180326, 3030.9696903031017, 3769.962300377002, 3852.6725228355485, 3914.725969182158, 3915.804209789513, 3265.4448743713624, 3997.3604223324273, 4031.294523458383, 4033.2740106780766, 4034.9394759078637, 3729.4592284118785, 3960.544537378195, 3989.1822176453757, 3990.38149086892, 4001.4598029266112, 3916.608339166089, 3947.46709194258, 3973.7615743055508, 3983.521977362706, 4011.618896204856, 3436.1066122808, 3436.381451338758, 3437.7077948374417, 3445.0870519312152, 3451.3606037132413, 5108.744562771846, 5119.135053034972, 5128.743562821881, 5131.486851314876, 5148.639595228336, 3611.963880361215, 3912.5304963404287, 4149.647279981205, 4156.39978608238, 4521.660875434355, 4605.355250264965, 4702.3181638662545, 4970.478099799541, 5004.499550045003, 5506.91739623906, 3510.192655689206, 3726.9254614907823, 3753.3431649461236, 3756.145329549535, 3756.69946404287, 4890.535399137077, 4917.877053073666, 5449.3188351456065, 5614.045612245887, 5660.801871934463, 3788.9431658525145, 3790.677792387678, 3797.240551889633, 3808.8857334280015, 3812.6187381262207, 3812.656860882478, 3857.2478366718783, 3868.5551161616213, 3868.709846761504, 3873.0, 3991.0, 4554.840580579664, 4560.270356742905, 4577.313402989512, 4578.313253012075, 4337.457817772778, 4551.772411379484, 5379.919301210485, 5513.8345849624575, 5529.253550770594, 1305.2233920817098, 1316.7490883660369, 1319.9142055766345, 1321.5837011341396, 1331.5353111577188, 719.3022767915114, 838.4508147163617, 853.5988085599759, 888.3426264564305, 894.1639567004871, 5224.675019616234, 5230.137027390514, 5232.790688372498, 5239.842804715865, 5246.501582349671, 4582.977085114553, 4980.5019498049905, 5393.867287869592, 5620.690862002629, 5704.458076482728, 4787.904241915142, 4982.800687972441, 5071.594272458195, 5137.383513978271, 5176.7411629418375, 2266.6713326567883, 2369.419492224416, 2539.996701302975, 2953.556966455049, 2967.4065186962694, 4563.771811409416, 4713.064591066498, 5076.644634875597, 5297.390800057966, 5588.702665427418, 4587.243104887723, 4788.712746983387, 5660.801871934545, 5774.0945487988865, 5808.30300363959, 5829.271341082364, 5863.677497737665, 5865.659412035064, 5870.530357571384, 5876.239206907582, 4628.5371462853445, 4847.297141914332, 4982.551570358685, 5056.292119103255, 5259.815906443256, 5073.340465739578, 5361.0, 5583.776648933997, 5599.384067752462, 5619.667837847248, 5052.014857102829, 5807.332156802022, 5867.266591676041, 5871.6183448075735, 5881.411858814085, 3638.7270954679034, 3777.9244415110993, 3781.3551105269294, 3809.5809460958717, 3824.2733880562605, 4156.210320039183, 4893.559579637849, 5180.963807238492, 5421.241026256248, 5580.014692139685, 5023.09584274834, 5167.777855522161, 5386.461353864739, 5500.4499550044675, 5510.862228444321, 4539.046800172001, 5279.574514881037, 5361.785528578813, 5436.864078398072, 5505.779768809363, 4821.0, 4948.455669876239, 4958.6611614864505, 5360.490753378423, 5385.192221166856, 4950.108980383421, 5108.0, 5477.643953143033, 5541.861453463695, 5578.497935185853, 5437.10287802524, 5448.858867260831, 5449.6730196188355, 5456.43547532659, 5469.097598896137], "value": 3950.2665807857134, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.7204060314966, 676.8240257533046, 684.2985939412102, 770.8265640230949, 795.7135431244752, 14931.477398291063, 15766.21168941554, 15884.0, 16051.357945682174, 16450.42423515177, 14669.413223471074, 14775.335109920052, 14894.329755161016, 14935.327910244037, 14973.775393369107, 702.9191642961074, 849.7450764770575, 868.891388576428, 869.1525762381691, 869.4044579463057, 677.7221339250908, 691.2085661917101, 695.2873304862532, 835.9498430094213, 885.6014793342989, 913.8949020862586, 924.7040946896996, 926.5969303353063, 929.1126973740062, 930.3069213435966, 919.9862002069974, 920.5995392004467, 921.258386998466, 922.2022950148073, 923.8937522184967, 432.3126229295435, 539.7220431477792, 540.3704684043086, 683.5454422808826, 686.3925425997978, 12566.0, 12611.054170937216, 14393.496227631982, 14802.963792534527, 14921.701565968728, 14340.92829535856, 14738.852611473856, 14793.40826366944, 15027.924860375628, 15215.239238038053, 11934.940325298405, 12007.939960300142, 12056.63830085099, 12070.69823254417, 12122.691076061887, 3807.7715337079862, 3847.076701591598, 3861.6331448512346, 3890.0469385000574, 4000.5399379071487, 119400.0, 120055.0, 120459.0, 123099.38450307692, 123680.38159809144, 11124.777504449865, 11208.495617697223, 11241.156913231376, 11380.487878045507, 11608.709782255512, 20868.791312086683, 23765.0, 23766.405839854142, 23774.286771396884, 23806.0, 7941.36469082472, 8089.9191008089165, 8111.513309201467, 8152.836943261102, 8230.21812927771, 4198.895027624334, 4391.25348690717, 4427.070315233773, 4556.225441674923, 4602.263637817933, 3463.8268086595567, 3617.8914632561064, 3627.437747149196, 3628.9455658165148, 3629.4374371972385, 656.7241758461457, 670.1087553553762, 680.2721088435327, 690.602903330587, 695.8225652458591, 635.1806170040596, 635.4471609699499, 668.6924014953177, 678.9456843452512, 688.7448765916129, 9049.366544341832, 9355.345125841126, 9496.0, 9762.0, 9766.07222313879, 641.4195153386192, 655.7147640776277, 672.2605134352272, 673.1854456108164, 683.62400679627, 4360.738355698668, 4421.734695918255, 4561.657875659339, 4593.724376537419, 4764.737939413366, 166439.0, 166984.0, 170483.0, 172007.0, 172076.1396193011, 90685.0, 112172.0, 141442.0, 142110.2894485521, 144523.0, 94411.0, 94753.0, 97267.0, 123119.0, 128810.35594822154, 9115.27077833785, 9859.802803943738, 9912.752181195528, 10060.899391005996, 10068.093871551595, 55940.720296398256, 61185.47036324128, 61440.69279653573, 62883.6855815718, 62985.0, 63335.0, 85160.57419712862, 91930.0, 92865.0, 93883.53058234665, 12762.42569084412, 12877.424515097206, 13382.866171338163, 13495.325233738078, 13537.864621354054, 14730.852691473377, 14833.777493337824, 14900.552983410515, 14913.62715932067, 15456.536303910902, 13676.384562694504, 13677.521286754916, 13706.603838957626, 14153.858461415666, 14280.214588197749, 13499.32503374847, 13727.794083088962, 13762.518311859038, 13770.380332884844, 13792.655183620489, 11069.5572177112, 13357.866421336052, 13423.463061477432, 13522.93238533801, 13559.59321220365, 11012.080215025855, 11495.942520287344, 11567.421628918351, 11655.825162622737, 11659.591914282959, 9801.607935682492, 10428.426436546062, 10705.785884282115, 11563.6530904073, 11583.305001699588], "value": 7883.974439572774, "unit": "score"}], "name": "dromaeo_css", "value": 7281.326274449934, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 116.0, 112.0, 113.0, 113.0, 111.0, 113.0, 113.0, 123.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 108.0, 130.0, 159.0, 109.0, 141.0, 123.0, 89.0, 191.0, 139.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 185.0, 181.0, 181.0, 182.0, 180.0, 183.0, 233.0, 179.0], "value": 187.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 98.0, 190.0, 82.0, 57.0, 57.0, 60.0, 141.0, 56.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 139.0, 71.0, 69.0, 81.0, 119.0, 69.0, 68.0, 118.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 84.0, 95.0, 129.0, 88.0, 83.0, 87.0, 83.0], "value": 91.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 84.0, 84.0, 85.0, 86.0, 85.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 57.0, 56.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 75.0, 83.0, 72.0, 69.0, 72.0, 69.0, 70.0, 74.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 85.0, 88.0, 84.0, 87.0, 84.0, 89.0, 85.0, 92.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 133.0, 136.0, 141.0, 150.0, 154.0, 144.0, 135.0, 180.0, 124.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 168.0, 182.0, 169.0, 170.0, 170.0, 169.0, 169.0, 168.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 67.0, 66.0, 65.0, 69.0, 68.0, 80.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1478.8, "alertThreshold": 2.0}]} 12:33:03 INFO - Return code: 0 12:33:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:33:03 INFO - # TBPL SUCCESS # 12:33:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:33:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:33:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:33:03 INFO - 2016-09-09 12:33:03.310 screenresolution[1671:10501] starting screenresolution argv=screenresolution get 12:33:03 INFO - 2016-09-09 12:33:03.312 screenresolution[1671:10501] Display 0: 1600x1200x32@60 12:33:03 INFO - 2016-09-09 12:33:03.318 screenresolution[1672:10504] starting screenresolution argv=screenresolution list 12:33:03 INFO - Available Modes on Display 0 12:33:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:33:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:33:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:33:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:33:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:33:03 INFO - Intel Iris: 12:33:03 INFO - Chipset Model: Intel Iris 12:33:03 INFO - Type: GPU 12:33:03 INFO - Bus: Built-In 12:33:03 INFO - VRAM (Dynamic, Max): 1536 MB 12:33:03 INFO - Vendor: Intel (0x8086) 12:33:03 INFO - Device ID: 0x0a2e 12:33:03 INFO - Revision ID: 0x0009 12:33:03 INFO - Displays: 12:33:03 INFO - Display: 12:33:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:33:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:33:03 INFO - Display Serial Number: 1600x1200 60 12:33:03 INFO - Main Display: Yes 12:33:03 INFO - Mirror: Off 12:33:03 INFO - Online: Yes 12:33:03 INFO - Rotation: Supported 12:33:03 INFO - Return code: 0 12:33:03 INFO - Running post-action listener: _resource_record_post_action 12:33:03 INFO - [mozharness: 2016-09-09 19:33:03.558819Z] Finished run-tests step (success) 12:33:03 INFO - Running post-run listener: _resource_record_post_run 12:33:03 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 32177152; Write bytes: 707364352; Read time: 203; Write time: 1988 12:33:03 INFO - TinderboxPrint: CPU usage
53.2% 12:33:03 INFO - TinderboxPrint: I/O read bytes / time
32,177,152 / 203 12:33:03 INFO - TinderboxPrint: I/O write bytes / time
707,364,352 / 1,988 12:33:03 INFO - TinderboxPrint: CPU idle
2,267.8 (46.8%) 12:33:03 INFO - TinderboxPrint: CPU system
966.0 (19.9%) 12:33:03 INFO - TinderboxPrint: CPU user
1,615.9 (33.3%) 12:33:03 INFO - TinderboxPrint: Swap in / out
447,815,680 / 0 12:33:03 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400708096; Write bytes: 395732992; Read time: 29546; Write time: 821 12:33:03 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30129152; Write bytes: 296951296; Read time: 181; Write time: 1126 12:33:04 INFO - Running post-run listener: _upload_blobber_files 12:33:04 INFO - Blob upload gear active. 12:33:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:33:04 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 12:33:04 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'] 12:33:04 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 12:33:04 INFO - (blobuploader) - INFO - Open directory for files ... 12:33:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:33:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:33:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:06 INFO - (blobuploader) - INFO - Done attempting. 12:33:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:33:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:33:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:07 INFO - (blobuploader) - INFO - Done attempting. 12:33:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:33:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:33:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:09 INFO - (blobuploader) - INFO - Done attempting. 12:33:09 INFO - (blobuploader) - INFO - Iteration through files over. 12:33:09 INFO - Return code: 0 12:33:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:33:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:33:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ace5029e42e517d0cf85b395c011040e840e903115d41dbe9715c098254f058d89a569ee88535d9db62a651d8182c47ce6ac303fadffcace2013511a5f82e1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/907c0db1f6352aa44c0da54a06ee79e7f7c9b671f5482cfa6f5190fc09d796c3c85e80f9b04ae5d0e7e9fa8eeb6e21189bfb4a5bfefb1a5dd5bf545005b651e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0206bdf5a2e422ba080ae96a0e2d772b9640148a7fb34ed677466b960d567e181afc6b8559623a8ec8e44b60c1008ca90741c0b5939244dc57f4aad703ccd1d4"} 12:33:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:33:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:33:09 INFO - Contents: 12:33:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ace5029e42e517d0cf85b395c011040e840e903115d41dbe9715c098254f058d89a569ee88535d9db62a651d8182c47ce6ac303fadffcace2013511a5f82e1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/907c0db1f6352aa44c0da54a06ee79e7f7c9b671f5482cfa6f5190fc09d796c3c85e80f9b04ae5d0e7e9fa8eeb6e21189bfb4a5bfefb1a5dd5bf545005b651e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0206bdf5a2e422ba080ae96a0e2d772b9640148a7fb34ed677466b960d567e181afc6b8559623a8ec8e44b60c1008ca90741c0b5939244dc57f4aad703ccd1d4"} 12:33:09 INFO - Running post-run listener: copy_logs_to_upload_dir 12:33:09 INFO - Copying logs to upload dir... 12:33:09 INFO - mkdir: /builds/slave/test/build/upload/logs 12:33:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.165864 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-09 12:33:09.676148) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-09 12:33:09.680042) ========= 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.fDdLc1n042/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.jlS9uS0cNI/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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/5ace5029e42e517d0cf85b395c011040e840e903115d41dbe9715c098254f058d89a569ee88535d9db62a651d8182c47ce6ac303fadffcace2013511a5f82e1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/907c0db1f6352aa44c0da54a06ee79e7f7c9b671f5482cfa6f5190fc09d796c3c85e80f9b04ae5d0e7e9fa8eeb6e21189bfb4a5bfefb1a5dd5bf545005b651e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0206bdf5a2e422ba080ae96a0e2d772b9640148a7fb34ed677466b960d567e181afc6b8559623a8ec8e44b60c1008ca90741c0b5939244dc57f4aad703ccd1d4"} build_url:https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010965 build_url: 'https://queue.taskcluster.net/v1/task/d12FpD37RU2zc7Rl8CQboQ/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/5ace5029e42e517d0cf85b395c011040e840e903115d41dbe9715c098254f058d89a569ee88535d9db62a651d8182c47ce6ac303fadffcace2013511a5f82e1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/907c0db1f6352aa44c0da54a06ee79e7f7c9b671f5482cfa6f5190fc09d796c3c85e80f9b04ae5d0e7e9fa8eeb6e21189bfb4a5bfefb1a5dd5bf545005b651e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0206bdf5a2e422ba080ae96a0e2d772b9640148a7fb34ed677466b960d567e181afc6b8559623a8ec8e44b60c1008ca90741c0b5939244dc57f4aad703ccd1d4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-09 12:33:09.713359) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 12:33:09.713734) ========= 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.fDdLc1n042/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.jlS9uS0cNI/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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.005033 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 12:33:09.762561) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-09 12:33:09.762906) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-09 12:33:09.763330) ========= ========= Total master_lag: 0.18 =========