builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0051 starttime: 1473719428.43 results: success (0) buildid: 20160912133516 builduid: 7f3056faec3845edab52fe483a7e4867 revision: c273bf6370c3b57ab2dda6add44b034c769ef728 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-12 15:30:28.427976) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-12 15:30:28.428531) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-12 15:30:28.428854) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-12 15:30:28.453275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 15:30:28.453774) ========= 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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 15:30:28-- 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% 7.90M=0.001s 2016-09-12 15:30:28 (7.90 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143674 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 15:30:28.620830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 15:30:28.622710) ========= 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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.021034 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 15:30:28.674588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-12 15:30:28.675431) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c273bf6370c3b57ab2dda6add44b034c769ef728 --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 c273bf6370c3b57ab2dda6add44b034c769ef728 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 15:30:28,752 truncating revision to first 12 chars 2016-09-12 15:30:28,752 Setting DEBUG logging. 2016-09-12 15:30:28,752 attempt 1/10 2016-09-12 15:30:28,752 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c273bf6370c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-12 15:30:29,856 unpacking tar archive at: fx-team-c273bf6370c3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.355797 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-12 15:30:30.054562) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-12 15:30:30.054888) ========= script_repo_revision: c273bf6370c3b57ab2dda6add44b034c769ef728 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-12 15:30:30.055286) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-12 15:30:30.055574) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-12 15:30:30.074424) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-12 15:30:30.074854) ========= /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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 15:30:30 INFO - MultiFileLogger online at 20160912 15:30:30 in /builds/slave/test 15:30:30 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 15:30:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:30:30 INFO - {'append_to_log': False, 15:30:30 INFO - 'base_work_dir': '/builds/slave/test', 15:30:30 INFO - 'blob_upload_branch': 'Fx-Team', 15:30:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:30:30 INFO - 'branch': 'Fx-Team', 15:30:30 INFO - 'buildbot_json_path': 'buildprops.json', 15:30:30 INFO - 'config_files': ('talos/mac_config.py',), 15:30:30 INFO - 'default_actions': ('clobber', 15:30:30 INFO - 'read-buildbot-config', 15:30:30 INFO - 'download-and-extract', 15:30:30 INFO - 'populate-webroot', 15:30:30 INFO - 'create-virtualenv', 15:30:30 INFO - 'install', 15:30:30 INFO - 'run-tests'), 15:30:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:30:30 INFO - 'download_minidump_stackwalk': True, 15:30:30 INFO - 'download_symbols': 'ondemand', 15:30:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:30:30 INFO - 'tooltool.py': '/tools/tooltool.py', 15:30:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:30:30 INFO - '/tools/misc-python/virtualenv.py')}, 15:30:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:30:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:30:30 INFO - 'installer_path': 'installer.exe', 15:30:30 INFO - 'log_level': 'info', 15:30:30 INFO - 'log_name': 'talos', 15:30:30 INFO - 'log_to_console': True, 15:30:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:30:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:30:30 INFO - 'opt_config_files': (), 15:30:30 INFO - 'pip_index': False, 15:30:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:30:30 INFO - 'cmd': ('bash', 15:30:30 INFO - '-c', 15:30:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:30:30 INFO - 'enabled': True, 15:30:30 INFO - 'halt_on_failure': False, 15:30:30 INFO - 'name': 'check_screen_resolution'},), 15:30:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:30:30 INFO - 'cmd': ('bash', 15:30:30 INFO - '-c', 15:30:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:30:30 INFO - 'enabled': True, 15:30:30 INFO - 'halt_on_failure': False, 15:30:30 INFO - 'name': 'check_screen_resolution'},), 15:30:30 INFO - 'run_cmd_checks_enabled': True, 15:30:30 INFO - 'sps_profile': False, 15:30:30 INFO - 'sps_profile_interval': 0, 15:30:30 INFO - 'suite': 'dromaeojs', 15:30:30 INFO - 'system_bits': '32', 15:30:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:30:30 INFO - 'title': 't-yosemite-r7-0051', 15:30:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:30:30 INFO - 'use_talos_json': True, 15:30:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:30:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:30:30 INFO - 'work_dir': 'build'} 15:30:30 INFO - [mozharness: 2016-09-12 22:30:30.268857Z] Running clobber step. 15:30:30 INFO - Running pre-action listener: _resource_record_pre_action 15:30:30 INFO - Running main action method: clobber 15:30:30 INFO - rmtree: /builds/slave/test/build 15:30:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:30:31 INFO - Running post-action listener: _resource_record_post_action 15:30:31 INFO - [mozharness: 2016-09-12 22:30:31.809976Z] Finished clobber step (success) 15:30:31 INFO - [mozharness: 2016-09-12 22:30:31.810184Z] Running read-buildbot-config step. 15:30:31 INFO - Running pre-action listener: _resource_record_pre_action 15:30:31 INFO - Running main action method: read_buildbot_config 15:30:31 INFO - Using buildbot properties: 15:30:31 INFO - { 15:30:31 INFO - "project": "", 15:30:31 INFO - "product": "firefox", 15:30:31 INFO - "script_repo_revision": "production", 15:30:31 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:30:31 INFO - "repository": "", 15:30:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:30:31 INFO - "buildid": "20160912133516", 15:30:31 INFO - "pgo_build": "False", 15:30:31 INFO - "basedir": "/builds/slave/test", 15:30:31 INFO - "buildnumber": 156, 15:30:31 INFO - "slavename": "t-yosemite-r7-0051", 15:30:31 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 15:30:31 INFO - "platform": "yosemite_r7", 15:30:31 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:30:31 INFO - "branch": "fx-team", 15:30:31 INFO - "repo_path": "integration/fx-team", 15:30:31 INFO - "revision": "c273bf6370c3b57ab2dda6add44b034c769ef728", 15:30:31 INFO - "stage_platform": "macosx64", 15:30:31 INFO - "builduid": "7f3056faec3845edab52fe483a7e4867", 15:30:31 INFO - "slavebuilddir": "test" 15:30:31 INFO - } 15:30:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/c_VWR8r_RpeNFM1TJG63vw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 15:30:31 INFO - Running post-action listener: _resource_record_post_action 15:30:31 INFO - [mozharness: 2016-09-12 22:30:31.815935Z] Finished read-buildbot-config step (success) 15:30:31 INFO - [mozharness: 2016-09-12 22:30:31.816162Z] Running download-and-extract step. 15:30:31 INFO - Running pre-action listener: _resource_record_pre_action 15:30:31 INFO - Running main action method: download_and_extract 15:30:31 INFO - mkdir: /builds/slave/test/build/tests 15:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:31 INFO - trying https://queue.taskcluster.net/v1/task/c_VWR8r_RpeNFM1TJG63vw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 15:30:31 INFO - Downloading https://queue.taskcluster.net/v1/task/c_VWR8r_RpeNFM1TJG63vw/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 15:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c_VWR8r_RpeNFM1TJG63vw/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 15:30:33 INFO - Downloaded 1199 bytes. 15:30:33 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 15:30:33 INFO - Using the following test package requirements: 15:30:33 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:30:33 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:30:33 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 15:30:33 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:30:33 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 15:30:33 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:30:33 INFO - u'jsshell-mac.zip'], 15:30:33 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:30:33 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 15:30:33 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:30:33 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:30:33 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 15:30:33 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:30:33 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 15:30:33 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:30:33 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 15:30:33 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:30:33 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 15:30:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:30:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c_VWR8r_RpeNFM1TJG63vw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:30:33 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 15:30:40 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 15:30:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c_VWR8r_RpeNFM1TJG63vw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:30:40 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 15:30:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c_VWR8r_RpeNFM1TJG63vw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 15:30:48 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 15:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:49 INFO - trying https://queue.taskcluster.net/v1/task/c_VWR8r_RpeNFM1TJG63vw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:30:49 INFO - Downloading https://queue.taskcluster.net/v1/task/c_VWR8r_RpeNFM1TJG63vw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 15:30:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c_VWR8r_RpeNFM1TJG63vw/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 15:30:52 INFO - Downloaded 111395000 bytes. 15:30:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c_VWR8r_RpeNFM1TJG63vw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:30:52 INFO - mkdir: /builds/slave/test/properties 15:30:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:30:52 INFO - Writing to file /builds/slave/test/properties/build_url 15:30:52 INFO - Contents: 15:30:52 INFO - build_url:https://queue.taskcluster.net/v1/task/c_VWR8r_RpeNFM1TJG63vw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:30:52 INFO - Running post-action listener: _resource_record_post_action 15:30:52 INFO - Running post-action listener: set_extra_try_arguments 15:30:52 INFO - [mozharness: 2016-09-12 22:30:52.683818Z] Finished download-and-extract step (success) 15:30:52 INFO - [mozharness: 2016-09-12 22:30:52.683965Z] Running populate-webroot step. 15:30:52 INFO - Running pre-action listener: _resource_record_pre_action 15:30:52 INFO - Running main action method: populate_webroot 15:30:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:30:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:30:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:30:52 INFO - '--tppagecycles', 15:30:52 INFO - '7'], 15:30:52 INFO - 'tests': ['tsvgm']}}, 15:30:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:30:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:30:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:30:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:30:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:30:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:30:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:52 INFO - 'talos_options': ['--disable-e10s'], 15:30:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:52 INFO - 'talos_options': ['--disable-e10s'], 15:30:52 INFO - 'tests': ['damp', 'tps']}, 15:30:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:52 INFO - 'tests': ['damp', 'tps']}, 15:30:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:30:52 INFO - 'tests': ['dromaeo_dom']}, 15:30:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:30:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:30:52 INFO - 'tests': ['basic_compositor_video']}, 15:30:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:30:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:30:52 INFO - 'tests': ['a11yr', 15:30:52 INFO - 'ts_paint', 15:30:52 INFO - 'tpaint', 15:30:52 INFO - 'sessionrestore', 15:30:52 INFO - 'sessionrestore_no_auto_restore', 15:30:52 INFO - 'tabpaint']}, 15:30:52 INFO - 'other-e10s': {'tests': ['a11yr', 15:30:52 INFO - 'ts_paint', 15:30:52 INFO - 'tpaint', 15:30:52 INFO - 'sessionrestore', 15:30:52 INFO - 'sessionrestore_no_auto_restore', 15:30:52 INFO - 'tabpaint']}, 15:30:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:30:52 INFO - 'ts_paint', 15:30:52 INFO - 'tpaint', 15:30:52 INFO - 'sessionrestore', 15:30:52 INFO - 'sessionrestore_no_auto_restore', 15:30:52 INFO - 'tabpaint']}, 15:30:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:30:52 INFO - 'ts_paint', 15:30:52 INFO - 'tpaint', 15:30:52 INFO - 'sessionrestore', 15:30:52 INFO - 'sessionrestore_no_auto_restore', 15:30:52 INFO - 'tabpaint']}, 15:30:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:30:52 INFO - 'tests': ['a11yr', 15:30:52 INFO - 'ts_paint', 15:30:52 INFO - 'tpaint', 15:30:52 INFO - 'sessionrestore', 15:30:52 INFO - 'sessionrestore_no_auto_restore', 15:30:52 INFO - 'tabpaint']}, 15:30:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:30:52 INFO - 'tests': ['a11yr', 15:30:52 INFO - 'ts_paint', 15:30:52 INFO - 'tpaint', 15:30:52 INFO - 'sessionrestore', 15:30:52 INFO - 'sessionrestore_no_auto_restore', 15:30:52 INFO - 'tabpaint']}, 15:30:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:30:52 INFO - 'tests': ['tsvgx', 15:30:52 INFO - 'tsvgr_opacity', 15:30:52 INFO - 'tart', 15:30:52 INFO - 'tscrollx', 15:30:52 INFO - 'cart']}, 15:30:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:30:52 INFO - 'tsvgr_opacity', 15:30:52 INFO - 'tart', 15:30:52 INFO - 'tscrollx', 15:30:52 INFO - 'cart']}, 15:30:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:52 INFO - 'talos_options': ['--disable-e10s'], 15:30:52 INFO - 'tests': ['tp5o']}, 15:30:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:52 INFO - 'tests': ['tp5o']}, 15:30:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:52 INFO - 'talos_options': ['--disable-e10s', 15:30:52 INFO - '--xperf_path', 15:30:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:52 INFO - 'tests': ['tp5n']}, 15:30:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:52 INFO - 'talos_options': ['--xperf_path', 15:30:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:52 INFO - 'tests': ['tp5n']}}, 15:30:52 INFO - 'talos.zip': {'path': '', 15:30:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:30:52 INFO - Running post-action listener: _resource_record_post_action 15:30:52 INFO - [mozharness: 2016-09-12 22:30:52.702547Z] Finished populate-webroot step (success) 15:30:52 INFO - [mozharness: 2016-09-12 22:30:52.702647Z] Running create-virtualenv step. 15:30:52 INFO - Running pre-action listener: _resource_record_pre_action 15:30:52 INFO - Running main action method: create_virtualenv 15:30:52 INFO - Creating virtualenv /builds/slave/test/build/venv 15:30:52 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 15:30:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:30:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:30:52 INFO - Using real prefix '/tools/python27' 15:30:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:30:53 INFO - Installing distribute.............................................................................................................................................................................................done. 15:30:56 INFO - Installing pip.................done. 15:30:56 INFO - Return code: 0 15:30:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:56 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 0x106aed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f05b3060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106901d30>, '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 0x106727db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068f9b20>, '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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 15:30:56 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 15:30:56 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 15:30:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sk7VlCk1Sl/Render', 15:30:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:30:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:30:56 INFO - 'HOME': '/Users/cltbld', 15:30:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:30:56 INFO - 'LOGNAME': 'cltbld', 15:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:56 INFO - 'MOZ_NO_REMOTE': '1', 15:30:56 INFO - 'NO_EM_RESTART': '1', 15:30:56 INFO - 'PAGER': '/bin/cat', 15:30:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:56 INFO - 'PWD': '/builds/slave/test', 15:30:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:30:56 INFO - 'SHELL': '/bin/bash', 15:30:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zQSyWNt96J/Listeners', 15:30:56 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:30:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:30:56 INFO - 'USER': 'cltbld', 15:30:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:30:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:56 INFO - 'XPC_FLAGS': '0x0', 15:30:56 INFO - 'XPC_SERVICE_NAME': '0', 15:30:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:56 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 15:30:56 INFO - Cleaning up... 15:30:56 INFO - Return code: 0 15:30:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:56 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 0x106aed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f05b3060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106901d30>, '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 0x106727db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068f9b20>, '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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 15:30:56 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 15:30:56 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 15:30:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sk7VlCk1Sl/Render', 15:30:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:30:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:30:56 INFO - 'HOME': '/Users/cltbld', 15:30:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:30:56 INFO - 'LOGNAME': 'cltbld', 15:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:56 INFO - 'MOZ_NO_REMOTE': '1', 15:30:56 INFO - 'NO_EM_RESTART': '1', 15:30:56 INFO - 'PAGER': '/bin/cat', 15:30:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:56 INFO - 'PWD': '/builds/slave/test', 15:30:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:30:56 INFO - 'SHELL': '/bin/bash', 15:30:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zQSyWNt96J/Listeners', 15:30:56 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:30:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:30:56 INFO - 'USER': 'cltbld', 15:30:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:30:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:56 INFO - 'XPC_FLAGS': '0x0', 15:30:56 INFO - 'XPC_SERVICE_NAME': '0', 15:30:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:56 INFO - Downloading/unpacking psutil>=3.1.1 15:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:30:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:31:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:00 INFO - Installing collected packages: psutil 15:31:00 INFO - Running setup.py install for psutil 15:31:00 INFO - building 'psutil._psutil_osx' extension 15:31:00 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 15:31:00 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 15:31:00 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 15:31:00 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 15:31:00 INFO - building 'psutil._psutil_posix' extension 15:31:00 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 15:31:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:31:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:31:01 INFO - ^ 15:31:01 INFO - 1 warning generated. 15:31:01 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 15:31:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:01 INFO - Successfully installed psutil 15:31:01 INFO - Cleaning up... 15:31:01 INFO - Return code: 0 15:31:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:31:01 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')]} 15:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:01 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')]} 15:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:01 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 0x106aed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f05b3060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106901d30>, '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 0x106727db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068f9b20>, '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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 15:31:01 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 15:31:01 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 15:31:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sk7VlCk1Sl/Render', 15:31:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:01 INFO - 'HOME': '/Users/cltbld', 15:31:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:01 INFO - 'LOGNAME': 'cltbld', 15:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:01 INFO - 'MOZ_NO_REMOTE': '1', 15:31:01 INFO - 'NO_EM_RESTART': '1', 15:31:01 INFO - 'PAGER': '/bin/cat', 15:31:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:01 INFO - 'PWD': '/builds/slave/test', 15:31:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:01 INFO - 'SHELL': '/bin/bash', 15:31:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zQSyWNt96J/Listeners', 15:31:01 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:31:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:01 INFO - 'USER': 'cltbld', 15:31:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:01 INFO - 'XPC_FLAGS': '0x0', 15:31:01 INFO - 'XPC_SERVICE_NAME': '0', 15:31:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:31:01 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 15:31:01 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 15:31:01 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 15:31:01 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 15:31:01 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 15:31:01 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 15:31:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:31:04 INFO - Installing collected packages: mozsystemmonitor 15:31:04 INFO - Running setup.py install for mozsystemmonitor 15:31:04 INFO - Successfully installed mozsystemmonitor 15:31:04 INFO - Cleaning up... 15:31:04 INFO - Return code: 0 15:31:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106aed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f05b3060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106901d30>, '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 0x106727db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068f9b20>, '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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 15:31: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==2.5.1'] in /builds/slave/test/build 15:31: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==2.5.1 15:31:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sk7VlCk1Sl/Render', 15:31:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:04 INFO - 'HOME': '/Users/cltbld', 15:31:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:04 INFO - 'LOGNAME': 'cltbld', 15:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:04 INFO - 'MOZ_NO_REMOTE': '1', 15:31:04 INFO - 'NO_EM_RESTART': '1', 15:31:04 INFO - 'PAGER': '/bin/cat', 15:31:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:04 INFO - 'PWD': '/builds/slave/test', 15:31:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:04 INFO - 'SHELL': '/bin/bash', 15:31:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zQSyWNt96J/Listeners', 15:31:04 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:31:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:04 INFO - 'USER': 'cltbld', 15:31:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:04 INFO - 'XPC_FLAGS': '0x0', 15:31:04 INFO - 'XPC_SERVICE_NAME': '0', 15:31:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:04 INFO - Downloading/unpacking jsonschema==2.5.1 15:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:31:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:31:07 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 15:31:07 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 15:31:07 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 15:31:07 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 15:31:07 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 15:31:07 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 15:31:07 INFO - Downloading functools32-3.2.3-2.tar.gz 15:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:31:07 INFO - warning: no files found matching '*.txt' 15:31:07 INFO - no previously-included directories found matching 'build' 15:31:07 INFO - no previously-included directories found matching 'dist' 15:31:07 INFO - no previously-included directories found matching '.git*' 15:31:07 INFO - Installing collected packages: jsonschema, functools32 15:31:07 INFO - Running setup.py install for functools32 15:31:07 INFO - warning: no files found matching '*.txt' 15:31:07 INFO - no previously-included directories found matching 'build' 15:31:07 INFO - no previously-included directories found matching 'dist' 15:31:07 INFO - no previously-included directories found matching '.git*' 15:31:07 INFO - Successfully installed jsonschema functools32 15:31:07 INFO - Cleaning up... 15:31:07 INFO - Return code: 0 15:31:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:07 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 0x106aed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f05b3060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106901d30>, '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 0x106727db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068f9b20>, '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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 15:31:07 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 15:31:07 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 15:31:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sk7VlCk1Sl/Render', 15:31:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:07 INFO - 'HOME': '/Users/cltbld', 15:31:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:07 INFO - 'LOGNAME': 'cltbld', 15:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:07 INFO - 'MOZ_NO_REMOTE': '1', 15:31:07 INFO - 'NO_EM_RESTART': '1', 15:31:07 INFO - 'PAGER': '/bin/cat', 15:31:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:07 INFO - 'PWD': '/builds/slave/test', 15:31:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:07 INFO - 'SHELL': '/bin/bash', 15:31:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zQSyWNt96J/Listeners', 15:31:07 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:31:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:07 INFO - 'USER': 'cltbld', 15:31:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:07 INFO - 'XPC_FLAGS': '0x0', 15:31:07 INFO - 'XPC_SERVICE_NAME': '0', 15:31:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:31:08 INFO - Cleaning up... 15:31:08 INFO - Return code: 0 15:31:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106aed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f05b3060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106901d30>, '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 0x106727db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068f9b20>, '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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 15:31:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:31:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sk7VlCk1Sl/Render', 15:31:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:08 INFO - 'HOME': '/Users/cltbld', 15:31:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:08 INFO - 'LOGNAME': 'cltbld', 15:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:08 INFO - 'MOZ_NO_REMOTE': '1', 15:31:08 INFO - 'NO_EM_RESTART': '1', 15:31:08 INFO - 'PAGER': '/bin/cat', 15:31:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:08 INFO - 'PWD': '/builds/slave/test', 15:31:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:08 INFO - 'SHELL': '/bin/bash', 15:31:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zQSyWNt96J/Listeners', 15:31:08 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:31:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:08 INFO - 'USER': 'cltbld', 15:31:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:08 INFO - 'XPC_FLAGS': '0x0', 15:31:08 INFO - 'XPC_SERVICE_NAME': '0', 15:31:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:08 INFO - Downloading/unpacking blobuploader==1.2.4 15:31:08 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 15:31:08 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 15:31:08 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 15:31:08 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 15:31:08 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 15:31:08 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 15:31:10 INFO - Downloading blobuploader-1.2.4.tar.gz 15:31:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:31:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:31:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:31:11 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 15:31:11 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 15:31:11 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 15:31:11 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 15:31:11 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 15:31:11 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 15:31:11 INFO - Downloading docopt-0.6.1.tar.gz 15:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:31:12 INFO - Installing collected packages: blobuploader, requests, docopt 15:31:12 INFO - Running setup.py install for blobuploader 15:31:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:31:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:31:12 INFO - Running setup.py install for requests 15:31:12 INFO - Running setup.py install for docopt 15:31:12 INFO - Successfully installed blobuploader requests docopt 15:31:12 INFO - Cleaning up... 15:31:12 INFO - Return code: 0 15:31:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:12 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 0x106aed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f05b3060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106901d30>, '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 0x106727db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068f9b20>, '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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 15:31:12 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 15:31:12 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 15:31:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sk7VlCk1Sl/Render', 15:31:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:12 INFO - 'HOME': '/Users/cltbld', 15:31:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:12 INFO - 'LOGNAME': 'cltbld', 15:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:12 INFO - 'MOZ_NO_REMOTE': '1', 15:31:12 INFO - 'NO_EM_RESTART': '1', 15:31:12 INFO - 'PAGER': '/bin/cat', 15:31:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:12 INFO - 'PWD': '/builds/slave/test', 15:31:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:12 INFO - 'SHELL': '/bin/bash', 15:31:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zQSyWNt96J/Listeners', 15:31:12 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:31:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:12 INFO - 'USER': 'cltbld', 15:31:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:12 INFO - 'XPC_FLAGS': '0x0', 15:31:12 INFO - 'XPC_SERVICE_NAME': '0', 15:31:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-vvMLx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-pTfG8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-WEJJWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-AE8zK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-8SrphV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-E75ITa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-bkjARx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:13 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-ng0Jhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-R7_0TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-VROw9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-gvTwT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-JPYl00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-aDmRcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-CEoGfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-cXF9sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-qOgoMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:14 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-D463jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:31:14 INFO - Running setup.py install for manifestparser 15:31:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:31:15 INFO - Running setup.py install for mozcrash 15:31:15 INFO - Running setup.py install for mozdebug 15:31:15 INFO - Running setup.py install for mozdevice 15:31:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:31:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:31:15 INFO - Running setup.py install for mozfile 15:31:15 INFO - Running setup.py install for mozhttpd 15:31:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:31:15 INFO - Running setup.py install for mozinfo 15:31:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:31:15 INFO - Running setup.py install for mozInstall 15:31:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:31:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:31:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:31:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:31:16 INFO - Running setup.py install for mozleak 15:31:16 INFO - Running setup.py install for mozlog 15:31:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:31:16 INFO - Running setup.py install for moznetwork 15:31:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:31:16 INFO - Running setup.py install for mozprocess 15:31:16 INFO - Running setup.py install for mozprofile 15:31:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:31:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:31:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:31:16 INFO - Running setup.py install for mozrunner 15:31:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:31:17 INFO - Running setup.py install for mozscreenshot 15:31:17 INFO - Running setup.py install for moztest 15:31:17 INFO - Running setup.py install for mozversion 15:31:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:31:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:31:17 INFO - Cleaning up... 15:31:17 INFO - Return code: 0 15:31:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:17 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 0x106aed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f05b3060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106901d30>, '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 0x106727db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068f9b20>, '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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 15:31:17 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 15:31:17 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 15:31:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sk7VlCk1Sl/Render', 15:31:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:17 INFO - 'HOME': '/Users/cltbld', 15:31:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:17 INFO - 'LOGNAME': 'cltbld', 15:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:17 INFO - 'MOZ_NO_REMOTE': '1', 15:31:17 INFO - 'NO_EM_RESTART': '1', 15:31:17 INFO - 'PAGER': '/bin/cat', 15:31:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:17 INFO - 'PWD': '/builds/slave/test', 15:31:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:17 INFO - 'SHELL': '/bin/bash', 15:31:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zQSyWNt96J/Listeners', 15:31:17 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:31:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:17 INFO - 'USER': 'cltbld', 15:31:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:17 INFO - 'XPC_FLAGS': '0x0', 15:31:17 INFO - 'XPC_SERVICE_NAME': '0', 15:31:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:17 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-9NIe1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:17 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)) 15:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:17 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-nIJ9Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:18 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)) 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:18 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Fz3xOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:18 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)) 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:18 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-MV_XCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:18 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)) 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:18 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-tF8ZUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:18 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)) 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:18 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-o7r4lM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:18 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)) 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:18 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-rrAMUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:18 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)) 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:18 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-jehMpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:18 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)) 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:18 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-cok3up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:18 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)) 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:18 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-V7BDXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:18 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)) 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:18 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-JVTVcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:18 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)) 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:18 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-gu4B0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:19 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)) 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:19 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-jxtD28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:19 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)) 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:19 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Pcoomg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:19 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)) 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:19 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-YC637i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:19 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)) 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:19 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-AawG32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:19 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)) 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:19 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Pi7HYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:19 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)) 15:31:19 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)) 15:31:19 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)) 15:31:19 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)) 15:31:19 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)) 15:31:19 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)) 15:31:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:31:19 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 15:31:19 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 15:31:19 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 15:31:19 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 15:31:19 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 15:31:19 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 15:31:22 INFO - Downloading blessings-1.6.tar.gz 15:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:31:22 INFO - Installing collected packages: blessings 15:31:22 INFO - Running setup.py install for blessings 15:31:22 INFO - Successfully installed blessings 15:31:22 INFO - Cleaning up... 15:31:22 INFO - Return code: 0 15:31:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:31:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:22 INFO - Reading from file tmpfile_stdout 15:31:22 INFO - Current package versions: 15:31:22 INFO - blessings == 1.6 15:31:22 INFO - blobuploader == 1.2.4 15:31:22 INFO - docopt == 0.6.1 15:31:22 INFO - functools32 == 3.2.3-2 15:31:22 INFO - jsonschema == 2.5.1 15:31:22 INFO - manifestparser == 1.1 15:31:22 INFO - mozInstall == 1.12 15:31:22 INFO - mozcrash == 0.17 15:31:22 INFO - mozdebug == 0.1 15:31:22 INFO - mozdevice == 0.48 15:31:22 INFO - mozfile == 1.2 15:31:22 INFO - mozhttpd == 0.7 15:31:22 INFO - mozinfo == 0.9 15:31:22 INFO - mozleak == 0.1 15:31:22 INFO - mozlog == 3.3 15:31:22 INFO - moznetwork == 0.27 15:31:22 INFO - mozprocess == 0.23 15:31:22 INFO - mozprofile == 0.28 15:31:22 INFO - mozrunner == 6.12 15:31:22 INFO - mozscreenshot == 0.1 15:31:22 INFO - mozsystemmonitor == 0.3 15:31:22 INFO - moztest == 0.7 15:31:22 INFO - mozversion == 1.4 15:31:22 INFO - psutil == 3.1.1 15:31:22 INFO - requests == 1.2.3 15:31:22 INFO - wsgiref == 0.1.2 15:31:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:22 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')]} 15:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:22 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')]} 15:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:22 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 0x106aed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f05b3060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106901d30>, '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 0x106727db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068f9b20>, '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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 15:31:22 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 15:31:22 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 15:31:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sk7VlCk1Sl/Render', 15:31:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:22 INFO - 'HOME': '/Users/cltbld', 15:31:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:22 INFO - 'LOGNAME': 'cltbld', 15:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:22 INFO - 'MOZ_NO_REMOTE': '1', 15:31:22 INFO - 'NO_EM_RESTART': '1', 15:31:22 INFO - 'PAGER': '/bin/cat', 15:31:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:22 INFO - 'PWD': '/builds/slave/test', 15:31:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:22 INFO - 'SHELL': '/bin/bash', 15:31:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zQSyWNt96J/Listeners', 15:31:22 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:31:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:22 INFO - 'USER': 'cltbld', 15:31:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:22 INFO - 'XPC_FLAGS': '0x0', 15:31:22 INFO - 'XPC_SERVICE_NAME': '0', 15:31:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:22 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)) 15:31:22 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)) 15:31:22 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)) 15:31:22 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)) 15:31:22 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)) 15:31:22 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)) 15:31:22 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)) 15:31:22 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)) 15:31:22 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)) 15:31:22 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)) 15:31:22 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)) 15:31:22 INFO - Cleaning up... 15:31:22 INFO - Return code: 0 15:31:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:31:22 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')]} 15:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:22 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')]} 15:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:22 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 0x106aed490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6f05b3060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106901d30>, '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 0x106727db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068f9b20>, '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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 15:31:22 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 15:31:22 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 15:31:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sk7VlCk1Sl/Render', 15:31:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:22 INFO - 'HOME': '/Users/cltbld', 15:31:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:22 INFO - 'LOGNAME': 'cltbld', 15:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:22 INFO - 'MOZ_NO_REMOTE': '1', 15:31:22 INFO - 'NO_EM_RESTART': '1', 15:31:22 INFO - 'PAGER': '/bin/cat', 15:31:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:22 INFO - 'PWD': '/builds/slave/test', 15:31:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:22 INFO - 'SHELL': '/bin/bash', 15:31:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zQSyWNt96J/Listeners', 15:31:22 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:31:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:22 INFO - 'USER': 'cltbld', 15:31:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:22 INFO - 'XPC_FLAGS': '0x0', 15:31:22 INFO - 'XPC_SERVICE_NAME': '0', 15:31:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:31:23 INFO - Cleaning up... 15:31:23 INFO - Return code: 0 15:31:23 INFO - Running post-action listener: _resource_record_post_action 15:31:23 INFO - Running post-action listener: _start_resource_monitoring 15:31:23 INFO - Starting resource monitoring. 15:31:23 INFO - [mozharness: 2016-09-12 22:31:23.271155Z] Finished create-virtualenv step (success) 15:31:23 INFO - [mozharness: 2016-09-12 22:31:23.272115Z] Running install step. 15:31:23 INFO - Running pre-action listener: _resource_record_pre_action 15:31:23 INFO - Running main action method: install 15:31:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:23 INFO - Reading from file tmpfile_stdout 15:31:23 INFO - Detecting whether we're running mozinstall >=1.0... 15:31:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:31:23 INFO - Reading from file tmpfile_stdout 15:31:23 INFO - Output received: 15:31:23 INFO - Usage: mozinstall [options] installer 15:31:23 INFO - Options: 15:31:23 INFO - -h, --help show this help message and exit 15:31:23 INFO - -d DEST, --destination=DEST 15:31:23 INFO - Directory to install application into. [default: 15:31:23 INFO - "/builds/slave/test"] 15:31:23 INFO - --app=APP Application being installed. [default: firefox] 15:31:23 INFO - mkdir: /builds/slave/test/build/application 15:31:23 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'] 15:31:23 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 15:31:58 INFO - Reading from file tmpfile_stdout 15:31:58 INFO - Output received: 15:31:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:31:58 INFO - Running post-action listener: _resource_record_post_action 15:31:58 INFO - [mozharness: 2016-09-12 22:31:58.285603Z] Finished install step (success) 15:31:58 INFO - [mozharness: 2016-09-12 22:31:58.285733Z] Running run-tests step. 15:31:58 INFO - Running pre-action listener: _resource_record_pre_action 15:31:58 INFO - Running main action method: run_tests 15:31:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:31:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:31:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:31:58 INFO - 2016-09-12 15:31:58.300 screenresolution[1940:16988] starting screenresolution argv=screenresolution get 15:31:58 INFO - 2016-09-12 15:31:58.303 screenresolution[1940:16988] Display 0: 1600x1200x32@60 15:31:58 INFO - 2016-09-12 15:31:58.308 screenresolution[1941:16991] starting screenresolution argv=screenresolution list 15:31:58 INFO - Available Modes on Display 0 15:31:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:31:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:31:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:31:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:31:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:31:58 INFO - Intel Iris: 15:31:58 INFO - Chipset Model: Intel Iris 15:31:58 INFO - Type: GPU 15:31:58 INFO - Bus: Built-In 15:31:58 INFO - VRAM (Dynamic, Max): 1536 MB 15:31:58 INFO - Vendor: Intel (0x8086) 15:31:58 INFO - Device ID: 0x0a2e 15:31:58 INFO - Revision ID: 0x0009 15:31:58 INFO - Displays: 15:31:58 INFO - Display: 15:31:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:31:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:31:58 INFO - Display Serial Number: 1600x1200 60 15:31:58 INFO - Main Display: Yes 15:31:58 INFO - Mirror: Off 15:31:58 INFO - Online: Yes 15:31:58 INFO - Rotation: Supported 15:31:58 INFO - Return code: 0 15:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:31:58 INFO - Python 2.7.3 15:31:58 INFO - Return code: 0 15:31:58 INFO - grabbing minidump binary from tooltool 15:31: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')]} 15:31:58 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 0x106901d30>, '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 0x106727db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068f9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:31:58 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 15:31:58 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 15:31:58 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 15:31:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:31:58 INFO - Return code: 0 15:31:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:31:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:31:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:31:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:31:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:31:58 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/c_VWR8r_RpeNFM1TJG63vw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--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 15:31:58 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/c_VWR8r_RpeNFM1TJG63vw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --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 15:31:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sk7VlCk1Sl/Render', 15:31:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:58 INFO - 'HOME': '/Users/cltbld', 15:31:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:58 INFO - 'LOGNAME': 'cltbld', 15:31:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:31:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:58 INFO - 'MOZ_NO_REMOTE': '1', 15:31:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:31:58 INFO - 'NO_EM_RESTART': '1', 15:31:58 INFO - 'PAGER': '/bin/cat', 15:31:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:58 INFO - 'PWD': '/builds/slave/test', 15:31:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:31:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:58 INFO - 'SHELL': '/bin/bash', 15:31:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zQSyWNt96J/Listeners', 15:31:58 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 15:31:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:58 INFO - 'USER': 'cltbld', 15:31:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:58 INFO - 'XPC_FLAGS': '0x0', 15:31:58 INFO - 'XPC_SERVICE_NAME': '0', 15:31:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:58 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/c_VWR8r_RpeNFM1TJG63vw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--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 15:31:58 INFO - mozversion application_buildid: 20160912133516 15:31:58 INFO - mozversion application_changeset: c273bf6370c3b57ab2dda6add44b034c769ef728 15:31:58 INFO - mozversion application_display_name: Nightly 15:31:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:31:58 INFO - mozversion application_name: Firefox 15:31:58 INFO - mozversion application_remotingname: firefox 15:31:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:31:58 INFO - mozversion application_vendor: Mozilla 15:31:58 INFO - mozversion application_version: 51.0a1 15:31:58 INFO - mozversion platform_buildid: 20160912133516 15:31:58 INFO - mozversion platform_changeset: c273bf6370c3b57ab2dda6add44b034c769ef728 15:31:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:31:58 INFO - mozversion platform_version: 51.0a1 15:31:58 INFO - using testdate: 1473719518 15:31:58 INFO - actual date: 1473719518 15:31:58 INFO - starting webserver on 'localhost:52913' 15:31:58 INFO - SUITE-START | Running 2 tests 15:31:58 INFO - TEST-START | dromaeo_css 15:31:58 INFO - operating with platform_type : mac_ 15:31:58 INFO - Initialising browser for dromaeo_css test... 15:31:58 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmprSWnjp/profile http://localhost:52913/getInfo.html) 15:32:01 INFO - PROCESS | 1951 | __metrics Screen width/height:1600/1200 15:32:01 INFO - PROCESS | 1951 | colorDepth:24 15:32:01 INFO - PROCESS | 1951 | Browser inner width/height: 1024/689 15:32:01 INFO - PROCESS | 1951 | __metrics 15:32:01 INFO - PROCESS | 1951 | 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" 15:32:01 INFO - PROCESS | 1951 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:32:01 INFO - TEST-INFO | 1951: exit 0 15:32:01 INFO - Browser initialized. 15:32:01 INFO - Running cycle 1/1 for dromaeo_css test... 15:32:01 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmprSWnjp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:13 INFO - PROCESS | 1953 | RSS: Main: 232767488 15:32:13 INFO - PROCESS | 1953 | 15:33:04 INFO - PROCESS | 1953 | 1473719584865 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] 15:35:16 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52913/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52913/tests/dromaeo/cssquery-ext.html) 15:35:18 INFO - PROCESS | 1953 | RSS: Main: 429957120 15:35:18 INFO - PROCESS | 1953 | 15:38:22 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52913/tests/dromaeo/cssquery-ext.html (next: http://localhost:52913/tests/dromaeo/cssquery-jquery.html) 15:38:22 INFO - PROCESS | 1953 | RSS: Main: 371363840 15:38:22 INFO - PROCESS | 1953 | 15:41:25 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52913/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52913/tests/dromaeo/cssquery-mootools.html) 15:41:25 INFO - PROCESS | 1953 | RSS: Main: 332460032 15:41:25 INFO - PROCESS | 1953 | 15:44:27 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52913/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52913/tests/dromaeo/cssquery-prototype.html) 15:44:28 INFO - PROCESS | 1953 | RSS: Main: 344514560 15:44:28 INFO - PROCESS | 1953 | 15:47:31 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52913/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52913/tests/dromaeo/cssquery-yui.html) 15:47:32 INFO - PROCESS | 1953 | RSS: Main: 331268096 15:47:32 INFO - PROCESS | 1953 | 15:50:35 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:52913/tests/dromaeo/cssquery-yui.html (next: http://localhost:52913/tests/dromaeo/cssquery-dojo.html) 15:50:36 INFO - PROCESS | 1953 | RSS: Main: 410456064 15:50:36 INFO - PROCESS | 1953 | 15:50:36 INFO - PROCESS | 1953 | __start_tp_report 15:50:36 INFO - PROCESS | 1953 | _x_x_mozilla_page_load 15:50:36 INFO - PROCESS | 1953 | _x_x_mozilla_page_load_details 15:50:36 INFO - PROCESS | 1953 | |i|pagename|runs| 15:50:36 INFO - PROCESS | 1953 | |0;dojo.html;3200.8079515229083;3339.098443420276;3360.479125735512;3392.3724111039473;3444.2422667013266;5611.242482264893;5670.432956704328;5732.455416735414;5769.249997500325;5784.421557844219;5748.741306641201;5758.769649214037;5775.942240577593;5832.2418085648915;5861.560382971284;5141.177411614142;5170.689758614495;5172.741362931857;5215.9828833377505;5275.446078161776;5359.1425371940495;5365.248865158881;5373.328333958255;5375.704336261504;5386.461353864602;5185.351831021122;5315.468453154654;5323.1749078892835;5339.946600533984;5375.247465354834;5215.348081489814;5228.8692782680355;5270.130428479296;5292.338457692788;5319.840404787863;5236.842894713165;5249.790008399659;5282.366116066097;5283.445238249967;5344.091504444254;5762.481376676077;5768.942310576925;5788.450097240755;5789.131630255453;5796.13058041293;6097.312956045969;6116.816495505097;6175.62946223228;6236.781712640081;6301.590396624205;6241.095041219043;6315.147455093595;6317.241930968267;6319.778807741753;6327.8734425311695;5774.82675519735;5843.094320380348;5857.970710146465;5863.560232982543;5872.29532456108;6227.314995350508;6283.3088360280335;6304.243490781136;6369.840753981188;6374.58565193261;6128.19758601264;6129.601575897553;6133.3866613339205;6146.139540464339;6151.169592105098;6256.624602523863;6258.843528911813;6306.527010474233;6320.652364119926;6334.303226645157;5329.813456529003;6196.380361963767;6265.404786545362;6266.561340706198;6296.622202667854;5131.974340128276;6102.216595924226;6275.6862156891975;6287.2140982377205;6295.150154729053;4687.882802929886;4743.003969166445;4886.802733330357;4988.152014157602;5066.062778385936;4469.597736203757;4471.396361491222;4474.642028637766;4476.529964353761;4527.596445102029;5687.317521897398;5719.113537401709;5744.310682718101;5753;5768.048272035067;6150.708351246199;6233.096201050822;6245.906311405332;6258.561900667;6263.655498947602;5739.684317362502;5753.827385178452;5758.452946970031;5764.827055188351;5805.912911306334;4605.792739326738;5455.263539422127;5492.5331346835965;5498.065328894098;5512.50387465122;6177.135201071764;6228.968855155696;6275.497960163268;6288.779892703734;6391.488680905423;6245.375462453719;6282.2147231596055;6316.7473301069285;6324.335944725737;6325.557210995186;6292.465140463112;6337.4613157882095;6339.461145802658;6351.364863513611;6353.459955903615;6116.670564642461;6141.455323060992;6154.569180157346;6240.4071613196675;6241.438270555672;6192.845178870564;6284.214473190851;6295.905561416491;6298.212723409574;6312.905306420499;6197.318294987638;6198.721057552511;6203.627782333075;6207.379262073757;6211.65835879031;4496.550344965477;6057.636541807329;6150.077488376601;6175.722092505938;6223.066540019034;5909.497692696169;5959.622587079119;5996.580239383376;5999.970000149971;6027.60820546663;6165.599236049642;6180.134781130555;6194.938050619617;6209.534284928739;6222.191115155001;5807.186993820784;5820.563457740602;5835.328937172109;5853.09277062056;6023.48800351975 15:50:36 INFO - PROCESS | 1953 | |1;ext.html;500.1347668533435;520.4925197932016;523.7093413155698;524.6799452334076;531.9095753721867;29747.107586772403;31077.756889724413;39810.8009459953;40662.59337406625;40991;41716.16567668645;42118.57881421185;42167.578324216745;42208;42372.576274237246;9650.613975440992;9828.508574571279;9831.754206144831;9849.571812087243;9874.60501579936;8255.050669173062;8638.827223455528;10674.412907290096;12151.878481215163;12151.967082797973;12042.81935770964;12111.576094836682;12119.212251203644;12127.757444851097;12265.386730663477;12093.274403535772;12169.878301216962;12174.817377739386;12180.756384872342;12189.878101218963;11887.46506407205;11959.641210763692;11975;11978.460969256404;12000.699982500508;40043.79978100091;40340.79829600862;40342.39486407706;40363;40381.798091009354;2903.5499497577907;3244.9675503244903;3315.088350703576;3327.1349449143154;3403.7447191460737;25178;30359.392812143633;30743.692563074306;31301;31442.899498517443;2813.7889658275712;3180;3191.4255434021866;3225.064731227941;3314.4365457871977;376814;379278;379868;380436.1956380456;380859;32860.83569582137;56549;56879.57801055007;56894.7155264221;57010.714946425;33269.16827079294;34349.656503435144;34551.4817277741;34565.65434345674;34582.654173458446;14555.636109097357;14730.779038314435;14737.926310368379;14739.189344586151;14814.481493147689;11364.783867145827;11561.76876462466;12555.932745716716;12669.873301266869;12676.619701408788;7271.3455788979245;7475.588842613708;7666.693332266647;7667;7683.654235559413;3208.406444807718;3229.4187046331417;3231.1760501072545;3235.175030367241;3279.967200328014;896.6368620708623;904.2585080234277;905.42053086025;925.8842644669417;1007;24095.638565421534;28906.421871562452;29832.552511712343;30107.849460752557;30751.384972300428;1103.9282446640943;1148.4372657397982;1175.1949914308725;1192.0642295797757;1230.3233221728015;15226.695466090616;16025.278862450985;16186.947848389816;16216.918915405347;16287.674246515004;696150;710009;711488;711789;711810;57657.71171144201;58001.54996125131;58028.419715803146;58087;58130;1243.440451796695;1273.5860845225525;1365.8156148920166;1375.9518416855362;1401.4954616338314;24372.713277485032;28736.994205202718;30330.696693032787;30674.693253067184;30741.385172296876;47549.52450475589;48286.75856620695;48299.517004829504;48336.758316208194;48358.5164148354;556149;561074;562076;562696.1865190648;562848;25106.62340064937;26628;27022.459550808482;27224.183274501796;27940.580891287053;45940;46431.303530447745;46708.766456167505;47125.52874471348;47471;33218;36710.531578736554;37810.62189378071;38843.22313553769;39021;38713.289509861184;39017;39221.41167882427;39537.6898453312;40065.799671001456;36691.08272293214;36712.08219794527;37896.62103379041;38435.6156438432;38671.80664096661;32853.83573082119;33776.15559611029;34427.65572344245;34448;34765.47851782276;21819.23632672849;22925.312240632808;23844.52310953806;25205.74794252034;25403.237902862944 15:50:36 INFO - PROCESS | 1953 | |2;jquery.html;352.18996308490466;352.9682328590429;374.68526437792264;381.75949152034224;402.9456023436835;15069.472568460105;15082.170480623576;16441.50675479736;20706.378808635727;20780.168793248253;17854.464366069005;18872.245110195574;20208.494787630316;20900.581988360223;21038.684419733716;5227.973860130694;5816.621919575236;5902.909519340211;6096.35988221237;6104.084387341912;4683.9531604684025;6027.72875220614;6102.145699602059;6104.511639068886;6104.755809767604;5797.36229014808;5954.196183515235;6082.5742198046155;6083.452489275965;6092.939070609304;5988.640681559121;6045.6674882881425;6055;6055.273367195965;6067.302260240085;5231.843044708665;5234.136367499358;5257.579393648499;5525.033119204123;5594.58040646949;13234.801477977839;13497.325133743274;13526.59420217395;16239;25223.24330270095;2059.5263089489354;2071;2260.604394231003;2432.72023717273;2484.4037431016604;9809.950950245275;9860.753481163028;9900.851487227697;10316.27786054969;10401.115905148072;1774.0686139776722;1814.0929535232383;1823.4165067178508;1841.861860360465;1910.0736142970648;79490;123992;130191.20933697541;130211;130299;11038.289065194907;11390.202685812079;11442.54229830814;11469.598564050219;11591.826122608167;14111.50609728675;14240.359183836752;14246.07400518963;14275.143491390341;14302.427902883976;8305.294050005818;8540.274076703425;8590.441621294722;8699.086595907338;8735.825283494294;8518.57407129641;8519.527248194623;8520.829583408422;8678.913210867937;8717.65129394817;4160.54234034256;4167.770772607536;4427.848759322599;4523.864284071417;4607.3089036644105;1583.9604009899615;1585.5718955881848;1833.9633207335778;1902.581432084939;1906.9427917162507;747.622450662412;897.4391005621486;923.3213588012806;924.117467818232;933.0669330669331;20702.378928632166;21385.358439246847;21437.785622143892;21447;21467.78532214689;921.4611598630304;949.3307218411004;954.7231302922214;964.5514835601479;1019.8317277649105;8643.611037503328;10428.478576071166;11093.278936869077;11144.996950274513;11171.72070698239;519960;554005;559636;574875;578089;97576;123167;125912.48175036447;136782.63217367698;139303;832.3549249331817;970.7233438470003;1004.2668851738272;1004.8743907011624;1032.8554002439814;15713.978591391522;17964.922104673762;19263.51841203981;19339.4198174055;19519.414417567496;52052.47947520476;54481.72759136179;60144.411877403334;60212.39787602068;60962;87468;88132;88526;89384.5530772342;89910;7856.057273127033;8016;8075.475094118863;8179.877301840358;8219.95890020546;9052.954735226282;11508.769824603294;11943.701407464883;12836.935815320863;13250.271235082164;10810.29733067348;11008.339499630049;11260.155488338243;11428.828567571327;11448.771024579295;10975.28660637056;11078.833817492905;11188.83216751733;11284.548618055514;11318.830217546578;11079.169062320198;11214.943925280322;11385.373804440504;11416.143789215675;11610.70973225676;7011.964940175267;7939.7371749053555;8138.186181381814;8169.877451838346;8314.916850831656;10759.946200269262;10820.242583019428;11108.50011749457;11166.274192177483;11210.719732006764 15:50:36 INFO - PROCESS | 1953 | |3;mootools.html;1464.5972357601659;1520.7718842173672;1638.4347400146953;1699.660067986403;1859.4979355573987;8438.282745966593;8928.107189281069;8948.28413726902;8950.552472376372;8977.955110224457;7866.331361834251;8077.474964127342;8078.192180781919;8558.315334773219;8777.736667899957;2380.654805053262;2414.106780491212;2415.154695856445;2418.2382549496942;2422.3701837522285;2388.1163969331374;2402.8918698658604;2419.9637005444933;2424.7211570669424;2428.368624157714;2228.543148654522;2243.6858839762444;2247.2696373678536;2254.5603607296584;2269.6482045283005;2378.607529757588;2389.940251493718;2403.3270684208364;2408.6266628672583;2412.1798588479824;2403.567357875582;2404.651325557802;2405.314485371661;2407.205622144688;2411.7588241175918;8836.983746869128;8850.778730531723;8937.73186804397;8964.14840590143;8968.865467017935;5232.555232805216;5385.676859388449;5404.675719456806;5409.810656627039;5410.783568657249;3485.4597537381746;3551.8598262677156;3712.7401081924277;3715.294094122108;3717.4795528626014;1088.1403691084033;1107.70951841105;1750.9299628014865;1794.0939825388225;1822.9270829166817;11523.654290371302;11595.246308989888;11604.477798499087;11616.825747613793;11633.418329083597;4443.844465443694;4657.720536767804;4843.709377437365;4914.877128071756;4953.0589188054155;9259.907400925904;9295.58169882357;9301.767455813524;9307.162355388047;9326.626934922662;4517.638588912879;5302.09864323066;5305.8938821223355;5308.946910530845;5322.707251101227;4679.508651591602;4820.060088282821;4910.410750709938;4948.851534453972;4955.108080545537;3771.4719939208535;3811.5516103880905;3863.942040869389;3889.7277190596387;3895.649391554717;1006.9093781559695;1175.6825657072543;1178.6287319494504;1182.4737991593831;1191.862935762381;777.8254835198891;802.3982013489882;902.7992769616394;904.6110172625835;907.4419232172166;5357.866053348619;5804.535637149018;6051.576389652682;6086.513078953673;6121.234845644294;931.5761328595473;940.849464085743;948.5257371314343;965.2181732796457;994.0010289658846;3813.2945405100145;3857.247836671822;3942.1721438498234;3989.9202015959518;4056.3915412687743;10542.736431589272;10836.241463097507;10928.633920759905;10934.890651093547;10936.835947460795;9218.76953076165;10845.566177352817;10894.346339219672;10895.673129806119;10912;8065.677372905136;8097.2307630774985;8239.217274358927;8324.70863519774;8335.874961875577;5810.358027023654;5835.2122463466885;5878.2064421304285;5992.580519363602;6003.219581454383;10132;10187.7453063674;10212.489375531342;10234.078932896075;10272.691819245434;8667.566621669017;9371.344005919793;10051.949740251252;10166.390016599027;10406.895931040593;5794.62334948227;6580.374864387875;7078.929210707827;7149.678264478007;7226.927730722626;8293.83412331762;8332.833343333221;8362.623681934449;8388.580570971304;8499.532525711145;7473.177950425557;7533.8116547086765;7549.962250188714;7591.696332146873;7642.197569255148;7291.744788932362;7465.141508726566;7475.102987641518;7493.138289096823;7596.506227095221;6924.826879328057;7002.404795592228;7086.645667716697;7089.893651595127;7105.005299258005;4775.379200703886;4909.4845041270155;4974.32846565709;5001.524855138756;5143.948560514347;4601.907961840811;4774.069056533943;4832.95167048339;4996.525330093636;5030.4718004608985 15:50:36 INFO - PROCESS | 1953 | |4;prototype.html;301.4844615707142;303.567416431585;311.6945393514356;313.4076595235006;317.1405491119067;4835.68568043077;5035.395752509699;5463.787166197686;5477.479639434252;5529.751161197746;4662.671138725464;4877.926831097537;5090.058339207249;5129.563987061104;5381.246625472437;3379.493076038589;3448.7413443991677;3848.5189351331082;4099.754014759109;4139.4204811326435;4036.7577945323374;4061.4720086388875;4090.550039495653;4094.5700701426367;4106.486689163855;3677.816109194543;3926.725129240954;4061.0050537618326;4062.4609618988134;4079.3676980068135;4056.8782936511952;4057.3305404608204;4075.3683179107284;4079.102597428591;4088.5093788745244;3519.03226612681;3548.254866478043;3564.198055437532;3569.6430356964097;3577.5170352002665;4395.351743096339;4996.700197988096;5073.949260507385;5179.695035709111;5226.895462090775;4249.447571815645;4290.4636920384955;4686.649045932141;4692.343071969893;4695.3661255730385;5603.355614104389;5608.44815608897;5612.859678508029;5616.66300022;5650.858728531778;3727.4036154215196;3879.4568760373572;3889.2221555688975;3891.182851601167;3914.3559704924;5572.554195664377;5847.707614619252;5855.912161317584;5860.238169037998;5869.413058694139;3188.952165717516;3931.567527571965;3953.9802300988313;3954.762714237155;3963.583823698528;3372.7689393371243;4004.839806407769;4023.6177563131455;4036.9596304036586;4044.9191016180102;3957.3470377387407;4476.529964353761;4632.305154226826;4667.509911459316;4696.577308042292;5641.7996981177375;5646.491815736604;5653.604247702621;5654;5671.631343962629;1182.030734797475;1265.9366132448788;1346.3335648853683;1381.7633218269793;1385.896057795649;776.2005134711256;799.6081919859228;837.9622916968751;880.4981160738317;894.4186278918625;5093.490650934877;5155.175171972466;5164.5539249010335;5167.509086636764;5170.146925757208;4748.786304616231;5470.425605311465;5696.629719068247;5699.772009119589;5717.656940583578;4275.486941567032;4794.7362895040405;4799.952000480021;5116.948830511722;5206.453322401169;2952.5423559348337;2962.8370439625596;2972.4203780263074;2974.895878644237;3002.789804713693;4918.5819205367225;5609.691466969356;5851.268591426072;5871.412858714094;5881;5622.57830662702;5840.649561026352;5850.531957443394;5865.35481097079;5895.351511333835;4605.4933957264675;5874.148248503943;5921.67430791302;5940.4653581177035;5958.582899197015;4534.977325113353;5419.376771671308;5693.868372395249;5726.284214473191;5745.534888603379;5199.906055896736;5635.379548509963;5638.011853717537;5653.575981801299;5687.5734319927;4934.7285899275885;5813.738381772915;5875.529957603467;5906.822795316148;5913.58604897653;3761.9623803762706;3917.3536366499206;3951.585083566184;3954.8022598870516;3966.5438474575794;4783.493199642102;5687.829365119053;5692.971535142297;5720.225690540168;5752.511036561772;5243.007657090281;5382.381026181883;5568.053430916835;5600.327960644749;5608.523275521627;5209.426963033988;5444.401115877171;5490.780368785204;5554.611177217556;5559.861003474945;5217.869553261199;5399.325084364455;5407.72961351923;5462.399136095106;5462.726863656881;5365.892682146413;5490.91763623538;5531.502164805187;5646.689432081275;5735.71321433935;4523.991545622124;5456.953642384106;5487.5306112248845;5510.8071217507195;5539.916901246565 15:50:36 INFO - PROCESS | 1953 | |5;yui.html;700.3976580141075;711.2887112887109;712.2912701861646;756.1153450462958;822.9423940324176;15384.769228461568;16363.83636163638;16367.59081022975;16388.672226555478;16407.75388369174;14574.344154513046;14830.629234269149;14835.406583736665;14857.479988200415;14859.851401485981;671.6910221298209;694.149666658342;831.991680083199;832.6586099699125;857.8455877941968;829.9957051967127;841.5876220651897;842.6334544473143;843.8185790055137;847.2925107535216;901.0358915959926;901.2474583722567;901.2834796336895;903.1465265324272;903.3631289940608;710.4742490557003;895.1048951048919;899.5052721003455;899.8560230363111;903.8056817784208;543.1526818163677;662.7746566167526;677.8678157759239;682.2870100744734;684.5208354152113;14870.182139982297;14914.328855201542;14914.477993270184;14915.701685966329;14917.955743097988;13502.257375844325;13883.37524811386;14025.859741402557;14044.859551404457;14060.578182654537;12396.380180991004;12533.56132535366;12644.810327845089;12673.93663031688;13015.86984130156;4488;4607.239805432133;4618.468876079261;4649.442066951953;4728.243481043017;105239.94760052378;106394;106663.93336066695;113201.43399283034;113646.43176784064;8731.476111433334;10665.786684266272;10972.506237219344;11161.609343673095;11370.715732106764;18340.633187336447;22204.222852200095;22224.777752222595;22224.88887555552;22264.888675556518;7661.693532258647;7765.53406795594;7820.413468989848;7902.841943161105;8032.1164671886045;3864.2078373933277;4308.310670292801;4375.496817865923;4459.821607135678;4560.247559152769;3449.9310013800086;3575.785452872836;3576.8926932191557;3582.9283414331567;3587.8385472653795;631.9778807741707;637.5951270942985;648.3516483516484;648.9448396886318;650.0314531348257;515.9558604234969;552.4171998541497;563.39997902234;623.0591806372411;631.1605564599072;8572;9440.29197810167;9461.716148515556;9464.384814987141;9706.854397184048;604.4257954942822;623.9953674583916;632.4876849751715;634.4258446106281;672.3276723276723;4239.38528913312;4642.18761716705;4658.557437043475;4673.462551806518;4757.3577567028005;161601;164865;167645;167989;170473;123048;133568.33215834052;144594.2770286142;148383;150973;123436;123531;123795.3810230943;124635;125746.74253257533;8617.181367770303;8921.420107693239;8949.910500894908;8965.372423930523;9118.042605526323;62536;63993.68003159954;64418;67166;67669.66165169142;101545;101577;102166;104404.47797760963;106186;9697.709068727949;11754.412279386168;11885.702857428634;11932.582359617372;12072.204036690131;12984.285864277555;12999.610011699664;13177.670558235737;13178.143420677625;13570.321483925962;11844.52621895149;11964.16250862466;12121.757564848478;12128.757424851277;12378;11934.701632459259;11986.76026479448;12255.509779608716;12269;12394.566190183301;11851.229670071418;11921.46353414081;12392.380380980734;12402.75194496123;12428.75142497127;9853;10043.69868903934;10210.438425886647;10434.06093451593;10559.419231942316;8807.647694092164;9418.161178216047;10049;10119.089281964658;10226.53980570891 15:50:36 INFO - PROCESS | 1953 | __end_tp_report 15:50:36 INFO - PROCESS | 1953 | __start_cc_report 15:50:36 INFO - PROCESS | 1953 | _x_x_mozilla_cycle_collect,2031 15:50:36 INFO - PROCESS | 1953 | __end_cc_report 15:50:36 INFO - PROCESS | 1953 | __startTimestamp1473720636059__endTimestamp 15:50:36 INFO - PROCESS | 1953 | 15:50:36 INFO - PROCESS | 1953 | ------- Summary: start ------- 15:50:36 INFO - PROCESS | 1953 | Number of tests: 6 15:50:36 INFO - PROCESS | 1953 | 15:50:36 INFO - PROCESS | 1953 | [#0] dojo.html Cycles:165 Average:5759.13 Median:5909.50 stddev:652.13 (11.0%) stddev-sans-first:622.49 15:50:36 INFO - PROCESS | 1953 | Values: 3200.8 3339.1 3360.5 3392.4 3444.2 5611.2 5670.4 5732.5 5769.2 5784.4 5748.7 5758.8 5775.9 5832.2 5861.6 5141.2 5170.7 5172.7 5216.0 5275.4 5359.1 5365.2 5373.3 5375.7 5386.5 5185.4 5315.5 5323.2 5339.9 5375.2 5215.3 5228.9 5270.1 5292.3 5319.8 5236.8 5249.8 5282.4 5283.4 5344.1 5762.5 5768.9 5788.5 5789.1 5796.1 6097.3 6116.8 6175.6 6236.8 6301.6 6241.1 6315.1 6317.2 6319.8 6327.9 5774.8 5843.1 5858.0 5863.6 5872.3 6227.3 6283.3 6304.2 6369.8 6374.6 6128.2 6129.6 6133.4 6146.1 6151.2 6256.6 6258.8 6306.5 6320.7 6334.3 5329.8 6196.4 6265.4 6266.6 6296.6 5132.0 6102.2 6275.7 6287.2 6295.2 4687.9 4743.0 4886.8 4988.2 5066.1 4469.6 4471.4 4474.6 4476.5 4527.6 5687.3 5719.1 5744.3 5753.0 5768.0 6150.7 6233.1 6245.9 6258.6 6263.7 5739.7 5753.8 5758.5 5764.8 5805.9 4605.8 5455.3 5492.5 5498.1 5512.5 6177.1 6229.0 6275.5 6288.8 6391.5 6245.4 6282.2 6316.7 6324.3 6325.6 6292.5 6337.5 6339.5 6351.4 6353.5 6116.7 6141.5 6154.6 6240.4 6241.4 6192.8 6284.2 6295.9 6298.2 6312.9 6197.3 6198.7 6203.6 6207.4 6211.7 4496.6 6057.6 6150.1 6175.7 6223.1 5909.5 5959.6 5996.6 6000.0 6027.6 6165.6 6180.1 6194.9 6209.5 6222.2 5807.2 5820.6 5835.3 5853.1 6023.5 15:50:36 INFO - PROCESS | 1953 | 15:50:36 INFO - PROCESS | 1953 | [#1] ext.html Cycles:180 Average:67040.55 Median:18876.70 stddev:151882.88 (804.6%) stddev-sans-first:152226.78 15:50:36 INFO - PROCESS | 1953 | Values: 500.1 520.5 523.7 524.7 531.9 29747.1 31077.8 39810.8 40662.6 40991.0 41716.2 42118.6 42167.6 42208.0 42372.6 9650.6 9828.5 9831.8 9849.6 9874.6 8255.1 8638.8 10674.4 12151.9 12152.0 12042.8 12111.6 12119.2 12127.8 12265.4 12093.3 12169.9 12174.8 12180.8 12189.9 11887.5 11959.6 11975.0 11978.5 12000.7 40043.8 40340.8 40342.4 40363.0 40381.8 2903.5 3245.0 3315.1 3327.1 3403.7 25178.0 30359.4 30743.7 31301.0 31442.9 2813.8 3180.0 3191.4 3225.1 3314.4 376814.0 379278.0 379868.0 380436.2 380859.0 32860.8 56549.0 56879.6 56894.7 57010.7 33269.2 34349.7 34551.5 34565.7 34582.7 14555.6 14730.8 14737.9 14739.2 14814.5 11364.8 11561.8 12555.9 12669.9 12676.6 7271.3 7475.6 7666.7 7667.0 7683.7 3208.4 3229.4 3231.2 3235.2 3280.0 896.6 904.3 905.4 925.9 1007.0 24095.6 28906.4 29832.6 30107.8 30751.4 1103.9 1148.4 1175.2 1192.1 1230.3 15226.7 16025.3 16186.9 16216.9 16287.7 696150.0 710009.0 711488.0 711789.0 711810.0 57657.7 58001.5 58028.4 58087.0 58130.0 1243.4 1273.6 1365.8 1376.0 1401.5 24372.7 28737.0 30330.7 30674.7 30741.4 47549.5 48286.8 48299.5 48336.8 48358.5 556149.0 561074.0 562076.0 562696.2 562848.0 25106.6 26628.0 27022.5 27224.2 27940.6 45940.0 46431.3 46708.8 47125.5 47471.0 33218.0 36710.5 37810.6 38843.2 39021.0 38713.3 39017.0 39221.4 39537.7 40065.8 36691.1 36712.1 37896.6 38435.6 38671.8 32853.8 33776.2 34427.7 34448.0 34765.5 21819.2 22925.3 23844.5 25205.7 25403.2 15:50:36 INFO - PROCESS | 1953 | 15:50:36 INFO - PROCESS | 1953 | [#2] jquery.html Cycles:180 Average:33849.05 Median:13853.82 stddev:93753.76 (676.7%) stddev-sans-first:93983.02 15:50:36 INFO - PROCESS | 1953 | Values: 352.2 353.0 374.7 381.8 402.9 15069.5 15082.2 16441.5 20706.4 20780.2 17854.5 18872.2 20208.5 20900.6 21038.7 5228.0 5816.6 5902.9 6096.4 6104.1 4684.0 6027.7 6102.1 6104.5 6104.8 5797.4 5954.2 6082.6 6083.5 6092.9 5988.6 6045.7 6055.0 6055.3 6067.3 5231.8 5234.1 5257.6 5525.0 5594.6 13234.8 13497.3 13526.6 16239.0 25223.2 2059.5 2071.0 2260.6 2432.7 2484.4 9810.0 9860.8 9900.9 10316.3 10401.1 1774.1 1814.1 1823.4 1841.9 1910.1 79490.0 123992.0 130191.2 130211.0 130299.0 11038.3 11390.2 11442.5 11469.6 11591.8 14111.5 14240.4 14246.1 14275.1 14302.4 8305.3 8540.3 8590.4 8699.1 8735.8 8518.6 8519.5 8520.8 8678.9 8717.7 4160.5 4167.8 4427.8 4523.9 4607.3 1584.0 1585.6 1834.0 1902.6 1906.9 747.6 897.4 923.3 924.1 933.1 20702.4 21385.4 21437.8 21447.0 21467.8 921.5 949.3 954.7 964.6 1019.8 8643.6 10428.5 11093.3 11145.0 11171.7 519960.0 554005.0 559636.0 574875.0 578089.0 97576.0 123167.0 125912.5 136782.6 139303.0 832.4 970.7 1004.3 1004.9 1032.9 15714.0 17964.9 19263.5 19339.4 19519.4 52052.5 54481.7 60144.4 60212.4 60962.0 87468.0 88132.0 88526.0 89384.6 89910.0 7856.1 8016.0 8075.5 8179.9 8220.0 9053.0 11508.8 11943.7 12836.9 13250.3 10810.3 11008.3 11260.2 11428.8 11448.8 10975.3 11078.8 11188.8 11284.5 11318.8 11079.2 11214.9 11385.4 11416.1 11610.7 7012.0 7939.7 8138.2 8169.9 8314.9 10759.9 10820.2 11108.5 11166.3 11210.7 15:50:36 INFO - PROCESS | 1953 | 15:50:36 INFO - PROCESS | 1953 | [#3] mootools.html Cycles:180 Average:5689.39 Median:4950.96 stddev:3153.35 (63.7%) stddev-sans-first:3146.21 15:50:36 INFO - PROCESS | 1953 | Values: 1464.6 1520.8 1638.4 1699.7 1859.5 8438.3 8928.1 8948.3 8950.6 8978.0 7866.3 8077.5 8078.2 8558.3 8777.7 2380.7 2414.1 2415.2 2418.2 2422.4 2388.1 2402.9 2420.0 2424.7 2428.4 2228.5 2243.7 2247.3 2254.6 2269.6 2378.6 2389.9 2403.3 2408.6 2412.2 2403.6 2404.7 2405.3 2407.2 2411.8 8837.0 8850.8 8937.7 8964.1 8968.9 5232.6 5385.7 5404.7 5409.8 5410.8 3485.5 3551.9 3712.7 3715.3 3717.5 1088.1 1107.7 1750.9 1794.1 1822.9 11523.7 11595.2 11604.5 11616.8 11633.4 4443.8 4657.7 4843.7 4914.9 4953.1 9259.9 9295.6 9301.8 9307.2 9326.6 4517.6 5302.1 5305.9 5308.9 5322.7 4679.5 4820.1 4910.4 4948.9 4955.1 3771.5 3811.6 3863.9 3889.7 3895.6 1006.9 1175.7 1178.6 1182.5 1191.9 777.8 802.4 902.8 904.6 907.4 5357.9 5804.5 6051.6 6086.5 6121.2 931.6 940.8 948.5 965.2 994.0 3813.3 3857.2 3942.2 3989.9 4056.4 10542.7 10836.2 10928.6 10934.9 10936.8 9218.8 10845.6 10894.3 10895.7 10912.0 8065.7 8097.2 8239.2 8324.7 8335.9 5810.4 5835.2 5878.2 5992.6 6003.2 10132.0 10187.7 10212.5 10234.1 10272.7 8667.6 9371.3 10051.9 10166.4 10406.9 5794.6 6580.4 7078.9 7149.7 7226.9 8293.8 8332.8 8362.6 8388.6 8499.5 7473.2 7533.8 7550.0 7591.7 7642.2 7291.7 7465.1 7475.1 7493.1 7596.5 6924.8 7002.4 7086.6 7089.9 7105.0 4775.4 4909.5 4974.3 5001.5 5143.9 4601.9 4774.1 4833.0 4996.5 5030.5 15:50:36 INFO - PROCESS | 1953 | 15:50:36 INFO - PROCESS | 1953 | [#4] prototype.html Cycles:180 Average:4545.61 Median:5142.37 stddev:1390.22 (27.0%) stddev-sans-first:1357.13 15:50:36 INFO - PROCESS | 1953 | Values: 301.5 303.6 311.7 313.4 317.1 4835.7 5035.4 5463.8 5477.5 5529.8 4662.7 4877.9 5090.1 5129.6 5381.2 3379.5 3448.7 3848.5 4099.8 4139.4 4036.8 4061.5 4090.6 4094.6 4106.5 3677.8 3926.7 4061.0 4062.5 4079.4 4056.9 4057.3 4075.4 4079.1 4088.5 3519.0 3548.3 3564.2 3569.6 3577.5 4395.4 4996.7 5073.9 5179.7 5226.9 4249.4 4290.5 4686.6 4692.3 4695.4 5603.4 5608.4 5612.9 5616.7 5650.9 3727.4 3879.5 3889.2 3891.2 3914.4 5572.6 5847.7 5855.9 5860.2 5869.4 3189.0 3931.6 3954.0 3954.8 3963.6 3372.8 4004.8 4023.6 4037.0 4044.9 3957.3 4476.5 4632.3 4667.5 4696.6 5641.8 5646.5 5653.6 5654.0 5671.6 1182.0 1265.9 1346.3 1381.8 1385.9 776.2 799.6 838.0 880.5 894.4 5093.5 5155.2 5164.6 5167.5 5170.1 4748.8 5470.4 5696.6 5699.8 5717.7 4275.5 4794.7 4800.0 5116.9 5206.5 2952.5 2962.8 2972.4 2974.9 3002.8 4918.6 5609.7 5851.3 5871.4 5881.0 5622.6 5840.6 5850.5 5865.4 5895.4 4605.5 5874.1 5921.7 5940.5 5958.6 4535.0 5419.4 5693.9 5726.3 5745.5 5199.9 5635.4 5638.0 5653.6 5687.6 4934.7 5813.7 5875.5 5906.8 5913.6 3762.0 3917.4 3951.6 3954.8 3966.5 4783.5 5687.8 5693.0 5720.2 5752.5 5243.0 5382.4 5568.1 5600.3 5608.5 5209.4 5444.4 5490.8 5554.6 5559.9 5217.9 5399.3 5407.7 5462.4 5462.7 5365.9 5490.9 5531.5 5646.7 5735.7 4524.0 5457.0 5487.5 5510.8 5539.9 15:50:36 INFO - PROCESS | 1953 | 15:50:36 INFO - PROCESS | 1953 | [#5] yui.html Cycles:180 Average:26209.03 Median:3512.86 stddev:43539.81 (1239.4%) stddev-sans-first:43619.82 15:50:36 INFO - PROCESS | 1953 | Values: 700.4 711.3 712.3 756.1 822.9 15384.8 16363.8 16367.6 16388.7 16407.8 14574.3 14830.6 14835.4 14857.5 14859.9 671.7 694.1 832.0 832.7 857.8 830.0 841.6 842.6 843.8 847.3 901.0 901.2 901.3 903.1 903.4 710.5 895.1 899.5 899.9 903.8 543.2 662.8 677.9 682.3 684.5 14870.2 14914.3 14914.5 14915.7 14918.0 13502.3 13883.4 14025.9 14044.9 14060.6 12396.4 12533.6 12644.8 12673.9 13015.9 4488.0 4607.2 4618.5 4649.4 4728.2 105239.9 106394.0 106663.9 113201.4 113646.4 8731.5 10665.8 10972.5 11161.6 11370.7 18340.6 22204.2 22224.8 22224.9 22264.9 7661.7 7765.5 7820.4 7902.8 8032.1 3864.2 4308.3 4375.5 4459.8 4560.2 3449.9 3575.8 3576.9 3582.9 3587.8 632.0 637.6 648.4 648.9 650.0 516.0 552.4 563.4 623.1 631.2 8572.0 9440.3 9461.7 9464.4 9706.9 604.4 624.0 632.5 634.4 672.3 4239.4 4642.2 4658.6 4673.5 4757.4 161601.0 164865.0 167645.0 167989.0 170473.0 123048.0 133568.3 144594.3 148383.0 150973.0 123436.0 123531.0 123795.4 124635.0 125746.7 8617.2 8921.4 8949.9 8965.4 9118.0 62536.0 63993.7 64418.0 67166.0 67669.7 101545.0 101577.0 102166.0 104404.5 106186.0 9697.7 11754.4 11885.7 11932.6 12072.2 12984.3 12999.6 13177.7 13178.1 13570.3 11844.5 11964.2 12121.8 12128.8 12378.0 11934.7 11986.8 12255.5 12269.0 12394.6 11851.2 11921.5 12392.4 12402.8 12428.8 9853.0 10043.7 10210.4 10434.1 10559.4 8807.6 9418.2 10049.0 10119.1 10226.5 15:50:36 INFO - PROCESS | 1953 | -------- Summary: end -------- 15:50:36 INFO - PROCESS | 1953 | 15:50:36 INFO - TEST-INFO | 1953: exit 0 15:50:36 INFO - TEST-OK | dromaeo_css | took 1117831ms 15:50:36 INFO - TEST-START | kraken 15:50:36 INFO - operating with platform_type : mac_ 15:50:36 INFO - Initialising browser for kraken test... 15:50:36 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpwIrOLT/profile http://localhost:52913/getInfo.html) 15:50:38 INFO - PROCESS | 1956 | __metrics Screen width/height:1600/1200 15:50:38 INFO - PROCESS | 1956 | colorDepth:24 15:50:38 INFO - PROCESS | 1956 | Browser inner width/height: 1024/689 15:50:38 INFO - PROCESS | 1956 | __metrics 15:50:38 INFO - PROCESS | 1956 | 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" 15:50:38 INFO - PROCESS | 1956 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:50:39 INFO - TEST-INFO | 1956: exit 0 15:50:39 INFO - Browser initialized. 15:50:39 INFO - Running cycle 1/1 for kraken test... 15:50:39 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpwIrOLT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:51 INFO - PROCESS | 1957 | RSS: Main: 232644608 15:50:51 INFO - PROCESS | 1957 | 15:50:54 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52913/tests/kraken/driver.html?testName=audio-beat-detection) 15:50:55 INFO - PROCESS | 1957 | RSS: Main: 292622336 15:50:55 INFO - PROCESS | 1957 | 15:50:57 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52913/tests/kraken/driver.html?testName=audio-dft) 15:50:58 INFO - PROCESS | 1957 | RSS: Main: 289361920 15:50:58 INFO - PROCESS | 1957 | 15:51:01 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52913/tests/kraken/driver.html?testName=audio-fft) 15:51:02 INFO - PROCESS | 1957 | RSS: Main: 379432960 15:51:02 INFO - PROCESS | 1957 | 15:51:04 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52913/tests/kraken/driver.html?testName=audio-oscillator) 15:51:05 INFO - PROCESS | 1957 | RSS: Main: 281501696 15:51:05 INFO - PROCESS | 1957 | 15:51:07 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52913/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:51:07 INFO - PROCESS | 1957 | RSS: Main: 285282304 15:51:07 INFO - PROCESS | 1957 | 15:51:10 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52913/tests/kraken/driver.html?testName=imaging-darkroom) 15:51:11 INFO - PROCESS | 1957 | RSS: Main: 321888256 15:51:11 INFO - PROCESS | 1957 | 15:51:14 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52913/tests/kraken/driver.html?testName=imaging-desaturate) 15:51:14 INFO - PROCESS | 1957 | RSS: Main: 323723264 15:51:14 INFO - PROCESS | 1957 | 15:51:17 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52913/tests/kraken/driver.html?testName=json-parse-financial) 15:51:18 INFO - PROCESS | 1957 | RSS: Main: 321130496 15:51:18 INFO - PROCESS | 1957 | 15:51:19 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52913/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:51:20 INFO - PROCESS | 1957 | RSS: Main: 299347968 15:51:20 INFO - PROCESS | 1957 | 15:51:22 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:51:22 INFO - PROCESS | 1957 | RSS: Main: 303796224 15:51:22 INFO - PROCESS | 1957 | 15:51:25 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:51:25 INFO - PROCESS | 1957 | RSS: Main: 301027328 15:51:25 INFO - PROCESS | 1957 | 15:51:28 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:51:29 INFO - PROCESS | 1957 | RSS: Main: 318074880 15:51:29 INFO - PROCESS | 1957 | 15:51:32 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:51:32 INFO - PROCESS | 1957 | RSS: Main: 314363904 15:51:32 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52913/tests/kraken/driver.html?testName=ai-astar) 15:51:34 INFO - PROCESS | 1957 | RSS: Main: 357789696 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | __start_tp_report 15:51:34 INFO - PROCESS | 1957 | _x_x_mozilla_page_load 15:51:34 INFO - PROCESS | 1957 | _x_x_mozilla_page_load_details 15:51:34 INFO - PROCESS | 1957 | |i|pagename|runs| 15:51:34 INFO - PROCESS | 1957 | |0;ai-astar;113;113;116;113;113;112;112;110;113;124 15:51:34 INFO - PROCESS | 1957 | |1;audio-beat-detection;148;117;166;177;108;131;129;110;158;106 15:51:34 INFO - PROCESS | 1957 | |2;audio-dft;184;185;184;183;175;183;182;184;186;183 15:51:34 INFO - PROCESS | 1957 | |3;audio-fft;76;73;76;153;58;57;56;69;142;57 15:51:34 INFO - PROCESS | 1957 | |4;audio-oscillator;81;83;135;70;71;72;117;68;70;118 15:51:34 INFO - PROCESS | 1957 | |5;imaging-gaussian-blur;91;87;91;88;91;90;91;88;91;87 15:51:34 INFO - PROCESS | 1957 | |6;imaging-darkroom;95;95;95;95;95;94;95;95;95;95 15:51:34 INFO - PROCESS | 1957 | |7;imaging-desaturate;87;85;85;84;85;85;85;90;127;83 15:51:34 INFO - PROCESS | 1957 | |8;json-parse-financial;54;55;56;54;54;54;55;53;53;53 15:51:34 INFO - PROCESS | 1957 | |9;json-stringify-tinderbox;64;64;71;69;73;75;70;69;70;69 15:51:34 INFO - PROCESS | 1957 | |10;stanford-crypto-aes;85;91;107;106;105;85;84;87;85;90 15:51:34 INFO - PROCESS | 1957 | |11;stanford-crypto-ccm;139;138;139;136;140;137;140;136;180;139 15:51:34 INFO - PROCESS | 1957 | |12;stanford-crypto-pbkdf2;168;168;168;168;221;240;226;168;169;167 15:51:34 INFO - PROCESS | 1957 | |13;stanford-crypto-sha256-iterative;66;66;67;66;67;68;67;68;66;68 15:51:34 INFO - PROCESS | 1957 | __end_tp_report 15:51:34 INFO - PROCESS | 1957 | __start_cc_report 15:51:34 INFO - PROCESS | 1957 | _x_x_mozilla_cycle_collect,2028 15:51:34 INFO - PROCESS | 1957 | __end_cc_report 15:51:34 INFO - PROCESS | 1957 | __startTimestamp1473720694939__endTimestamp 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | ------- Summary: start ------- 15:51:34 INFO - PROCESS | 1957 | Number of tests: 14 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | [#0] ai-astar Cycles:10 Average:113.90 Median:113.00 stddev:3.84 (3.4%) stddev-sans-first:4.06 15:51:34 INFO - PROCESS | 1957 | Values: 113.0 113.0 116.0 113.0 113.0 112.0 112.0 110.0 113.0 124.0 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:139.50 stddev:25.81 (18.5%) stddev-sans-first:26.94 15:51:34 INFO - PROCESS | 1957 | Values: 148.0 117.0 166.0 177.0 108.0 131.0 129.0 110.0 158.0 106.0 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | [#2] audio-dft Cycles:10 Average:182.90 Median:184.00 stddev:3.00 (1.6%) stddev-sans-first:3.15 15:51:34 INFO - PROCESS | 1957 | Values: 184.0 185.0 184.0 183.0 175.0 183.0 182.0 184.0 186.0 183.0 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | [#3] audio-fft Cycles:10 Average:81.70 Median:63.50 stddev:35.69 (56.2%) stddev-sans-first:37.80 15:51:34 INFO - PROCESS | 1957 | Values: 76.0 73.0 76.0 153.0 58.0 57.0 56.0 69.0 142.0 57.0 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | [#4] audio-oscillator Cycles:10 Average:88.50 Median:70.50 stddev:24.98 (35.4%) stddev-sans-first:26.34 15:51:34 INFO - PROCESS | 1957 | Values: 81.0 83.0 135.0 70.0 71.0 72.0 117.0 68.0 70.0 118.0 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:91.00 stddev:1.78 (2.0%) stddev-sans-first:1.80 15:51:34 INFO - PROCESS | 1957 | Values: 91.0 87.0 91.0 88.0 91.0 90.0 91.0 88.0 91.0 87.0 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:51:34 INFO - PROCESS | 1957 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | [#7] imaging-desaturate Cycles:10 Average:89.60 Median:85.00 stddev:13.28 (15.6%) stddev-sans-first:14.05 15:51:34 INFO - PROCESS | 1957 | Values: 87.0 85.0 85.0 84.0 85.0 85.0 85.0 90.0 127.0 83.0 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.99 (1.8%) stddev-sans-first:1.05 15:51:34 INFO - PROCESS | 1957 | Values: 54.0 55.0 56.0 54.0 54.0 54.0 55.0 53.0 53.0 53.0 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:70.00 stddev:3.44 (4.9%) stddev-sans-first:3.04 15:51:34 INFO - PROCESS | 1957 | Values: 64.0 64.0 71.0 69.0 73.0 75.0 70.0 69.0 70.0 69.0 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | [#10] stanford-crypto-aes Cycles:10 Average:92.50 Median:85.00 stddev:9.59 (11.3%) stddev-sans-first:9.79 15:51:34 INFO - PROCESS | 1957 | Values: 85.0 91.0 107.0 106.0 105.0 85.0 84.0 87.0 85.0 90.0 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:139.00 stddev:13.29 (9.6%) stddev-sans-first:14.04 15:51:34 INFO - PROCESS | 1957 | Values: 139.0 138.0 139.0 136.0 140.0 137.0 140.0 136.0 180.0 139.0 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.30 Median:168.50 stddev:29.83 (17.7%) stddev-sans-first:30.90 15:51:34 INFO - PROCESS | 1957 | Values: 168.0 168.0 168.0 168.0 221.0 240.0 226.0 168.0 169.0 167.0 15:51:34 INFO - PROCESS | 1957 | 15:51:34 INFO - PROCESS | 1957 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 15:51:34 INFO - PROCESS | 1957 | Values: 66.0 66.0 67.0 66.0 67.0 68.0 67.0 68.0 66.0 68.0 15:51:34 INFO - PROCESS | 1957 | -------- Summary: end -------- 15:51:34 INFO - PROCESS | 1957 | 15:51:35 INFO - TEST-INFO | 1957: exit 0 15:51:35 INFO - TEST-OK | kraken | took 59058ms 15:51:35 INFO - SUITE-END | took 1176s 15:51:36 INFO - Completed test suite (00:19:37) 15:51:36 INFO - javascript benchmark 15:51:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3200.8079515229083, 3339.098443420276, 3360.479125735512, 3392.3724111039473, 3444.2422667013266, 5611.242482264893, 5670.432956704328, 5732.455416735414, 5769.249997500325, 5784.421557844219, 5748.741306641201, 5758.769649214037, 5775.942240577593, 5832.2418085648915, 5861.560382971284, 5141.177411614142, 5170.689758614495, 5172.741362931857, 5215.9828833377505, 5275.446078161776, 5359.1425371940495, 5365.248865158881, 5373.328333958255, 5375.704336261504, 5386.461353864602, 5185.351831021122, 5315.468453154654, 5323.1749078892835, 5339.946600533984, 5375.247465354834, 5215.348081489814, 5228.8692782680355, 5270.130428479296, 5292.338457692788, 5319.840404787863, 5236.842894713165, 5249.790008399659, 5282.366116066097, 5283.445238249967, 5344.091504444254, 5762.481376676077, 5768.942310576925, 5788.450097240755, 5789.131630255453, 5796.13058041293, 6097.312956045969, 6116.816495505097, 6175.62946223228, 6236.781712640081, 6301.590396624205, 6241.095041219043, 6315.147455093595, 6317.241930968267, 6319.778807741753, 6327.8734425311695, 5774.82675519735, 5843.094320380348, 5857.970710146465, 5863.560232982543, 5872.29532456108, 6227.314995350508, 6283.3088360280335, 6304.243490781136, 6369.840753981188, 6374.58565193261, 6128.19758601264, 6129.601575897553, 6133.3866613339205, 6146.139540464339, 6151.169592105098, 6256.624602523863, 6258.843528911813, 6306.527010474233, 6320.652364119926, 6334.303226645157, 5329.813456529003, 6196.380361963767, 6265.404786545362, 6266.561340706198, 6296.622202667854, 5131.974340128276, 6102.216595924226, 6275.6862156891975, 6287.2140982377205, 6295.150154729053, 4687.882802929886, 4743.003969166445, 4886.802733330357, 4988.152014157602, 5066.062778385936, 4469.597736203757, 4471.396361491222, 4474.642028637766, 4476.529964353761, 4527.596445102029, 5687.317521897398, 5719.113537401709, 5744.310682718101, 5753.0, 5768.048272035067, 6150.708351246199, 6233.096201050822, 6245.906311405332, 6258.561900667, 6263.655498947602, 5739.684317362502, 5753.827385178452, 5758.452946970031, 5764.827055188351, 5805.912911306334, 4605.792739326738, 5455.263539422127, 5492.5331346835965, 5498.065328894098, 5512.50387465122, 6177.135201071764, 6228.968855155696, 6275.497960163268, 6288.779892703734, 6391.488680905423, 6245.375462453719, 6282.2147231596055, 6316.7473301069285, 6324.335944725737, 6325.557210995186, 6292.465140463112, 6337.4613157882095, 6339.461145802658, 6351.364863513611, 6353.459955903615, 6116.670564642461, 6141.455323060992, 6154.569180157346, 6240.4071613196675, 6241.438270555672, 6192.845178870564, 6284.214473190851, 6295.905561416491, 6298.212723409574, 6312.905306420499, 6197.318294987638, 6198.721057552511, 6203.627782333075, 6207.379262073757, 6211.65835879031, 4496.550344965477, 6057.636541807329, 6150.077488376601, 6175.722092505938, 6223.066540019034, 5909.497692696169, 5959.622587079119, 5996.580239383376, 5999.970000149971, 6027.60820546663, 6165.599236049642, 6180.134781130555, 6194.938050619617, 6209.534284928739, 6222.191115155001, 5807.186993820784, 5820.563457740602, 5835.328937172109, 5853.09277062056, 6023.48800351975], "value": 5718.129237069532, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.1347668533435, 520.4925197932016, 523.7093413155698, 524.6799452334076, 531.9095753721867, 29747.107586772403, 31077.756889724413, 39810.8009459953, 40662.59337406625, 40991.0, 41716.16567668645, 42118.57881421185, 42167.578324216745, 42208.0, 42372.576274237246, 9650.613975440992, 9828.508574571279, 9831.754206144831, 9849.571812087243, 9874.60501579936, 8255.050669173062, 8638.827223455528, 10674.412907290096, 12151.878481215163, 12151.967082797973, 12042.81935770964, 12111.576094836682, 12119.212251203644, 12127.757444851097, 12265.386730663477, 12093.274403535772, 12169.878301216962, 12174.817377739386, 12180.756384872342, 12189.878101218963, 11887.46506407205, 11959.641210763692, 11975.0, 11978.460969256404, 12000.699982500508, 40043.79978100091, 40340.79829600862, 40342.39486407706, 40363.0, 40381.798091009354, 2903.5499497577907, 3244.9675503244903, 3315.088350703576, 3327.1349449143154, 3403.7447191460737, 25178.0, 30359.392812143633, 30743.692563074306, 31301.0, 31442.899498517443, 2813.7889658275712, 3180.0, 3191.4255434021866, 3225.064731227941, 3314.4365457871977, 376814.0, 379278.0, 379868.0, 380436.1956380456, 380859.0, 32860.83569582137, 56549.0, 56879.57801055007, 56894.7155264221, 57010.714946425, 33269.16827079294, 34349.656503435144, 34551.4817277741, 34565.65434345674, 34582.654173458446, 14555.636109097357, 14730.779038314435, 14737.926310368379, 14739.189344586151, 14814.481493147689, 11364.783867145827, 11561.76876462466, 12555.932745716716, 12669.873301266869, 12676.619701408788, 7271.3455788979245, 7475.588842613708, 7666.693332266647, 7667.0, 7683.654235559413, 3208.406444807718, 3229.4187046331417, 3231.1760501072545, 3235.175030367241, 3279.967200328014, 896.6368620708623, 904.2585080234277, 905.42053086025, 925.8842644669417, 1007.0, 24095.638565421534, 28906.421871562452, 29832.552511712343, 30107.849460752557, 30751.384972300428, 1103.9282446640943, 1148.4372657397982, 1175.1949914308725, 1192.0642295797757, 1230.3233221728015, 15226.695466090616, 16025.278862450985, 16186.947848389816, 16216.918915405347, 16287.674246515004, 696150.0, 710009.0, 711488.0, 711789.0, 711810.0, 57657.71171144201, 58001.54996125131, 58028.419715803146, 58087.0, 58130.0, 1243.440451796695, 1273.5860845225525, 1365.8156148920166, 1375.9518416855362, 1401.4954616338314, 24372.713277485032, 28736.994205202718, 30330.696693032787, 30674.693253067184, 30741.385172296876, 47549.52450475589, 48286.75856620695, 48299.517004829504, 48336.758316208194, 48358.5164148354, 556149.0, 561074.0, 562076.0, 562696.1865190648, 562848.0, 25106.62340064937, 26628.0, 27022.459550808482, 27224.183274501796, 27940.580891287053, 45940.0, 46431.303530447745, 46708.766456167505, 47125.52874471348, 47471.0, 33218.0, 36710.531578736554, 37810.62189378071, 38843.22313553769, 39021.0, 38713.289509861184, 39017.0, 39221.41167882427, 39537.6898453312, 40065.799671001456, 36691.08272293214, 36712.08219794527, 37896.62103379041, 38435.6156438432, 38671.80664096661, 32853.83573082119, 33776.15559611029, 34427.65572344245, 34448.0, 34765.47851782276, 21819.23632672849, 22925.312240632808, 23844.52310953806, 25205.74794252034, 25403.237902862944], "value": 18709.917479354055, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.18996308490466, 352.9682328590429, 374.68526437792264, 381.75949152034224, 402.9456023436835, 15069.472568460105, 15082.170480623576, 16441.50675479736, 20706.378808635727, 20780.168793248253, 17854.464366069005, 18872.245110195574, 20208.494787630316, 20900.581988360223, 21038.684419733716, 5227.973860130694, 5816.621919575236, 5902.909519340211, 6096.35988221237, 6104.084387341912, 4683.9531604684025, 6027.72875220614, 6102.145699602059, 6104.511639068886, 6104.755809767604, 5797.36229014808, 5954.196183515235, 6082.5742198046155, 6083.452489275965, 6092.939070609304, 5988.640681559121, 6045.6674882881425, 6055.0, 6055.273367195965, 6067.302260240085, 5231.843044708665, 5234.136367499358, 5257.579393648499, 5525.033119204123, 5594.58040646949, 13234.801477977839, 13497.325133743274, 13526.59420217395, 16239.0, 25223.24330270095, 2059.5263089489354, 2071.0, 2260.604394231003, 2432.72023717273, 2484.4037431016604, 9809.950950245275, 9860.753481163028, 9900.851487227697, 10316.27786054969, 10401.115905148072, 1774.0686139776722, 1814.0929535232383, 1823.4165067178508, 1841.861860360465, 1910.0736142970648, 79490.0, 123992.0, 130191.20933697541, 130211.0, 130299.0, 11038.289065194907, 11390.202685812079, 11442.54229830814, 11469.598564050219, 11591.826122608167, 14111.50609728675, 14240.359183836752, 14246.07400518963, 14275.143491390341, 14302.427902883976, 8305.294050005818, 8540.274076703425, 8590.441621294722, 8699.086595907338, 8735.825283494294, 8518.57407129641, 8519.527248194623, 8520.829583408422, 8678.913210867937, 8717.65129394817, 4160.54234034256, 4167.770772607536, 4427.848759322599, 4523.864284071417, 4607.3089036644105, 1583.9604009899615, 1585.5718955881848, 1833.9633207335778, 1902.581432084939, 1906.9427917162507, 747.622450662412, 897.4391005621486, 923.3213588012806, 924.117467818232, 933.0669330669331, 20702.378928632166, 21385.358439246847, 21437.785622143892, 21447.0, 21467.78532214689, 921.4611598630304, 949.3307218411004, 954.7231302922214, 964.5514835601479, 1019.8317277649105, 8643.611037503328, 10428.478576071166, 11093.278936869077, 11144.996950274513, 11171.72070698239, 519960.0, 554005.0, 559636.0, 574875.0, 578089.0, 97576.0, 123167.0, 125912.48175036447, 136782.63217367698, 139303.0, 832.3549249331817, 970.7233438470003, 1004.2668851738272, 1004.8743907011624, 1032.8554002439814, 15713.978591391522, 17964.922104673762, 19263.51841203981, 19339.4198174055, 19519.414417567496, 52052.47947520476, 54481.72759136179, 60144.411877403334, 60212.39787602068, 60962.0, 87468.0, 88132.0, 88526.0, 89384.5530772342, 89910.0, 7856.057273127033, 8016.0, 8075.475094118863, 8179.877301840358, 8219.95890020546, 9052.954735226282, 11508.769824603294, 11943.701407464883, 12836.935815320863, 13250.271235082164, 10810.29733067348, 11008.339499630049, 11260.155488338243, 11428.828567571327, 11448.771024579295, 10975.28660637056, 11078.833817492905, 11188.83216751733, 11284.548618055514, 11318.830217546578, 11079.169062320198, 11214.943925280322, 11385.373804440504, 11416.143789215675, 11610.70973225676, 7011.964940175267, 7939.7371749053555, 8138.186181381814, 8169.877451838346, 8314.916850831656, 10759.946200269262, 10820.242583019428, 11108.50011749457, 11166.274192177483, 11210.719732006764], "value": 9353.16801013799, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.5972357601659, 1520.7718842173672, 1638.4347400146953, 1699.660067986403, 1859.4979355573987, 8438.282745966593, 8928.107189281069, 8948.28413726902, 8950.552472376372, 8977.955110224457, 7866.331361834251, 8077.474964127342, 8078.192180781919, 8558.315334773219, 8777.736667899957, 2380.654805053262, 2414.106780491212, 2415.154695856445, 2418.2382549496942, 2422.3701837522285, 2388.1163969331374, 2402.8918698658604, 2419.9637005444933, 2424.7211570669424, 2428.368624157714, 2228.543148654522, 2243.6858839762444, 2247.2696373678536, 2254.5603607296584, 2269.6482045283005, 2378.607529757588, 2389.940251493718, 2403.3270684208364, 2408.6266628672583, 2412.1798588479824, 2403.567357875582, 2404.651325557802, 2405.314485371661, 2407.205622144688, 2411.7588241175918, 8836.983746869128, 8850.778730531723, 8937.73186804397, 8964.14840590143, 8968.865467017935, 5232.555232805216, 5385.676859388449, 5404.675719456806, 5409.810656627039, 5410.783568657249, 3485.4597537381746, 3551.8598262677156, 3712.7401081924277, 3715.294094122108, 3717.4795528626014, 1088.1403691084033, 1107.70951841105, 1750.9299628014865, 1794.0939825388225, 1822.9270829166817, 11523.654290371302, 11595.246308989888, 11604.477798499087, 11616.825747613793, 11633.418329083597, 4443.844465443694, 4657.720536767804, 4843.709377437365, 4914.877128071756, 4953.0589188054155, 9259.907400925904, 9295.58169882357, 9301.767455813524, 9307.162355388047, 9326.626934922662, 4517.638588912879, 5302.09864323066, 5305.8938821223355, 5308.946910530845, 5322.707251101227, 4679.508651591602, 4820.060088282821, 4910.410750709938, 4948.851534453972, 4955.108080545537, 3771.4719939208535, 3811.5516103880905, 3863.942040869389, 3889.7277190596387, 3895.649391554717, 1006.9093781559695, 1175.6825657072543, 1178.6287319494504, 1182.4737991593831, 1191.862935762381, 777.8254835198891, 802.3982013489882, 902.7992769616394, 904.6110172625835, 907.4419232172166, 5357.866053348619, 5804.535637149018, 6051.576389652682, 6086.513078953673, 6121.234845644294, 931.5761328595473, 940.849464085743, 948.5257371314343, 965.2181732796457, 994.0010289658846, 3813.2945405100145, 3857.247836671822, 3942.1721438498234, 3989.9202015959518, 4056.3915412687743, 10542.736431589272, 10836.241463097507, 10928.633920759905, 10934.890651093547, 10936.835947460795, 9218.76953076165, 10845.566177352817, 10894.346339219672, 10895.673129806119, 10912.0, 8065.677372905136, 8097.2307630774985, 8239.217274358927, 8324.70863519774, 8335.874961875577, 5810.358027023654, 5835.2122463466885, 5878.2064421304285, 5992.580519363602, 6003.219581454383, 10132.0, 10187.7453063674, 10212.489375531342, 10234.078932896075, 10272.691819245434, 8667.566621669017, 9371.344005919793, 10051.949740251252, 10166.390016599027, 10406.895931040593, 5794.62334948227, 6580.374864387875, 7078.929210707827, 7149.678264478007, 7226.927730722626, 8293.83412331762, 8332.833343333221, 8362.623681934449, 8388.580570971304, 8499.532525711145, 7473.177950425557, 7533.8116547086765, 7549.962250188714, 7591.696332146873, 7642.197569255148, 7291.744788932362, 7465.141508726566, 7475.102987641518, 7493.138289096823, 7596.506227095221, 6924.826879328057, 7002.404795592228, 7086.645667716697, 7089.893651595127, 7105.005299258005, 4775.379200703886, 4909.4845041270155, 4974.32846565709, 5001.524855138756, 5143.948560514347, 4601.907961840811, 4774.069056533943, 4832.95167048339, 4996.525330093636, 5030.4718004608985], "value": 4607.569453719391, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.4844615707142, 303.567416431585, 311.6945393514356, 313.4076595235006, 317.1405491119067, 4835.68568043077, 5035.395752509699, 5463.787166197686, 5477.479639434252, 5529.751161197746, 4662.671138725464, 4877.926831097537, 5090.058339207249, 5129.563987061104, 5381.246625472437, 3379.493076038589, 3448.7413443991677, 3848.5189351331082, 4099.754014759109, 4139.4204811326435, 4036.7577945323374, 4061.4720086388875, 4090.550039495653, 4094.5700701426367, 4106.486689163855, 3677.816109194543, 3926.725129240954, 4061.0050537618326, 4062.4609618988134, 4079.3676980068135, 4056.8782936511952, 4057.3305404608204, 4075.3683179107284, 4079.102597428591, 4088.5093788745244, 3519.03226612681, 3548.254866478043, 3564.198055437532, 3569.6430356964097, 3577.5170352002665, 4395.351743096339, 4996.700197988096, 5073.949260507385, 5179.695035709111, 5226.895462090775, 4249.447571815645, 4290.4636920384955, 4686.649045932141, 4692.343071969893, 4695.3661255730385, 5603.355614104389, 5608.44815608897, 5612.859678508029, 5616.66300022, 5650.858728531778, 3727.4036154215196, 3879.4568760373572, 3889.2221555688975, 3891.182851601167, 3914.3559704924, 5572.554195664377, 5847.707614619252, 5855.912161317584, 5860.238169037998, 5869.413058694139, 3188.952165717516, 3931.567527571965, 3953.9802300988313, 3954.762714237155, 3963.583823698528, 3372.7689393371243, 4004.839806407769, 4023.6177563131455, 4036.9596304036586, 4044.9191016180102, 3957.3470377387407, 4476.529964353761, 4632.305154226826, 4667.509911459316, 4696.577308042292, 5641.7996981177375, 5646.491815736604, 5653.604247702621, 5654.0, 5671.631343962629, 1182.030734797475, 1265.9366132448788, 1346.3335648853683, 1381.7633218269793, 1385.896057795649, 776.2005134711256, 799.6081919859228, 837.9622916968751, 880.4981160738317, 894.4186278918625, 5093.490650934877, 5155.175171972466, 5164.5539249010335, 5167.509086636764, 5170.146925757208, 4748.786304616231, 5470.425605311465, 5696.629719068247, 5699.772009119589, 5717.656940583578, 4275.486941567032, 4794.7362895040405, 4799.952000480021, 5116.948830511722, 5206.453322401169, 2952.5423559348337, 2962.8370439625596, 2972.4203780263074, 2974.895878644237, 3002.789804713693, 4918.5819205367225, 5609.691466969356, 5851.268591426072, 5871.412858714094, 5881.0, 5622.57830662702, 5840.649561026352, 5850.531957443394, 5865.35481097079, 5895.351511333835, 4605.4933957264675, 5874.148248503943, 5921.67430791302, 5940.4653581177035, 5958.582899197015, 4534.977325113353, 5419.376771671308, 5693.868372395249, 5726.284214473191, 5745.534888603379, 5199.906055896736, 5635.379548509963, 5638.011853717537, 5653.575981801299, 5687.5734319927, 4934.7285899275885, 5813.738381772915, 5875.529957603467, 5906.822795316148, 5913.58604897653, 3761.9623803762706, 3917.3536366499206, 3951.585083566184, 3954.8022598870516, 3966.5438474575794, 4783.493199642102, 5687.829365119053, 5692.971535142297, 5720.225690540168, 5752.511036561772, 5243.007657090281, 5382.381026181883, 5568.053430916835, 5600.327960644749, 5608.523275521627, 5209.426963033988, 5444.401115877171, 5490.780368785204, 5554.611177217556, 5559.861003474945, 5217.869553261199, 5399.325084364455, 5407.72961351923, 5462.399136095106, 5462.726863656881, 5365.892682146413, 5490.91763623538, 5531.502164805187, 5646.689432081275, 5735.71321433935, 4523.991545622124, 5456.953642384106, 5487.5306112248845, 5510.8071217507195, 5539.916901246565], "value": 4097.375738277943, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.3976580141075, 711.2887112887109, 712.2912701861646, 756.1153450462958, 822.9423940324176, 15384.769228461568, 16363.83636163638, 16367.59081022975, 16388.672226555478, 16407.75388369174, 14574.344154513046, 14830.629234269149, 14835.406583736665, 14857.479988200415, 14859.851401485981, 671.6910221298209, 694.149666658342, 831.991680083199, 832.6586099699125, 857.8455877941968, 829.9957051967127, 841.5876220651897, 842.6334544473143, 843.8185790055137, 847.2925107535216, 901.0358915959926, 901.2474583722567, 901.2834796336895, 903.1465265324272, 903.3631289940608, 710.4742490557003, 895.1048951048919, 899.5052721003455, 899.8560230363111, 903.8056817784208, 543.1526818163677, 662.7746566167526, 677.8678157759239, 682.2870100744734, 684.5208354152113, 14870.182139982297, 14914.328855201542, 14914.477993270184, 14915.701685966329, 14917.955743097988, 13502.257375844325, 13883.37524811386, 14025.859741402557, 14044.859551404457, 14060.578182654537, 12396.380180991004, 12533.56132535366, 12644.810327845089, 12673.93663031688, 13015.86984130156, 4488.0, 4607.239805432133, 4618.468876079261, 4649.442066951953, 4728.243481043017, 105239.94760052378, 106394.0, 106663.93336066695, 113201.43399283034, 113646.43176784064, 8731.476111433334, 10665.786684266272, 10972.506237219344, 11161.609343673095, 11370.715732106764, 18340.633187336447, 22204.222852200095, 22224.777752222595, 22224.88887555552, 22264.888675556518, 7661.693532258647, 7765.53406795594, 7820.413468989848, 7902.841943161105, 8032.1164671886045, 3864.2078373933277, 4308.310670292801, 4375.496817865923, 4459.821607135678, 4560.247559152769, 3449.9310013800086, 3575.785452872836, 3576.8926932191557, 3582.9283414331567, 3587.8385472653795, 631.9778807741707, 637.5951270942985, 648.3516483516484, 648.9448396886318, 650.0314531348257, 515.9558604234969, 552.4171998541497, 563.39997902234, 623.0591806372411, 631.1605564599072, 8572.0, 9440.29197810167, 9461.716148515556, 9464.384814987141, 9706.854397184048, 604.4257954942822, 623.9953674583916, 632.4876849751715, 634.4258446106281, 672.3276723276723, 4239.38528913312, 4642.18761716705, 4658.557437043475, 4673.462551806518, 4757.3577567028005, 161601.0, 164865.0, 167645.0, 167989.0, 170473.0, 123048.0, 133568.33215834052, 144594.2770286142, 148383.0, 150973.0, 123436.0, 123531.0, 123795.3810230943, 124635.0, 125746.74253257533, 8617.181367770303, 8921.420107693239, 8949.910500894908, 8965.372423930523, 9118.042605526323, 62536.0, 63993.68003159954, 64418.0, 67166.0, 67669.66165169142, 101545.0, 101577.0, 102166.0, 104404.47797760963, 106186.0, 9697.709068727949, 11754.412279386168, 11885.702857428634, 11932.582359617372, 12072.204036690131, 12984.285864277555, 12999.610011699664, 13177.670558235737, 13178.143420677625, 13570.321483925962, 11844.52621895149, 11964.16250862466, 12121.757564848478, 12128.757424851277, 12378.0, 11934.701632459259, 11986.76026479448, 12255.509779608716, 12269.0, 12394.566190183301, 11851.229670071418, 11921.46353414081, 12392.380380980734, 12402.75194496123, 12428.75142497127, 9853.0, 10043.69868903934, 10210.438425886647, 10434.06093451593, 10559.419231942316, 8807.647694092164, 9418.161178216047, 10049.0, 10119.089281964658, 10226.53980570891], "value": 7744.047684761173, "unit": "score"}], "name": "dromaeo_css", "value": 7259.034661170992, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 116.0, 113.0, 113.0, 112.0, 112.0, 110.0, 113.0, 124.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 166.0, 177.0, 108.0, 131.0, 129.0, 110.0, 158.0, 106.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 184.0, 183.0, 175.0, 183.0, 182.0, 184.0, 186.0, 183.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 76.0, 153.0, 58.0, 57.0, 56.0, 69.0, 142.0, 57.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 135.0, 70.0, 71.0, 72.0, 117.0, 68.0, 70.0, 118.0], "value": 88.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 91.0, 88.0, 91.0, 90.0, 91.0, 88.0, 91.0, 87.0], "value": 89.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 90.0, 127.0, 83.0], "value": 89.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 54.0, 54.0, 54.0, 55.0, 53.0, 53.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 71.0, 69.0, 73.0, 75.0, 70.0, 69.0, 70.0, 69.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 91.0, 107.0, 106.0, 105.0, 85.0, 84.0, 87.0, 85.0, 90.0], "value": 92.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 139.0, 136.0, 140.0, 137.0, 140.0, 136.0, 180.0, 139.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 168.0, 168.0, 221.0, 240.0, 226.0, 168.0, 169.0, 167.0], "value": 186.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 67.0, 68.0, 67.0, 68.0, 66.0, 68.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1487.6000000000001, "alertThreshold": 2.0}]} 15:51:36 INFO - Return code: 0 15:51:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:51:36 INFO - # TBPL SUCCESS # 15:51:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:51:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:51:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:51:36 INFO - 2016-09-12 15:51:36.278 screenresolution[1961:18959] starting screenresolution argv=screenresolution get 15:51:36 INFO - 2016-09-12 15:51:36.280 screenresolution[1961:18959] Display 0: 1600x1200x32@60 15:51:36 INFO - 2016-09-12 15:51:36.286 screenresolution[1962:18962] starting screenresolution argv=screenresolution list 15:51:36 INFO - Available Modes on Display 0 15:51:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:51:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:51:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:51:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:51:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:51:36 INFO - Intel Iris: 15:51:36 INFO - Chipset Model: Intel Iris 15:51:36 INFO - Type: GPU 15:51:36 INFO - Bus: Built-In 15:51:36 INFO - VRAM (Dynamic, Max): 1536 MB 15:51:36 INFO - Vendor: Intel (0x8086) 15:51:36 INFO - Device ID: 0x0a2e 15:51:36 INFO - Revision ID: 0x0009 15:51:36 INFO - Displays: 15:51:36 INFO - Display: 15:51:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:51:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:51:36 INFO - Display Serial Number: 1600x1200 60 15:51:36 INFO - Main Display: Yes 15:51:36 INFO - Mirror: Off 15:51:36 INFO - Online: Yes 15:51:36 INFO - Rotation: Supported 15:51:36 INFO - Return code: 0 15:51:36 INFO - Running post-action listener: _resource_record_post_action 15:51:36 INFO - [mozharness: 2016-09-12 22:51:36.529562Z] Finished run-tests step (success) 15:51:36 INFO - Running post-run listener: _resource_record_post_run 15:51:36 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 757760; Write bytes: 704150016; Read time: 8; Write time: 2178 15:51:36 INFO - TinderboxPrint: CPU usage
53.5% 15:51:36 INFO - TinderboxPrint: I/O read bytes / time
757,760 / 8 15:51:36 INFO - TinderboxPrint: I/O write bytes / time
704,150,016 / 2,178 15:51:36 INFO - TinderboxPrint: CPU idle
2,256.0 (46.5%) 15:51:36 INFO - TinderboxPrint: CPU system
967.9 (20.0%) 15:51:36 INFO - TinderboxPrint: CPU user
1,625.8 (33.5%) 15:51:36 INFO - TinderboxPrint: Swap in / out
405,159,936 / 0 15:51:36 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 382585344; Write bytes: 377710592; Read time: 29094; Write time: 720 15:51:36 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 757760; Write bytes: 295993856; Read time: 8; Write time: 1400 15:51:36 INFO - Running post-run listener: _upload_blobber_files 15:51:36 INFO - Blob upload gear active. 15:51:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:51:36 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 15:51:36 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'] 15:51:36 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 15:51:37 INFO - (blobuploader) - INFO - Open directory for files ... 15:51:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:51:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:51:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:38 INFO - (blobuploader) - INFO - Done attempting. 15:51:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:51:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:51:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:39 INFO - (blobuploader) - INFO - Done attempting. 15:51:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:51:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:41 INFO - (blobuploader) - INFO - Done attempting. 15:51:41 INFO - (blobuploader) - INFO - Iteration through files over. 15:51:41 INFO - Return code: 0 15:51:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:51:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:51:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f79a97b3b26c81ad3bd709fac02a3d46800e1719221f75797d7e520186bc1fad22734f00df6d5d26516d2c530396282ee2a8af616e3ceba1c517fbac7b37431", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c03a1362a3c696c9e7700fa3b1519f77fbcf127806270ab3fb965be06d1f2e0cb309c385320c0ba6714d467097ce30d9edd0e5bccecfc2ea07edb26dacd5c17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4d5435c5f2a9471a042a2d9b4e485ba3aba7267660185b1145f8df048c5cee4b7e2c8402959fd3f819f4696c8be56e4eae2a1c011b6ae1d74119fe213a13429"} 15:51:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:51:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:51:41 INFO - Contents: 15:51:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f79a97b3b26c81ad3bd709fac02a3d46800e1719221f75797d7e520186bc1fad22734f00df6d5d26516d2c530396282ee2a8af616e3ceba1c517fbac7b37431", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c03a1362a3c696c9e7700fa3b1519f77fbcf127806270ab3fb965be06d1f2e0cb309c385320c0ba6714d467097ce30d9edd0e5bccecfc2ea07edb26dacd5c17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4d5435c5f2a9471a042a2d9b4e485ba3aba7267660185b1145f8df048c5cee4b7e2c8402959fd3f819f4696c8be56e4eae2a1c011b6ae1d74119fe213a13429"} 15:51:41 INFO - Running post-run listener: copy_logs_to_upload_dir 15:51:41 INFO - Copying logs to upload dir... 15:51:41 INFO - mkdir: /builds/slave/test/build/upload/logs 15:51:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.318921 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-12 15:51:41.431496) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-12 15:51:41.434975) ========= 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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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/0f79a97b3b26c81ad3bd709fac02a3d46800e1719221f75797d7e520186bc1fad22734f00df6d5d26516d2c530396282ee2a8af616e3ceba1c517fbac7b37431", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c03a1362a3c696c9e7700fa3b1519f77fbcf127806270ab3fb965be06d1f2e0cb309c385320c0ba6714d467097ce30d9edd0e5bccecfc2ea07edb26dacd5c17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4d5435c5f2a9471a042a2d9b4e485ba3aba7267660185b1145f8df048c5cee4b7e2c8402959fd3f819f4696c8be56e4eae2a1c011b6ae1d74119fe213a13429"} build_url:https://queue.taskcluster.net/v1/task/c_VWR8r_RpeNFM1TJG63vw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011131 build_url: 'https://queue.taskcluster.net/v1/task/c_VWR8r_RpeNFM1TJG63vw/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/0f79a97b3b26c81ad3bd709fac02a3d46800e1719221f75797d7e520186bc1fad22734f00df6d5d26516d2c530396282ee2a8af616e3ceba1c517fbac7b37431", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c03a1362a3c696c9e7700fa3b1519f77fbcf127806270ab3fb965be06d1f2e0cb309c385320c0ba6714d467097ce30d9edd0e5bccecfc2ea07edb26dacd5c17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4d5435c5f2a9471a042a2d9b4e485ba3aba7267660185b1145f8df048c5cee4b7e2c8402959fd3f819f4696c8be56e4eae2a1c011b6ae1d74119fe213a13429"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-12 15:51:41.529059) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 15:51:41.529424) ========= 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.Sk7VlCk1Sl/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.zQSyWNt96J/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005122 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 15:51:41.556677) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-12 15:51:41.556996) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-12 15:51:41.557334) ========= ========= Total master_lag: 0.22 =========