builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0341 starttime: 1473735967.25 results: success (0) buildid: 20160912185208 builduid: b162cbfac3184859a7d8ee054414f544 revision: 8267ed3c552a0be430c4016dd4c86bb8d178f6ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-12 20:06:07.245480) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-12 20:06:07.246197) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-12 20:06:07.246477) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-12 20:06:07.271728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 20:06:07.272165) ========= 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.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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-12 20:06:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 135M=0s 2016-09-12 20:06:07 (135 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092622 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 20:06:07.387808) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 20:06:07.388193) ========= 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.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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.025712 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 20:06:07.437119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-12 20:06:07.437513) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8267ed3c552a0be430c4016dd4c86bb8d178f6ab --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8267ed3c552a0be430c4016dd4c86bb8d178f6ab --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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-12 20:06:07,520 truncating revision to first 12 chars 2016-09-12 20:06:07,520 Setting DEBUG logging. 2016-09-12 20:06:07,520 attempt 1/10 2016-09-12 20:06:07,520 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8267ed3c552a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-12 20:06:08,268 unpacking tar archive at: fx-team-8267ed3c552a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.013663 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-12 20:06:08.474807) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-12 20:06:08.475266) ========= script_repo_revision: 8267ed3c552a0be430c4016dd4c86bb8d178f6ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-12 20:06:08.475784) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-12 20:06:08.476167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-12 20:06:08.495555) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-12 20:06:08.496024) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 20:06:08 INFO - MultiFileLogger online at 20160912 20:06:08 in /builds/slave/test 20:06:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:06:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:06:08 INFO - {'append_to_log': False, 20:06:08 INFO - 'base_work_dir': '/builds/slave/test', 20:06:08 INFO - 'blob_upload_branch': 'Fx-Team', 20:06:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:06:08 INFO - 'branch': 'Fx-Team', 20:06:08 INFO - 'buildbot_json_path': 'buildprops.json', 20:06:08 INFO - 'config_files': ('talos/mac_config.py',), 20:06:08 INFO - 'default_actions': ('clobber', 20:06:08 INFO - 'read-buildbot-config', 20:06:08 INFO - 'download-and-extract', 20:06:08 INFO - 'populate-webroot', 20:06:08 INFO - 'create-virtualenv', 20:06:08 INFO - 'install', 20:06:08 INFO - 'run-tests'), 20:06:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:06:08 INFO - 'download_minidump_stackwalk': True, 20:06:08 INFO - 'download_symbols': 'ondemand', 20:06:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:06:08 INFO - 'tooltool.py': '/tools/tooltool.py', 20:06:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:06:08 INFO - '/tools/misc-python/virtualenv.py')}, 20:06:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:06:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:06:08 INFO - 'installer_path': 'installer.exe', 20:06:08 INFO - 'log_level': 'info', 20:06:08 INFO - 'log_name': 'talos', 20:06:08 INFO - 'log_to_console': True, 20:06:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:06:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:06:08 INFO - 'opt_config_files': (), 20:06:08 INFO - 'pip_index': False, 20:06:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:06:08 INFO - 'cmd': ('bash', 20:06:08 INFO - '-c', 20:06:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:06:08 INFO - 'enabled': True, 20:06:08 INFO - 'halt_on_failure': False, 20:06:08 INFO - 'name': 'check_screen_resolution'},), 20:06:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:06:08 INFO - 'cmd': ('bash', 20:06:08 INFO - '-c', 20:06:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:06:08 INFO - 'enabled': True, 20:06:08 INFO - 'halt_on_failure': False, 20:06:08 INFO - 'name': 'check_screen_resolution'},), 20:06:08 INFO - 'run_cmd_checks_enabled': True, 20:06:08 INFO - 'sps_profile': False, 20:06:08 INFO - 'sps_profile_interval': 0, 20:06:08 INFO - 'suite': 'dromaeojs', 20:06:08 INFO - 'system_bits': '32', 20:06:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:06:08 INFO - 'title': 't-yosemite-r7-0341', 20:06:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:06:08 INFO - 'use_talos_json': True, 20:06:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:06:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:06:08 INFO - 'work_dir': 'build'} 20:06:08 INFO - [mozharness: 2016-09-13 03:06:08.691521Z] Running clobber step. 20:06:08 INFO - Running pre-action listener: _resource_record_pre_action 20:06:08 INFO - Running main action method: clobber 20:06:08 INFO - rmtree: /builds/slave/test/build 20:06:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:06:10 INFO - Running post-action listener: _resource_record_post_action 20:06:10 INFO - [mozharness: 2016-09-13 03:06:10.886493Z] Finished clobber step (success) 20:06:10 INFO - [mozharness: 2016-09-13 03:06:10.886737Z] Running read-buildbot-config step. 20:06:10 INFO - Running pre-action listener: _resource_record_pre_action 20:06:10 INFO - Running main action method: read_buildbot_config 20:06:10 INFO - Using buildbot properties: 20:06:10 INFO - { 20:06:10 INFO - "project": "", 20:06:10 INFO - "product": "firefox", 20:06:10 INFO - "script_repo_revision": "production", 20:06:10 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 20:06:10 INFO - "repository": "", 20:06:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 20:06:10 INFO - "buildid": "20160912185208", 20:06:10 INFO - "pgo_build": "False", 20:06:10 INFO - "basedir": "/builds/slave/test", 20:06:10 INFO - "buildnumber": 20, 20:06:10 INFO - "slavename": "t-yosemite-r7-0341", 20:06:10 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:06:10 INFO - "platform": "yosemite_r7", 20:06:10 INFO - "scheduler": "tests-fx-team-macosx64-talos", 20:06:10 INFO - "branch": "fx-team", 20:06:10 INFO - "repo_path": "integration/fx-team", 20:06:10 INFO - "revision": "8267ed3c552a0be430c4016dd4c86bb8d178f6ab", 20:06:10 INFO - "stage_platform": "macosx64", 20:06:10 INFO - "builduid": "b162cbfac3184859a7d8ee054414f544", 20:06:10 INFO - "slavebuilddir": "test" 20:06:10 INFO - } 20:06:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 20:06:10 INFO - Running post-action listener: _resource_record_post_action 20:06:10 INFO - [mozharness: 2016-09-13 03:06:10.892622Z] Finished read-buildbot-config step (success) 20:06:10 INFO - [mozharness: 2016-09-13 03:06:10.892857Z] Running download-and-extract step. 20:06:10 INFO - Running pre-action listener: _resource_record_pre_action 20:06:10 INFO - Running main action method: download_and_extract 20:06:10 INFO - mkdir: /builds/slave/test/build/tests 20:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:10 INFO - trying https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 20:06:10 INFO - Downloading https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/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 20:06:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/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 20:06:11 INFO - Downloaded 1199 bytes. 20:06:11 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 20:06:11 INFO - Using the following test package requirements: 20:06:11 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 20:06:11 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:06:11 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 20:06:11 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:06:11 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 20:06:11 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:06:11 INFO - u'jsshell-mac.zip'], 20:06:11 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:06:11 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 20:06:11 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 20:06:11 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:06:11 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 20:06:11 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:06:11 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 20:06:11 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:06:11 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 20:06:11 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:06:11 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 20:06:11 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:06:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:06:12 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 20:06:19 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 20:06:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:06:20 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 20:06:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 20:06:27 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 20:06:29 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')]} 20:06:29 INFO - trying https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:06:29 INFO - Downloading https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 20:06:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/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 20:06:33 INFO - Downloaded 111405822 bytes. 20:06:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:06:33 INFO - mkdir: /builds/slave/test/properties 20:06:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:33 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:33 INFO - Contents: 20:06:33 INFO - build_url:https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:06:33 INFO - Running post-action listener: _resource_record_post_action 20:06:33 INFO - Running post-action listener: set_extra_try_arguments 20:06:33 INFO - [mozharness: 2016-09-13 03:06:33.989911Z] Finished download-and-extract step (success) 20:06:33 INFO - [mozharness: 2016-09-13 03:06:33.990030Z] Running populate-webroot step. 20:06:33 INFO - Running pre-action listener: _resource_record_pre_action 20:06:33 INFO - Running main action method: populate_webroot 20:06:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:06:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:06:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:06:33 INFO - '--tppagecycles', 20:06:33 INFO - '7'], 20:06:33 INFO - 'tests': ['tsvgm']}}, 20:06:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:06:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:06:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:06:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:06:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['damp', 'tps']}, 20:06:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'tests': ['damp', 'tps']}, 20:06:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['dromaeo_dom']}, 20:06:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['basic_compositor_video']}, 20:06:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:06:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['tsvgx', 20:06:34 INFO - 'tsvgr_opacity', 20:06:34 INFO - 'tart', 20:06:34 INFO - 'tscrollx', 20:06:34 INFO - 'cart']}, 20:06:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:34 INFO - 'tsvgr_opacity', 20:06:34 INFO - 'tart', 20:06:34 INFO - 'tscrollx', 20:06:34 INFO - 'cart']}, 20:06:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['tp5o']}, 20:06:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'tests': ['tp5o']}, 20:06:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--disable-e10s', 20:06:34 INFO - '--xperf_path', 20:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:34 INFO - 'tests': ['tp5n']}, 20:06:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--xperf_path', 20:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:34 INFO - 'tests': ['tp5n']}}, 20:06:34 INFO - 'talos.zip': {'path': '', 20:06:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:06:34 INFO - Running post-action listener: _resource_record_post_action 20:06:34 INFO - [mozharness: 2016-09-13 03:06:34.008811Z] Finished populate-webroot step (success) 20:06:34 INFO - [mozharness: 2016-09-13 03:06:34.008959Z] Running create-virtualenv step. 20:06:34 INFO - Running pre-action listener: _resource_record_pre_action 20:06:34 INFO - Running main action method: create_virtualenv 20:06:34 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:34 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 20:06:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:34 INFO - Using real prefix '/tools/python27' 20:06:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:34 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:37 INFO - Installing pip.................done. 20:06:37 INFO - Return code: 0 20:06:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06:37 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')]} 20:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:37 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')]} 20:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:37 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 0x108039490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107faf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3bd902d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e4dd30>, '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 0x107c73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e45b20>, '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.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 20:06:37 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 20:06:37 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 20:06:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L3ht4VQ3od/Render', 20:06:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:37 INFO - 'HOME': '/Users/cltbld', 20:06:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:37 INFO - 'LOGNAME': 'cltbld', 20:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:37 INFO - 'MOZ_NO_REMOTE': '1', 20:06:37 INFO - 'NO_EM_RESTART': '1', 20:06:37 INFO - 'PAGER': '/bin/cat', 20:06:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:37 INFO - 'PWD': '/builds/slave/test', 20:06:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:37 INFO - 'SHELL': '/bin/bash', 20:06:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nbk8hYgN5R/Listeners', 20:06:37 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 20:06:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:37 INFO - 'USER': 'cltbld', 20:06:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:37 INFO - 'XPC_FLAGS': '0x0', 20:06:37 INFO - 'XPC_SERVICE_NAME': '0', 20:06:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:37 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 20:06:37 INFO - Cleaning up... 20:06:37 INFO - Return code: 0 20:06:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:06:37 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')]} 20:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:37 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')]} 20:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:37 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 0x108039490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107faf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3bd902d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e4dd30>, '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 0x107c73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e45b20>, '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.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 20:06:37 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 20:06:37 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 20:06:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L3ht4VQ3od/Render', 20:06:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:37 INFO - 'HOME': '/Users/cltbld', 20:06:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:37 INFO - 'LOGNAME': 'cltbld', 20:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:37 INFO - 'MOZ_NO_REMOTE': '1', 20:06:37 INFO - 'NO_EM_RESTART': '1', 20:06:37 INFO - 'PAGER': '/bin/cat', 20:06:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:37 INFO - 'PWD': '/builds/slave/test', 20:06:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:37 INFO - 'SHELL': '/bin/bash', 20:06:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nbk8hYgN5R/Listeners', 20:06:37 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 20:06:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:37 INFO - 'USER': 'cltbld', 20:06:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:37 INFO - 'XPC_FLAGS': '0x0', 20:06:37 INFO - 'XPC_SERVICE_NAME': '0', 20:06:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:38 INFO - Downloading/unpacking psutil>=3.1.1 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:40 INFO - Installing collected packages: psutil 20:06:40 INFO - Running setup.py install for psutil 20:06:40 INFO - building 'psutil._psutil_osx' extension 20:06:40 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 20:06:41 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 20:06:41 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 20:06:41 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 20:06:41 INFO - building 'psutil._psutil_posix' extension 20:06:41 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 20:06:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:06:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:06:41 INFO - ^ 20:06:41 INFO - 1 warning generated. 20:06:41 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 20:06:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:41 INFO - Successfully installed psutil 20:06:41 INFO - Cleaning up... 20:06:42 INFO - Return code: 0 20:06:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:06:42 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')]} 20:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:42 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')]} 20:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:42 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 0x108039490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107faf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3bd902d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e4dd30>, '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 0x107c73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e45b20>, '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.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 20:06:42 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 20:06:42 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 20:06:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L3ht4VQ3od/Render', 20:06:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:42 INFO - 'HOME': '/Users/cltbld', 20:06:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:42 INFO - 'LOGNAME': 'cltbld', 20:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:42 INFO - 'MOZ_NO_REMOTE': '1', 20:06:42 INFO - 'NO_EM_RESTART': '1', 20:06:42 INFO - 'PAGER': '/bin/cat', 20:06:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:42 INFO - 'PWD': '/builds/slave/test', 20:06:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:42 INFO - 'SHELL': '/bin/bash', 20:06:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nbk8hYgN5R/Listeners', 20:06:42 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 20:06:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:42 INFO - 'USER': 'cltbld', 20:06:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:42 INFO - 'XPC_FLAGS': '0x0', 20:06:42 INFO - 'XPC_SERVICE_NAME': '0', 20:06:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:06:42 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 20:06:42 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 20:06:42 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 20:06:42 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 20:06:42 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 20:06:42 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 20:06:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:06:44 INFO - Installing collected packages: mozsystemmonitor 20:06:44 INFO - Running setup.py install for mozsystemmonitor 20:06:44 INFO - Successfully installed mozsystemmonitor 20:06:44 INFO - Cleaning up... 20:06:45 INFO - Return code: 0 20:06:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:45 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 0x108039490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107faf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3bd902d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e4dd30>, '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 0x107c73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e45b20>, '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.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 20:06:45 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 20:06:45 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 20:06:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L3ht4VQ3od/Render', 20:06:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:45 INFO - 'HOME': '/Users/cltbld', 20:06:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:45 INFO - 'LOGNAME': 'cltbld', 20:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:45 INFO - 'MOZ_NO_REMOTE': '1', 20:06:45 INFO - 'NO_EM_RESTART': '1', 20:06:45 INFO - 'PAGER': '/bin/cat', 20:06:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:45 INFO - 'PWD': '/builds/slave/test', 20:06:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:45 INFO - 'SHELL': '/bin/bash', 20:06:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nbk8hYgN5R/Listeners', 20:06:45 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 20:06:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:45 INFO - 'USER': 'cltbld', 20:06:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:45 INFO - 'XPC_FLAGS': '0x0', 20:06:45 INFO - 'XPC_SERVICE_NAME': '0', 20:06:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:45 INFO - Downloading/unpacking jsonschema==2.5.1 20:06:45 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 20:06:45 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 20:06:45 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 20:06:45 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 20:06:45 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 20:06:45 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 20:06:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:48 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:48 INFO - warning: no files found matching '*.txt' 20:06:48 INFO - no previously-included directories found matching 'build' 20:06:48 INFO - no previously-included directories found matching 'dist' 20:06:48 INFO - no previously-included directories found matching '.git*' 20:06:48 INFO - Installing collected packages: jsonschema, functools32 20:06:48 INFO - Running setup.py install for functools32 20:06:48 INFO - warning: no files found matching '*.txt' 20:06:48 INFO - no previously-included directories found matching 'build' 20:06:48 INFO - no previously-included directories found matching 'dist' 20:06:48 INFO - no previously-included directories found matching '.git*' 20:06:48 INFO - Successfully installed jsonschema functools32 20:06:48 INFO - Cleaning up... 20:06:48 INFO - Return code: 0 20:06:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:06:48 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')]} 20:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:48 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')]} 20:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:48 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 0x108039490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107faf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3bd902d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e4dd30>, '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 0x107c73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e45b20>, '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.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 20:06:48 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 20:06:48 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 20:06:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L3ht4VQ3od/Render', 20:06:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:48 INFO - 'HOME': '/Users/cltbld', 20:06:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:48 INFO - 'LOGNAME': 'cltbld', 20:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:48 INFO - 'MOZ_NO_REMOTE': '1', 20:06:48 INFO - 'NO_EM_RESTART': '1', 20:06:48 INFO - 'PAGER': '/bin/cat', 20:06:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:48 INFO - 'PWD': '/builds/slave/test', 20:06:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:48 INFO - 'SHELL': '/bin/bash', 20:06:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nbk8hYgN5R/Listeners', 20:06:48 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 20:06:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:48 INFO - 'USER': 'cltbld', 20:06:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:48 INFO - 'XPC_FLAGS': '0x0', 20:06:48 INFO - 'XPC_SERVICE_NAME': '0', 20:06:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:06:48 INFO - Cleaning up... 20:06:48 INFO - Return code: 0 20:06:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06:48 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')]} 20:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:48 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')]} 20:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:48 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 0x108039490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107faf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3bd902d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e4dd30>, '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 0x107c73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e45b20>, '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.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 20:06:48 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 20:06:48 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 20:06:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L3ht4VQ3od/Render', 20:06:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:48 INFO - 'HOME': '/Users/cltbld', 20:06:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:48 INFO - 'LOGNAME': 'cltbld', 20:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:48 INFO - 'MOZ_NO_REMOTE': '1', 20:06:48 INFO - 'NO_EM_RESTART': '1', 20:06:48 INFO - 'PAGER': '/bin/cat', 20:06:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:48 INFO - 'PWD': '/builds/slave/test', 20:06:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:48 INFO - 'SHELL': '/bin/bash', 20:06:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nbk8hYgN5R/Listeners', 20:06:48 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 20:06:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:48 INFO - 'USER': 'cltbld', 20:06:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:48 INFO - 'XPC_FLAGS': '0x0', 20:06:48 INFO - 'XPC_SERVICE_NAME': '0', 20:06:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:48 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:48 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 20:06:48 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 20:06:48 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 20:06:48 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 20:06:48 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 20:06:48 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 20:06:51 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:52 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 20:06:52 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 20:06:52 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 20:06:52 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 20:06:52 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 20:06:52 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 20:06:52 INFO - Downloading docopt-0.6.1.tar.gz 20:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:52 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:52 INFO - Running setup.py install for blobuploader 20:06:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:52 INFO - Running setup.py install for requests 20:06:53 INFO - Running setup.py install for docopt 20:06:53 INFO - Successfully installed blobuploader requests docopt 20:06:53 INFO - Cleaning up... 20:06:53 INFO - Return code: 0 20:06:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:53 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 0x108039490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107faf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3bd902d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e4dd30>, '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 0x107c73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e45b20>, '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.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 20:06:53 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 20:06:53 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 20:06:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L3ht4VQ3od/Render', 20:06:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:53 INFO - 'HOME': '/Users/cltbld', 20:06:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:53 INFO - 'LOGNAME': 'cltbld', 20:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:53 INFO - 'MOZ_NO_REMOTE': '1', 20:06:53 INFO - 'NO_EM_RESTART': '1', 20:06:53 INFO - 'PAGER': '/bin/cat', 20:06:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:53 INFO - 'PWD': '/builds/slave/test', 20:06:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:53 INFO - 'SHELL': '/bin/bash', 20:06:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nbk8hYgN5R/Listeners', 20:06:53 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 20:06:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:53 INFO - 'USER': 'cltbld', 20:06:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:53 INFO - 'XPC_FLAGS': '0x0', 20:06:53 INFO - 'XPC_SERVICE_NAME': '0', 20:06:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:53 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-OccbDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:53 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-R02Xft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-sU38rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-W6cteo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-6SmcYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-zlDNNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-9zXLBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-RjqAzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-WXBcC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-muPq6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-aLfXdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:55 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-KbNwAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:55 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Dbl5by-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:55 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-tta8QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:55 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-8btOum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:55 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-kA4yg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:55 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-KMuV6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:55 INFO - Running setup.py install for manifestparser 20:06:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:55 INFO - Running setup.py install for mozcrash 20:06:55 INFO - Running setup.py install for mozdebug 20:06:56 INFO - Running setup.py install for mozdevice 20:06:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:06:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:56 INFO - Running setup.py install for mozfile 20:06:56 INFO - Running setup.py install for mozhttpd 20:06:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:56 INFO - Running setup.py install for mozinfo 20:06:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:56 INFO - Running setup.py install for mozInstall 20:06:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:56 INFO - Running setup.py install for mozleak 20:06:56 INFO - Running setup.py install for mozlog 20:06:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:57 INFO - Running setup.py install for moznetwork 20:06:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:57 INFO - Running setup.py install for mozprocess 20:06:57 INFO - Running setup.py install for mozprofile 20:06:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:57 INFO - Running setup.py install for mozrunner 20:06:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:57 INFO - Running setup.py install for mozscreenshot 20:06:57 INFO - Running setup.py install for moztest 20:06:58 INFO - Running setup.py install for mozversion 20:06:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:58 INFO - Cleaning up... 20:06:58 INFO - Return code: 0 20:06:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:58 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 0x108039490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107faf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3bd902d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e4dd30>, '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 0x107c73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e45b20>, '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.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 20:06:58 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 20:06:58 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 20:06:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L3ht4VQ3od/Render', 20:06:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:06:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:06:58 INFO - 'HOME': '/Users/cltbld', 20:06:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:06:58 INFO - 'LOGNAME': 'cltbld', 20:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:58 INFO - 'MOZ_NO_REMOTE': '1', 20:06:58 INFO - 'NO_EM_RESTART': '1', 20:06:58 INFO - 'PAGER': '/bin/cat', 20:06:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:58 INFO - 'PWD': '/builds/slave/test', 20:06:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:06:58 INFO - 'SHELL': '/bin/bash', 20:06:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nbk8hYgN5R/Listeners', 20:06:58 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 20:06:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:06:58 INFO - 'USER': 'cltbld', 20:06:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:06:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:58 INFO - 'XPC_FLAGS': '0x0', 20:06:58 INFO - 'XPC_SERVICE_NAME': '0', 20:06:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-FFoaXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:58 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)) 20:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-l3N0zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:58 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)) 20:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-cHKcFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:58 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)) 20:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-9dLA34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:58 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)) 20:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-P7nCYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:59 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)) 20:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-I5MbGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:59 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)) 20:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-b15Rjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:59 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)) 20:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-8JDV3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:59 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)) 20:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Y65bAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:59 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)) 20:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-F7HIn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:59 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)) 20:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-KYg90Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:59 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)) 20:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-uiraF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:59 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)) 20:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-xlmAzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:59 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)) 20:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-XQDy0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:59 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)) 20:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-cbu_PU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:00 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)) 20:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:07:00 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-aYtCJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:07:00 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)) 20:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:07:00 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-hUnzhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:07:00 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)) 20:07:00 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)) 20:07:00 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)) 20:07:00 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)) 20:07:00 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)) 20:07:00 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)) 20:07:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:02 INFO - Downloading blessings-1.6.tar.gz 20:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:07:02 INFO - Installing collected packages: blessings 20:07:02 INFO - Running setup.py install for blessings 20:07:03 INFO - Successfully installed blessings 20:07:03 INFO - Cleaning up... 20:07:03 INFO - Return code: 0 20:07:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:07:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:07:03 INFO - Reading from file tmpfile_stdout 20:07:03 INFO - Current package versions: 20:07:03 INFO - blessings == 1.6 20:07:03 INFO - blobuploader == 1.2.4 20:07:03 INFO - docopt == 0.6.1 20:07:03 INFO - functools32 == 3.2.3-2 20:07:03 INFO - jsonschema == 2.5.1 20:07:03 INFO - manifestparser == 1.1 20:07:03 INFO - mozInstall == 1.12 20:07:03 INFO - mozcrash == 0.17 20:07:03 INFO - mozdebug == 0.1 20:07:03 INFO - mozdevice == 0.48 20:07:03 INFO - mozfile == 1.2 20:07:03 INFO - mozhttpd == 0.7 20:07:03 INFO - mozinfo == 0.9 20:07:03 INFO - mozleak == 0.1 20:07:03 INFO - mozlog == 3.3 20:07:03 INFO - moznetwork == 0.27 20:07:03 INFO - mozprocess == 0.23 20:07:03 INFO - mozprofile == 0.28 20:07:03 INFO - mozrunner == 6.12 20:07:03 INFO - mozscreenshot == 0.1 20:07:03 INFO - mozsystemmonitor == 0.3 20:07:03 INFO - moztest == 0.7 20:07:03 INFO - mozversion == 1.4 20:07:03 INFO - psutil == 3.1.1 20:07:03 INFO - requests == 1.2.3 20:07:03 INFO - wsgiref == 0.1.2 20:07:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:03 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')]} 20:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:03 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')]} 20:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:03 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 0x108039490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107faf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3bd902d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e4dd30>, '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 0x107c73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e45b20>, '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.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 20:07:03 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 20:07:03 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 20:07:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L3ht4VQ3od/Render', 20:07:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:07:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:07:03 INFO - 'HOME': '/Users/cltbld', 20:07:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:07:03 INFO - 'LOGNAME': 'cltbld', 20:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:03 INFO - 'MOZ_NO_REMOTE': '1', 20:07:03 INFO - 'NO_EM_RESTART': '1', 20:07:03 INFO - 'PAGER': '/bin/cat', 20:07:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:03 INFO - 'PWD': '/builds/slave/test', 20:07:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:07:03 INFO - 'SHELL': '/bin/bash', 20:07:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nbk8hYgN5R/Listeners', 20:07:03 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 20:07:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:07:03 INFO - 'USER': 'cltbld', 20:07:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:07:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:03 INFO - 'XPC_FLAGS': '0x0', 20:07:03 INFO - 'XPC_SERVICE_NAME': '0', 20:07:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:04 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)) 20:07:04 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)) 20:07:04 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)) 20:07:04 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)) 20:07:04 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)) 20:07:04 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)) 20:07:04 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)) 20:07:04 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)) 20:07:04 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)) 20:07:04 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)) 20:07:04 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)) 20:07:04 INFO - Cleaning up... 20:07:04 INFO - Return code: 0 20:07:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:07:04 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')]} 20:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:04 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')]} 20:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:04 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 0x108039490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107faf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c3bd902d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e4dd30>, '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 0x107c73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e45b20>, '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.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 20:07:04 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 20:07:04 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 20:07:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L3ht4VQ3od/Render', 20:07:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:07:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:07:04 INFO - 'HOME': '/Users/cltbld', 20:07:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:07:04 INFO - 'LOGNAME': 'cltbld', 20:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:04 INFO - 'MOZ_NO_REMOTE': '1', 20:07:04 INFO - 'NO_EM_RESTART': '1', 20:07:04 INFO - 'PAGER': '/bin/cat', 20:07:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:04 INFO - 'PWD': '/builds/slave/test', 20:07:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:07:04 INFO - 'SHELL': '/bin/bash', 20:07:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nbk8hYgN5R/Listeners', 20:07:04 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 20:07:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:07:04 INFO - 'USER': 'cltbld', 20:07:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:07:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:04 INFO - 'XPC_FLAGS': '0x0', 20:07:04 INFO - 'XPC_SERVICE_NAME': '0', 20:07:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:07:04 INFO - Cleaning up... 20:07:04 INFO - Return code: 0 20:07:04 INFO - Running post-action listener: _resource_record_post_action 20:07:04 INFO - Running post-action listener: _start_resource_monitoring 20:07:04 INFO - Starting resource monitoring. 20:07:04 INFO - [mozharness: 2016-09-13 03:07:04.790257Z] Finished create-virtualenv step (success) 20:07:04 INFO - [mozharness: 2016-09-13 03:07:04.791168Z] Running install step. 20:07:04 INFO - Running pre-action listener: _resource_record_pre_action 20:07:04 INFO - Running main action method: install 20:07:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:07:05 INFO - Reading from file tmpfile_stdout 20:07:05 INFO - Detecting whether we're running mozinstall >=1.0... 20:07:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:07:05 INFO - Reading from file tmpfile_stdout 20:07:05 INFO - Output received: 20:07:05 INFO - Usage: mozinstall [options] installer 20:07:05 INFO - Options: 20:07:05 INFO - -h, --help show this help message and exit 20:07:05 INFO - -d DEST, --destination=DEST 20:07:05 INFO - Directory to install application into. [default: 20:07:05 INFO - "/builds/slave/test"] 20:07:05 INFO - --app=APP Application being installed. [default: firefox] 20:07:05 INFO - mkdir: /builds/slave/test/build/application 20:07:05 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'] 20:07:05 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 20:07:39 INFO - Reading from file tmpfile_stdout 20:07:39 INFO - Output received: 20:07:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:07:39 INFO - Running post-action listener: _resource_record_post_action 20:07:39 INFO - [mozharness: 2016-09-13 03:07:39.374151Z] Finished install step (success) 20:07:39 INFO - [mozharness: 2016-09-13 03:07:39.374313Z] Running run-tests step. 20:07:39 INFO - Running pre-action listener: _resource_record_pre_action 20:07:39 INFO - Running main action method: run_tests 20:07:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:07:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:07:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:07:39 INFO - 2016-09-12 20:07:39.388 screenresolution[1643:7438] starting screenresolution argv=screenresolution get 20:07:39 INFO - 2016-09-12 20:07:39.391 screenresolution[1643:7438] Display 0: 1600x1200x32@60 20:07:39 INFO - 2016-09-12 20:07:39.397 screenresolution[1644:7440] starting screenresolution argv=screenresolution list 20:07:39 INFO - Available Modes on Display 0 20:07:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:07:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:07:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:07:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:07:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:07:39 INFO - Intel Iris: 20:07:39 INFO - Chipset Model: Intel Iris 20:07:39 INFO - Type: GPU 20:07:39 INFO - Bus: Built-In 20:07:39 INFO - VRAM (Dynamic, Max): 1536 MB 20:07:39 INFO - Vendor: Intel (0x8086) 20:07:39 INFO - Device ID: 0x0a2e 20:07:39 INFO - Revision ID: 0x0009 20:07:39 INFO - Displays: 20:07:39 INFO - Display: 20:07:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:07:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:07:39 INFO - Display Serial Number: 1600x1200 60 20:07:39 INFO - Main Display: Yes 20:07:39 INFO - Mirror: Off 20:07:39 INFO - Online: Yes 20:07:39 INFO - Rotation: Supported 20:07:39 INFO - Return code: 0 20:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:07:39 INFO - Python 2.7.3 20:07:39 INFO - Return code: 0 20:07:39 INFO - grabbing minidump binary from tooltool 20:07:39 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')]} 20:07:39 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 0x107e4dd30>, '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 0x107c73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e45b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:07:39 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 20:07:39 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 20:07:39 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 20:07:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:07:39 INFO - Return code: 0 20:07:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:07:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:07:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:07:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:07:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0341', '--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 20:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0341 --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 20:07:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L3ht4VQ3od/Render', 20:07:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:07:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:07:39 INFO - 'HOME': '/Users/cltbld', 20:07:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:07:39 INFO - 'LOGNAME': 'cltbld', 20:07:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:07:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:39 INFO - 'MOZ_NO_REMOTE': '1', 20:07:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:07:39 INFO - 'NO_EM_RESTART': '1', 20:07:39 INFO - 'PAGER': '/bin/cat', 20:07:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:39 INFO - 'PWD': '/builds/slave/test', 20:07:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:07:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:07:39 INFO - 'SHELL': '/bin/bash', 20:07:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nbk8hYgN5R/Listeners', 20:07:39 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 20:07:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:07:39 INFO - 'USER': 'cltbld', 20:07:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:07:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:39 INFO - 'XPC_FLAGS': '0x0', 20:07:39 INFO - 'XPC_SERVICE_NAME': '0', 20:07:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:07:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0341', '--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 20:07:39 INFO - mozversion application_buildid: 20160912185208 20:07:39 INFO - mozversion application_changeset: 8267ed3c552a0be430c4016dd4c86bb8d178f6ab 20:07:39 INFO - mozversion application_display_name: Nightly 20:07:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:07:39 INFO - mozversion application_name: Firefox 20:07:39 INFO - mozversion application_remotingname: firefox 20:07:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:07:39 INFO - mozversion application_vendor: Mozilla 20:07:39 INFO - mozversion application_version: 51.0a1 20:07:39 INFO - mozversion platform_buildid: 20160912185208 20:07:39 INFO - mozversion platform_changeset: 8267ed3c552a0be430c4016dd4c86bb8d178f6ab 20:07:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:07:39 INFO - mozversion platform_version: 51.0a1 20:07:39 INFO - using testdate: 1473736059 20:07:39 INFO - actual date: 1473736059 20:07:39 INFO - starting webserver on 'localhost:49277' 20:07:39 INFO - SUITE-START | Running 2 tests 20:07:39 INFO - TEST-START | dromaeo_css 20:07:39 INFO - operating with platform_type : mac_ 20:07:39 INFO - Initialising browser for dromaeo_css test... 20:07:39 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpZ0xXNy/profile http://localhost:49277/getInfo.html) 20:07:42 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 20:07:42 INFO - PROCESS | 1654 | colorDepth:24 20:07:42 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 20:07:42 INFO - PROCESS | 1654 | __metrics 20:07:42 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" 20:07:42 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] 20:07:43 INFO - TEST-INFO | 1654: exit 0 20:07:43 INFO - Browser initialized. 20:07:43 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:43 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpZ0xXNy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:55 INFO - PROCESS | 1656 | RSS: Main: 234205184 20:07:55 INFO - PROCESS | 1656 | 20:08:46 INFO - PROCESS | 1656 | 1473736126431 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] 20:10:58 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 20:10:59 INFO - PROCESS | 1656 | RSS: Main: 353009664 20:10:59 INFO - PROCESS | 1656 | 20:14:02 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 20:14:03 INFO - PROCESS | 1656 | RSS: Main: 371748864 20:14:03 INFO - PROCESS | 1656 | 20:17:05 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 20:17:06 INFO - PROCESS | 1656 | RSS: Main: 328003584 20:17:06 INFO - PROCESS | 1656 | 20:20:08 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 20:20:09 INFO - PROCESS | 1656 | RSS: Main: 353509376 20:20:09 INFO - PROCESS | 1656 | 20:23:12 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 20:23:13 INFO - PROCESS | 1656 | RSS: Main: 325730304 20:23:13 INFO - PROCESS | 1656 | 20:26:16 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 20:26:16 INFO - PROCESS | 1656 | RSS: Main: 392519680 20:26:16 INFO - PROCESS | 1656 | 20:26:16 INFO - PROCESS | 1656 | __start_tp_report 20:26:16 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 20:26:16 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 20:26:16 INFO - PROCESS | 1656 | |i|pagename|runs| 20:26:16 INFO - PROCESS | 1656 | |0;dojo.html;2811.56420754783;3220.3237320162766;3248.870045198192;3353.5472711183997;3390.169408494919;5627.986962346786;5698.34469036061;5755.827325180241;5773.076307790749;5775.682337471448;4458.6210172135325;5428.212909128174;5732.48407643313;5742.2247996520455;5742.8277151685415;5145.408278048026;5185.455527169649;5200.531952124308;5246.108161612516;5285.471452854722;5187.299714538545;5259.947400526004;5269.235960785683;5270.998510283053;5271.630985830993;5156.407013193474;5174.249733788598;5178.275041494194;5197.376314842205;5263.921041184385;5272.578193744491;5287.947120528784;5290.074237008508;5304.336957880265;5337.11937530307;4363.607275345203;5092.37234379956;5116.616253780981;5128.435872054071;5214.32213812202;5656.604037717361;5695.487406133427;5710.543156547466;5718.7426565804635;5749.59752817303;5136.845894623168;6239.937600624026;6242.094896240065;6243.96878015607;6258.4680302174365;5868.4424979626865;6134.375358695247;6145.8156255312415;6307.810765677037;6339.968300158515;5228;5624.015797235549;5716.742746576414;5726.31284245889;5756.819851930344;6310.7791227306825;6314.463270621956;6331.986882098934;6342.112104305401;6348.873022539523;5986.102084687332;6076.0047534046935;6133.907991380043;6138.447539721446;6141.385861413913;6101.786437474756;6140.933729673037;6144.740328232701;6180.103884936659;6282.528810339243;5487.957288115245;6028.939710602838;6207.81376558704;6237.09562113491;6241.594296370721;5910.143029260733;6011.1884895539415;6253.5622506424115;6259.405356491126;6278.529110316745;4321.503027151918;4788.928166077511;4794.520547945247;4833.32333473314;4869.975650121798;4397.714148580332;4401.9875428651585;4432.867013989586;4440.666949978765;4449.621782148489;5645.068563687028;5662;5683.630564013326;5692.658440493584;5706.11555208935;6163.907541386883;6180.289266734383;6190.41191086846;6228.657423841732;6238.875222495525;5695.117256825199;5726.885462290814;5759.798407055733;5762.250907382014;5792.565557583198;5407.324084489439;5408.323959505062;5409.83770486886;5411.864703382447;5413.025655382069;6249.156363890998;6312.305646378894;6313.905291420724;6321.051842223611;6328.398802113792;6151.723172457339;6171.012637977902;6180.011198208265;6211.3478084800445;6253.624782513064;6270.15352927349;6274.341194174546;6293.811185664437;6299.338569450325;6303.086052522451;6167.814965551041;6171.56799024064;6189.288231853395;6193.009118541012;6197.81406557804;5383.569314454912;6094.7432096071825;6113.902014424272;6168.0439531872635;6206.596571222856;6100.550895826025;6110.346130329577;6115.879294474606;6120.325235636462;6124.136831511461;6098.704546243851;6114.054067497468;6131.315499378873;6144.740328232791;6145.877082458415;5730.799422020209;5767.279090113736;5858.853528661817;5878.94121058801;6020.337762846171;6110.26676798787;6137.508999279958;6153.107799369156;6155.415235552616;6159.414855588712;5807.332156802022;5824.70876456167;5926.674032928058;5935.436133567304;5983.910241346471 20:26:16 INFO - PROCESS | 1656 | |1;ext.html;457.32772823948807;481.9662623616347;506.5188071332235;522.1202274168027;566.7135602183042;24239.75760242397;32110.83944580277;32119.51820722691;32144.839275803646;39668.60331396685;42526.78736606312;42763.35854962178;42889.571104288945;42925.92685182864;42964.785176074074;9710.902890971089;9914.256430767686;9915.305928585001;9916.504174791267;9917.603295868194;8739.95630021849;8920.28637708985;9773.26700497462;9880.752981175456;11912.880871191264;12033.398330083504;12147.210431321935;12175.57385491508;12182.390880455987;12200.328981905992;10900.99999999996;11557.133215008907;12123.090768192376;12193.573224937174;12209.023278137727;9943.403395796204;10518.631847885288;11958.282503049844;11998.400079996052;12045.698857528545;39799.4030089546;40120.79939600312;40178.39732404016;40207;40343.19313613741;3342.74929380295;3445.5176275321223;3554.875579354736;3574.803385813779;3794.886153415402;29922.251943701365;30976.380472390425;31160.37679246425;31162.68837311643;31170.90901818448;3121.241309783446;3279.7212236959886;3295.242094318296;3322.9169270768184;3342.598888133415;513721;513982;514151.15093094535;514608;521558;56835.294941151835;56947;57236;57269.14096288559;57327.71336143293;60213.09680354798;61044;61053;61056.38943610596;61107.694461527404;15931;16121.355145794038;16154.434594789125;16158.192090395669;16192.595185120466;12556;12594.307313097868;12603.49586016549;12617.116801823784;12672.746545069047;13931.930340348234;14291.57125286243;14308.856911430961;15638.609034773994;15914.840851591567;6104.359042300494;6184.536159788034;6254.9687251563455;6265.561410701207;6319.778807741707;859.6045818923241;938.4510061614033;1030.7423144213947;1072.7050061233224;1086.7554800169898;25753.48493030129;26109.216723497946;26489.735102649112;26851.73148268492;27280.908763649233;1040.4173662748885;1049.5539395756925;1053.836655318427;1106.1593189176283;1124.9043831274269;11759.588414405454;14493.78259326111;14516.637084072983;14856;14949.252537373306;651106;655438;655599;657178;657623;47875;48546.78633034132;54723.72638136784;57190.14214786782;57300.56748581319;1320.6764342736092;1358.7893876449166;1360.7210521843197;1370.047816767337;1374.1548947397478;30107.03302847565;30745;30763.846180768953;31385.37229255448;31886.043418697474;41566.792166040184;49263.75368123136;49694.25458618051;49831.750841245565;49843.25235121549;349785;366323;427687;429500;430023;24908.0036798526;25117.869695864094;25183.992640294917;25198.496030079663;25306.367340816625;42314.788426057676;45081.323780142666;45325.77337113425;45750.54249457596;45839.31241031454;38990;38993.610063898996;39452.80273598614;39986.40020399638;40599.3910091343;37936;38170.42744358781;39321.80339098286;40389.3596215602;41141.58858411378;37420.43869341908;37765;38277.851664450114;38368.80815595904;38382.80808595939;31855;32475.837620811744;33582.99251022473;34055.82972085223;34242.48636270508;24959.87680554343;25002.74997250004;25128.748712513374;25401.61897571501;25646.61530077013 20:26:16 INFO - PROCESS | 1656 | |2;jquery.html;343.94923508681;365.2767520309785;367.1042655919556;379.69624300559553;398.3268276612525;14932.477363292286;15136.167510786903;16140.192990350493;16701.331946722148;20321.390358289238;19079.618407631875;19092.809071909276;19250.748701334403;19932.60134797303;20195.990200489952;5683.119116536944;5942.227510423639;5952.434518720736;5952.880942381172;5953.3748956359605;4832.275158726184;5072.898542029157;5840.415958404168;5908.1433192187105;5920.970395148018;5590.161475778646;5842.269716285465;5870.559708021916;5872.853178670524;5876.412358764111;5722.284714410699;5767.250257466544;5811.88376232473;5812.389699081577;5814.360420353758;4361.520232774392;4833.782479788418;5026.246063090529;5072.0616685912855;5102.668326558799;25618.359541011625;25959.480810383688;25998.22005339843;26251.868740656173;26599.33501662474;2218.4121207879925;2346.389938615955;2547.7579629935126;2949.410117976392;2976.880924763007;14205.076670016417;14892.62768430798;15161;15600.60998475036;15686.52940411778;1779.8576113910985;1829.039754129093;1919.9424017279505;1922.9423117306503;1944.1542928826007;123815;124648.37675811653;124898.37550812279;127269.72730272764;130690.69309306976;10858.34849909008;11321.886781132083;11328.433578321052;11371.090312774959;11515.30908145514;14139.575812725634;14182.290885455686;14188.36152373125;14196.14823110596;14196.503122390666;6602.636854973022;8319.126491718403;8374.497530148088;8488.363372746946;8614.267787238156;8456.2812160967;8506.702265420681;8513.489190648581;8698.652053917773;8706.259967902672;3873.69010479161;4275.123599662062;4337.284348082594;4440.844570440084;4505.526919673387;1754.2018381636324;1834.1379551610721;1888.0654076232079;1892.139076720089;1895.2797936783934;709.794159693683;721.8375865430236;736.9263073692695;849.6601359456267;849.8597731374253;20157;21851.344459666234;21894.562108758055;21933.01301441439;22011.559768804535;918.8300164469595;927.6594476751345;956.7512446763752;969.3650658818485;970.2092794372563;8405.537695426689;9105.998340182574;10488.42673598951;11331.980121789078;11359.091272698164;562334;565563;571639.2688584903;581378;582693;127604;132946;133770;135563.32218338846;136918.63081369258;977.4037836919473;990.5691024404407;997.5411310796969;1015.1726343030407;1016.6289304403839;12783.488660453479;16322.26988711224;19103;19614.411567652995;19738.11178497;55204.34386968397;55932.30451038142;56309;57095;59321.70339148277;78530;78550.82173767513;78698.60650696939;80788.19211808042;81084.18915810766;5624.437556244507;7931.286184243446;8056.556889370906;8181.550014749246;8186.959065204635;9538.570764315762;11103.835406908993;11576.79044429993;13334.466621335037;13380.866191337962;9981.750456238653;11209.831852522382;11269.154813389192;11405.372704501;11603;9697;9859.309848310837;10568.630097946534;10775.784484310114;11273.267237629529;10811.675649730521;11029.22795404314;11237.71905702364;11290.096792256436;11646.301221926711;7933.60331983387;8183.836323273382;8193.50838949641;8306;8345.41582089248;10230.488475576043;11256.493457794255;11361.54553817838;11514.021308188898;11520.884791152317 20:26:16 INFO - PROCESS | 1656 | |3;mootools.html;1284.4284293489397;1443.292786534598;1570.4346435283303;1801.5946412057297;1828.0494143045617;8453.78865528362;8989.280857531397;8989.415687980276;8991.235744961677;8998.19016288534;7624;7830.412719046066;8464.703735369263;8714.520701361422;8788.604512796923;2365.9645105323434;2390.474095698952;2393.042782886842;2394.616861302192;2400.7839294463497;2384.1178763857397;2400.435897564071;2409.7590240975937;2425.5391475619663;2425.7331693513697;2170.197027099975;2260.880863972328;2387.7373488916205;2412.0713525292713;2419.6128619420897;2362.787349138586;2372.857628542284;2381.4641705616273;2381.7141942966955;2381.7261014983237;2376.964345534818;2383.9284821455385;2387.2002879035545;2387.307680772574;2388.1283331584023;8858.557072146432;8919.866202006975;8923.821523569492;8928.598213080362;8934.28525717941;5108.4125325587665;5333.599980001515;5348.1442969124755;5355.062863998784;5360.115580929142;3424.845881935294;3521.7358698097487;3596.8741094061843;3645.54430696163;3653.3058718843336;1055.9155267578576;1095.6932059023486;1102.2394547762099;1112.527175950218;1116.9385683787389;11646.475908584134;11761.470733817;11769.58806441779;11788.29270243788;11790.705232369173;4530.207213737583;4592.288195329663;4778.378810754649;4789.449213340441;4792.784324705397;9943.701688949342;9946.055124763136;9949.55227014786;9949.751256218653;9958;5314.946850531445;5321.388040375329;5326.573874090063;5326.733663316819;5327.413984461706;4369.47566292047;4385.342198670161;4830.830920917751;4891.755412229374;4892.510748925079;3879.18537107205;3887.8444862205197;3970.6426421621613;4002.1195337025806;4015.9799201003807;1268.6257554021586;1288.3365066990507;1290.148501988683;1302.0950439444496;1303.9934800325937;861.4228466927174;882.5498995512335;887.3788348156316;916.2852974679761;957.3777044920718;5598.188262701886;5908.350081491032;5917.7928772493615;5988.760449581968;6086.239220097488;432.9710413546695;454.27269255756437;456.21303251890885;457.8969731810316;461.58226804741093;3407.966909450591;3772.7359084863797;4045.6358927696647;4053.2096241232675;4063.2686116499312;9151.63393464254;10346.586136554453;10805.973432523897;10811.18916081297;10821.404822734825;10754.408507532004;10776.946115269373;10778.407187604756;10779.514921828537;10788.352698837938;8145.3483721302155;8223.629936652866;8234.341252699769;8243.299319557906;8248.917510824935;5478.589105817159;5610.971945140248;5752.0509115997065;5795.275590551181;5897.882042359214;9996.400215987063;10039.247056470647;10064.094231519199;10077.034978179478;10094;9827.164691001344;10172.593096276067;10218.795624087328;10222.1089098517;10430.11344035735;6903.965480172567;7121.608311542915;7135.322144396274;7440.888386674313;7596.392288617008;8171.387145963958;8297.502149870785;8407.159284071544;8407.28538074246;8416.915830841614;7353.77938661841;7490.625468726651;7531.736389226351;7592.772216833504;7605.087389513294;6343;7278.308560686726;7361.705531778883;7519.624018799148;7540.132884718328;6885.621290828852;6915.481338899502;6986;6992.0910281663055;7008.964955175192;4894.583960363409;4968.726720030433;5019.774110164978;5023.899522009612;5064.772085256099;4873.976464942401;4978.800847966041;5101.7194054327365;5119.46245644202;5253.789848406173 20:26:16 INFO - PROCESS | 1656 | |4;prototype.html;299.344435685848;299.9999999999999;306.9877204911803;310.81506503630334;313.2903972502281;4893.923336865892;5301.920471192935;5340.73018966939;5341.889953468378;5349.893002139955;3969.821358038888;4851.369321988145;5095.6942583444925;5146.768395422206;5210.791568337262;3952.308346039446;3975.026118600947;4006.7595944243294;4051.270771261172;4077.2864748669012;3314.701676849083;3325.48454989477;3921.784301863396;4019.678425725935;4046.251443482965;3863.556044459269;3926.7447615905016;3962.4254483099935;3992.6207010333974;3998.1803730235233;3969.920601587981;4009.7995100245016;4015.6586690131226;4018.9799051004557;4050.1494686115952;3466.930661386758;3480.2517458746493;3512.8594856205723;3522.7534072614926;3525.964740352589;5039.44566097729;5097.7196254206;5098.59211263098;5124.026434977342;5126.871828204287;4144.378343248507;4396.296592545209;4457.465104187486;4477.3731677565165;4477.731336119843;4640.303954406866;4708.4820669726305;5241.344831896013;5498.615096943216;5555.944440555623;3266.4120458317493;3444.2594842109065;3675.6691897729334;3726.8881933541766;3744.9625503744887;5289.889123284115;5363.383210930715;5477.4796394342875;5641.774329026834;5796;3778.5465744110334;3785.6782173515007;3790.6967442604528;3797.240551889633;3797.6582107610448;3826.7129965252716;3844.2695887781233;3865.8840234792438;3888.844446222176;3900.5904380040256;4336.609705126553;4513.638908887281;4521.163584736834;4536.954630453719;4539.72761634303;4808.3989501312335;5443.564514838803;5487;5496.31296087989;5503.394626591072;1288.6005338345144;1315.4080663701372;1317.5520323090195;1318.9250760630057;1319.3601103464812;817.791463176886;841.4110122913985;847.5296210603051;868.444195714743;888.7733627924838;4968.801247950041;4986.90026199474;5015.949840501548;5019.67372120811;5127.435982041972;5493.725313734298;5554.638948468418;5556.861078473071;5599.8880022400135;5637.605367624227;4393.560643935581;4664.976675116603;4679.672422930362;4989.750512474362;5084.339035925306;2236.4073520517077;2849.3189018479197;2901;2905.3317736920626;2919.1680371094135;4710.36410084641;4889.926651100236;5575.275214222206;5616.831495055155;5682.431756824284;4733.573978341897;5031.723255220924;5285.260063591023;5342.035170480343;5566.276384070045;5009.797648564391;5575.665460072328;5590.664560126405;5732.082866741302;5742.48317651405;4059.167870586464;5157.922631160461;5498.5876059294915;5552.805651802168;5580.525655319181;5060.468650791761;5185.637005409585;5473.8357849264585;5493.313335833021;5506.421825708403;4905.386826646669;5681.318241811009;5710.373228314856;5713.514351280188;5793.3337666167245;3240.303334783033;3562.9109272267365;3689.9077523062138;3720.2001569662652;3756.323861704919;4682.742449165328;5445.727713614383;5463.262459567907;5475.589330800286;5506.284183056177;4518.841840535565;4732.574068333866;5391.81128660495;5400.946815371122;5401.567874570103;5080.332825266617;5314;5337.946620533745;5381.623286369917;5491.199488260936;4812.820858889594;5053.837617348104;5378.838634840961;5407.918881216863;5429.891402172014;4047.5024241031006;5088.847334579968;5178.43037265908;5244.767479642357;5391.81128660495;4952.925706114339;5265.894162225975;5334.746334611285;5415.5126038655135;5417.295751552273 20:26:16 INFO - PROCESS | 1656 | |5;yui.html;699.6606645776798;702.5433468245643;750.5571712689513;779.0153365535286;802.5987006496752;15228;16470.34118635256;16478.505644830646;16499.340026398928;16500.587485312873;14759.262036898166;14903;14914.925425372885;14924;14964.551063468087;678.2200469460136;684.9486288528356;693.3551796828947;827.3463963468868;833.5832083958021;851.1105894340429;855.2687452228348;865.16079402979;866.2204016385241;868.1622234543664;915.8534634458488;919.4804935211585;919.5815903763771;923.958421871014;924.9075092490764;707.1761397971358;716.3839098375392;911.4349103555804;913.6025828764475;914.3553794574809;653.3303364051885;658.246307977368;659.8548319369731;670.8658268346351;671.1409395973162;14943.103413795207;15022.173780442072;15025.248737563079;15031.624209394744;15035.849641503555;13654.726905461934;13992.510262140777;14104.153750774884;14151.575452736435;14485.348159332856;11088;11638.825417618742;11703.824442633368;11839.704007399798;12075.93962030193;4557.293619488984;4561.635069194456;4591.288350305708;4620.884477888046;4659.720416775004;114740.4262978688;117647;118387.40806295999;118863.40568297189;120762.99999999913;9521.428714277166;10775.08411785007;10805.189610779065;10817.405042722727;11105.167112466597;20831.687524687142;20840.687389689167;20870.895645521676;20872.79127208739;20895.164193432396;7740.993670822757;7762.961185194038;7986.361091112697;8037.919620803834;8057.31512821405;4246.808893599796;4320.719153255029;4362.974700945339;4513.75174365413;4522.186006518792;3346.715529179998;3442.1738782691973;3482.8432720527635;3483.0247530691445;3493.8602455901478;580.5239703443136;585.4292065236446;590.2209084009153;591.4322250639434;597.7877853362081;537.8762884536578;546.4126064480699;582.1297160744629;612.2622240200548;620.184457438476;7396.926030739732;7967.0439547253545;8935.73192804204;8936.776580585538;9113.088691130833;522.6576592332028;556.7772890843695;559.5188138201144;590.4744777148342;658.1049772309655;3872.935146464311;4187.832486700498;4413.3821265022925;4426.336049592587;4541.909161816745;103607.4819625912;150687;164350;169359.3064069368;170056;140917;141653.29173354275;145825;147015;147599;69850.95223571651;77153.6142319296;111547;122088;125908;7193.028941092885;8488.575571221538;8495.95752021236;8504.702335418231;8745.825083498421;64169.679151603945;66819;67810;67827.66086169735;71174;69121.96317055148;84021.15978840133;85715.57142214249;90375.09624903667;91730;13279.398788455566;13355.657542642868;13457.596272111852;13650.795238071238;13822.239776812372;14558.12651240929;14832.7775083376;14982.775258370915;15248;15530.456434024754;13676.521321753691;13793.793093103812;13838.23889686077;13922.791158132839;14244.216568088854;11251.549938002388;13433.932830335785;14190.645233869236;14356.35396407185;14468.131912085308;13644.181349118688;13655.931720341334;14030.438782448997;14054.156750594997;14084.577462676136;10674.679759607225;11014.94728746438;11052.171087168334;11298.7740245193;11326.603568875049;9080.496404454188;11472.393864859094;11576.305421674726;11594.47824847867;11600.709982250512 20:26:16 INFO - PROCESS | 1656 | __end_tp_report 20:26:16 INFO - PROCESS | 1656 | __start_cc_report 20:26:16 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1177 20:26:16 INFO - PROCESS | 1656 | __end_cc_report 20:26:16 INFO - PROCESS | 1656 | __startTimestamp1473737176758__endTimestamp 20:26:16 INFO - PROCESS | 1656 | 20:26:16 INFO - PROCESS | 1656 | ------- Summary: start ------- 20:26:16 INFO - PROCESS | 1656 | Number of tests: 6 20:26:16 INFO - PROCESS | 1656 | 20:26:16 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5692.34 Median:5858.85 stddev:672.14 (11.5%) stddev-sans-first:635.08 20:26:16 INFO - PROCESS | 1656 | Values: 2811.6 3220.3 3248.9 3353.5 3390.2 5628.0 5698.3 5755.8 5773.1 5775.7 4458.6 5428.2 5732.5 5742.2 5742.8 5145.4 5185.5 5200.5 5246.1 5285.5 5187.3 5259.9 5269.2 5271.0 5271.6 5156.4 5174.2 5178.3 5197.4 5263.9 5272.6 5287.9 5290.1 5304.3 5337.1 4363.6 5092.4 5116.6 5128.4 5214.3 5656.6 5695.5 5710.5 5718.7 5749.6 5136.8 6239.9 6242.1 6244.0 6258.5 5868.4 6134.4 6145.8 6307.8 6340.0 5228.0 5624.0 5716.7 5726.3 5756.8 6310.8 6314.5 6332.0 6342.1 6348.9 5986.1 6076.0 6133.9 6138.4 6141.4 6101.8 6140.9 6144.7 6180.1 6282.5 5488.0 6028.9 6207.8 6237.1 6241.6 5910.1 6011.2 6253.6 6259.4 6278.5 4321.5 4788.9 4794.5 4833.3 4870.0 4397.7 4402.0 4432.9 4440.7 4449.6 5645.1 5662.0 5683.6 5692.7 5706.1 6163.9 6180.3 6190.4 6228.7 6238.9 5695.1 5726.9 5759.8 5762.3 5792.6 5407.3 5408.3 5409.8 5411.9 5413.0 6249.2 6312.3 6313.9 6321.1 6328.4 6151.7 6171.0 6180.0 6211.3 6253.6 6270.2 6274.3 6293.8 6299.3 6303.1 6167.8 6171.6 6189.3 6193.0 6197.8 5383.6 6094.7 6113.9 6168.0 6206.6 6100.6 6110.3 6115.9 6120.3 6124.1 6098.7 6114.1 6131.3 6144.7 6145.9 5730.8 5767.3 5858.9 5878.9 6020.3 6110.3 6137.5 6153.1 6155.4 6159.4 5807.3 5824.7 5926.7 5935.4 5983.9 20:26:16 INFO - PROCESS | 1656 | 20:26:16 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:65813.82 Median:3564.84 stddev:142890.06 (4008.3%) stddev-sans-first:143206.64 20:26:16 INFO - PROCESS | 1656 | Values: 457.3 482.0 506.5 522.1 566.7 24239.8 32110.8 32119.5 32144.8 39668.6 42526.8 42763.4 42889.6 42925.9 42964.8 9710.9 9914.3 9915.3 9916.5 9917.6 8740.0 8920.3 9773.3 9880.8 11912.9 12033.4 12147.2 12175.6 12182.4 12200.3 10901.0 11557.1 12123.1 12193.6 12209.0 9943.4 10518.6 11958.3 11998.4 12045.7 39799.4 40120.8 40178.4 40207.0 40343.2 3342.7 3445.5 3554.9 3574.8 3794.9 29922.3 30976.4 31160.4 31162.7 31170.9 3121.2 3279.7 3295.2 3322.9 3342.6 513721.0 513982.0 514151.2 514608.0 521558.0 56835.3 56947.0 57236.0 57269.1 57327.7 60213.1 61044.0 61053.0 61056.4 61107.7 15931.0 16121.4 16154.4 16158.2 16192.6 12556.0 12594.3 12603.5 12617.1 12672.7 13931.9 14291.6 14308.9 15638.6 15914.8 6104.4 6184.5 6255.0 6265.6 6319.8 859.6 938.5 1030.7 1072.7 1086.8 25753.5 26109.2 26489.7 26851.7 27280.9 1040.4 1049.6 1053.8 1106.2 1124.9 11759.6 14493.8 14516.6 14856.0 14949.3 651106.0 655438.0 655599.0 657178.0 657623.0 47875.0 48546.8 54723.7 57190.1 57300.6 1320.7 1358.8 1360.7 1370.0 1374.2 30107.0 30745.0 30763.8 31385.4 31886.0 41566.8 49263.8 49694.3 49831.8 49843.3 349785.0 366323.0 427687.0 429500.0 430023.0 24908.0 25117.9 25184.0 25198.5 25306.4 42314.8 45081.3 45325.8 45750.5 45839.3 38990.0 38993.6 39452.8 39986.4 40599.4 37936.0 38170.4 39321.8 40389.4 41141.6 37420.4 37765.0 38277.9 38368.8 38382.8 31855.0 32475.8 33583.0 34055.8 34242.5 24959.9 25002.7 25128.7 25401.6 25646.6 20:26:16 INFO - PROCESS | 1656 | 20:26:16 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:34734.05 Median:1660.42 stddev:96271.87 (5798.1%) stddev-sans-first:96507.31 20:26:16 INFO - PROCESS | 1656 | Values: 343.9 365.3 367.1 379.7 398.3 14932.5 15136.2 16140.2 16701.3 20321.4 19079.6 19092.8 19250.7 19932.6 20196.0 5683.1 5942.2 5952.4 5952.9 5953.4 4832.3 5072.9 5840.4 5908.1 5921.0 5590.2 5842.3 5870.6 5872.9 5876.4 5722.3 5767.3 5811.9 5812.4 5814.4 4361.5 4833.8 5026.2 5072.1 5102.7 25618.4 25959.5 25998.2 26251.9 26599.3 2218.4 2346.4 2547.8 2949.4 2976.9 14205.1 14892.6 15161.0 15600.6 15686.5 1779.9 1829.0 1919.9 1922.9 1944.2 123815.0 124648.4 124898.4 127269.7 130690.7 10858.3 11321.9 11328.4 11371.1 11515.3 14139.6 14182.3 14188.4 14196.1 14196.5 6602.6 8319.1 8374.5 8488.4 8614.3 8456.3 8506.7 8513.5 8698.7 8706.3 3873.7 4275.1 4337.3 4440.8 4505.5 1754.2 1834.1 1888.1 1892.1 1895.3 709.8 721.8 736.9 849.7 849.9 20157.0 21851.3 21894.6 21933.0 22011.6 918.8 927.7 956.8 969.4 970.2 8405.5 9106.0 10488.4 11332.0 11359.1 562334.0 565563.0 571639.3 581378.0 582693.0 127604.0 132946.0 133770.0 135563.3 136918.6 977.4 990.6 997.5 1015.2 1016.6 12783.5 16322.3 19103.0 19614.4 19738.1 55204.3 55932.3 56309.0 57095.0 59321.7 78530.0 78550.8 78698.6 80788.2 81084.2 5624.4 7931.3 8056.6 8181.6 8187.0 9538.6 11103.8 11576.8 13334.5 13380.9 9981.8 11209.8 11269.2 11405.4 11603.0 9697.0 9859.3 10568.6 10775.8 11273.3 10811.7 11029.2 11237.7 11290.1 11646.3 7933.6 8183.8 8193.5 8306.0 8345.4 10230.5 11256.5 11361.5 11514.0 11520.9 20:26:16 INFO - PROCESS | 1656 | 20:26:16 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5692.19 Median:4882.87 stddev:3215.80 (65.9%) stddev-sans-first:3207.76 20:26:16 INFO - PROCESS | 1656 | Values: 1284.4 1443.3 1570.4 1801.6 1828.0 8453.8 8989.3 8989.4 8991.2 8998.2 7624.0 7830.4 8464.7 8714.5 8788.6 2366.0 2390.5 2393.0 2394.6 2400.8 2384.1 2400.4 2409.8 2425.5 2425.7 2170.2 2260.9 2387.7 2412.1 2419.6 2362.8 2372.9 2381.5 2381.7 2381.7 2377.0 2383.9 2387.2 2387.3 2388.1 8858.6 8919.9 8923.8 8928.6 8934.3 5108.4 5333.6 5348.1 5355.1 5360.1 3424.8 3521.7 3596.9 3645.5 3653.3 1055.9 1095.7 1102.2 1112.5 1116.9 11646.5 11761.5 11769.6 11788.3 11790.7 4530.2 4592.3 4778.4 4789.4 4792.8 9943.7 9946.1 9949.6 9949.8 9958.0 5314.9 5321.4 5326.6 5326.7 5327.4 4369.5 4385.3 4830.8 4891.8 4892.5 3879.2 3887.8 3970.6 4002.1 4016.0 1268.6 1288.3 1290.1 1302.1 1304.0 861.4 882.5 887.4 916.3 957.4 5598.2 5908.4 5917.8 5988.8 6086.2 433.0 454.3 456.2 457.9 461.6 3408.0 3772.7 4045.6 4053.2 4063.3 9151.6 10346.6 10806.0 10811.2 10821.4 10754.4 10776.9 10778.4 10779.5 10788.4 8145.3 8223.6 8234.3 8243.3 8248.9 5478.6 5611.0 5752.1 5795.3 5897.9 9996.4 10039.2 10064.1 10077.0 10094.0 9827.2 10172.6 10218.8 10222.1 10430.1 6904.0 7121.6 7135.3 7440.9 7596.4 8171.4 8297.5 8407.2 8407.3 8416.9 7353.8 7490.6 7531.7 7592.8 7605.1 6343.0 7278.3 7361.7 7519.6 7540.1 6885.6 6915.5 6986.0 6992.1 7009.0 4894.6 4968.7 5019.8 5023.9 5064.8 4874.0 4978.8 5101.7 5119.5 5253.8 20:26:16 INFO - PROCESS | 1656 | 20:26:16 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4388.31 Median:4977.85 stddev:1326.56 (26.6%) stddev-sans-first:1294.29 20:26:16 INFO - PROCESS | 1656 | Values: 299.3 300.0 307.0 310.8 313.3 4893.9 5301.9 5340.7 5341.9 5349.9 3969.8 4851.4 5095.7 5146.8 5210.8 3952.3 3975.0 4006.8 4051.3 4077.3 3314.7 3325.5 3921.8 4019.7 4046.3 3863.6 3926.7 3962.4 3992.6 3998.2 3969.9 4009.8 4015.7 4019.0 4050.1 3466.9 3480.3 3512.9 3522.8 3526.0 5039.4 5097.7 5098.6 5124.0 5126.9 4144.4 4396.3 4457.5 4477.4 4477.7 4640.3 4708.5 5241.3 5498.6 5555.9 3266.4 3444.3 3675.7 3726.9 3745.0 5289.9 5363.4 5477.5 5641.8 5796.0 3778.5 3785.7 3790.7 3797.2 3797.7 3826.7 3844.3 3865.9 3888.8 3900.6 4336.6 4513.6 4521.2 4537.0 4539.7 4808.4 5443.6 5487.0 5496.3 5503.4 1288.6 1315.4 1317.6 1318.9 1319.4 817.8 841.4 847.5 868.4 888.8 4968.8 4986.9 5015.9 5019.7 5127.4 5493.7 5554.6 5556.9 5599.9 5637.6 4393.6 4665.0 4679.7 4989.8 5084.3 2236.4 2849.3 2901.0 2905.3 2919.2 4710.4 4889.9 5575.3 5616.8 5682.4 4733.6 5031.7 5285.3 5342.0 5566.3 5009.8 5575.7 5590.7 5732.1 5742.5 4059.2 5157.9 5498.6 5552.8 5580.5 5060.5 5185.6 5473.8 5493.3 5506.4 4905.4 5681.3 5710.4 5713.5 5793.3 3240.3 3562.9 3689.9 3720.2 3756.3 4682.7 5445.7 5463.3 5475.6 5506.3 4518.8 4732.6 5391.8 5400.9 5401.6 5080.3 5314.0 5337.9 5381.6 5491.2 4812.8 5053.8 5378.8 5407.9 5429.9 4047.5 5088.8 5178.4 5244.8 5391.8 4952.9 5265.9 5334.7 5415.5 5417.3 20:26:16 INFO - PROCESS | 1656 | 20:26:16 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:25295.49 Median:3683.40 stddev:41301.45 (1121.3%) stddev-sans-first:41376.03 20:26:16 INFO - PROCESS | 1656 | Values: 699.7 702.5 750.6 779.0 802.6 15228.0 16470.3 16478.5 16499.3 16500.6 14759.3 14903.0 14914.9 14924.0 14964.6 678.2 684.9 693.4 827.3 833.6 851.1 855.3 865.2 866.2 868.2 915.9 919.5 919.6 924.0 924.9 707.2 716.4 911.4 913.6 914.4 653.3 658.2 659.9 670.9 671.1 14943.1 15022.2 15025.2 15031.6 15035.8 13654.7 13992.5 14104.2 14151.6 14485.3 11088.0 11638.8 11703.8 11839.7 12075.9 4557.3 4561.6 4591.3 4620.9 4659.7 114740.4 117647.0 118387.4 118863.4 120763.0 9521.4 10775.1 10805.2 10817.4 11105.2 20831.7 20840.7 20870.9 20872.8 20895.2 7741.0 7763.0 7986.4 8037.9 8057.3 4246.8 4320.7 4363.0 4513.8 4522.2 3346.7 3442.2 3482.8 3483.0 3493.9 580.5 585.4 590.2 591.4 597.8 537.9 546.4 582.1 612.3 620.2 7396.9 7967.0 8935.7 8936.8 9113.1 522.7 556.8 559.5 590.5 658.1 3872.9 4187.8 4413.4 4426.3 4541.9 103607.5 150687.0 164350.0 169359.3 170056.0 140917.0 141653.3 145825.0 147015.0 147599.0 69851.0 77153.6 111547.0 122088.0 125908.0 7193.0 8488.6 8496.0 8504.7 8745.8 64169.7 66819.0 67810.0 67827.7 71174.0 69122.0 84021.2 85715.6 90375.1 91730.0 13279.4 13355.7 13457.6 13650.8 13822.2 14558.1 14832.8 14982.8 15248.0 15530.5 13676.5 13793.8 13838.2 13922.8 14244.2 11251.5 13433.9 14190.6 14356.4 14468.1 13644.2 13655.9 14030.4 14054.2 14084.6 10674.7 11014.9 11052.2 11298.8 11326.6 9080.5 11472.4 11576.3 11594.5 11600.7 20:26:16 INFO - PROCESS | 1656 | -------- Summary: end -------- 20:26:16 INFO - PROCESS | 1656 | 20:26:17 INFO - TEST-INFO | 1656: exit 0 20:26:17 INFO - TEST-OK | dromaeo_css | took 1117405ms 20:26:17 INFO - TEST-START | kraken 20:26:17 INFO - operating with platform_type : mac_ 20:26:17 INFO - Initialising browser for kraken test... 20:26:17 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpiDKh0l/profile http://localhost:49277/getInfo.html) 20:26:19 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 20:26:19 INFO - PROCESS | 1665 | colorDepth:24 20:26:19 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 20:26:19 INFO - PROCESS | 1665 | __metrics 20:26:19 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" 20:26:19 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] 20:26:20 INFO - TEST-INFO | 1665: exit 0 20:26:20 INFO - Browser initialized. 20:26:20 INFO - Running cycle 1/1 for kraken test... 20:26:20 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpiDKh0l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:26:32 INFO - PROCESS | 1666 | RSS: Main: 234090496 20:26:32 INFO - PROCESS | 1666 | 20:26:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 20:26:36 INFO - PROCESS | 1666 | RSS: Main: 293933056 20:26:36 INFO - PROCESS | 1666 | 20:26:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 20:26:39 INFO - PROCESS | 1666 | RSS: Main: 289718272 20:26:39 INFO - PROCESS | 1666 | 20:26:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 20:26:43 INFO - PROCESS | 1666 | RSS: Main: 373407744 20:26:43 INFO - PROCESS | 1666 | 20:26:45 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 20:26:46 INFO - PROCESS | 1666 | RSS: Main: 280977408 20:26:46 INFO - PROCESS | 1666 | 20:26:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:49 INFO - PROCESS | 1666 | RSS: Main: 284225536 20:26:49 INFO - PROCESS | 1666 | 20:26:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:52 INFO - PROCESS | 1666 | RSS: Main: 322920448 20:26:52 INFO - PROCESS | 1666 | 20:26:55 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 20:26:56 INFO - PROCESS | 1666 | RSS: Main: 323448832 20:26:56 INFO - PROCESS | 1666 | 20:26:58 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 20:26:59 INFO - PROCESS | 1666 | RSS: Main: 323543040 20:26:59 INFO - PROCESS | 1666 | 20:27:00 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:27:01 INFO - PROCESS | 1666 | RSS: Main: 298823680 20:27:01 INFO - PROCESS | 1666 | 20:27:03 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:27:04 INFO - PROCESS | 1666 | RSS: Main: 304422912 20:27:04 INFO - PROCESS | 1666 | 20:27:06 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:27:07 INFO - PROCESS | 1666 | RSS: Main: 305188864 20:27:07 INFO - PROCESS | 1666 | 20:27:09 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:27:10 INFO - PROCESS | 1666 | RSS: Main: 321679360 20:27:10 INFO - PROCESS | 1666 | 20:27:13 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:27:14 INFO - PROCESS | 1666 | RSS: Main: 318205952 20:27:14 INFO - PROCESS | 1666 | 20:27:15 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 20:27:16 INFO - PROCESS | 1666 | RSS: Main: 362250240 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | __start_tp_report 20:27:16 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 20:27:16 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 20:27:16 INFO - PROCESS | 1666 | |i|pagename|runs| 20:27:16 INFO - PROCESS | 1666 | |0;ai-astar;112;111;116;119;165;156;112;111;113;123 20:27:16 INFO - PROCESS | 1666 | |1;audio-beat-detection;147;117;160;195;108;128;129;108;157;116 20:27:16 INFO - PROCESS | 1666 | |2;audio-dft;185;184;186;187;186;181;180;182;184;182 20:27:16 INFO - PROCESS | 1666 | |3;audio-fft;80;74;78;153;73;81;80;88;143;58 20:27:16 INFO - PROCESS | 1666 | |4;audio-oscillator;81;82;137;70;70;73;118;69;69;116 20:27:16 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;88;85;88;85;88;84;88;84;87;85 20:27:16 INFO - PROCESS | 1666 | |6;imaging-darkroom;95;96;97;95;96;108;162;97;96;101 20:27:16 INFO - PROCESS | 1666 | |7;imaging-desaturate;85;94;87;84;84;84;87;86;84;83 20:27:16 INFO - PROCESS | 1666 | |8;json-parse-financial;55;55;56;54;55;55;54;53;53;52 20:27:16 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;64;63;70;71;72;74;68;69;65;70 20:27:16 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;88;85;85;86;95;101;105;106;88;84 20:27:16 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;139;140;139;139;141;138;137;152;178;160 20:27:16 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;168;169;167;201;166;167;169;167;168;171 20:27:16 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;67;67;69;67;68;66;67;67;67;68 20:27:16 INFO - PROCESS | 1666 | __end_tp_report 20:27:16 INFO - PROCESS | 1666 | __start_cc_report 20:27:16 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,2096 20:27:16 INFO - PROCESS | 1666 | __end_cc_report 20:27:16 INFO - PROCESS | 1666 | __startTimestamp1473737236108__endTimestamp 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | ------- Summary: start ------- 20:27:16 INFO - PROCESS | 1666 | Number of tests: 14 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:123.80 Median:117.50 stddev:19.84 (16.9%) stddev-sans-first:20.58 20:27:16 INFO - PROCESS | 1666 | Values: 112.0 111.0 116.0 119.0 165.0 156.0 112.0 111.0 113.0 123.0 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:138.00 stddev:28.00 (20.3%) stddev-sans-first:29.44 20:27:16 INFO - PROCESS | 1666 | Values: 147.0 117.0 160.0 195.0 108.0 128.0 129.0 108.0 157.0 116.0 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.50 stddev:2.36 (1.3%) stddev-sans-first:2.46 20:27:16 INFO - PROCESS | 1666 | Values: 185.0 184.0 186.0 187.0 186.0 181.0 180.0 182.0 184.0 182.0 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:90.80 Median:79.00 stddev:31.22 (39.5%) stddev-sans-first:32.86 20:27:16 INFO - PROCESS | 1666 | Values: 80.0 74.0 78.0 153.0 73.0 81.0 80.0 88.0 143.0 58.0 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:88.50 Median:70.00 stddev:25.30 (36.1%) stddev-sans-first:26.69 20:27:16 INFO - PROCESS | 1666 | Values: 81.0 82.0 137.0 70.0 70.0 73.0 118.0 69.0 69.0 116.0 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:87.50 stddev:1.75 (2.0%) stddev-sans-first:1.73 20:27:16 INFO - PROCESS | 1666 | Values: 88.0 85.0 88.0 85.0 88.0 84.0 88.0 84.0 87.0 85.0 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:104.30 Median:96.00 stddev:20.66 (21.5%) stddev-sans-first:21.63 20:27:16 INFO - PROCESS | 1666 | Values: 95.0 96.0 97.0 95.0 96.0 108.0 162.0 97.0 96.0 101.0 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:85.50 stddev:3.19 (3.7%) stddev-sans-first:3.37 20:27:16 INFO - PROCESS | 1666 | Values: 85.0 94.0 87.0 84.0 84.0 84.0 87.0 86.0 84.0 83.0 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:1.23 (2.2%) stddev-sans-first:1.27 20:27:16 INFO - PROCESS | 1666 | Values: 55.0 55.0 56.0 54.0 55.0 55.0 54.0 53.0 53.0 52.0 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:70.00 stddev:3.60 (5.1%) stddev-sans-first:3.41 20:27:16 INFO - PROCESS | 1666 | Values: 64.0 63.0 70.0 71.0 72.0 74.0 68.0 69.0 65.0 70.0 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:92.30 Median:85.50 stddev:8.72 (10.2%) stddev-sans-first:9.11 20:27:16 INFO - PROCESS | 1666 | Values: 88.0 85.0 85.0 86.0 95.0 101.0 105.0 106.0 88.0 84.0 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:140.50 stddev:13.37 (9.5%) stddev-sans-first:13.91 20:27:16 INFO - PROCESS | 1666 | Values: 139.0 140.0 139.0 139.0 141.0 138.0 137.0 152.0 178.0 160.0 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:168.50 stddev:10.53 (6.2%) stddev-sans-first:11.10 20:27:16 INFO - PROCESS | 1666 | Values: 168.0 169.0 167.0 201.0 166.0 167.0 169.0 167.0 168.0 171.0 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 20:27:16 INFO - PROCESS | 1666 | Values: 67.0 67.0 69.0 67.0 68.0 66.0 67.0 67.0 67.0 68.0 20:27:16 INFO - PROCESS | 1666 | -------- Summary: end -------- 20:27:16 INFO - PROCESS | 1666 | 20:27:16 INFO - TEST-INFO | 1666: exit 0 20:27:16 INFO - TEST-OK | kraken | took 59575ms 20:27:16 INFO - SUITE-END | took 1176s 20:27:17 INFO - Completed test suite (00:19:37) 20:27:17 INFO - javascript benchmark 20:27:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2811.56420754783, 3220.3237320162766, 3248.870045198192, 3353.5472711183997, 3390.169408494919, 5627.986962346786, 5698.34469036061, 5755.827325180241, 5773.076307790749, 5775.682337471448, 4458.6210172135325, 5428.212909128174, 5732.48407643313, 5742.2247996520455, 5742.8277151685415, 5145.408278048026, 5185.455527169649, 5200.531952124308, 5246.108161612516, 5285.471452854722, 5187.299714538545, 5259.947400526004, 5269.235960785683, 5270.998510283053, 5271.630985830993, 5156.407013193474, 5174.249733788598, 5178.275041494194, 5197.376314842205, 5263.921041184385, 5272.578193744491, 5287.947120528784, 5290.074237008508, 5304.336957880265, 5337.11937530307, 4363.607275345203, 5092.37234379956, 5116.616253780981, 5128.435872054071, 5214.32213812202, 5656.604037717361, 5695.487406133427, 5710.543156547466, 5718.7426565804635, 5749.59752817303, 5136.845894623168, 6239.937600624026, 6242.094896240065, 6243.96878015607, 6258.4680302174365, 5868.4424979626865, 6134.375358695247, 6145.8156255312415, 6307.810765677037, 6339.968300158515, 5228.0, 5624.015797235549, 5716.742746576414, 5726.31284245889, 5756.819851930344, 6310.7791227306825, 6314.463270621956, 6331.986882098934, 6342.112104305401, 6348.873022539523, 5986.102084687332, 6076.0047534046935, 6133.907991380043, 6138.447539721446, 6141.385861413913, 6101.786437474756, 6140.933729673037, 6144.740328232701, 6180.103884936659, 6282.528810339243, 5487.957288115245, 6028.939710602838, 6207.81376558704, 6237.09562113491, 6241.594296370721, 5910.143029260733, 6011.1884895539415, 6253.5622506424115, 6259.405356491126, 6278.529110316745, 4321.503027151918, 4788.928166077511, 4794.520547945247, 4833.32333473314, 4869.975650121798, 4397.714148580332, 4401.9875428651585, 4432.867013989586, 4440.666949978765, 4449.621782148489, 5645.068563687028, 5662.0, 5683.630564013326, 5692.658440493584, 5706.11555208935, 6163.907541386883, 6180.289266734383, 6190.41191086846, 6228.657423841732, 6238.875222495525, 5695.117256825199, 5726.885462290814, 5759.798407055733, 5762.250907382014, 5792.565557583198, 5407.324084489439, 5408.323959505062, 5409.83770486886, 5411.864703382447, 5413.025655382069, 6249.156363890998, 6312.305646378894, 6313.905291420724, 6321.051842223611, 6328.398802113792, 6151.723172457339, 6171.012637977902, 6180.011198208265, 6211.3478084800445, 6253.624782513064, 6270.15352927349, 6274.341194174546, 6293.811185664437, 6299.338569450325, 6303.086052522451, 6167.814965551041, 6171.56799024064, 6189.288231853395, 6193.009118541012, 6197.81406557804, 5383.569314454912, 6094.7432096071825, 6113.902014424272, 6168.0439531872635, 6206.596571222856, 6100.550895826025, 6110.346130329577, 6115.879294474606, 6120.325235636462, 6124.136831511461, 6098.704546243851, 6114.054067497468, 6131.315499378873, 6144.740328232791, 6145.877082458415, 5730.799422020209, 5767.279090113736, 5858.853528661817, 5878.94121058801, 6020.337762846171, 6110.26676798787, 6137.508999279958, 6153.107799369156, 6155.415235552616, 6159.414855588712, 5807.332156802022, 5824.70876456167, 5926.674032928058, 5935.436133567304, 5983.910241346471], "value": 5647.486296584871, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.32772823948807, 481.9662623616347, 506.5188071332235, 522.1202274168027, 566.7135602183042, 24239.75760242397, 32110.83944580277, 32119.51820722691, 32144.839275803646, 39668.60331396685, 42526.78736606312, 42763.35854962178, 42889.571104288945, 42925.92685182864, 42964.785176074074, 9710.902890971089, 9914.256430767686, 9915.305928585001, 9916.504174791267, 9917.603295868194, 8739.95630021849, 8920.28637708985, 9773.26700497462, 9880.752981175456, 11912.880871191264, 12033.398330083504, 12147.210431321935, 12175.57385491508, 12182.390880455987, 12200.328981905992, 10900.99999999996, 11557.133215008907, 12123.090768192376, 12193.573224937174, 12209.023278137727, 9943.403395796204, 10518.631847885288, 11958.282503049844, 11998.400079996052, 12045.698857528545, 39799.4030089546, 40120.79939600312, 40178.39732404016, 40207.0, 40343.19313613741, 3342.74929380295, 3445.5176275321223, 3554.875579354736, 3574.803385813779, 3794.886153415402, 29922.251943701365, 30976.380472390425, 31160.37679246425, 31162.68837311643, 31170.90901818448, 3121.241309783446, 3279.7212236959886, 3295.242094318296, 3322.9169270768184, 3342.598888133415, 513721.0, 513982.0, 514151.15093094535, 514608.0, 521558.0, 56835.294941151835, 56947.0, 57236.0, 57269.14096288559, 57327.71336143293, 60213.09680354798, 61044.0, 61053.0, 61056.38943610596, 61107.694461527404, 15931.0, 16121.355145794038, 16154.434594789125, 16158.192090395669, 16192.595185120466, 12556.0, 12594.307313097868, 12603.49586016549, 12617.116801823784, 12672.746545069047, 13931.930340348234, 14291.57125286243, 14308.856911430961, 15638.609034773994, 15914.840851591567, 6104.359042300494, 6184.536159788034, 6254.9687251563455, 6265.561410701207, 6319.778807741707, 859.6045818923241, 938.4510061614033, 1030.7423144213947, 1072.7050061233224, 1086.7554800169898, 25753.48493030129, 26109.216723497946, 26489.735102649112, 26851.73148268492, 27280.908763649233, 1040.4173662748885, 1049.5539395756925, 1053.836655318427, 1106.1593189176283, 1124.9043831274269, 11759.588414405454, 14493.78259326111, 14516.637084072983, 14856.0, 14949.252537373306, 651106.0, 655438.0, 655599.0, 657178.0, 657623.0, 47875.0, 48546.78633034132, 54723.72638136784, 57190.14214786782, 57300.56748581319, 1320.6764342736092, 1358.7893876449166, 1360.7210521843197, 1370.047816767337, 1374.1548947397478, 30107.03302847565, 30745.0, 30763.846180768953, 31385.37229255448, 31886.043418697474, 41566.792166040184, 49263.75368123136, 49694.25458618051, 49831.750841245565, 49843.25235121549, 349785.0, 366323.0, 427687.0, 429500.0, 430023.0, 24908.0036798526, 25117.869695864094, 25183.992640294917, 25198.496030079663, 25306.367340816625, 42314.788426057676, 45081.323780142666, 45325.77337113425, 45750.54249457596, 45839.31241031454, 38990.0, 38993.610063898996, 39452.80273598614, 39986.40020399638, 40599.3910091343, 37936.0, 38170.42744358781, 39321.80339098286, 40389.3596215602, 41141.58858411378, 37420.43869341908, 37765.0, 38277.851664450114, 38368.80815595904, 38382.80808595939, 31855.0, 32475.837620811744, 33582.99251022473, 34055.82972085223, 34242.48636270508, 24959.87680554343, 25002.74997250004, 25128.748712513374, 25401.61897571501, 25646.61530077013], "value": 19607.83939856578, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.94923508681, 365.2767520309785, 367.1042655919556, 379.69624300559553, 398.3268276612525, 14932.477363292286, 15136.167510786903, 16140.192990350493, 16701.331946722148, 20321.390358289238, 19079.618407631875, 19092.809071909276, 19250.748701334403, 19932.60134797303, 20195.990200489952, 5683.119116536944, 5942.227510423639, 5952.434518720736, 5952.880942381172, 5953.3748956359605, 4832.275158726184, 5072.898542029157, 5840.415958404168, 5908.1433192187105, 5920.970395148018, 5590.161475778646, 5842.269716285465, 5870.559708021916, 5872.853178670524, 5876.412358764111, 5722.284714410699, 5767.250257466544, 5811.88376232473, 5812.389699081577, 5814.360420353758, 4361.520232774392, 4833.782479788418, 5026.246063090529, 5072.0616685912855, 5102.668326558799, 25618.359541011625, 25959.480810383688, 25998.22005339843, 26251.868740656173, 26599.33501662474, 2218.4121207879925, 2346.389938615955, 2547.7579629935126, 2949.410117976392, 2976.880924763007, 14205.076670016417, 14892.62768430798, 15161.0, 15600.60998475036, 15686.52940411778, 1779.8576113910985, 1829.039754129093, 1919.9424017279505, 1922.9423117306503, 1944.1542928826007, 123815.0, 124648.37675811653, 124898.37550812279, 127269.72730272764, 130690.69309306976, 10858.34849909008, 11321.886781132083, 11328.433578321052, 11371.090312774959, 11515.30908145514, 14139.575812725634, 14182.290885455686, 14188.36152373125, 14196.14823110596, 14196.503122390666, 6602.636854973022, 8319.126491718403, 8374.497530148088, 8488.363372746946, 8614.267787238156, 8456.2812160967, 8506.702265420681, 8513.489190648581, 8698.652053917773, 8706.259967902672, 3873.69010479161, 4275.123599662062, 4337.284348082594, 4440.844570440084, 4505.526919673387, 1754.2018381636324, 1834.1379551610721, 1888.0654076232079, 1892.139076720089, 1895.2797936783934, 709.794159693683, 721.8375865430236, 736.9263073692695, 849.6601359456267, 849.8597731374253, 20157.0, 21851.344459666234, 21894.562108758055, 21933.01301441439, 22011.559768804535, 918.8300164469595, 927.6594476751345, 956.7512446763752, 969.3650658818485, 970.2092794372563, 8405.537695426689, 9105.998340182574, 10488.42673598951, 11331.980121789078, 11359.091272698164, 562334.0, 565563.0, 571639.2688584903, 581378.0, 582693.0, 127604.0, 132946.0, 133770.0, 135563.32218338846, 136918.63081369258, 977.4037836919473, 990.5691024404407, 997.5411310796969, 1015.1726343030407, 1016.6289304403839, 12783.488660453479, 16322.26988711224, 19103.0, 19614.411567652995, 19738.11178497, 55204.34386968397, 55932.30451038142, 56309.0, 57095.0, 59321.70339148277, 78530.0, 78550.82173767513, 78698.60650696939, 80788.19211808042, 81084.18915810766, 5624.437556244507, 7931.286184243446, 8056.556889370906, 8181.550014749246, 8186.959065204635, 9538.570764315762, 11103.835406908993, 11576.79044429993, 13334.466621335037, 13380.866191337962, 9981.750456238653, 11209.831852522382, 11269.154813389192, 11405.372704501, 11603.0, 9697.0, 9859.309848310837, 10568.630097946534, 10775.784484310114, 11273.267237629529, 10811.675649730521, 11029.22795404314, 11237.71905702364, 11290.096792256436, 11646.301221926711, 7933.60331983387, 8183.836323273382, 8193.50838949641, 8306.0, 8345.41582089248, 10230.488475576043, 11256.493457794255, 11361.54553817838, 11514.021308188898, 11520.884791152317], "value": 9473.977532738683, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.4284293489397, 1443.292786534598, 1570.4346435283303, 1801.5946412057297, 1828.0494143045617, 8453.78865528362, 8989.280857531397, 8989.415687980276, 8991.235744961677, 8998.19016288534, 7624.0, 7830.412719046066, 8464.703735369263, 8714.520701361422, 8788.604512796923, 2365.9645105323434, 2390.474095698952, 2393.042782886842, 2394.616861302192, 2400.7839294463497, 2384.1178763857397, 2400.435897564071, 2409.7590240975937, 2425.5391475619663, 2425.7331693513697, 2170.197027099975, 2260.880863972328, 2387.7373488916205, 2412.0713525292713, 2419.6128619420897, 2362.787349138586, 2372.857628542284, 2381.4641705616273, 2381.7141942966955, 2381.7261014983237, 2376.964345534818, 2383.9284821455385, 2387.2002879035545, 2387.307680772574, 2388.1283331584023, 8858.557072146432, 8919.866202006975, 8923.821523569492, 8928.598213080362, 8934.28525717941, 5108.4125325587665, 5333.599980001515, 5348.1442969124755, 5355.062863998784, 5360.115580929142, 3424.845881935294, 3521.7358698097487, 3596.8741094061843, 3645.54430696163, 3653.3058718843336, 1055.9155267578576, 1095.6932059023486, 1102.2394547762099, 1112.527175950218, 1116.9385683787389, 11646.475908584134, 11761.470733817, 11769.58806441779, 11788.29270243788, 11790.705232369173, 4530.207213737583, 4592.288195329663, 4778.378810754649, 4789.449213340441, 4792.784324705397, 9943.701688949342, 9946.055124763136, 9949.55227014786, 9949.751256218653, 9958.0, 5314.946850531445, 5321.388040375329, 5326.573874090063, 5326.733663316819, 5327.413984461706, 4369.47566292047, 4385.342198670161, 4830.830920917751, 4891.755412229374, 4892.510748925079, 3879.18537107205, 3887.8444862205197, 3970.6426421621613, 4002.1195337025806, 4015.9799201003807, 1268.6257554021586, 1288.3365066990507, 1290.148501988683, 1302.0950439444496, 1303.9934800325937, 861.4228466927174, 882.5498995512335, 887.3788348156316, 916.2852974679761, 957.3777044920718, 5598.188262701886, 5908.350081491032, 5917.7928772493615, 5988.760449581968, 6086.239220097488, 432.9710413546695, 454.27269255756437, 456.21303251890885, 457.8969731810316, 461.58226804741093, 3407.966909450591, 3772.7359084863797, 4045.6358927696647, 4053.2096241232675, 4063.2686116499312, 9151.63393464254, 10346.586136554453, 10805.973432523897, 10811.18916081297, 10821.404822734825, 10754.408507532004, 10776.946115269373, 10778.407187604756, 10779.514921828537, 10788.352698837938, 8145.3483721302155, 8223.629936652866, 8234.341252699769, 8243.299319557906, 8248.917510824935, 5478.589105817159, 5610.971945140248, 5752.0509115997065, 5795.275590551181, 5897.882042359214, 9996.400215987063, 10039.247056470647, 10064.094231519199, 10077.034978179478, 10094.0, 9827.164691001344, 10172.593096276067, 10218.795624087328, 10222.1089098517, 10430.11344035735, 6903.965480172567, 7121.608311542915, 7135.322144396274, 7440.888386674313, 7596.392288617008, 8171.387145963958, 8297.502149870785, 8407.159284071544, 8407.28538074246, 8416.915830841614, 7353.77938661841, 7490.625468726651, 7531.736389226351, 7592.772216833504, 7605.087389513294, 6343.0, 7278.308560686726, 7361.705531778883, 7519.624018799148, 7540.132884718328, 6885.621290828852, 6915.481338899502, 6986.0, 6992.0910281663055, 7008.964955175192, 4894.583960363409, 4968.726720030433, 5019.774110164978, 5023.899522009612, 5064.772085256099, 4873.976464942401, 4978.800847966041, 5101.7194054327365, 5119.46245644202, 5253.789848406173], "value": 4500.830903414695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.344435685848, 299.9999999999999, 306.9877204911803, 310.81506503630334, 313.2903972502281, 4893.923336865892, 5301.920471192935, 5340.73018966939, 5341.889953468378, 5349.893002139955, 3969.821358038888, 4851.369321988145, 5095.6942583444925, 5146.768395422206, 5210.791568337262, 3952.308346039446, 3975.026118600947, 4006.7595944243294, 4051.270771261172, 4077.2864748669012, 3314.701676849083, 3325.48454989477, 3921.784301863396, 4019.678425725935, 4046.251443482965, 3863.556044459269, 3926.7447615905016, 3962.4254483099935, 3992.6207010333974, 3998.1803730235233, 3969.920601587981, 4009.7995100245016, 4015.6586690131226, 4018.9799051004557, 4050.1494686115952, 3466.930661386758, 3480.2517458746493, 3512.8594856205723, 3522.7534072614926, 3525.964740352589, 5039.44566097729, 5097.7196254206, 5098.59211263098, 5124.026434977342, 5126.871828204287, 4144.378343248507, 4396.296592545209, 4457.465104187486, 4477.3731677565165, 4477.731336119843, 4640.303954406866, 4708.4820669726305, 5241.344831896013, 5498.615096943216, 5555.944440555623, 3266.4120458317493, 3444.2594842109065, 3675.6691897729334, 3726.8881933541766, 3744.9625503744887, 5289.889123284115, 5363.383210930715, 5477.4796394342875, 5641.774329026834, 5796.0, 3778.5465744110334, 3785.6782173515007, 3790.6967442604528, 3797.240551889633, 3797.6582107610448, 3826.7129965252716, 3844.2695887781233, 3865.8840234792438, 3888.844446222176, 3900.5904380040256, 4336.609705126553, 4513.638908887281, 4521.163584736834, 4536.954630453719, 4539.72761634303, 4808.3989501312335, 5443.564514838803, 5487.0, 5496.31296087989, 5503.394626591072, 1288.6005338345144, 1315.4080663701372, 1317.5520323090195, 1318.9250760630057, 1319.3601103464812, 817.791463176886, 841.4110122913985, 847.5296210603051, 868.444195714743, 888.7733627924838, 4968.801247950041, 4986.90026199474, 5015.949840501548, 5019.67372120811, 5127.435982041972, 5493.725313734298, 5554.638948468418, 5556.861078473071, 5599.8880022400135, 5637.605367624227, 4393.560643935581, 4664.976675116603, 4679.672422930362, 4989.750512474362, 5084.339035925306, 2236.4073520517077, 2849.3189018479197, 2901.0, 2905.3317736920626, 2919.1680371094135, 4710.36410084641, 4889.926651100236, 5575.275214222206, 5616.831495055155, 5682.431756824284, 4733.573978341897, 5031.723255220924, 5285.260063591023, 5342.035170480343, 5566.276384070045, 5009.797648564391, 5575.665460072328, 5590.664560126405, 5732.082866741302, 5742.48317651405, 4059.167870586464, 5157.922631160461, 5498.5876059294915, 5552.805651802168, 5580.525655319181, 5060.468650791761, 5185.637005409585, 5473.8357849264585, 5493.313335833021, 5506.421825708403, 4905.386826646669, 5681.318241811009, 5710.373228314856, 5713.514351280188, 5793.3337666167245, 3240.303334783033, 3562.9109272267365, 3689.9077523062138, 3720.2001569662652, 3756.323861704919, 4682.742449165328, 5445.727713614383, 5463.262459567907, 5475.589330800286, 5506.284183056177, 4518.841840535565, 4732.574068333866, 5391.81128660495, 5400.946815371122, 5401.567874570103, 5080.332825266617, 5314.0, 5337.946620533745, 5381.623286369917, 5491.199488260936, 4812.820858889594, 5053.837617348104, 5378.838634840961, 5407.918881216863, 5429.891402172014, 4047.5024241031006, 5088.847334579968, 5178.43037265908, 5244.767479642357, 5391.81128660495, 4952.925706114339, 5265.894162225975, 5334.746334611285, 5415.5126038655135, 5417.295751552273], "value": 3967.630462963853, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.6606645776798, 702.5433468245643, 750.5571712689513, 779.0153365535286, 802.5987006496752, 15228.0, 16470.34118635256, 16478.505644830646, 16499.340026398928, 16500.587485312873, 14759.262036898166, 14903.0, 14914.925425372885, 14924.0, 14964.551063468087, 678.2200469460136, 684.9486288528356, 693.3551796828947, 827.3463963468868, 833.5832083958021, 851.1105894340429, 855.2687452228348, 865.16079402979, 866.2204016385241, 868.1622234543664, 915.8534634458488, 919.4804935211585, 919.5815903763771, 923.958421871014, 924.9075092490764, 707.1761397971358, 716.3839098375392, 911.4349103555804, 913.6025828764475, 914.3553794574809, 653.3303364051885, 658.246307977368, 659.8548319369731, 670.8658268346351, 671.1409395973162, 14943.103413795207, 15022.173780442072, 15025.248737563079, 15031.624209394744, 15035.849641503555, 13654.726905461934, 13992.510262140777, 14104.153750774884, 14151.575452736435, 14485.348159332856, 11088.0, 11638.825417618742, 11703.824442633368, 11839.704007399798, 12075.93962030193, 4557.293619488984, 4561.635069194456, 4591.288350305708, 4620.884477888046, 4659.720416775004, 114740.4262978688, 117647.0, 118387.40806295999, 118863.40568297189, 120762.99999999913, 9521.428714277166, 10775.08411785007, 10805.189610779065, 10817.405042722727, 11105.167112466597, 20831.687524687142, 20840.687389689167, 20870.895645521676, 20872.79127208739, 20895.164193432396, 7740.993670822757, 7762.961185194038, 7986.361091112697, 8037.919620803834, 8057.31512821405, 4246.808893599796, 4320.719153255029, 4362.974700945339, 4513.75174365413, 4522.186006518792, 3346.715529179998, 3442.1738782691973, 3482.8432720527635, 3483.0247530691445, 3493.8602455901478, 580.5239703443136, 585.4292065236446, 590.2209084009153, 591.4322250639434, 597.7877853362081, 537.8762884536578, 546.4126064480699, 582.1297160744629, 612.2622240200548, 620.184457438476, 7396.926030739732, 7967.0439547253545, 8935.73192804204, 8936.776580585538, 9113.088691130833, 522.6576592332028, 556.7772890843695, 559.5188138201144, 590.4744777148342, 658.1049772309655, 3872.935146464311, 4187.832486700498, 4413.3821265022925, 4426.336049592587, 4541.909161816745, 103607.4819625912, 150687.0, 164350.0, 169359.3064069368, 170056.0, 140917.0, 141653.29173354275, 145825.0, 147015.0, 147599.0, 69850.95223571651, 77153.6142319296, 111547.0, 122088.0, 125908.0, 7193.028941092885, 8488.575571221538, 8495.95752021236, 8504.702335418231, 8745.825083498421, 64169.679151603945, 66819.0, 67810.0, 67827.66086169735, 71174.0, 69121.96317055148, 84021.15978840133, 85715.57142214249, 90375.09624903667, 91730.0, 13279.398788455566, 13355.657542642868, 13457.596272111852, 13650.795238071238, 13822.239776812372, 14558.12651240929, 14832.7775083376, 14982.775258370915, 15248.0, 15530.456434024754, 13676.521321753691, 13793.793093103812, 13838.23889686077, 13922.791158132839, 14244.216568088854, 11251.549938002388, 13433.932830335785, 14190.645233869236, 14356.35396407185, 14468.131912085308, 13644.181349118688, 13655.931720341334, 14030.438782448997, 14054.156750594997, 14084.577462676136, 10674.679759607225, 11014.94728746438, 11052.171087168334, 11298.7740245193, 11326.603568875049, 9080.496404454188, 11472.393864859094, 11576.305421674726, 11594.47824847867, 11600.709982250512], "value": 7748.875405600018, "unit": "score"}], "name": "dromaeo_css", "value": 7249.7197548610275, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 116.0, 119.0, 165.0, 156.0, 112.0, 111.0, 113.0, 123.0], "value": 123.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 160.0, 195.0, 108.0, 128.0, 129.0, 108.0, 157.0, 116.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 186.0, 187.0, 186.0, 181.0, 180.0, 182.0, 184.0, 182.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 74.0, 78.0, 153.0, 73.0, 81.0, 80.0, 88.0, 143.0, 58.0], "value": 90.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 137.0, 70.0, 70.0, 73.0, 118.0, 69.0, 69.0, 116.0], "value": 88.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 88.0, 84.0, 88.0, 84.0, 87.0, 85.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 95.0, 96.0, 108.0, 162.0, 97.0, 96.0, 101.0], "value": 104.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 94.0, 87.0, 84.0, 84.0, 84.0, 87.0, 86.0, 84.0, 83.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 54.0, 55.0, 55.0, 54.0, 53.0, 53.0, 52.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 70.0, 71.0, 72.0, 74.0, 68.0, 69.0, 65.0, 70.0], "value": 68.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 85.0, 86.0, 95.0, 101.0, 105.0, 106.0, 88.0, 84.0], "value": 92.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 139.0, 139.0, 141.0, 138.0, 137.0, 152.0, 178.0, 160.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 167.0, 201.0, 166.0, 167.0, 169.0, 167.0, 168.0, 171.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 67.0, 68.0, 66.0, 67.0, 67.0, 67.0, 68.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1499.6, "alertThreshold": 2.0}]} 20:27:17 INFO - Return code: 0 20:27:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:27:17 INFO - # TBPL SUCCESS # 20:27:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:27:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:27:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:27:17 INFO - 2016-09-12 20:27:17.452 screenresolution[1670:9726] starting screenresolution argv=screenresolution get 20:27:17 INFO - 2016-09-12 20:27:17.455 screenresolution[1670:9726] Display 0: 1600x1200x32@60 20:27:17 INFO - 2016-09-12 20:27:17.460 screenresolution[1671:9730] starting screenresolution argv=screenresolution list 20:27:17 INFO - Available Modes on Display 0 20:27:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:27:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:27:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:27:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:27:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:27:17 INFO - Intel Iris: 20:27:17 INFO - Chipset Model: Intel Iris 20:27:17 INFO - Type: GPU 20:27:17 INFO - Bus: Built-In 20:27:17 INFO - VRAM (Dynamic, Max): 1536 MB 20:27:17 INFO - Vendor: Intel (0x8086) 20:27:17 INFO - Device ID: 0x0a2e 20:27:17 INFO - Revision ID: 0x0009 20:27:17 INFO - Displays: 20:27:17 INFO - Display: 20:27:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:27:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:27:17 INFO - Display Serial Number: 1600x1200 60 20:27:17 INFO - Main Display: Yes 20:27:17 INFO - Mirror: Off 20:27:17 INFO - Online: Yes 20:27:17 INFO - Rotation: Supported 20:27:17 INFO - Return code: 0 20:27:17 INFO - Running post-action listener: _resource_record_post_action 20:27:17 INFO - [mozharness: 2016-09-13 03:27:17.697526Z] Finished run-tests step (success) 20:27:17 INFO - Running post-run listener: _resource_record_post_run 20:27:17 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37286912; Write bytes: 705166336; Read time: 235; Write time: 1922 20:27:17 INFO - TinderboxPrint: CPU usage
53.5% 20:27:17 INFO - TinderboxPrint: I/O read bytes / time
37,286,912 / 235 20:27:17 INFO - TinderboxPrint: I/O write bytes / time
705,166,336 / 1,922 20:27:17 INFO - TinderboxPrint: CPU idle
2,254.2 (46.5%) 20:27:17 INFO - TinderboxPrint: CPU system
968.6 (20.0%) 20:27:17 INFO - TinderboxPrint: CPU user
1,626.8 (33.5%) 20:27:17 INFO - TinderboxPrint: Swap in / out
442,019,840 / 0 20:27:17 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 393351680; Write bytes: 389048320; Read time: 29713; Write time: 778 20:27:17 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 35386368; Write bytes: 295322624; Read time: 219; Write time: 1093 20:27:18 INFO - Running post-run listener: _upload_blobber_files 20:27:18 INFO - Blob upload gear active. 20:27:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:27:18 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 20:27:18 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:27:18 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:27:18 INFO - (blobuploader) - INFO - Open directory for files ... 20:27:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:27:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:27:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:19 INFO - (blobuploader) - INFO - Done attempting. 20:27:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:27:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:27:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:20 INFO - (blobuploader) - INFO - Done attempting. 20:27:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:27:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:27:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:22 INFO - (blobuploader) - INFO - Done attempting. 20:27:22 INFO - (blobuploader) - INFO - Iteration through files over. 20:27:23 INFO - Return code: 0 20:27:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:27:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:27:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e58659e7c650555bf968d90072d0abd2ad7918b4f42301feac6ae00fd5b1de2d33631b402ddf037330b3c175a9f064b42caf1156fea9a9dbb3552ab1a617621c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0d7d105fb5a78faf431459001b33bc7237c5a7709321efcba1f92d456328cea25c7eab63f8acea2bc37c61012892d44c3ca4cfe75f36cc6ec48e61d03e1427a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4bfec12da73774a70d0fd6de2b32aff8052214b6cfd796c8b5a3055fc8fbcb187f8adde9eb85dfe4beeb493cc2a4b1d761f6801b1ed589d88a0f4094a642123"} 20:27:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:27:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:27:23 INFO - Contents: 20:27:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e58659e7c650555bf968d90072d0abd2ad7918b4f42301feac6ae00fd5b1de2d33631b402ddf037330b3c175a9f064b42caf1156fea9a9dbb3552ab1a617621c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0d7d105fb5a78faf431459001b33bc7237c5a7709321efcba1f92d456328cea25c7eab63f8acea2bc37c61012892d44c3ca4cfe75f36cc6ec48e61d03e1427a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4bfec12da73774a70d0fd6de2b32aff8052214b6cfd796c8b5a3055fc8fbcb187f8adde9eb85dfe4beeb493cc2a4b1d761f6801b1ed589d88a0f4094a642123"} 20:27:23 INFO - Running post-run listener: copy_logs_to_upload_dir 20:27:23 INFO - Copying logs to upload dir... 20:27:23 INFO - mkdir: /builds/slave/test/build/upload/logs 20:27:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.534045 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-12 20:27:23.070095) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-12 20:27:23.073429) ========= 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.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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/Fx-Team/sha512/e58659e7c650555bf968d90072d0abd2ad7918b4f42301feac6ae00fd5b1de2d33631b402ddf037330b3c175a9f064b42caf1156fea9a9dbb3552ab1a617621c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0d7d105fb5a78faf431459001b33bc7237c5a7709321efcba1f92d456328cea25c7eab63f8acea2bc37c61012892d44c3ca4cfe75f36cc6ec48e61d03e1427a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4bfec12da73774a70d0fd6de2b32aff8052214b6cfd796c8b5a3055fc8fbcb187f8adde9eb85dfe4beeb493cc2a4b1d761f6801b1ed589d88a0f4094a642123"} build_url:https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010659 build_url: 'https://queue.taskcluster.net/v1/task/LU-DwevwQtGfx_V4wxW19A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e58659e7c650555bf968d90072d0abd2ad7918b4f42301feac6ae00fd5b1de2d33631b402ddf037330b3c175a9f064b42caf1156fea9a9dbb3552ab1a617621c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0d7d105fb5a78faf431459001b33bc7237c5a7709321efcba1f92d456328cea25c7eab63f8acea2bc37c61012892d44c3ca4cfe75f36cc6ec48e61d03e1427a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4bfec12da73774a70d0fd6de2b32aff8052214b6cfd796c8b5a3055fc8fbcb187f8adde9eb85dfe4beeb493cc2a4b1d761f6801b1ed589d88a0f4094a642123"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-12 20:27:23.104362) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 20:27:23.104705) ========= 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.L3ht4VQ3od/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.Nbk8hYgN5R/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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.004860 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 20:27:23.153020) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-12 20:27:23.153331) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-12 20:27:23.153664) ========= ========= Total master_lag: 0.17 =========